Jan 09 12:24:04 volumio go-librespot[1644]: time="2026-01-09T12:24:04+02:00" level=trace msg="sent dealer ping" Jan 09 12:24:04 volumio go-librespot[1644]: time="2026-01-09T12:24:04+02:00" level=trace msg="received dealer pong" Jan 09 12:24:34 volumio go-librespot[1644]: time="2026-01-09T12:24:34+02:00" level=trace msg="received accesspoint ping" Jan 09 12:24:34 volumio go-librespot[1644]: time="2026-01-09T12:24:34+02:00" level=trace msg="received accesspoint pong ack" Jan 09 12:24:34 volumio go-librespot[1644]: time="2026-01-09T12:24:34+02:00" level=trace msg="sent dealer ping" Jan 09 12:24:34 volumio go-librespot[1644]: time="2026-01-09T12:24:34+02:00" level=trace msg="received dealer pong" Jan 09 12:25:04 volumio go-librespot[1644]: time="2026-01-09T12:25:04+02:00" level=trace msg="sent dealer ping" Jan 09 12:25:04 volumio go-librespot[1644]: time="2026-01-09T12:25:04+02:00" level=trace msg="received dealer pong" Jan 09 12:25:32 volumio volumio[1217]: verbose: New Socket.io Connection to 192.168.8.108:3000 from 192.168.8.147 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jan 09 12:25:32 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 12:25:32 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 12:25:32 volumio volumio[1217]: info: Discovery: Getting this device information Jan 09 12:25:32 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState Jan 09 12:25:32 volumio volumio[1217]: info: CorePlayQueue::getTrack 0 Jan 09 12:25:32 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 12:25:34 volumio go-librespot[1644]: time="2026-01-09T12:25:34+02:00" level=trace msg="sent dealer ping" Jan 09 12:25:34 volumio go-librespot[1644]: time="2026-01-09T12:25:34+02:00" level=trace msg="received dealer pong" Jan 09 12:25:36 volumio volumio[1217]: verbose: New Socket.io Connection to 192.168.8.108 from 192.168.8.147 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState Jan 09 12:25:36 volumio volumio[1217]: info: CorePlayQueue::getTrack 0 Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 09 12:25:36 volumio volumio[1217]: info: Received Get System Info Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 12:25:36 volumio volumio[1217]: info: Discovery: Getting this device information Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState Jan 09 12:25:36 volumio volumio[1217]: info: CorePlayQueue::getTrack 0 Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState Jan 09 12:25:36 volumio volumio[1217]: info: CorePlayQueue::getTrack 0 Jan 09 12:25:36 volumio volumio[1217]: info: Listing playlists Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::volumioGetQueue Jan 09 12:25:36 volumio volumio[1217]: info: CoreStateMachine::getQueue Jan 09 12:25:36 volumio volumio[1217]: info: CorePlayQueue::getQueue Jan 09 12:25:36 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 09 12:25:59 volumio volumio[1217]: info: Preload queue cleared Jan 09 12:25:59 volumio volumio[1217]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::ClearQueue Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::stop Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::stPlaybackTimer Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::updateTrackBlock Jan 09 12:25:59 volumio volumio[1217]: info: CorePlayQueue::getTrackBlock Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::pushState Jan 09 12:25:59 volumio volumio[1217]: info: CorePlayQueue::getTrack 0 Jan 09 12:25:59 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 12:25:59 volumio volumio[1217]: info: CoreCommandRouter::volumioPushState Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::serviceStop Jan 09 12:25:59 volumio volumio[1217]: info: CorePlayQueue::getTrack 0 Jan 09 12:25:59 volumio volumio[1217]: info: CoreCommandRouter::serviceStop Jan 09 12:25:59 volumio volumio[1217]: info: ControllerMpd::stop Jan 09 12:25:59 volumio volumio[1217]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 12:25:59 volumio volumio[1217]: info: CorePlayQueue::clearPlayQueue Jan 09 12:25:59 volumio volumio[1217]: info: CorePlayQueue::saveQueue Jan 09 12:25:59 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Jan 09 12:25:59 volumio volumio[1217]: info: CoreStateMachine::addQueueItems Jan 09 12:25:59 volumio volumio[1217]: info: CorePlayQueue::addQueueItems Jan 09 12:25:59 volumio volumio[1217]: info: Preload queue cleared Jan 09 12:25:59 volumio volumio[1217]: info: Adding Item to queue: music-library/USB/Cdrive/Burmester - DEMO CD3 Jan 09 12:25:59 volumio volumio[1217]: info: Exploding uri music-library/USB/Cdrive/Burmester - DEMO CD3 in service mpd Jan 09 12:25:59 volumio volumio[1217]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Jan 09 12:25:59 volumio volumio[1217]: SPOTIFY: SPOTIFY VOLUME 39 Jan 09 12:25:59 volumio volumio[1217]: SPOTIFY: VOLUMIO VOLUME 40 Jan 09 12:25:59 volumio volumio[1217]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 09 12:25:59 volumio volumio[1217]: info: Jan 09 12:25:59 volumio volumio[1217]: ---------------------------- MPD announces state update: player Jan 09 12:25:59 volumio volumio[1217]: info: ALBUMART /albumart?cacheid=139&web=//extralarge&path=%2Fmnt%2FUSB%2FCdrive%2FBurmester%20-%20DEMO%20CD3%2FCDImage.ape&metadata=false Jan 09 12:25:59 volumio volumio[1217]: info: URI /mnt/USB/Cdrive/Burmester - DEMO CD3/CDImage.ape Jan 09 12:25:59 volumio volumio[1217]: info: ALBUMART /albumart?cacheid=139&web=Melissa%20Walker/Burmester%20Reference%20CD%20III/extralarge&path=%2Fmnt%2FUSB%2FCdrive%2FBurmester%20-%20DEMO%20CD3%2FCDImage.ape.cue&metadata=false Jan 09 12:25:59 volumio volumio[1217]: info: URI /mnt/USB/Cdrive/Burmester - DEMO CD3/CDImage.ape.cue Jan 09 12:25:59 volumio volumio[1217]: info: ALBUMART /albumart?cacheid=139&web=Nicolo%20Paganini%20by%20Gil%20Shaham%20und%20Goran%20Sollscher/Burmester%20Reference%20CD%20III/extralarge&path=%2Fmnt%2FUSB%2FCdrive%2FBurmester%20-%20DEMO%20CD3%2FCDImage.ape.cue&metadata=false Jan 09 12:25:59 volumio volumio[1217]: info: URI /mnt/USB/Cdrive/Burmester - DEMO CD3/CDImage.ape.cue Jan 09 12:25:59 volumio volumio[1217]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 12:25:59 volumio volumio[1217]: Error: Unable to resolve or reject the same promise twice Jan 09 12:25:59 volumio volumio[1217]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 09 12:25:59 volumio volumio[1217]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Jan 09 12:25:59 volumio volumio[1217]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jan 09 12:25:59 volumio volumio[1217]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jan 09 12:25:59 volumio volumio[1217]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jan 09 12:25:59 volumio volumio[1217]: at Socket.emit (node:events:514:28) Jan 09 12:25:59 volumio volumio[1217]: at addChunk (node:internal/streams/readable:343:12) Jan 09 12:25:59 volumio volumio[1217]: at readableAddChunk (node:internal/streams/readable:312:11) Jan 09 12:25:59 volumio volumio[1217]: at Readable.push (node:internal/streams/readable:253:10) Jan 09 12:25:59 volumio volumio[1217]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jan 09 12:25:59 volumio volumio[1217]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 12:25:59 volumio sudo[6809]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 12:24' Jan 09 12:25:59 volumio sudo[6809]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"