Dec 05 20:44:04 volumio volumio[1043]: verbose: New Socket.io Connection to 192.168.1.216 from 192.168.1.200 UA: Mozilla/5.0 (Linux; Android 16; SM-S938B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.102 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:05 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 05 20:44:05 volumio volumio[1043]: info: Received Get System Info
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 05 20:44:05 volumio volumio[1043]: info: Discovery: Getting this device information
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:05 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:05 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:05 volumio volumio[1043]: info: Listing playlists
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::volumioGetQueue
Dec 05 20:44:05 volumio volumio[1043]: info: CoreStateMachine::getQueue
Dec 05 20:44:05 volumio volumio[1043]: info: CorePlayQueue::getQueue
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:05 volumio volumio[1043]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 05 20:44:09 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:09 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:17 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:17 volumio volumio[1043]: info: Listing playlists
Dec 05 20:44:17 volumio volumio[1043]: info: Listing playlists
Dec 05 20:44:23 volumio go-librespot[1589]: time="2025-12-05T20:44:23+01:00" level=trace msg="sent dealer ping"
Dec 05 20:44:23 volumio go-librespot[1589]: time="2025-12-05T20:44:23+01:00" level=trace msg="received dealer pong"
Dec 05 20:44:27 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:27 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:37 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:37 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:37 volumio volumio[1043]: info: Listing playlists
Dec 05 20:44:37 volumio volumio[1043]: info: Listing playlists
Dec 05 20:44:45 volumio volumio[1043]: verbose: New Socket.io Connection to 192.168.1.216:3000 from 192.168.1.200 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Dec 05 20:44:45 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 05 20:44:45 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 05 20:44:45 volumio volumio[1043]: info: Discovery: Getting this device information
Dec 05 20:44:45 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:45 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:45 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 05 20:44:47 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:47 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:48 volumio go-librespot[1589]: time="2025-12-05T20:44:48+01:00" level=trace msg="received accesspoint ping"
Dec 05 20:44:48 volumio go-librespot[1589]: time="2025-12-05T20:44:48+01:00" level=trace msg="received accesspoint pong ack"
Dec 05 20:44:53 volumio go-librespot[1589]: time="2025-12-05T20:44:53+01:00" level=trace msg="sent dealer ping"
Dec 05 20:44:53 volumio go-librespot[1589]: time="2025-12-05T20:44:53+01:00" level=trace msg="received dealer pong"
Dec 05 20:44:57 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:44:57 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:44:57 volumio volumio[1043]: info: Listing playlists
Dec 05 20:44:57 volumio volumio[1043]: info: Listing playlists
Dec 05 20:45:07 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:45:07 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:45:11 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 05 20:45:11 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 05 20:45:11 volumio volumio[1043]: info: Discovery: Getting this device information
Dec 05 20:45:11 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:45:11 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:45:11 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 05 20:45:11 volumio volumio[1043]: verbose: New Socket.io Connection to 192.168.1.216:3000 from 192.168.1.200 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Dec 05 20:45:11 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 05 20:45:11 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 05 20:45:17 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:45:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:45:17 volumio volumio[1043]: info: Listing playlists
Dec 05 20:45:17 volumio volumio[1043]: info: Listing playlists
Dec 05 20:45:23 volumio go-librespot[1589]: time="2025-12-05T20:45:23+01:00" level=trace msg="sent dealer ping"
Dec 05 20:45:23 volumio go-librespot[1589]: time="2025-12-05T20:45:23+01:00" level=trace msg="received dealer pong"
Dec 05 20:45:27 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Dec 05 20:45:27 volumio volumio[1043]: info: CorePlayQueue::getTrack 4
Dec 05 20:45:28 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 05 20:45:28 volumio volumio[1043]: info: CURURI: music-library/NAS/music/Howells - Choral works (2010) [FLAC]
Dec 05 20:45:28 volumio volumio[1043]: info: Preload queue cleared
Dec 05 20:45:33 volumio volumio[1043]: info: Preload queue cleared
Dec 05 20:45:33 volumio volumio[1043]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 05 20:45:33 volumio volumio[1043]: info: CoreStateMachine::ClearQueue
Dec 05 20:45:33 volumio volumio[1043]: info: CoreStateMachine::stop
Dec 05 20:45:33 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 05 20:45:33 volumio volumio[1043]: info: CorePlayQueue::clearPlayQueue
Dec 05 20:45:33 volumio volumio[1043]: info: CorePlayQueue::saveQueue
Dec 05 20:45:33 volumio volumio[1043]: info: CoreCommandRouter::volumioPushQueue
Dec 05 20:45:33 volumio volumio[1043]: info: CoreStateMachine::addQueueItems
Dec 05 20:45:33 volumio volumio[1043]: info: CorePlayQueue::addQueueItems
Dec 05 20:45:33 volumio volumio[1043]: info: Preload queue cleared
Dec 05 20:45:33 volumio volumio[1043]: info: Adding Item to queue: music-library/NAS/music/Howells - Choral works (2010) [FLAC]
Dec 05 20:45:33 volumio volumio[1043]: info: Exploding uri music-library/NAS/music/Howells - Choral works (2010) [FLAC] in service mpd
Dec 05 20:45:33 volumio volumio[1043]: info: ALBUMART /albumart?cacheid=418&web=Choir%20of%20St.%20John's%20College%2C%20Cambridge%2C%20%20Andrew%20Nethsingha/Howells%20-%20Choral%20works/large&path=%2Fmnt%2FNAS%2Fmusic%2FHowells%20-%20Choral%20works%20(2010)%20%5BFLAC%5D%2FHowells%20-%20Choral%20works.cue&metadata=false
Dec 05 20:45:33 volumio volumio[1043]: info: URI /mnt/NAS/music/Howells - Choral works (2010) [FLAC]/Howells - Choral works.cue
Dec 05 20:45:33 volumio volumio[1043]: info: ALBUMART /albumart?cacheid=418&web=Choir%20of%20St.%20John's%20College%2C%20Cambridge%2C%20%20Andrew%20Nethsingha/Howells%20-%20Choral%20works/large&path=%2Fmnt%2FNAS%2Fmusic%2FHowells%20-%20Choral%20works%20(2010)%20%5BFLAC%5D%2FHowells%20-%20Choral%20works.cue&metadata=false
Dec 05 20:45:33 volumio volumio[1043]: info: URI /mnt/NAS/music/Howells - Choral works (2010) [FLAC]/Howells - Choral works.cue
Dec 05 20:45:33 volumio volumio[1043]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 20:45:33 volumio volumio[1043]: Error: Unable to resolve or reject the same promise twice
Dec 05 20:45:33 volumio volumio[1043]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Dec 05 20:45:33 volumio volumio[1043]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21
Dec 05 20:45:33 volumio volumio[1043]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Dec 05 20:45:33 volumio volumio[1043]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Dec 05 20:45:33 volumio volumio[1043]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Dec 05 20:45:33 volumio volumio[1043]: at Socket.emit (node:events:514:28)
Dec 05 20:45:33 volumio volumio[1043]: at addChunk (node:internal/streams/readable:343:12)
Dec 05 20:45:33 volumio volumio[1043]: at readableAddChunk (node:internal/streams/readable:312:11)
Dec 05 20:45:33 volumio volumio[1043]: at Readable.push (node:internal/streams/readable:253:10)
Dec 05 20:45:33 volumio volumio[1043]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Dec 05 20:45:33 volumio volumio[1043]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 20:45:34 volumio sudo[21203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-05 20:44'
Dec 05 20:45:34 volumio sudo[21203]: 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="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Dec 2 11:51:19 UTC 2025"
VOLUMIO_VERSION="4.072"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e5001581b220b096097cf8f46a54d4f1"