Jun 03 06:34:09 volumio-4g-old ntpd[1132]: PROTO: 202.28.33.225 unlink local addr 192.168.1.181 -> Jun 03 06:34:14 volumio-4g-old ntpd[1132]: PROTO: 47.87.71.223 unlink local addr 192.168.1.181 -> Jun 03 06:34:14 volumio-4g-old ntpd[1132]: PROTO: 202.29.58.130 unlink local addr 192.168.1.181 -> Jun 03 06:34:17 volumio-4g-old wpa_supplicant[1325]: wlan0: WPA: Group rekeying completed with 6e:6c:0f:6e:37:d0 [GTK=CCMP] Jun 03 06:34:22 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:22.981+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.152:54042 Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.007+07:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.152:54042 @ 0x16ba900" latency=10.057607ms platform=PLATFORM_IOS version=5.260413.0 Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.008+07:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.152:54042 @ 0x16ba900" latency=10.137921ms timeout=10s Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.008+07:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: Received Get System Info Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: Discovery: Getting this device information Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetState Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.018+07:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" name=Volumio Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.020+07:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" language=en Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.023+07:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" timezone=Asia/Bangkok Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.025+07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" available=true connected=false macAddress= ip4Address= ip6Address= Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.028+07:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" available=true connected=true macAddress=e4:5f:01:3b:6f:39 ip4Address=192.168.1.181/24 ip6Address= ssid=Pumpkim_5GHz Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.028+07:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" setupComplete=true Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 06:34:23 volumio-4g-old volumio[1364]: amixer -c 0 info | grep "bcm2835 Headphones" Jun 03 06:34:23 volumio-4g-old volumio[1364]: Card sysdefault:0 'Headphones'/'bcm2835 Headphones' Jun 03 06:34:23 volumio-4g-old volumio[1364]: amixer -c 1 info | grep "vc4-hdmi-0" Jun 03 06:34:23 volumio-4g-old volumio[1364]: Card sysdefault:1 'vc4hdmi0'/'vc4-hdmi-0' Jun 03 06:34:23 volumio-4g-old volumio[1364]: amixer -c 2 info | grep "vc4-hdmi-1" Jun 03 06:34:23 volumio-4g-old volumio[1364]: Card sysdefault:2 'vc4hdmi1'/'vc4-hdmi-1' Jun 03 06:34:23 volumio-4g-old volumio[1364]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Jun 03 06:34:23 volumio-4g-old volumio[1364]: /bin/sh: 1: /usr/local/bin/alsacap: not found Jun 03 06:34:23 volumio-4g-old volumio[1364]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\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)"} Jun 03 06:34:23 volumio-4g-old volumio[1364]: amixer -c 5 info | grep "XMOS Audio" Jun 03 06:34:23 volumio-4g-old volumio[1364]: Card sysdefault:5 'Audio'/'XMOS XMOS Audio at usb-0000:01:00.0-1.1, high speed' Jun 03 06:34:23 volumio-4g-old volumio[1364]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Jun 03 06:34:23 volumio-4g-old volumio[1364]: /bin/sh: 1: /usr/local/bin/alsacap: not found Jun 03 06:34:23 volumio-4g-old volumio[1364]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\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)"} Jun 03 06:34:23 volumio-4g-old volumio[1364]: amixer -c 5 info | grep "XMOS Audio" Jun 03 06:34:23 volumio-4g-old volumio[1364]: Card sysdefault:5 'Audio'/'XMOS XMOS Audio at usb-0000:01:00.0-1.1, high speed' Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.163+07:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" selectedOutputId=5 Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: Received Get System Info Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: Discovery: Getting this device information Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetState Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.179+07:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" currentVersion=4.119 latestVersion=4.119 Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.179+07:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.152:54042 @ 0x16ba900" status=UPDATE_STATUS_NONE progress=0 Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.180+07:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" userId= Jun 03 06:34:23 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:23.180+07:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" providers=3 Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: Discovery: Getting this device information Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetState Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 06:34:23 volumio-4g-old volumio[1364]: verbose: New Socket.io Connection to 192.168.1.181:3000 from 192.168.1.152 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 03 06:34:23 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 03 06:34:24 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:24.238+07:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" plugins=67 Jun 03 06:34:24 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetState Jun 03 06:34:24 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:24 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:24.242+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" state=STATUS_STOPPED positionMs=0 volume=50 Jun 03 06:34:24 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:24.242+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" id= title= Jun 03 06:34:24 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:24.498+07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.152:54042 @ 0x16ba900" latency=6.787349ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Jun 03 06:34:25 volumio-4g-old sudo[3513]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 06:34:25 volumio-4g-old sudo[3513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 06:34:25 volumio-4g-old sudo[3513]: pam_unix(sudo:session): session closed for user root Jun 03 06:34:25 volumio-4g-old sudo[3515]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 06:34:25 volumio-4g-old sudo[3515]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 06:34:25 volumio-4g-old sudo[3515]: pam_unix(sudo:session): session closed for user root Jun 03 06:34:25 volumio-4g-old volumio[1364]: verbose: New Socket.io Connection to 192.168.1.181 from 192.168.1.152 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: 7 Jun 03 06:34:25 volumio-4g-old sudo[3519]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 06:34:25 volumio-4g-old sudo[3519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 06:34:25 volumio-4g-old sudo[3519]: pam_unix(sudo:session): session closed for user root Jun 03 06:34:25 volumio-4g-old sudo[3521]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 06:34:25 volumio-4g-old sudo[3521]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 06:34:25 volumio-4g-old sudo[3521]: pam_unix(sudo:session): session closed for user root Jun 03 06:34:25 volumio-4g-old volumio[1364]: verbose: New Socket.io Connection to 192.168.1.181 from 192.168.1.152 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: 7 Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetState Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: Listing playlists Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 03 06:34:25 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: Received Get System Info Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: Discovery: Getting this device information Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetState Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:27 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: VolumeController::SetAlsaVolume- Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreStateMachine::pushState Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioPushState Jun 03 06:34:29 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:29.323+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" state=STATUS_STOPPED positionMs=0 volume=48 Jun 03 06:34:29 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:29.323+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" id= title= Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: Received Get System Info Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: Discovery: Getting this device information Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetState Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:29 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 06:34:31 volumio-4g-old volumio[1364]: info: VolumeController::SetAlsaVolume- Jun 03 06:34:31 volumio-4g-old volumio[1364]: info: CoreStateMachine::pushState Jun 03 06:34:31 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:31 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 06:34:31 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioPushState Jun 03 06:34:31 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:31.924+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" state=STATUS_STOPPED positionMs=0 volume=46 Jun 03 06:34:31 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:31.926+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" id= title= Jun 03 06:34:32 volumio-4g-old volumio[1364]: info: VolumeController::SetAlsaVolume- Jun 03 06:34:32 volumio-4g-old volumio[1364]: info: CoreStateMachine::pushState Jun 03 06:34:32 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:32 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 06:34:32 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioPushState Jun 03 06:34:32 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:32.506+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" state=STATUS_STOPPED positionMs=0 volume=44 Jun 03 06:34:32 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:32.507+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" id= title= Jun 03 06:34:33 volumio-4g-old volumio[1364]: info: VolumeController::SetAlsaVolume40 Jun 03 06:34:33 volumio-4g-old volumio[1364]: info: CoreStateMachine::pushState Jun 03 06:34:33 volumio-4g-old volumio[1364]: info: CorePlayQueue::getTrack 0 Jun 03 06:34:33 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 06:34:33 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioPushState Jun 03 06:34:33 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:33.161+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" state=STATUS_STOPPED positionMs=0 volume=40 Jun 03 06:34:33 volumio-4g-old volumio5-onboarding[2188]: time=2026-06-03T06:34:33.169+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.152:54042 @ 0x16ba900" id= title= Jun 03 06:34:34 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetVisibleSources Jun 03 06:34:34 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 06:34:34 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioGetQueue Jun 03 06:34:34 volumio-4g-old volumio[1364]: info: CoreStateMachine::getQueue Jun 03 06:34:34 volumio-4g-old volumio[1364]: info: CorePlayQueue::getQueue Jun 03 06:34:35 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 06:34:35 volumio-4g-old volumio[1364]: info: CURURI: music-library Jun 03 06:34:35 volumio-4g-old volumio[1364]: info: Preload queue cleared Jun 03 06:34:36 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 06:34:36 volumio-4g-old volumio[1364]: info: CURURI: music-library/USB Jun 03 06:34:36 volumio-4g-old volumio[1364]: info: Preload queue cleared Jun 03 06:34:37 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 06:34:37 volumio-4g-old volumio[1364]: info: CURURI: music-library/USB/SanDisk Jun 03 06:34:37 volumio-4g-old volumio[1364]: info: Preload queue cleared Jun 03 06:34:37 volumio-4g-old volumio[1364]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 06:34:37 volumio-4g-old volumio[1364]: info: CURURI: music-library/USB/SanDisk/International Jun 03 06:34:37 volumio-4g-old volumio[1364]: info: Preload queue cleared Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: Preload queue cleared Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: CoreCommandRouter::volumioAddQueueItems Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: CoreStateMachine::addQueueItems Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: CorePlayQueue::addQueueItems Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: Preload queue cleared Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: Adding Item to queue: music-library/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009) Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: Exploding uri music-library/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009) in service mpd Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Bonnie%20Lam/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F01.%20Blue%20Moon.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/01. Blue Moon.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Susan%20Wong/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F02.%20Love%20Will%20Keep%20Us%20Alive%20(2008%20Version).flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/02. Love Will Keep Us Alive (2008 Version).flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Alice%20%26%20C%C3%A9cile/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F03.%20Smile.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/03. Smile.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Lydia%20Gray/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F04.%20One%20Note%20Samba.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/04. One Note Samba.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Phe%20Cullen/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F05.%20Fly%20Me%20To%20The%20Moon.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/05. Fly Me To The Moon.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Lovisa/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F07.%20My%20One%20And%20Only%20Love.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/07. My One And Only Love.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Judy%20Akin/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F08.%20More%20Than%20You%20Know.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/08. More Than You Know.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Liane%20Carroll/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F09.%20I%20Wish%20You%20Love.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/09. I Wish You Love.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Alice%20%26%20C%C3%A9cile/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F10.%20Going%20Out%20Of%20My%20Head.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/10. Going Out Of My Head.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Lovisa/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F11.%20When%20I%20Fall%20In%20Love.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/11. When I Fall In Love.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Judy%20Akin/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F12.%20They%20Can't%20Take%20That%20Away%20From%20Me.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/12. They Can't Take That Away From Me.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Liane%20Carroll/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2F13.%20You've%20Got%20A%20Friend.flac&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/13. You've Got A Friend.flac Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Bonnie%20Lam/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2FVarious%20Artists%20-%20Reference%20Vocal%202.cue&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/Various Artists - Reference Vocal 2.cue Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: ALBUMART /albumart?cacheid=77&web=Susan%20Wong/Reference%20Vocal%202/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2F%5BROCKINMUSIC%5D%20Reference%20Vocal%20Vol.2%20(2009)%2FVarious%20Artists%20-%20Reference%20Vocal%202.cue&metadata=false Jun 03 06:34:44 volumio-4g-old volumio[1364]: info: URI /mnt/USB/SanDisk/International/[ROCKINMUSIC] Reference Vocal Vol.2 (2009)/Various Artists - Reference Vocal 2.cue Jun 03 06:34:44 volumio-4g-old volumio[1364]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 06:34:44 volumio-4g-old volumio[1364]: Error: Unable to resolve or reject the same promise twice Jun 03 06:34:44 volumio-4g-old volumio[1364]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Jun 03 06:34:44 volumio-4g-old volumio[1364]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at Socket.emit (node:events:514:28) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at addChunk (node:internal/streams/readable:343:12) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at readableAddChunk (node:internal/streams/readable:312:11) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at Readable.push (node:internal/streams/readable:253:10) Jun 03 06:34:44 volumio-4g-old volumio[1364]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jun 03 06:34:44 volumio-4g-old volumio[1364]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 06:34:44 volumio-4g-old sudo[3557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-03 06:33' Jun 03 06:34:44 volumio-4g-old sudo[3557]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"