May 30 13:02:07 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 30 13:02:07 volumio dbus-daemon[801]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.290' (uid=0 pid=20767 comm="timedatectl show --property=NTPSynchronized --valu") May 30 13:02:07 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 30 13:02:07 volumio dbus-daemon[801]: [system] Successfully activated service 'org.freedesktop.timedate1' May 30 13:02:07 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. May 30 13:02:07 volumio setdatetime-helper.sh[20759]: Time is already synchronized. May 30 13:02:07 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 30 13:02:07 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 30 13:02:37 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. May 30 13:02:42 volumio volumio[973]: info: Preload queue cleared May 30 13:02:42 volumio volumio[973]: info: CoreCommandRouter::volumioReplaceandPlayItems May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::ClearQueue May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::stop May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::updateTrackBlock May 30 13:02:42 volumio volumio[973]: info: CorePlayQueue::getTrackBlock May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::stPlaybackTimer May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::pushState May 30 13:02:42 volumio volumio[973]: info: CorePlayQueue::getTrack 0 May 30 13:02:42 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 13:02:42 volumio volumio[973]: info: CoreCommandRouter::volumioPushState May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::serviceStop May 30 13:02:42 volumio volumio[973]: info: CorePlayQueue::getTrack 0 May 30 13:02:42 volumio volumio[973]: info: CoreCommandRouter::serviceStop May 30 13:02:42 volumio volumio[973]: info: ControllerMpd::stop May 30 13:02:42 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand stop May 30 13:02:42 volumio volumio[973]: info: CorePlayQueue::clearPlayQueue May 30 13:02:42 volumio volumio[973]: info: CorePlayQueue::saveQueue May 30 13:02:42 volumio volumio[973]: info: CoreCommandRouter::volumioPushQueue May 30 13:02:42 volumio volumio[973]: info: CoreStateMachine::addQueueItems May 30 13:02:42 volumio volumio[973]: info: CorePlayQueue::addQueueItems May 30 13:02:42 volumio volumio[973]: info: Preload queue cleared May 30 13:02:42 volumio volumio[973]: info: Adding Item to queue: music-library/NAS/Music/DSD/Pink Floyd - Wish You Were Here (DSD 128) (2016) May 30 13:02:42 volumio volumio[973]: info: Exploding uri music-library/NAS/Music/DSD/Pink Floyd - Wish You Were Here (DSD 128) (2016) in service mpd May 30 13:02:42 volumio volumio[973]: info: May 30 13:02:42 volumio volumio[973]: ---------------------------- MPD announces state update: player May 30 13:02:42 volumio volumio[973]: info: ALBUMART /albumart?cacheid=502&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2FDSD%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here%20(DSD%20128)%20(2016)%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here%20side%2001.dsf&metadata=false May 30 13:02:42 volumio volumio[973]: info: URI /mnt/NAS/Music/DSD/Pink Floyd - Wish You Were Here (DSD 128) (2016)/Pink Floyd - Wish You Were Here side 01.dsf May 30 13:02:42 volumio volumio[973]: info: ALBUMART /albumart?cacheid=502&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2FDSD%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here%20(DSD%20128)%20(2016)%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here%20side%2002.dsf&metadata=false May 30 13:02:42 volumio volumio[973]: info: URI /mnt/NAS/Music/DSD/Pink Floyd - Wish You Were Here (DSD 128) (2016)/Pink Floyd - Wish You Were Here side 02.dsf May 30 13:02:42 volumio volumio[973]: info: ALBUMART /albumart?cacheid=502&web=/Wish%20You%20Were%20Here/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FDSD%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here%20(DSD%20128)%20(2016)%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here.cue&metadata=false May 30 13:02:42 volumio volumio[973]: info: URI /mnt/NAS/Music/DSD/Pink Floyd - Wish You Were Here (DSD 128) (2016)/Pink Floyd - Wish You Were Here.cue May 30 13:02:42 volumio volumio[973]: info: ALBUMART /albumart?cacheid=502&web=/Wish%20You%20Were%20Here/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FDSD%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here%20(DSD%20128)%20(2016)%2FPink%20Floyd%20-%20Wish%20You%20Were%20Here.cue&metadata=false May 30 13:02:42 volumio volumio[973]: info: URI /mnt/NAS/Music/DSD/Pink Floyd - Wish You Were Here (DSD 128) (2016)/Pink Floyd - Wish You Were Here.cue May 30 13:02:42 volumio volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 13:02:42 volumio volumio[973]: Error: Unable to resolve or reject the same promise twice May 30 13:02:42 volumio volumio[973]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 30 13:02:42 volumio volumio[973]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 May 30 13:02:42 volumio volumio[973]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) May 30 13:02:42 volumio volumio[973]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) May 30 13:02:42 volumio volumio[973]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) May 30 13:02:42 volumio volumio[973]: at Socket.emit (node:events:514:28) May 30 13:02:42 volumio volumio[973]: at addChunk (node:internal/streams/readable:343:12) May 30 13:02:42 volumio volumio[973]: at readableAddChunk (node:internal/streams/readable:312:11) May 30 13:02:42 volumio volumio[973]: at Readable.push (node:internal/streams/readable:253:10) May 30 13:02:42 volumio volumio[973]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) May 30 13:02:42 volumio volumio[973]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 13:02:42 volumio sudo[20830]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-30 13:01' May 30 13:02:42 volumio sudo[20830]: 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="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 07:33:33 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="d67a2da4ffe3f001e986b1f31eaa3a76"