Aug 25 19:54:41 volumio volumio[1370]: info: CoreCommandRouter::volumioPlay Aug 25 19:54:41 volumio volumio[1370]: info: CoreStateMachine::play index undefined Aug 25 19:54:41 volumio volumio[1370]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 25 19:54:41 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:54:41 volumio volumio[1370]: info: CoreStateMachine::startPlaybackTimer Aug 25 19:54:41 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:54:41 volumio volumio[1370]: info: ControllerMpd::resume Aug 25 19:54:41 volumio volumio[1370]: verbose: ControllerMpd::sendMpdCommand play Aug 25 19:54:41 volumio volumio[1370]: info: Aug 25 19:54:41 volumio volumio[1370]: ---------------------------- MPD announces state update: player Aug 25 19:54:41 volumio volumio[1370]: info: sendMpdCommand play took 3 milliseconds Aug 25 19:54:41 volumio volumio[1370]: info: ControllerMpd::getState Aug 25 19:54:41 volumio volumio[1370]: verbose: ControllerMpd::sendMpdCommand status Aug 25 19:54:41 volumio volumio[1370]: info: sendMpdCommand status took 0 milliseconds Aug 25 19:54:41 volumio volumio[1370]: verbose: ControllerMpd::parseState Aug 25 19:54:41 volumio volumio[1370]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 19:54:41 volumio volumio[1370]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 25 19:54:41 volumio volumio[1370]: verbose: ControllerMpd::parseTrackInfo Aug 25 19:54:41 volumio volumio[1370]: info: ControllerMpd::pushState Aug 25 19:54:41 volumio volumio[1370]: info: CoreCommandRouter::servicePushState Aug 25 19:54:41 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:54:41 volumio volumio[1370]: verbose: STATE SERVICE {"status":"play","position":0,"seek":159180,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"937 Kbps","isStreaming":false,"title":"Just Got Back From Baby’s","artist":"ZZ Top","album":"ZZ Top’s First Album","uri":"NAS/Ugreen_1/Z/ZZ Top/Album de estudio/01 - 1970 - ZZ Top's First Album (1988 US 3268-2)/09 - Just Got Back From Baby’s.flac","trackType":"flac"} Aug 25 19:54:41 volumio volumio[1370]: verbose: CURRENT POSITION 1 Aug 25 19:54:41 volumio volumio[1370]: info: CoreStateMachine::syncState stateService play Aug 25 19:54:41 volumio volumio[1370]: info: CoreStateMachine::syncState currentStatus pause Aug 25 19:54:41 volumio volumio[1370]: info: CoreStateMachine::pushState Aug 25 19:54:41 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:54:41 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 19:54:41 volumio volumio[1370]: info: CoreCommandRouter::volumioPushState Aug 25 19:54:41 volumio volumio[1370]: info: ------------------------------ 7ms Aug 25 19:54:43 volumio volumio[1370]: info: CoreCommandRouter::volumioPause Aug 25 19:54:43 volumio volumio[1370]: info: CoreStateMachine::pause Aug 25 19:54:43 volumio volumio[1370]: info: CoreStateMachine::stPlaybackTimer Aug 25 19:54:43 volumio volumio[1370]: info: CoreStateMachine::servicePause Aug 25 19:54:43 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:54:43 volumio volumio[1370]: info: CoreCommandRouter::servicePause Aug 25 19:54:43 volumio volumio[1370]: info: ControllerMpd::pause Aug 25 19:54:43 volumio volumio[1370]: verbose: ControllerMpd::sendMpdCommand pause Aug 25 19:54:43 volumio volumio[1370]: info: Aug 25 19:54:43 volumio volumio[1370]: ---------------------------- MPD announces state update: player Aug 25 19:54:43 volumio volumio[1370]: info: sendMpdCommand pause took 1 milliseconds Aug 25 19:54:43 volumio volumio[1370]: info: ControllerMpd::getState Aug 25 19:54:43 volumio volumio[1370]: verbose: ControllerMpd::sendMpdCommand status Aug 25 19:54:43 volumio volumio[1370]: info: sendMpdCommand status took 0 milliseconds Aug 25 19:54:43 volumio volumio[1370]: verbose: ControllerMpd::parseState Aug 25 19:54:43 volumio volumio[1370]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 19:54:43 volumio volumio[1370]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 25 19:54:43 volumio volumio[1370]: verbose: ControllerMpd::parseTrackInfo Aug 25 19:54:43 volumio volumio[1370]: info: ControllerMpd::pushState Aug 25 19:54:43 volumio volumio[1370]: info: CoreCommandRouter::servicePushState Aug 25 19:54:43 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:54:43 volumio volumio[1370]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":161553,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"974 Kbps","isStreaming":false,"title":"Just Got Back From Baby’s","artist":"ZZ Top","album":"ZZ Top’s First Album","uri":"NAS/Ugreen_1/Z/ZZ Top/Album de estudio/01 - 1970 - ZZ Top's First Album (1988 US 3268-2)/09 - Just Got Back From Baby’s.flac","trackType":"flac"} Aug 25 19:54:43 volumio volumio[1370]: verbose: CURRENT POSITION 1 Aug 25 19:54:43 volumio volumio[1370]: info: CoreStateMachine::syncState stateService pause Aug 25 19:54:43 volumio volumio[1370]: info: CoreStateMachine::syncState currentStatus pause Aug 25 19:54:43 volumio volumio[1370]: info: CoreStateMachine::pushState Aug 25 19:54:43 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:54:43 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 19:54:43 volumio volumio[1370]: info: CoreCommandRouter::volumioPushState Aug 25 19:54:43 volumio volumio[1370]: info: CoreStateMachine::stPlaybackTimer Aug 25 19:54:43 volumio volumio[1370]: info: ------------------------------ 5ms Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 19:54:48 volumio volumio[1370]: info: Retrieving Cloud Streaming UI Aug 25 19:54:48 volumio volumio[1370]: info: Getting Tidal Cloud Configuration Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 19:54:48 volumio volumio[1370]: info: Getting Qobuz Cloud Configuration Aug 25 19:54:48 volumio volumio[1370]: info: Asking plugin for UI Config Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 19:54:48 volumio volumio[1370]: info: Getting Spotify Cloud Configuration Aug 25 19:54:48 volumio volumio[1370]: info: Asking plugin for UI Config Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 19:54:48 volumio volumio[1370]: info: Saving Spotify Acccount Aug 25 19:54:48 volumio volumio[1370]: info: Got Tidal Cloud Configuration Aug 25 19:54:48 volumio volumio[1370]: info: Got it Aug 25 19:54:48 volumio volumio[1370]: info: Got it Aug 25 19:54:48 volumio volumio[1370]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 19:54:48 volumio volumio[1370]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 19:54:48 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 25 19:54:53 volumio volumio[1370]: info: CoreCommandRouter::volumioGetState Aug 25 19:54:53 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:55:00 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 25 19:55:00 volumio volumio[1370]: info: CURURI: music-library/NAS/Ugreen_1 Aug 25 19:55:00 volumio volumio[1370]: info: Preload queue cleared Aug 25 19:55:04 volumio volumio[1370]: info: Preload queue cleared Aug 25 19:55:04 volumio volumio[1370]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::ClearQueue Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::stop Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::updateTrackBlock Aug 25 19:55:04 volumio volumio[1370]: info: CorePlayQueue::getTrackBlock Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::stPlaybackTimer Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::pushState Aug 25 19:55:04 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:55:04 volumio volumio[1370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 19:55:04 volumio volumio[1370]: info: CoreCommandRouter::volumioPushState Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::serviceStop Aug 25 19:55:04 volumio volumio[1370]: info: CorePlayQueue::getTrack 1 Aug 25 19:55:04 volumio volumio[1370]: info: CoreCommandRouter::serviceStop Aug 25 19:55:04 volumio volumio[1370]: info: ControllerMpd::stop Aug 25 19:55:04 volumio volumio[1370]: verbose: ControllerMpd::sendMpdCommand stop Aug 25 19:55:04 volumio volumio[1370]: info: CorePlayQueue::clearPlayQueue Aug 25 19:55:04 volumio volumio[1370]: info: CorePlayQueue::saveQueue Aug 25 19:55:04 volumio volumio[1370]: info: CoreCommandRouter::volumioPushQueue Aug 25 19:55:04 volumio volumio[1370]: info: CoreStateMachine::addQueueItems Aug 25 19:55:04 volumio volumio[1370]: info: CorePlayQueue::addQueueItems Aug 25 19:55:04 volumio volumio[1370]: info: Preload queue cleared Aug 25 19:55:04 volumio volumio[1370]: info: Adding Item to queue: music-library/NAS/Ugreen_1/Z Aug 25 19:55:04 volumio volumio[1370]: info: Exploding uri music-library/NAS/Ugreen_1/Z in service mpd Aug 25 19:55:04 volumio volumio[1370]: info: Aug 25 19:55:04 volumio volumio[1370]: ---------------------------- MPD announces state update: player Aug 25 19:55:04 volumio volumio[1370]: info: ALBUMART /albumart?cacheid=198&web=ZZ%20Top/ZZ%20Top%3Fs%20First%20Album/extralarge&path=%2Fmnt%2FNAS%2FUgreen_1%2FZ%2FZZ%20Top%2FAlbum%20de%20estudio%2F01%20-%201970%20-%20ZZ%20Top's%20First%20Album%20(1988%20US%203268-2)%2F00.%20ZZ%20Top%20-%20ZZ%20Top's%20First%20Album.cue&metadata=false Aug 25 19:55:04 volumio volumio[1370]: info: URI /mnt/NAS/Ugreen_1/Z/ZZ Top/Album de estudio/01 - 1970 - ZZ Top's First Album (1988 US 3268-2)/00. ZZ Top - ZZ Top's First Album.cue Aug 25 19:55:04 volumio volumio[1370]: info: ALBUMART /albumart?cacheid=198&web=ZZ%20Top/ZZ%20Top%3Fs%20First%20Album/extralarge&path=%2Fmnt%2FNAS%2FUgreen_1%2FZ%2FZZ%20Top%2FAlbum%20de%20estudio%2F01%20-%201970%20-%20ZZ%20Top's%20First%20Album%20(1988%20US%203268-2)%2F00.%20ZZ%20Top%20-%20ZZ%20Top's%20First%20Album.cue&metadata=false Aug 25 19:55:04 volumio volumio[1370]: info: URI /mnt/NAS/Ugreen_1/Z/ZZ Top/Album de estudio/01 - 1970 - ZZ Top's First Album (1988 US 3268-2)/00. ZZ Top - ZZ Top's First Album.cue Aug 25 19:55:04 volumio volumio[1370]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 19:55:04 volumio volumio[1370]: Error: Unable to resolve or reject the same promise twice Aug 25 19:55:04 volumio volumio[1370]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Aug 25 19:55:04 volumio volumio[1370]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Aug 25 19:55:04 volumio volumio[1370]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Aug 25 19:55:04 volumio volumio[1370]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Aug 25 19:55:04 volumio volumio[1370]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Aug 25 19:55:04 volumio volumio[1370]: at Socket.emit (node:events:514:28) Aug 25 19:55:04 volumio volumio[1370]: at addChunk (node:internal/streams/readable:343:12) Aug 25 19:55:04 volumio volumio[1370]: at readableAddChunk (node:internal/streams/readable:312:11) Aug 25 19:55:04 volumio volumio[1370]: at Readable.push (node:internal/streams/readable:253:10) Aug 25 19:55:04 volumio volumio[1370]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Aug 25 19:55:04 volumio volumio[1370]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 19:55:04 volumio sudo[10036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 19:54' Aug 25 19:55:04 volumio sudo[10036]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"