-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Tue 2025-05-13 00:25:07 CST. -- May 13 00:24:02 volumio volumio[948]: info: VolumeController::SetAlsaVolume46 May 13 00:24:02 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:02 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:24:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 00:24:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 00:24:03 volumio volumio[948]: info: Discovery: Getting this device information May 13 00:24:03 volumio volumio[948]: info: CoreCommandRouter::volumioGetState May 13 00:24:03 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 00:24:07 volumio volumio[948]: info: CoreCommandRouter::volumioPlay May 13 00:24:07 volumio volumio[948]: info: CoreStateMachine::play index undefined May 13 00:24:07 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:24:07 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:07 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer May 13 00:24:07 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:07 volumio volumio[948]: info: ControllerMpd::resume May 13 00:24:07 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play May 13 00:24:07 volumio volumio[948]: info: sendMpdCommand play took 1 milliseconds May 13 00:24:18 volumio volumio[948]: info: CoreCommandRouter::volumioPlay May 13 00:24:18 volumio volumio[948]: info: CoreStateMachine::play index undefined May 13 00:24:18 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:24:18 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:18 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer May 13 00:24:18 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:18 volumio volumio[948]: info: ControllerMpd::resume May 13 00:24:18 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play May 13 00:24:18 volumio volumio[948]: info: sendMpdCommand play took 0 milliseconds May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::volumioNext May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::next May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::stop May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrackBlock May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::serviceStop May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 1 May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::serviceStop May 13 00:24:26 volumio volumio[948]: info: ControllerMpd::stop May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand stop took 3 milliseconds May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::play index undefined May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/5631-93B2/BaiduNetdiskDownload/01-爱久见人心.dff May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrackBlock May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand stop took 1 milliseconds May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear May 13 00:24:26 volumio volumio[948]: info: May 13 00:24:26 volumio volumio[948]: ---------------------------- MPD announces system playlist update May 13 00:24:26 volumio volumio[948]: info: Ignoring MPD Status Update May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand clear took 1 milliseconds May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/5631-93B2/BaiduNetdiskDownload/01-爱久见人心.dff" May 13 00:24:26 volumio volumio[948]: error: updateQueue error: null May 13 00:24:26 volumio volumio[948]: info: May 13 00:24:26 volumio volumio[948]: ---------------------------- MPD announces system playlist update May 13 00:24:26 volumio volumio[948]: info: Ignoring MPD Status Update May 13 00:24:26 volumio volumio[948]: info: ------------------------------ 5ms May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand add "USB/5631-93B2/BaiduNetdiskDownload/01-爱久见人心.dff" took 1 milliseconds May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play May 13 00:24:26 volumio volumio[948]: info: ------------------------------ 1ms May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand play took 1 milliseconds May 13 00:24:26 volumio volumio[948]: info: May 13 00:24:26 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:24:26 volumio volumio[948]: info: ControllerMpd::getState May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:24:26 volumio volumio[948]: info: May 13 00:24:26 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand status took 42 milliseconds May 13 00:24:26 volumio volumio[948]: info: ControllerMpd::getState May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand status took 2 milliseconds May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand playlistinfo took 2 milliseconds May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:24:26 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:26 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01-爱久见人心.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/01-爱久见人心.dff","trackType":"dff"} May 13 00:24:26 volumio volumio[948]: verbose: CURRENT POSITION 2 May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::syncState stateService play May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop May 13 00:24:26 volumio volumio[948]: info: ------------------------------ 56ms May 13 00:24:26 volumio volumio[948]: info: sendMpdCommand playlistinfo took 4 milliseconds May 13 00:24:26 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:24:26 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:26 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":417,"duration":297,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01-爱久见人心.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/01-爱久见人心.dff","trackType":"dff"} May 13 00:24:26 volumio volumio[948]: verbose: CURRENT POSITION 2 May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::syncState stateService play May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play May 13 00:24:26 volumio volumio[948]: info: Received an update from plugin. extracting info from payload May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:26 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:26 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:26 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:26 volumio volumio[948]: info: ------------------------------ 47ms May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::volumioNext May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::next May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::stop May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrackBlock May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::serviceStop May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 2 May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::serviceStop May 13 00:24:29 volumio volumio[948]: info: ControllerMpd::stop May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop May 13 00:24:29 volumio volumio[948]: info: May 13 00:24:29 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand stop took 8 milliseconds May 13 00:24:29 volumio volumio[948]: info: ControllerMpd::getState May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::play index undefined May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/5631-93B2/BaiduNetdiskDownload/01. 愛如潮水.dff May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrackBlock May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand status took 2 milliseconds May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand stop took 1 milliseconds May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear May 13 00:24:29 volumio volumio[948]: info: May 13 00:24:29 volumio volumio[948]: ---------------------------- MPD announces system playlist update May 13 00:24:29 volumio volumio[948]: info: Ignoring MPD Status Update May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand playlistinfo took 2 milliseconds May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand clear took 2 milliseconds May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/5631-93B2/BaiduNetdiskDownload/01. 愛如潮水.dff" May 13 00:24:29 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: 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":"01-爱久见人心.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/01-爱久见人心.dff","trackType":"dff"} May 13 00:24:29 volumio volumio[948]: verbose: CURRENT POSITION 3 May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:29 volumio volumio[948]: info: No code May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:29 volumio volumio[948]: info: ------------------------------ 24ms May 13 00:24:29 volumio volumio[948]: error: updateQueue error: null May 13 00:24:29 volumio volumio[948]: info: May 13 00:24:29 volumio volumio[948]: ---------------------------- MPD announces system playlist update May 13 00:24:29 volumio volumio[948]: info: Ignoring MPD Status Update May 13 00:24:29 volumio volumio[948]: info: ------------------------------ 21ms May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand add "USB/5631-93B2/BaiduNetdiskDownload/01. 愛如潮水.dff" took 20 milliseconds May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play May 13 00:24:29 volumio volumio[948]: info: May 13 00:24:29 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:24:29 volumio volumio[948]: info: ------------------------------ 5ms May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand play took 5 milliseconds May 13 00:24:29 volumio volumio[948]: info: ControllerMpd::getState May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:24:29 volumio volumio[948]: info: May 13 00:24:29 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand status took 31 milliseconds May 13 00:24:29 volumio volumio[948]: info: ControllerMpd::getState May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand status took 55 milliseconds May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand playlistinfo took 56 milliseconds May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:24:29 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01. 愛如潮水.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/01. 愛如潮水.dff","trackType":"dff"} May 13 00:24:29 volumio volumio[948]: verbose: CURRENT POSITION 3 May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::syncState stateService play May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop May 13 00:24:29 volumio volumio[948]: info: ------------------------------ 91ms May 13 00:24:29 volumio volumio[948]: info: sendMpdCommand playlistinfo took 3 milliseconds May 13 00:24:29 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:24:29 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":320,"duration":270,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01. 愛如潮水.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/01. 愛如潮水.dff","trackType":"dff"} May 13 00:24:29 volumio volumio[948]: verbose: CURRENT POSITION 3 May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::syncState stateService play May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play May 13 00:24:29 volumio volumio[948]: info: Received an update from plugin. extracting info from payload May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:29 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:24:29 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:29 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:24:29 volumio volumio[948]: info: ------------------------------ 76ms May 13 00:24:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 00:24:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 00:24:33 volumio volumio[948]: info: Discovery: Getting this device information May 13 00:24:33 volumio volumio[948]: info: CoreCommandRouter::volumioGetState May 13 00:24:33 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:24:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioNext May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::next May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::stop May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrackBlock May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::serviceStop May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 3 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::serviceStop May 13 00:25:03 volumio volumio[948]: info: ControllerMpd::stop May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop May 13 00:25:03 volumio volumio[948]: info: May 13 00:25:03 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand stop took 6 milliseconds May 13 00:25:03 volumio volumio[948]: info: ControllerMpd::getState May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::play index undefined May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/5631-93B2/BaiduNetdiskDownload/02 - Various Artist - Track 02.dff May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrackBlock May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand status took 2 milliseconds May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand stop took 1 milliseconds May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear May 13 00:25:03 volumio volumio[948]: info: May 13 00:25:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update May 13 00:25:03 volumio volumio[948]: info: Ignoring MPD Status Update May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 1 milliseconds May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand clear took 1 milliseconds May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/5631-93B2/BaiduNetdiskDownload/02 - Various Artist - Track 02.dff" May 13 00:25:03 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: 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":"01. 愛如潮水.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/01. 愛如潮水.dff","trackType":"dff"} May 13 00:25:03 volumio volumio[948]: verbose: CURRENT POSITION 4 May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:25:03 volumio volumio[948]: info: No code May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:25:03 volumio volumio[948]: info: ------------------------------ 21ms May 13 00:25:03 volumio volumio[948]: error: updateQueue error: null May 13 00:25:03 volumio volumio[948]: info: May 13 00:25:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update May 13 00:25:03 volumio volumio[948]: info: Ignoring MPD Status Update May 13 00:25:03 volumio volumio[948]: info: ------------------------------ 19ms May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand add "USB/5631-93B2/BaiduNetdiskDownload/02 - Various Artist - Track 02.dff" took 18 milliseconds May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play May 13 00:25:03 volumio volumio[948]: info: May 13 00:25:03 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:25:03 volumio volumio[948]: info: ------------------------------ 35ms May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand play took 35 milliseconds May 13 00:25:03 volumio volumio[948]: info: ControllerMpd::getState May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:25:03 volumio volumio[948]: info: May 13 00:25:03 volumio volumio[948]: ---------------------------- MPD announces state update: player May 13 00:25:03 volumio volumio[948]: info: ControllerMpd::getState May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand status took 2 milliseconds May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand status took 3 milliseconds May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 3 milliseconds May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::parseState May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:25:03 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":228,"duration":368,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"02 - Various Artist - Track 02.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/02 - Various Artist - Track 02.dff","trackType":"dff"} May 13 00:25:03 volumio volumio[948]: verbose: CURRENT POSITION 4 May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop May 13 00:25:03 volumio volumio[948]: info: ------------------------------ 12ms May 13 00:25:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 7 milliseconds May 13 00:25:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo May 13 00:25:03 volumio volumio[948]: info: ControllerMpd::pushState May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":257,"duration":368,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"02 - Various Artist - Track 02.dff","artist":null,"album":null,"uri":"USB/5631-93B2/BaiduNetdiskDownload/02 - Various Artist - Track 02.dff","trackType":"dff"} May 13 00:25:03 volumio volumio[948]: verbose: CURRENT POSITION 4 May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play May 13 00:25:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:25:03 volumio volumio[948]: info: CoreStateMachine::pushState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState May 13 00:25:03 volumio volumio[948]: info: ------------------------------ 59ms May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 13 00:25:03 volumio volumio[948]: info: Discovery: Getting this device information May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::volumioGetState May 13 00:25:03 volumio volumio[948]: info: CorePlayQueue::getTrack 4 May 13 00:25:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 13 00:25:06 volumio volumio[948]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 00:25:06 volumio volumio[948]: Error: connect ETIMEDOUT 74.86.12.172:443 May 13 00:25:06 volumio volumio[948]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 13 00:25:06 volumio volumio[948]: errno: -110, May 13 00:25:06 volumio volumio[948]: code: 'ETIMEDOUT', May 13 00:25:06 volumio volumio[948]: syscall: 'connect', May 13 00:25:06 volumio volumio[948]: address: '74.86.12.172', May 13 00:25:06 volumio volumio[948]: port: 443 May 13 00:25:06 volumio volumio[948]: } May 13 00:25:06 volumio volumio[948]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 00:25:07 volumio sudo[2423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 00:24 May 13 00:25:07 volumio sudo[2423]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"