Oct 13 01:12:00 volumio volumio5-onboarding[2758]: time=2026-10-13T01:12:00.738+03:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.0.207:53506 error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 13 01:12:00 volumio volumio5-onboarding[2758]: time=2026-10-13T01:12:00.738+03:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.207:53506 Oct 13 01:12:00 volumio volumio5-onboarding[2758]: time=2026-10-13T01:12:00.739+03:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.207:53506 Oct 13 01:12:04 volumio volumio[1175]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Oct 13 01:12:05 volumio volumio5-onboarding[2758]: time=2026-10-13T01:12:05.020+03:00 level=ERROR msg="failed to notify all device data" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.207:53506 @ 0xc000475110" latency=1.896454736s timeout=20s error="failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded" Oct 13 01:12:05 volumio volumio5-onboarding[2758]: time=2026-10-13T01:12:05.021+03:00 level=ERROR msg="failed to send response" component=server dst=" @ 0xc000475110" id=236279108 status=STATUS_UNKNOWN error="no addresses to write to" Oct 13 01:12:05 volumio volumio5-onboarding[2758]: time=2026-10-13T01:12:05.020+03:00 level=ERROR msg="failed to notify all device data" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.207:53506 @ 0xc000475110" latency=1.915263457s timeout=20s error="failed to get music providers: could not get available plugins: could not get available plugins: could not check MyVolumio login status: context deadline exceeded" Oct 13 01:12:05 volumio volumio5-onboarding[2758]: time=2026-10-13T01:12:05.021+03:00 level=ERROR msg="failed to send response" component=server dst=" @ 0xc000475110" id=1736310964 status=STATUS_UNKNOWN error="no addresses to write to" Oct 13 01:12:12 volumio sudo[3770]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 01:12:12 volumio sudo[3770]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 01:12:12 volumio sudo[3770]: pam_unix(sudo:session): session closed for user root Oct 13 01:12:12 volumio sudo[3772]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 01:12:12 volumio sudo[3772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 01:12:12 volumio sudo[3772]: pam_unix(sudo:session): session closed for user root Oct 13 01:12:12 volumio volumio[1175]: verbose: New Socket.io Connection to 192.168.0.215 from 192.168.0.207 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 13 01:12:13 volumio sudo[3780]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 01:12:13 volumio sudo[3780]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 01:12:13 volumio sudo[3782]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 01:12:13 volumio sudo[3782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 01:12:13 volumio sudo[3780]: pam_unix(sudo:session): session closed for user root Oct 13 01:12:13 volumio sudo[3782]: pam_unix(sudo:session): session closed for user root Oct 13 01:12:14 volumio volumio[1175]: verbose: New Socket.io Connection to 192.168.0.215 from 192.168.0.207 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::volumioGetVisibleSources Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 13 01:12:15 volumio volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 13 01:12:15 volumio volumio[1175]: info: Received Get System Info Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 01:12:15 volumio volumio[1175]: info: Discovery: Getting this device information Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 13 01:12:15 volumio volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 13 01:12:15 volumio volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 13 01:12:15 volumio volumio[1175]: info: Listing playlists Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 13 01:12:15 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 13 01:12:16 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 01:12:16 volumio volumio[1175]: info: Received Get System Info Oct 13 01:12:16 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 01:12:16 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 01:12:16 volumio volumio[1175]: info: Discovery: Getting this device information Oct 13 01:12:16 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 13 01:12:16 volumio volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 13 01:12:16 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 01:12:18 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 13 01:12:18 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 01:12:18 volumio volumio[1175]: info: Received Get System Info Oct 13 01:12:18 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 01:12:18 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 01:12:18 volumio volumio[1175]: info: Discovery: Getting this device information Oct 13 01:12:18 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 13 01:12:18 volumio volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 13 01:12:18 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 01:12:23 volumio volumio[1175]: info: CoreCommandRouter::volumioGetQueue Oct 13 01:12:23 volumio volumio[1175]: info: CoreStateMachine::getQueue Oct 13 01:12:23 volumio volumio[1175]: info: CorePlayQueue::getQueue Oct 13 01:12:24 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 13 01:12:32 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 13 01:12:32 volumio volumio[1175]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 13 01:12:32 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 13 01:12:32 volumio volumio[1175]: info: Received Get System Version Oct 13 01:12:32 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 01:12:32 volumio volumio[1175]: info: Received Get System Info Oct 13 01:12:32 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 01:12:32 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 01:12:32 volumio volumio[1175]: info: Discovery: Getting this device information Oct 13 01:12:32 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 13 01:12:32 volumio volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 13 01:12:32 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 01:12:38 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 01:12:38 volumio volumio[1175]: info: CURURI: albums:// Oct 13 01:12:38 volumio volumio[1175]: info: listAlbums - loading Albums from cache Oct 13 01:12:38 volumio volumio[1175]: info: Preload queue cleared Oct 13 01:12:43 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 01:12:43 volumio volumio[1175]: info: CURURI: music-library Oct 13 01:12:43 volumio volumio[1175]: info: Preload queue cleared Oct 13 01:12:44 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 01:12:44 volumio volumio[1175]: info: CURURI: music-library/USB Oct 13 01:12:44 volumio volumio[1175]: info: Preload queue cleared Oct 13 01:12:45 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 01:12:45 volumio volumio[1175]: info: CURURI: music-library/USB/MUSIC Oct 13 01:12:45 volumio volumio[1175]: info: Preload queue cleared Oct 13 01:13:02 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 01:13:02 volumio volumio[1175]: info: CURURI: music-library/USB/MUSIC/Camouflage Oct 13 01:13:02 volumio volumio[1175]: info: Preload queue cleared Oct 13 01:13:07 volumio volumio[1175]: info: Preload queue cleared Oct 13 01:13:07 volumio volumio[1175]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 13 01:13:07 volumio volumio[1175]: info: CoreStateMachine::ClearQueue Oct 13 01:13:07 volumio volumio[1175]: info: CoreStateMachine::stop Oct 13 01:13:07 volumio volumio[1175]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 01:13:07 volumio volumio[1175]: info: CorePlayQueue::clearPlayQueue Oct 13 01:13:07 volumio volumio[1175]: info: CorePlayQueue::saveQueue Oct 13 01:13:07 volumio volumio[1175]: info: CoreCommandRouter::volumioPushQueue Oct 13 01:13:07 volumio volumio[1175]: info: CoreStateMachine::addQueueItems Oct 13 01:13:07 volumio volumio[1175]: info: CorePlayQueue::addQueueItems Oct 13 01:13:07 volumio volumio[1175]: info: Preload queue cleared Oct 13 01:13:07 volumio volumio[1175]: info: Adding Item to queue: music-library/USB/MUSIC/Camouflage/Methods Of Silence (Remastered) Oct 13 01:13:07 volumio volumio[1175]: info: Exploding uri music-library/USB/MUSIC/Camouflage/Methods Of Silence (Remastered) in service mpd Oct 13 01:13:07 volumio volumio[1175]: info: ALBUMART /albumart?cacheid=715&web=Camouflage/Methods%20Of%20Silence%20(Remastered)/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FCamouflage%2FMethods%20Of%20Silence%20(Remastered)%2FCamouflage%20-%20Methods%20Of%20Silence%20(Remastered).cue&metadata=false Oct 13 01:13:07 volumio volumio[1175]: info: URI /mnt/USB/MUSIC/Camouflage/Methods Of Silence (Remastered)/Camouflage - Methods Of Silence (Remastered).cue Oct 13 01:13:07 volumio volumio[1175]: info: ALBUMART /albumart?cacheid=715&web=Camouflage/Methods%20Of%20Silence%20(Remastered)/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FCamouflage%2FMethods%20Of%20Silence%20(Remastered)%2FCamouflage%20-%20Methods%20Of%20Silence%20(Remastered).cue&metadata=false Oct 13 01:13:07 volumio volumio[1175]: info: URI /mnt/USB/MUSIC/Camouflage/Methods Of Silence (Remastered)/Camouflage - Methods Of Silence (Remastered).cue Oct 13 01:13:07 volumio volumio[1175]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 01:13:07 volumio volumio[1175]: Error: Unable to resolve or reject the same promise twice Oct 13 01:13:07 volumio volumio[1175]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 13 01:13:07 volumio volumio[1175]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 13 01:13:07 volumio volumio[1175]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 13 01:13:07 volumio volumio[1175]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 13 01:13:07 volumio volumio[1175]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 13 01:13:07 volumio volumio[1175]: at Socket.emit (node:events:514:28) Oct 13 01:13:07 volumio volumio[1175]: at addChunk (node:internal/streams/readable:343:12) Oct 13 01:13:07 volumio volumio[1175]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 13 01:13:07 volumio volumio[1175]: at Readable.push (node:internal/streams/readable:253:10) Oct 13 01:13:07 volumio volumio[1175]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 13 01:13:07 volumio volumio[1175]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 01:13:07 volumio sudo[3931]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 01:12' Oct 13 01:13:07 volumio sudo[3931]: 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"