-- Logs begin at Tue 2026-05-26 10:28:30 CEST, end at Tue 2026-05-26 16:12:11 CEST. -- May 26 16:11:01 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 16:11:02 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:03 volumio volumio[1148]: info: Received Get System Info May 26 16:11:03 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:03 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:03 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:03 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:03 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:03 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:03 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:03.471+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:03 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:03 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:05 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 16:11:08 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:09 volumio volumio[1148]: info: Received Get System Info May 26 16:11:09 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:09 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:09 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:09 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:09 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:09 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:09 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:09.084+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:09 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:09 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:09 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:09.561+02:00 level=INFO msg="new address was allocated" component=ble/conn old=1 new=2 May 26 16:11:09 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 16:11:09 volumio dbus-daemon[626]: [system] Rejected send message, 1 matched rules; type="error", sender=":1.18" (uid=0 pid=1532 comm="/usr/bin/volumio5-onboarding ") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.5" (uid=0 pid=740 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap,hostn") May 26 16:11:09 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:09.856+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="00:00:00:00:00:00%01 @ 0x1cae930" latency=51.453958ms platform=PLATFORM_ANDROID version=5.260413.0 May 26 16:11:09 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:09.953+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="00:00:00:00:00:00%01 @ 0x1cae930" latency=148.751869ms platform=PLATFORM_ANDROID version=5.260413.0 May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.050+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="00:00:00:00:00:00%01 @ 0x1cae930" latency=151.287748ms timeout=10s May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.050+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.148+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="00:00:00:00:00:00%01 @ 0x1cae930" latency=150.874982ms timeout=10s May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.148+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" May 26 16:11:10 volumio volumio[1148]: info: Received Get System Info May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:10 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:10 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.297+02:00 level=INFO msg="emitting device name changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" name=Volumio May 26 16:11:10 volumio volumio[1148]: info: Received Get System Info May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:10 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:10 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.394+02:00 level=INFO msg="emitting device name changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" name=Volumio May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.537+02:00 level=INFO msg="emitting device language changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" language=en May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.635+02:00 level=INFO msg="emitting device language changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" language=en May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.734+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" timezone=Europe/Belgrade May 26 16:11:10 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.831+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" timezone=Europe/Belgrade May 26 16:11:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:10.977+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" available=true connected=true macAddress=b8:27:eb:28:b6:25 ip4Address=192.168.1.64/24 ip6Address= May 26 16:11:11 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:11.074+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" available=true connected=true macAddress=b8:27:eb:28:b6:25 ip4Address=192.168.1.64/24 ip6Address= May 26 16:11:11 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:11.171+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:11 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:11.269+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:11 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:11.366+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" setupComplete=true May 26 16:11:11 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:11.463+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" setupComplete=true May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 26 16:11:11 volumio volumio[1148]: amixer -c 2 info | grep "HiFiBerry Digi+ Pro HiFi wm8804-spdif-0" May 26 16:11:11 volumio volumio[1148]: amixer -c 0 info | grep "bcm2835 ALSA" May 26 16:11:11 volumio volumio[1148]: amixer -c 1 info | grep "bcm2835 Headphones" May 26 16:11:11 volumio volumio[1148]: Card hw:1 'Headphones'/'bcm2835 Headphones' May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 16:11:11 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 26 16:11:11 volumio volumio[1148]: amixer -c 2 info | grep "HiFiBerry Digi+ Pro HiFi wm8804-spdif-0" May 26 16:11:11 volumio volumio[1148]: amixer -c 0 info | grep "bcm2835 ALSA" May 26 16:11:11 volumio volumio[1148]: amixer -c 1 info | grep "bcm2835 Headphones" May 26 16:11:12 volumio volumio[1148]: Card hw:1 'Headphones'/'bcm2835 Headphones' May 26 16:11:12 volumio volumio[1148]: amixer -c 2 info | grep "snd_rpi_hifiberry_digi" May 26 16:11:12 volumio volumio[1148]: Card hw:2 'sndrpihifiberry'/'snd_rpi_hifiberry_digi' May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.123+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" selectedOutputId=2 May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.123+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" selectedOutputId=2 May 26 16:11:12 volumio volumio[1148]: amixer -c 2 info | grep "snd_rpi_hifiberry_digi" May 26 16:11:12 volumio volumio[1148]: Card hw:2 'sndrpihifiberry'/'snd_rpi_hifiberry_digi' May 26 16:11:12 volumio volumio[1148]: info: Received Get System Info May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:12 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:12 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.225+02:00 level=INFO msg="emitting software info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" currentVersion=3.912 latestVersion=3.912 May 26 16:11:12 volumio volumio[1148]: info: Received Get System Info May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:12 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:12 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:12 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.306+02:00 level=INFO msg="emitting software info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" currentVersion=3.912 latestVersion=3.912 May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.438+02:00 level=INFO msg="emitting software update progress event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" status=UPDATE_STATUS_NONE progress=0 May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.535+02:00 level=INFO msg="emitting software update progress event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" status=UPDATE_STATUS_NONE progress=0 May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.682+02:00 level=INFO msg="emitting user changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" userId=DYaMXWSEACbtSDo4MO9dfFO60PM2 May 26 16:11:12 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:12.779+02:00 level=INFO msg="emitting user changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" userId=DYaMXWSEACbtSDo4MO9dfFO60PM2 May 26 16:11:13 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:13.023+02:00 level=INFO msg="emitting music providers changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" providers=9 May 26 16:11:13 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:13.315+02:00 level=INFO msg="emitting music providers changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" providers=9 May 26 16:11:13 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:13.559+02:00 level=INFO msg="emitting plugins changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" plugins=54 May 26 16:11:13 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:13.900+02:00 level=INFO msg="emitting plugins changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" plugins=54 May 26 16:11:14 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:14 volumio volumio[1148]: info: Received Get System Info May 26 16:11:14 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:14 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:14 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:14 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:14 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:14 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:14 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:14.696+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:14 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:14.697+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:14 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:14 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:15 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:15.374+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.71:57706 May 26 16:11:16 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:16 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:16 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:16.294+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:16 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:16 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:16 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:16 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:16 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:16 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:16 volumio volumio[1148]: verbose: New Socket.io Connection to 192.168.1.64:3000 from 192.168.1.71 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 May 26 16:11:16 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:16 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:18 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:18 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:18 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:18.584+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:18 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:18.584+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" id= title= May 26 16:11:19 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:19.019+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1cae930" id= title= May 26 16:11:19 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:19.040+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" latency=12.330106ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE May 26 16:11:19 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:19 volumio go-librespot[1504]: time="2026-05-26T16:11:19+02:00" level=trace msg="sent dealer ping" May 26 16:11:19 volumio go-librespot[1504]: time="2026-05-26T16:11:19+02:00" level=trace msg="received dealer pong" May 26 16:11:20 volumio sudo[8078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 16:11:20 volumio sudo[8078]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 16:11:20 volumio sudo[8078]: pam_unix(sudo:session): session closed for user root May 26 16:11:20 volumio sudo[8081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 16:11:20 volumio sudo[8081]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 16:11:20 volumio sudo[8081]: pam_unix(sudo:session): session closed for user root May 26 16:11:20 volumio volumio[1148]: info: Received Get System Info May 26 16:11:20 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:20 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:20 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:20 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:20 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:20 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:20 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:20.311+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:20 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:20.312+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:20 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:20.313+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:20 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:20 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:20 volumio volumio[1148]: verbose: New Socket.io Connection to 192.168.1.64 from 192.168.1.71 UA: Mozilla/5.0 (Linux; Android 16; SM-A346B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/148.0.7778.120 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 26 16:11:20 volumio sudo[8084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 16:11:20 volumio sudo[8084]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 16:11:20 volumio sudo[8084]: pam_unix(sudo:session): session closed for user root May 26 16:11:20 volumio sudo[8087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 16:11:20 volumio sudo[8087]: pam_unix(sudo:session): session opened for user root by (uid=0) May 26 16:11:20 volumio sudo[8087]: pam_unix(sudo:session): session closed for user root May 26 16:11:20 volumio volumio[1148]: verbose: New Socket.io Connection to 192.168.1.64 from 192.168.1.71 UA: Mozilla/5.0 (Linux; Android 16; SM-A346B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/148.0.7778.120 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::volumioGetVisibleSources May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:21 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 16:11:21 volumio volumio[1148]: info: Received Get System Info May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:21 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:21 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:21 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:21 volumio volumio[1148]: info: Listing playlists May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 16:11:21 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 26 16:11:22 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 26 16:11:22 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 16:11:22 volumio volumio[1148]: info: Received Get System Info May 26 16:11:22 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:22 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:22 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:22 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:22 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:22 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 16:11:24 volumio volumio[1148]: info: Received Get System Info May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:24 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:24 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 16:11:24 volumio volumio[1148]: info: Retrieving Cloud Streaming UI May 26 16:11:24 volumio volumio[1148]: info: Getting Tidal Cloud Configuration May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 16:11:24 volumio volumio[1148]: info: Getting Qobuz Cloud Configuration May 26 16:11:24 volumio volumio[1148]: info: Asking plugin for UI Config May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 16:11:24 volumio volumio[1148]: info: Getting Spotify Cloud Configuration May 26 16:11:24 volumio volumio[1148]: info: Asking plugin for UI Config May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 16:11:24 volumio volumio[1148]: info: Saving Spotify Acccount May 26 16:11:24 volumio volumio[1148]: info: Got Tidal Cloud Configuration May 26 16:11:24 volumio volumio[1148]: info: Got it May 26 16:11:24 volumio volumio[1148]: info: Got it May 26 16:11:24 volumio volumio[1148]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 16:11:24 volumio volumio[1148]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::volumioGetBrowseSources May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::volumioGetBrowseSources May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::volumioGetBrowseSources May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 16:11:24 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 26 16:11:25 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:25 volumio volumio[1148]: info: Received Get System Info May 26 16:11:25 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:25 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:25 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:25 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:25 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:25 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:25 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:25.927+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:25 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:25.928+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:25 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:25.928+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:25 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:25 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand rescan May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: update May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand rescan took 3 milliseconds May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 2 milliseconds May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 2 milliseconds May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: info: Command Router : Notfying DB Updatetrue May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::Close All Modals sent May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:26 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: No code May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.746+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.746+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.747+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.747+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.747+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.748+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.747+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.748+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.747+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.748+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.749+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.749+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.751+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.751+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.752+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.753+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.753+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.754+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio[1148]: info: ------------------------------ 95ms May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: update May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: update May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: MPD Database updated - AlbumList cache refreshed May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: database May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: update May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 6 milliseconds May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 10 milliseconds May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 10 milliseconds May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 10 milliseconds May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: info: Command Router : Notfying DB Updatefalse May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::Close All Modals sent May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: info: Command Router : Notfying DB Updatefalse May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::Close All Modals sent May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:26 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: No code May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:26 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: No code May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.876+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.876+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.876+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.877+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.878+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.879+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio[1148]: info: ------------------------------ 128ms May 26 16:11:26 volumio volumio[1148]: info: ------------------------------ 127ms May 26 16:11:26 volumio volumio[1148]: info: MPD Database updated - AlbumList cache refreshed May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: database May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: update May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: MPD Database updated - AlbumList cache refreshed May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: database May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: May 26 16:11:26 volumio volumio[1148]: ---------------------------- MPD announces state update: update May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::getState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::sendMpdCommand status May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 158 milliseconds May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 157 milliseconds May 26 16:11:26 volumio volumio[1148]: info: sendMpdCommand status took 158 milliseconds May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: info: Command Router : Notfying DB Updatefalse May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::Close All Modals sent May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:26 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: No code May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:26 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio[1148]: info: No code May 26 16:11:26 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:26 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:26 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.974+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.974+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.975+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.976+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.976+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.977+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.977+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.977+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.977+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.978+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.978+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.978+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.978+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.978+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.976+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.979+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.979+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.980+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.981+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.981+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.982+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:26 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:26.982+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:26 volumio volumio[1148]: info: ------------------------------ 226ms May 26 16:11:26 volumio volumio[1148]: info: ------------------------------ 227ms May 26 16:11:27 volumio volumio[1148]: info: sendMpdCommand status took 114 milliseconds May 26 16:11:27 volumio volumio[1148]: info: sendMpdCommand status took 112 milliseconds May 26 16:11:27 volumio volumio[1148]: info: sendMpdCommand status took 111 milliseconds May 26 16:11:27 volumio volumio[1148]: info: sendMpdCommand status took 110 milliseconds May 26 16:11:27 volumio volumio[1148]: info: sendMpdCommand status took 109 milliseconds May 26 16:11:27 volumio volumio[1148]: info: sendMpdCommand status took 109 milliseconds May 26 16:11:27 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:27 volumio volumio[1148]: info: Command Router : Notfying DB Updatefalse May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::Close All Modals sent May 26 16:11:27 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:27 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:27 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:27 volumio volumio[1148]: info: Command Router : Notfying DB Updatefalse May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::Close All Modals sent May 26 16:11:27 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:27 volumio volumio[1148]: verbose: ControllerMpd::parseState May 26 16:11:27 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:27 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: No code May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:27 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: No code May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:27 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: No code May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: ControllerMpd::pushState May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::servicePushState May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 26 16:11:27 volumio volumio[1148]: verbose: CURRENT POSITION 0 May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState stateService stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::syncState currentStatus stop May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio[1148]: info: No code May 26 16:11:27 volumio volumio[1148]: info: CoreStateMachine::pushState May 26 16:11:27 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:27 volumio volumio[1148]: info: CoreCommandRouter::volumioPushState May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.093+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.093+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.094+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.095+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.095+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.095+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.095+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.095+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.096+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.096+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.096+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.096+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.096+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.096+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.097+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.097+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.097+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.097+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.097+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.097+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.098+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.098+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.098+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.098+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.098+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.098+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.099+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.099+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.099+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.099+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.099+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.099+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.099+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.100+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.100+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.100+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.100+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.101+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.102+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.102+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.102+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.103+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.103+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.103+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.104+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.104+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.104+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio[1148]: info: ------------------------------ 223ms May 26 16:11:27 volumio volumio[1148]: info: ------------------------------ 225ms May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.104+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.105+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.105+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.105+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.105+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.106+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.106+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.107+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.107+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.108+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.109+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" state=STATUS_STOPPED positionMs=0 volume=100 May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.110+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.110+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" id= title= May 26 16:11:27 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:27.111+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" id= title= May 26 16:11:27 volumio volumio[1148]: info: ------------------------------ 220ms May 26 16:11:27 volumio volumio[1148]: info: ------------------------------ 221ms May 26 16:11:28 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 16:11:30 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 26 16:11:31 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:31 volumio volumio[1148]: info: Received Get System Info May 26 16:11:31 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:31 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:31 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:31 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:31 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:31 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:31 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:31.538+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:31 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:31.538+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:31 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:31.539+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:31 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:31 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:32 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 16:11:36 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:37 volumio volumio[1148]: info: Received Get System Info May 26 16:11:37 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:37 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:37 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:37 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:37 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:37 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:37 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:37.147+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:37 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:37.147+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:37 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:37.148+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:37 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:37 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::volumioGetQueue May 26 16:11:39 volumio volumio[1148]: info: CoreStateMachine::getQueue May 26 16:11:39 volumio volumio[1148]: info: CorePlayQueue::getQueue May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 16:11:39 volumio volumio[1148]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 26 16:11:39 volumio volumio[1148]: info: Received Get System Version May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 16:11:39 volumio volumio[1148]: info: Received Get System Info May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:39 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:39 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:39 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:42 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:42 volumio volumio[1148]: info: Received Get System Info May 26 16:11:42 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:42 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:42 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:42 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:42 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:42 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:42 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:42.758+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:42 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:42.759+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:42 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:42.759+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:42 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:42 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:43 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 26 16:11:43 volumio volumio[1148]: info: CURURI: music-library May 26 16:11:43 volumio volumio[1148]: info: Preload queue cleared May 26 16:11:44 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 26 16:11:44 volumio volumio[1148]: info: CURURI: music-library/USB May 26 16:11:44 volumio volumio[1148]: info: Preload queue cleared May 26 16:11:45 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 26 16:11:45 volumio volumio[1148]: info: CURURI: music-library/USB/KINGSTON May 26 16:11:45 volumio volumio[1148]: info: Preload queue cleared May 26 16:11:47 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:48 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 26 16:11:48 volumio volumio[1148]: info: CURURI: music-library/USB/KINGSTON/DianaKrall - Turn Up The Quiet May 26 16:11:48 volumio volumio[1148]: info: Received Get System Info May 26 16:11:48 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:48 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:48 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:48 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:48 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:48 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:48 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:48 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:48 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:48.380+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:48 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:48.381+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:48 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:48.382+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:48 volumio volumio[1148]: info: Preload queue cleared May 26 16:11:48 volumio ntpd[749]: Soliciting pool server 2001:ac8:7d:42:0:2:0:20 May 26 16:11:49 volumio go-librespot[1504]: time="2026-05-26T16:11:49+02:00" level=trace msg="sent dealer ping" May 26 16:11:49 volumio go-librespot[1504]: time="2026-05-26T16:11:49+02:00" level=trace msg="received dealer pong" May 26 16:11:53 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:53 volumio volumio[1148]: info: Received Get System Info May 26 16:11:53 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:53 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:53 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:53 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:53 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:53 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:53 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:53.994+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:53 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:53.995+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:53 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:53.995+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:53 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:53 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:59 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:11:59 volumio volumio[1148]: info: Received Get System Info May 26 16:11:59 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:11:59 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:11:59 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:11:59 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:11:59 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:11:59 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:11:59 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:11:59 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:11:59 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:59.609+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:59 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:59.610+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:11:59 volumio volumio5-onboarding[1532]: time=2026-05-26T16:11:59.610+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:12:04 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:12:05 volumio volumio[1148]: info: Received Get System Info May 26 16:12:05 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 16:12:05 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 16:12:05 volumio volumio[1148]: info: Discovery: Getting this device information May 26 16:12:05 volumio volumio[1148]: info: CoreCommandRouter::volumioGetState May 26 16:12:05 volumio volumio[1148]: info: CorePlayQueue::getTrack 0 May 26 16:12:05 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 16:12:05 volumio volumio5-onboarding[1532]: time=2026-05-26T16:12:05.224+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:12:05 volumio volumio5-onboarding[1532]: time=2026-05-26T16:12:05.224+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:12:05 volumio volumio5-onboarding[1532]: time=2026-05-26T16:12:05.225+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:12:05 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 16:12:05 volumio volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 16:12:10 volumio wpa_supplicant[882]: wlan0: Failed to initiate sched scan May 26 16:12:10 volumio volumio[1148]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ May 26 16:12:10 volumio volumio[1148]: info: PLUGIN onShutdown : networkfs May 26 16:12:10 volumio volumio[1148]: info: PLUGIN onShutdown : audiophonicsonoff May 26 16:12:10 volumio volumio[1148]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 16:12:10 volumio volumio[1148]: TypeError: Cannot read property 'writeSync' of undefined May 26 16:12:10 volumio volumio[1148]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) May 26 16:12:10 volumio volumio[1148]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) May 26 16:12:10 volumio volumio[1148]: at HashMap. (/volumio/app/pluginmanager.js:621:31) May 26 16:12:10 volumio volumio[1148]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) May 26 16:12:10 volumio volumio[1148]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) May 26 16:12:10 volumio volumio[1148]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) May 26 16:12:10 volumio volumio[1148]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1328:22) May 26 16:12:10 volumio volumio[1148]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) May 26 16:12:10 volumio volumio[1148]: at Socket.emit (events.js:315:20) May 26 16:12:10 volumio volumio[1148]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 26 16:12:10 volumio volumio[1148]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 26 16:12:10 volumio volumio[1148]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 16:12:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:12:10.827+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.73:60758 @ 0x1959560" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:12:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:12:10.827+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.1.71:57706 @ 0x1cae930" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:12:10 volumio volumio5-onboarding[1532]: time=2026-05-26T16:12:10.828+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.71:57706 @ 0x1cae210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 26 16:12:11 volumio sudo[8222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-26 16:11 May 26 16:12:11 volumio sudo[8222]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"