Feb 11 11:28:03 volumio4white volumio[1592]: info: CoreCommandRouter::volumioGetState Feb 11 11:28:03 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:28:18 volumio4white volumio[1592]: info: CoreCommandRouter::volumioGetState Feb 11 11:28:18 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:28:33 volumio4white volumio[1592]: info: CoreCommandRouter::volumioGetState Feb 11 11:28:33 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:28:48 volumio4white volumio[1592]: info: CoreCommandRouter::volumioGetState Feb 11 11:28:48 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:29:03 volumio4white volumio[1592]: info: CoreCommandRouter::volumioGetState Feb 11 11:29:03 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:29:18 volumio4white volumio[1592]: info: CoreCommandRouter::volumioGetState Feb 11 11:29:18 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:29:33 volumio4white volumio[1592]: info: CoreCommandRouter::volumioGetState Feb 11 11:29:33 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:29:35 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 1 Feb 11 11:29:35 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:35 volumio4white volumio[1592]: info: Prefetching next song Feb 11 11:29:35 volumio4white volumio[1592]: info: DOING PREFETCH IN MPD Feb 11 11:29:35 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand add "NAS/RAS/我的CD/[01]双声道单轨音频/[50]影视音乐/Chi Mai_Ennio Morricone.wav" Feb 11 11:29:35 volumio4white volumio[1592]: info: Feb 11 11:29:35 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:35 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:35 volumio4white volumio[1592]: info: sendMpdCommand add "NAS/RAS/我的CD/[01]双声道单轨音频/[50]影视音乐/Chi Mai_Ennio Morricone.wav" took 1 milliseconds Feb 11 11:29:35 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 11 11:29:35 volumio4white volumio[1592]: info: Feb 11 11:29:35 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:35 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:35 volumio4white volumio[1592]: info: Feb 11 11:29:35 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:35 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:35 volumio4white volumio[1592]: info: Feb 11 11:29:35 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:35 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:35 volumio4white volumio[1592]: info: ------------------------------ 1ms Feb 11 11:29:35 volumio4white volumio[1592]: info: sendMpdCommand consume 1 took 1 milliseconds Feb 11 11:29:35 volumio4white volumio[1592]: info: ------------------------------ 1ms Feb 11 11:29:35 volumio4white volumio[1592]: info: ------------------------------ 0ms Feb 11 11:29:35 volumio4white volumio[1592]: info: ------------------------------ 0ms Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::startPlaybackTimer Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:40 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces state update: player Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::getState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand status Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:40 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces state update: player Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::getState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand status Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:40 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces state update: player Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::getState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand status Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces system playlist update Feb 11 11:29:40 volumio4white volumio[1592]: info: Ignoring MPD Status Update Feb 11 11:29:40 volumio4white volumio[1592]: info: Feb 11 11:29:40 volumio4white volumio[1592]: ---------------------------- MPD announces state update: player Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::getState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand status Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 2ms Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand status took 2 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 2ms Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand status took 1 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 1ms Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand status took 2 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 2ms Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand status took 1 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseState Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseTrackInfo Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseTrackInfo Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::servicePushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Chi Mai","artist":"Ennio Morricone","album":"Very Best of Ennio Morricone","uri":"NAS/RAS/我的CD/[01]双声道单轨音频/[50]影视音乐/Chi Mai_Ennio Morricone.wav","trackType":"wav"} Feb 11 11:29:40 volumio4white volumio[1592]: verbose: CURRENT POSITION 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState stateService play Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState currentStatus play Feb 11 11:29:40 volumio4white volumio[1592]: info: Received an update from plugin. extracting info from payload Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::servicePushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Chi Mai","artist":"Ennio Morricone","album":"Very Best of Ennio Morricone","uri":"NAS/RAS/我的CD/[01]双声道单轨音频/[50]影视音乐/Chi Mai_Ennio Morricone.wav","trackType":"wav"} Feb 11 11:29:40 volumio4white volumio[1592]: verbose: CURRENT POSITION 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState stateService play Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState currentStatus play Feb 11 11:29:40 volumio4white volumio[1592]: info: Received an update from plugin. extracting info from payload Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 9ms Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 9ms Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseTrackInfo Feb 11 11:29:40 volumio4white volumio[1592]: verbose: ControllerMpd::parseTrackInfo Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::servicePushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Chi Mai","artist":"Ennio Morricone","album":"Very Best of Ennio Morricone","uri":"NAS/RAS/我的CD/[01]双声道单轨音频/[50]影视音乐/Chi Mai_Ennio Morricone.wav","trackType":"wav"} Feb 11 11:29:40 volumio4white volumio[1592]: verbose: CURRENT POSITION 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState stateService play Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState currentStatus play Feb 11 11:29:40 volumio4white volumio[1592]: info: Received an update from plugin. extracting info from payload Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: ControllerMpd::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::servicePushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Chi Mai","artist":"Ennio Morricone","album":"Very Best of Ennio Morricone","uri":"NAS/RAS/我的CD/[01]双声道单轨音频/[50]影视音乐/Chi Mai_Ennio Morricone.wav","trackType":"wav"} Feb 11 11:29:40 volumio4white volumio[1592]: verbose: CURRENT POSITION 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState stateService play Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::syncState currentStatus play Feb 11 11:29:40 volumio4white volumio[1592]: info: Received an update from plugin. extracting info from payload Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreStateMachine::pushState Feb 11 11:29:40 volumio4white volumio[1592]: info: CorePlayQueue::getTrack 2 Feb 11 11:29:40 volumio4white volumio[1592]: info: CoreCommandRouter::volumioPushState Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 17ms Feb 11 11:29:40 volumio4white volumio[1592]: info: ------------------------------ 18ms Feb 11 11:29:41 volumio4white volumio[1592]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 11:29:41 volumio4white volumio[1592]: AggregateError Feb 11 11:29:41 volumio4white volumio[1592]: at internalConnectMultiple (node:net:1114:18) Feb 11 11:29:41 volumio4white volumio[1592]: at internalConnectMultiple (node:net:1177:5) Feb 11 11:29:41 volumio4white volumio[1592]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Feb 11 11:29:41 volumio4white volumio[1592]: at listOnTimeout (node:internal/timers:575:11) Feb 11 11:29:41 volumio4white volumio[1592]: at process.processTimers (node:internal/timers:514:7) { Feb 11 11:29:41 volumio4white volumio[1592]: code: 'ETIMEDOUT', Feb 11 11:29:41 volumio4white volumio[1592]: [errors]: [ Feb 11 11:29:41 volumio4white volumio[1592]: Error: connect ETIMEDOUT 103.97.3.19:443 Feb 11 11:29:41 volumio4white volumio[1592]: at createConnectionError (node:net:1634:14) Feb 11 11:29:41 volumio4white volumio[1592]: at Timeout.internalConnectMultipleTimeout (node:net:1685:38) Feb 11 11:29:41 volumio4white volumio[1592]: at listOnTimeout (node:internal/timers:575:11) Feb 11 11:29:41 volumio4white volumio[1592]: at process.processTimers (node:internal/timers:514:7) { Feb 11 11:29:41 volumio4white volumio[1592]: errno: -110, Feb 11 11:29:41 volumio4white volumio[1592]: code: 'ETIMEDOUT', Feb 11 11:29:41 volumio4white volumio[1592]: syscall: 'connect', Feb 11 11:29:41 volumio4white volumio[1592]: address: '103.97.3.19', Feb 11 11:29:41 volumio4white volumio[1592]: port: 443 Feb 11 11:29:41 volumio4white volumio[1592]: }, Feb 11 11:29:41 volumio4white volumio[1592]: Error: connect ENETUNREACH 2a03:2880:f130:83:face:b00c:0:25de:443 - Local (:::0) Feb 11 11:29:41 volumio4white volumio[1592]: at internalConnectMultiple (node:net:1176:40) Feb 11 11:29:41 volumio4white volumio[1592]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Feb 11 11:29:41 volumio4white volumio[1592]: at listOnTimeout (node:internal/timers:575:11) Feb 11 11:29:41 volumio4white volumio[1592]: at process.processTimers (node:internal/timers:514:7) { Feb 11 11:29:41 volumio4white volumio[1592]: errno: -101, Feb 11 11:29:41 volumio4white volumio[1592]: code: 'ENETUNREACH', Feb 11 11:29:41 volumio4white volumio[1592]: syscall: 'connect', Feb 11 11:29:41 volumio4white volumio[1592]: address: '2a03:2880:f130:83:face:b00c:0:25de', Feb 11 11:29:41 volumio4white volumio[1592]: port: 443 Feb 11 11:29:41 volumio4white volumio[1592]: } Feb 11 11:29:41 volumio4white volumio[1592]: ] Feb 11 11:29:41 volumio4white volumio[1592]: } Feb 11 11:29:41 volumio4white volumio[1592]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 11:29:41 volumio4white sudo[25296]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 11:28' Feb 11 11:29:41 volumio4white sudo[25296]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"