Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.699+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=10.254.110.125:63139 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.716+07:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="10.254.110.125:63139 @ 0x2d74090" latency=57.656679ms platform=PLATFORM_IOS version=5.260120.0 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.717+07:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="10.254.110.125:63139 @ 0x2d74090" latency=58.235569ms timeout=10s Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.717+07:00 level=INFO msg="emitting device capabilities changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" Mar 04 18:54:32 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:32 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:32 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.719+07:00 level=INFO msg="emitting device name changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" name=Volumio Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.720+07:00 level=INFO msg="emitting device language changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" language=en Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.720+07:00 level=INFO msg="emitting device timezone changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" timezone=Asia/Bangkok Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.721+07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" available=true connected=true macAddress=2c:cf:67:e6:b3:27 ip4Address=10.254.110.13/24 ip6Address= Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.721+07:00 level=INFO msg="emitting wifi info changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.722+07:00 level=INFO msg="emitting device setup status changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" setupComplete=true Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 04 18:54:32 volumio volumio[3117]: amixer -c 0 info | grep "vc4-hdmi-0" Mar 04 18:54:32 volumio volumio[3117]: Card sysdefault:0 'vc4hdmi0'/'vc4-hdmi-0' Mar 04 18:54:32 volumio volumio[3117]: amixer -c 1 info | grep "vc4-hdmi-1" Mar 04 18:54:32 volumio volumio[3117]: Card sysdefault:1 'vc4hdmi1'/'vc4-hdmi-1' Mar 04 18:54:32 volumio volumio[3117]: amixer -c 2 info | grep "IQaudIODAC" Mar 04 18:54:32 volumio volumio[3117]: Card sysdefault:2 'IQaudIODAC'/'IQaudIODAC' Mar 04 18:54:32 volumio volumio[3117]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 2 Mar 04 18:54:32 volumio volumio[3117]: /bin/sh: 1: /usr/local/bin/alsacap: not found Mar 04 18:54:32 volumio volumio[3117]: {"cmd":"/usr/local/bin/alsacap -C 2","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 2\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Mar 04 18:54:32 volumio volumio[3117]: amixer -c 2 info | grep "IQaudIO DAC Plus" Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.790+07:00 level=INFO msg="emitting audio outputs changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" selectedOutputId=2 Mar 04 18:54:32 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:32 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:32 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.797+07:00 level=INFO msg="emitting software info changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" currentVersion=4.096 latestVersion=4.096 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.797+07:00 level=INFO msg="emitting software update progress event" component=server peer="10.254.110.125:63139 @ 0x2d74090" status=UPDATE_STATUS_NONE progress=0 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.798+07:00 level=INFO msg="emitting user changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" userId=zxC19nOTn4dDSmPrlE8ptyuqKEt1 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.798+07:00 level=INFO msg="emitting music providers changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" providers=9 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.798+07:00 level=INFO msg="emitting plugins changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" plugins=62 Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:32 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.799+07:00 level=INFO msg="emitting player state changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" state=STATUS_STOPPED positionMs=250 volume=100 Mar 04 18:54:32 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:32.799+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.254.110.125:63139 @ 0x2d74090" id="mnt/NAS/NAS84FF18_Downloads/transmission/completed/[Progressive Rock] Blackfield - Discography 2004-2020 FLAC (Jamal The Moroccan)/2004 - Blackfield I/01 - Open Mind.flac" title="Open Mind" Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:32 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:32 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:32 volumio volumio[3117]: verbose: New Socket.io Connection to 10.254.110.13:3000 from 10.254.110.125 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 04 18:54:32 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 04 18:54:34 volumio volumio5-onboarding[1614]: time=2026-03-04T18:54:34.737+07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="10.254.110.125:63139 @ 0x2d74090" latency=60.40025ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Mar 04 18:54:35 volumio sudo[13487]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 04 18:54:35 volumio sudo[13487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:54:35 volumio sudo[13487]: pam_unix(sudo:session): session closed for user root Mar 04 18:54:35 volumio sudo[13489]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 04 18:54:35 volumio sudo[13489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:54:35 volumio sudo[13489]: pam_unix(sudo:session): session closed for user root Mar 04 18:54:35 volumio volumio[3117]: verbose: New Socket.io Connection to 10.254.110.13 from 10.254.110.125 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 8 Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 04 18:54:35 volumio sudo[13493]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 04 18:54:35 volumio sudo[13493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:54:35 volumio sudo[13493]: pam_unix(sudo:session): session closed for user root Mar 04 18:54:35 volumio sudo[13495]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 04 18:54:35 volumio sudo[13495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:54:35 volumio sudo[13495]: pam_unix(sudo:session): session closed for user root Mar 04 18:54:35 volumio volumio[3117]: verbose: New Socket.io Connection to 10.254.110.13 from 10.254.110.125 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 8 Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::volumioGetVisibleSources Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:35 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::volumioGetQueue Mar 04 18:54:35 volumio volumio[3117]: info: CoreStateMachine::getQueue Mar 04 18:54:35 volumio volumio[3117]: info: CorePlayQueue::getQueue Mar 04 18:54:35 volumio volumio[3117]: info: Listing playlists Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 04 18:54:35 volumio volumio[3117]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 04 18:54:35 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:35 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:35 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:35 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 04 18:54:35 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 04 18:54:36 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 04 18:54:37 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:54:37 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:37 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:37 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:37 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:37 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:37 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:37 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:37 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 04 18:54:39 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:54:39 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:39 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:39 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:39 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:39 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:39 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:39 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:40 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:54:40 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:40 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:40 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:40 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:40 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:40 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:40 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:42 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:54:42 volumio volumio[3117]: info: CURURI: music-library/NAS/NAS84FF18_Downloads/transmission/completed/GENESIS Mar 04 18:54:42 volumio volumio[3117]: info: Preload queue cleared Mar 04 18:54:45 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 04 18:54:46 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:54:46 volumio volumio[3117]: info: CURURI: music-library/NAS/NAS84FF18_Downloads/transmission/completed/GENESIS/Albums Mar 04 18:54:46 volumio volumio[3117]: info: Preload queue cleared Mar 04 18:54:54 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 04 18:54:54 volumio volumio[3117]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 04 18:54:54 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 04 18:54:54 volumio volumio[3117]: info: Received Get System Version Mar 04 18:54:54 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 18:54:54 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:54 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:54 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:54 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:54 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:54 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:54 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:58 volumio volumio[3117]: verbose: New Socket.io Connection to 10.254.110.13 from 10.254.110.125 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 8 Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::volumioGetVisibleSources Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:58 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::volumioGetQueue Mar 04 18:54:58 volumio volumio[3117]: info: CoreStateMachine::getQueue Mar 04 18:54:58 volumio volumio[3117]: info: CorePlayQueue::getQueue Mar 04 18:54:58 volumio volumio[3117]: info: Listing playlists Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 04 18:54:58 volumio volumio[3117]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 04 18:54:58 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:58 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:58 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:58 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:58 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 04 18:54:59 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:54:59 volumio volumio[3117]: info: Received Get System Info Mar 04 18:54:59 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:54:59 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:54:59 volumio volumio[3117]: info: Discovery: Getting this device information Mar 04 18:54:59 volumio volumio[3117]: info: CoreCommandRouter::volumioGetState Mar 04 18:54:59 volumio volumio[3117]: info: CorePlayQueue::getTrack 0 Mar 04 18:54:59 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:55:11 volumio volumio[3117]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:55:11 volumio volumio[3117]: info: CURURI: music-library/NAS/NAS84FF18_Downloads/transmission/completed/GENESIS/Albums/1976 - A Trick Of The Tail (CDSCD 4001) Mar 04 18:55:12 volumio volumio[3117]: info: Preload queue cleared Mar 04 18:55:24 volumio volumio[3117]: info: Preload queue cleared Mar 04 18:55:24 volumio volumio[3117]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 04 18:55:24 volumio volumio[3117]: info: CoreStateMachine::ClearQueue Mar 04 18:55:24 volumio volumio[3117]: info: CoreStateMachine::stop Mar 04 18:55:24 volumio volumio[3117]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 18:55:24 volumio volumio[3117]: info: CorePlayQueue::clearPlayQueue Mar 04 18:55:24 volumio volumio[3117]: info: CorePlayQueue::saveQueue Mar 04 18:55:24 volumio volumio[3117]: info: CoreCommandRouter::volumioPushQueue Mar 04 18:55:24 volumio volumio[3117]: info: CoreStateMachine::addQueueItems Mar 04 18:55:24 volumio volumio[3117]: info: CorePlayQueue::addQueueItems Mar 04 18:55:24 volumio volumio[3117]: info: Preload queue cleared Mar 04 18:55:24 volumio volumio[3117]: info: Adding Item to queue: music-library/NAS/NAS84FF18_Downloads/transmission/completed/GENESIS/Albums/1976 - A Trick Of The Tail (CDSCD 4001) Mar 04 18:55:24 volumio volumio[3117]: info: Exploding uri music-library/NAS/NAS84FF18_Downloads/transmission/completed/GENESIS/Albums/1976 - A Trick Of The Tail (CDSCD 4001) in service mpd Mar 04 18:55:24 volumio volumio[3117]: info: ALBUMART /albumart?cacheid=934&web=Genesis/A%20Trick%20Of%20The%20Tail%20(CDSCD%204001)/extralarge&path=%2Fmnt%2FNAS%2FNAS84FF18_Downloads%2Ftransmission%2Fcompleted%2FGENESIS%2FAlbums%2F1976%20-%20A%20Trick%20Of%20The%20Tail%20(CDSCD%204001)%2FGenesis%20-%20A%20Trick%20Of%20The%20Tail%20(CDSCD%204001).cue&metadata=false Mar 04 18:55:24 volumio volumio[3117]: info: URI /mnt/NAS/NAS84FF18_Downloads/transmission/completed/GENESIS/Albums/1976 - A Trick Of The Tail (CDSCD 4001)/Genesis - A Trick Of The Tail (CDSCD 4001).cue Mar 04 18:55:24 volumio volumio[3117]: info: ALBUMART /albumart?cacheid=934&web=Genesis/A%20Trick%20Of%20The%20Tail%20(CDSCD%204001)/extralarge&path=%2Fmnt%2FNAS%2FNAS84FF18_Downloads%2Ftransmission%2Fcompleted%2FGENESIS%2FAlbums%2F1976%20-%20A%20Trick%20Of%20The%20Tail%20(CDSCD%204001)%2FGenesis%20-%20A%20Trick%20Of%20The%20Tail%20(CDSCD%204001).cue&metadata=false Mar 04 18:55:24 volumio volumio[3117]: info: URI /mnt/NAS/NAS84FF18_Downloads/transmission/completed/GENESIS/Albums/1976 - A Trick Of The Tail (CDSCD 4001)/Genesis - A Trick Of The Tail (CDSCD 4001).cue Mar 04 18:55:24 volumio volumio[3117]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 18:55:24 volumio volumio[3117]: Error: Unable to resolve or reject the same promise twice Mar 04 18:55:24 volumio volumio[3117]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 04 18:55:24 volumio volumio[3117]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Mar 04 18:55:24 volumio volumio[3117]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 04 18:55:24 volumio volumio[3117]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 04 18:55:24 volumio volumio[3117]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 04 18:55:24 volumio volumio[3117]: at Socket.emit (node:events:514:28) Mar 04 18:55:24 volumio volumio[3117]: at addChunk (node:internal/streams/readable:343:12) Mar 04 18:55:24 volumio volumio[3117]: at readableAddChunk (node:internal/streams/readable:312:11) Mar 04 18:55:24 volumio volumio[3117]: at Readable.push (node:internal/streams/readable:253:10) Mar 04 18:55:24 volumio volumio[3117]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Mar 04 18:55:24 volumio volumio[3117]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 18:55:24 volumio sudo[13619]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-04 18:54' Mar 04 18:55:24 volumio sudo[13619]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"