-- Logs begin at Mon 2025-05-19 09:27:20 UTC, end at Mon 2025-05-19 09:34:15 UTC. -- May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioSeek May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::seek May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: TRACKBLOCK {"uri":"mnt/USB/Ventoy/没关系-容祖儿.flac","service":"mpd","name":"没关系","artist":"容祖儿","album":"一百个我 国语新曲+精选","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=846&web=%E5%AE%B9%E7%A5%96%E5%84%BF/%E4%B8%80%E7%99%BE%E4%B8%AA%E6%88%91%20%E5%9B%BD%E8%AF%AD%E6%96%B0%E6%9B%B2%2B%E7%B2%BE%E9%80%89/extralarge&path=%2FUSB%2FVentoy&metadata=false","duration":219,"trackType":"flac","samplerate":"48 kHz","bitdepth":"24 bit","channels":2} May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::startPlaybackTimer May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: ControllerMpd::seek May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:21 volumio volumio[926]: error: null May 19 09:33:21 volumio volumio[926]: info: May 19 09:33:21 volumio volumio[926]: ---------------------------- MPD announces state update: player May 19 09:33:21 volumio volumio[926]: info: ControllerMpd::getState May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status May 19 09:33:21 volumio volumio[926]: info: May 19 09:33:21 volumio volumio[926]: ---------------------------- MPD announces state update: player May 19 09:33:21 volumio volumio[926]: info: ControllerMpd::getState May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status May 19 09:33:21 volumio volumio[926]: info: May 19 09:33:21 volumio volumio[926]: ---------------------------- MPD announces state update: player May 19 09:33:21 volumio volumio[926]: info: ControllerMpd::getState May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status May 19 09:33:21 volumio volumio[926]: info: sendMpdCommand status took 6 milliseconds May 19 09:33:21 volumio volumio[926]: info: sendMpdCommand status took 3 milliseconds May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::parseState May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::parseState May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 09:33:21 volumio volumio[926]: info: sendMpdCommand status took 5 milliseconds May 19 09:33:21 volumio volumio[926]: info: sendMpdCommand playlistinfo took 2 milliseconds May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::parseState May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo May 19 09:33:21 volumio volumio[926]: info: ControllerMpd::pushState May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::servicePushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":214000,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1949 Kbps","isStreaming":false,"title":"没关系","artist":"容祖儿","album":"一百个我 国语新曲+精选","uri":"USB/Ventoy/没关系-容祖儿.flac","trackType":"flac"} May 19 09:33:21 volumio volumio[926]: verbose: CURRENT POSITION 4 May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::syncState stateService play May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play May 19 09:33:21 volumio volumio[926]: info: Received an update from plugin. extracting info from payload May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:21 volumio volumio[926]: info: ControllerMpd::pushState May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::servicePushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":214000,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1949 Kbps","isStreaming":false,"title":"没关系","artist":"容祖儿","album":"一百个我 国语新曲+精选","uri":"USB/Ventoy/没关系-容祖儿.flac","trackType":"flac"} May 19 09:33:21 volumio volumio[926]: verbose: CURRENT POSITION 4 May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::syncState stateService play May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play May 19 09:33:21 volumio volumio[926]: info: Received an update from plugin. extracting info from payload May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:21 volumio volumio[926]: info: ------------------------------ 36ms May 19 09:33:21 volumio volumio[926]: info: ------------------------------ 36ms May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 5 May 19 09:33:21 volumio volumio[926]: info: Prefetching next song May 19 09:33:21 volumio volumio[926]: info: DOING PREFETCH IN MPD May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand add "USB/Ventoy/世界赠予我的-王菲.flac" May 19 09:33:21 volumio volumio[926]: info: sendMpdCommand playlistinfo took 29 milliseconds May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo May 19 09:33:21 volumio volumio[926]: info: ControllerMpd::pushState May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::servicePushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":214606,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1354 Kbps","isStreaming":false,"title":"没关系","artist":"容祖儿","album":"一百个我 国语新曲+精选","uri":"USB/Ventoy/没关系-容祖儿.flac","trackType":"flac"} May 19 09:33:21 volumio volumio[926]: verbose: CURRENT POSITION 4 May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::syncState stateService play May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play May 19 09:33:21 volumio volumio[926]: info: Received an update from plugin. extracting info from payload May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:21 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:21 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:21 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:21 volumio volumio[926]: info: ------------------------------ 52ms May 19 09:33:21 volumio volumio[926]: info: May 19 09:33:21 volumio volumio[926]: ---------------------------- MPD announces system playlist update May 19 09:33:21 volumio volumio[926]: info: Ignoring MPD Status Update May 19 09:33:21 volumio volumio[926]: info: sendMpdCommand add "USB/Ventoy/世界赠予我的-王菲.flac" took 22 milliseconds May 19 09:33:21 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand consume 1 May 19 09:33:21 volumio volumio[926]: info: May 19 09:33:21 volumio volumio[926]: ---------------------------- MPD announces system playlist update May 19 09:33:21 volumio volumio[926]: info: Ignoring MPD Status Update May 19 09:33:21 volumio volumio[926]: info: May 19 09:33:21 volumio volumio[926]: ---------------------------- MPD announces system playlist update May 19 09:33:21 volumio volumio[926]: info: Ignoring MPD Status Update May 19 09:33:21 volumio volumio[926]: info: ------------------------------ 6ms May 19 09:33:21 volumio volumio[926]: info: sendMpdCommand consume 1 took 5 milliseconds May 19 09:33:21 volumio volumio[926]: info: ------------------------------ 4ms May 19 09:33:21 volumio volumio[926]: info: ------------------------------ 3ms May 19 09:33:25 volumio volumio[926]: info: May 19 09:33:25 volumio volumio[926]: ---------------------------- MPD announces system playlist update May 19 09:33:25 volumio volumio[926]: info: Ignoring MPD Status Update May 19 09:33:25 volumio volumio[926]: info: May 19 09:33:25 volumio volumio[926]: ---------------------------- MPD announces state update: player May 19 09:33:25 volumio volumio[926]: info: ControllerMpd::getState May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status May 19 09:33:25 volumio volumio[926]: info: May 19 09:33:25 volumio volumio[926]: ---------------------------- MPD announces system playlist update May 19 09:33:25 volumio volumio[926]: info: Ignoring MPD Status Update May 19 09:33:25 volumio volumio[926]: info: May 19 09:33:25 volumio volumio[926]: ---------------------------- MPD announces state update: player May 19 09:33:25 volumio volumio[926]: info: ControllerMpd::getState May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status May 19 09:33:25 volumio volumio[926]: info: May 19 09:33:25 volumio volumio[926]: ---------------------------- MPD announces system playlist update May 19 09:33:25 volumio volumio[926]: info: Ignoring MPD Status Update May 19 09:33:25 volumio volumio[926]: info: May 19 09:33:25 volumio volumio[926]: ---------------------------- MPD announces state update: player May 19 09:33:25 volumio volumio[926]: info: ControllerMpd::getState May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status May 19 09:33:25 volumio volumio[926]: info: ------------------------------ 4ms May 19 09:33:25 volumio volumio[926]: info: sendMpdCommand status took 4 milliseconds May 19 09:33:25 volumio volumio[926]: info: ------------------------------ 4ms May 19 09:33:25 volumio volumio[926]: info: sendMpdCommand status took 3 milliseconds May 19 09:33:25 volumio volumio[926]: info: ------------------------------ 3ms May 19 09:33:25 volumio volumio[926]: info: sendMpdCommand status took 2 milliseconds May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::parseState May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::parseState May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::parseState May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 09:33:25 volumio volumio[926]: info: sendMpdCommand playlistinfo took 1 milliseconds May 19 09:33:25 volumio volumio[926]: info: sendMpdCommand playlistinfo took 2 milliseconds May 19 09:33:25 volumio volumio[926]: info: sendMpdCommand playlistinfo took 2 milliseconds May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo May 19 09:33:25 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo May 19 09:33:25 volumio volumio[926]: info: ControllerMpd::pushState May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::servicePushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1147 Kbps","isStreaming":false,"title":"世界赠与我的","artist":"王菲","album":"世界赠与我的","uri":"USB/Ventoy/世界赠予我的-王菲.flac","trackType":"flac"} May 19 09:33:25 volumio volumio[926]: verbose: CURRENT POSITION 4 May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::syncState stateService play May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play May 19 09:33:25 volumio volumio[926]: info: Received an update from plugin. extracting info from payload May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:25 volumio volumio[926]: info: ControllerMpd::pushState May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::servicePushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1147 Kbps","isStreaming":false,"title":"世界赠与我的","artist":"王菲","album":"世界赠与我的","uri":"USB/Ventoy/世界赠予我的-王菲.flac","trackType":"flac"} May 19 09:33:25 volumio volumio[926]: verbose: CURRENT POSITION 4 May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::syncState stateService play May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play May 19 09:33:25 volumio volumio[926]: info: Received an update from plugin. extracting info from payload May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:25 volumio volumio[926]: info: ControllerMpd::pushState May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::servicePushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1147 Kbps","isStreaming":false,"title":"世界赠与我的","artist":"王菲","album":"世界赠与我的","uri":"USB/Ventoy/世界赠予我的-王菲.flac","trackType":"flac"} May 19 09:33:25 volumio volumio[926]: verbose: CURRENT POSITION 4 May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::syncState stateService play May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play May 19 09:33:25 volumio volumio[926]: info: Received an update from plugin. extracting info from payload May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:25 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:25 volumio volumio[926]: info: CorePlayQueue::getTrack 4 May 19 09:33:25 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:25 volumio volumio[926]: info: ------------------------------ 50ms May 19 09:33:25 volumio volumio[926]: info: ------------------------------ 48ms May 19 09:33:25 volumio volumio[926]: info: ------------------------------ 48ms May 19 09:33:26 volumio volumio[926]: info: CoreStateMachine::startPlaybackTimer May 19 09:33:26 volumio volumio[926]: info: CorePlayQueue::getTrack 5 May 19 09:33:26 volumio volumio[926]: info: CoreStateMachine::pushState May 19 09:33:26 volumio volumio[926]: info: CorePlayQueue::getTrack 5 May 19 09:33:26 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 09:33:26 volumio volumio[926]: info: CoreCommandRouter::volumioPushState May 19 09:33:38 volumio ntpd[1796]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 19 09:34:15 volumio volumio[926]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 09:34:15 volumio volumio[926]: Error: connect ETIMEDOUT 199.16.158.9:443 May 19 09:34:15 volumio volumio[926]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 19 09:34:15 volumio volumio[926]: errno: -110, May 19 09:34:15 volumio volumio[926]: code: 'ETIMEDOUT', May 19 09:34:15 volumio volumio[926]: syscall: 'connect', May 19 09:34:15 volumio volumio[926]: address: '199.16.158.9', May 19 09:34:15 volumio volumio[926]: port: 443 May 19 09:34:15 volumio volumio[926]: } May 19 09:34:15 volumio volumio[926]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 09:34:15 volumio sudo[3576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-19 09:33 May 19 09:34:15 volumio sudo[3576]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"