-- Logs begin at Sat 2026-02-21 04:25:47 GMT, end at Sat 2026-02-21 11:49:13 GMT. -- Feb 21 11:48:20 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:20.267Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.235:55961 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.237Z level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.235:55961 @ 0x3400090" latency=26.518464ms platform=PLATFORM_IOS version=4.251125.0 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.240Z level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.235:55961 @ 0x3400090" latency=28.491277ms timeout=10s Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.240Z level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" Feb 21 11:48:21 volumio volumio[1155]: info: Received Get System Info Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:21 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:21 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.242Z level=INFO msg="emitting device name changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" name=Volumio Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.242Z level=INFO msg="emitting device language changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" language=en Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.243Z level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" timezone=Europe/London Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.243Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" available=true connected=false macAddress= ip4Address= ip6Address= Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.245Z level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" available=true connected=true macAddress=2c:cf:67:20:09:42 ip4Address=192.168.1.24/24 ip6Address= ssid="Wu Tang LAN" Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.245Z level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" setupComplete=true Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.246Z level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.235:55961 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.246Z level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.235:55961 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.262Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.235:55963 Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 11:48:21 volumio volumio[1155]: amixer -c 0 info | grep "vc4-hdmi-0" Feb 21 11:48:21 volumio volumio[1155]: Card hw:0 'vc4hdmi0'/'vc4-hdmi-0' Feb 21 11:48:21 volumio volumio[1155]: amixer -c 1 info | grep "vc4-hdmi-1" Feb 21 11:48:21 volumio volumio[1155]: Card hw:1 'vc4hdmi1'/'vc4-hdmi-1' Feb 21 11:48:21 volumio volumio[1155]: amixer -c 5 info | grep "USB Modi Device" Feb 21 11:48:21 volumio volumio[1155]: Card hw:5 'Device'/'Schiit Audio USB Modi Device at usb-xhci-hcd.1-2, high speed' Feb 21 11:48:21 volumio volumio[1155]: amixer -c 5 info | grep "USB Modi Device" Feb 21 11:48:21 volumio volumio[1155]: Card hw:5 'Device'/'Schiit Audio USB Modi Device at usb-xhci-hcd.1-2, high speed' Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.392Z level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" selectedOutputId=5 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.393Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_AUDIO_OUTPUTS_CHANGED error="no addresses to write to" Feb 21 11:48:21 volumio volumio[1155]: info: Received Get System Info Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:21 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:21 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=INFO msg="emitting software info changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" currentVersion=3.908 latestVersion=3.908 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_SOFTWARE_INFO_CHANGED error="no addresses to write to" Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=INFO msg="emitting software update progress event" component=server peer="192.168.1.235:55961 @ 0x3400090" status=UPDATE_STATUS_NONE progress=0 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_SOFTWARE_UPDATE_PROGRESS error="no addresses to write to" Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=INFO msg="emitting user changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" userId=ySzxUW854MQYTt4UqZfpYmGcON13 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_USER_CHANGED error="no addresses to write to" Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" providers=9 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_MUSIC_PROVIDERS_CHANGED error="no addresses to write to" Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" plugins=54 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.504Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_PLUGINS_CHANGED error="no addresses to write to" Feb 21 11:48:21 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:21 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.505Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" state=STATUS_STOPPED positionMs=0 volume= Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.505Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="no addresses to write to" Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.505Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.235:55961 @ 0x3400090" id="mnt/NAS/iTunes/Sault/7/01 Over.m4a" title=Over Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.506Z level=ERROR msg="failed to send event" component=server dst=" @ 0x3400090" event=SERVER_EVENT_TYPE_PLAYER_METADATA_CHANGED error="no addresses to write to" Feb 21 11:48:21 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:21.506Z level=ERROR msg="failed to send response" component=server dst=" @ 0x3400090" id=292790204 status=STATUS_OK error="no addresses to write to" Feb 21 11:48:25 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:25.766Z level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.235:55963 Feb 21 11:48:25 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:25.766Z level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.235:55963 Feb 21 11:48:25 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:25.770Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.235:55965 Feb 21 11:48:46 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:46 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:46 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:46 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:46 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:46 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:46 volumio volumio[1155]: verbose: New Socket.io Connection to 192.168.1.24:3000 from 192.168.1.55 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 11:48:46 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 11:48:46 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 11:48:46 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:46.885Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.55:64754 Feb 21 11:48:49 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:49 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:49 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:49 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:49 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:49 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:49 volumio volumio[1155]: verbose: New Socket.io Connection to 192.168.1.24:3000 from 192.168.1.55 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 11:48:49 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 11:48:49 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 11:48:51 volumio volumio[1155]: verbose: New Socket.io Connection to 192.168.1.24:3000 from 192.168.1.55 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:51 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:51 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.150Z level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.55:64754 @ 0x3933950" latency=20.492369ms platform=PLATFORM_IOS version=5.260120.0 Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.151Z level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.55:64754 @ 0x3933950" latency=18.38217ms timeout=10s Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.151Z level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" Feb 21 11:48:51 volumio volumio[1155]: info: Received Get System Info Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:51 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:51 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.152Z level=INFO msg="emitting device name changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" name=Volumio Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.153Z level=INFO msg="emitting device language changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" language=en Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.153Z level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" timezone=Europe/London Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.154Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" available=true connected=false macAddress= ip4Address= ip6Address= Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.155Z level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" available=true connected=true macAddress=2c:cf:67:20:09:42 ip4Address=192.168.1.24/24 ip6Address= ssid="Wu Tang LAN" Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.155Z level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" setupComplete=true Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 11:48:51 volumio volumio[1155]: amixer -c 0 info | grep "vc4-hdmi-0" Feb 21 11:48:51 volumio volumio[1155]: Card hw:0 'vc4hdmi0'/'vc4-hdmi-0' Feb 21 11:48:51 volumio volumio[1155]: amixer -c 1 info | grep "vc4-hdmi-1" Feb 21 11:48:51 volumio volumio[1155]: Card hw:1 'vc4hdmi1'/'vc4-hdmi-1' Feb 21 11:48:51 volumio volumio[1155]: amixer -c 5 info | grep "USB Modi Device" Feb 21 11:48:51 volumio volumio[1155]: Card hw:5 'Device'/'Schiit Audio USB Modi Device at usb-xhci-hcd.1-2, high speed' Feb 21 11:48:51 volumio volumio[1155]: amixer -c 5 info | grep "USB Modi Device" Feb 21 11:48:51 volumio volumio[1155]: Card hw:5 'Device'/'Schiit Audio USB Modi Device at usb-xhci-hcd.1-2, high speed' Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.302Z level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" selectedOutputId=5 Feb 21 11:48:51 volumio volumio[1155]: info: Received Get System Info Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:51 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:51 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.395Z level=INFO msg="emitting software info changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" currentVersion=3.908 latestVersion=3.908 Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.395Z level=INFO msg="emitting software update progress event" component=server peer="192.168.1.55:64754 @ 0x3933950" status=UPDATE_STATUS_NONE progress=0 Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.395Z level=INFO msg="emitting user changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" userId=ySzxUW854MQYTt4UqZfpYmGcON13 Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.395Z level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" providers=9 Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.395Z level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" plugins=54 Feb 21 11:48:51 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:51 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.397Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" state=STATUS_STOPPED positionMs=0 volume= Feb 21 11:48:51 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:51.397Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.55:64754 @ 0x3933950" id="mnt/NAS/iTunes/Sault/7/01 Over.m4a" title=Over Feb 21 11:48:54 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:54.689Z level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.1.235:55965 error="websocket: close 1006 (abnormal closure): unexpected EOF" Feb 21 11:48:54 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:54.689Z level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.235:55965 Feb 21 11:48:54 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:54.689Z level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.235:55965 Feb 21 11:48:56 volumio volumio5-onboarding[1558]: time=2026-02-21T11:48:56.154Z level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.55:64754 @ 0x3933950" latency=51.072566ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 21 11:48:56 volumio sudo[25191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 11:48:56 volumio sudo[25191]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 11:48:56 volumio sudo[25191]: pam_unix(sudo:session): session closed for user root Feb 21 11:48:56 volumio sudo[25194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 11:48:56 volumio sudo[25194]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 11:48:56 volumio sudo[25194]: pam_unix(sudo:session): session closed for user root Feb 21 11:48:56 volumio volumio[1155]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.55 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 11:48:56 volumio sudo[25197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 11:48:56 volumio sudo[25197]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 11:48:56 volumio sudo[25197]: pam_unix(sudo:session): session closed for user root Feb 21 11:48:56 volumio sudo[25200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 11:48:56 volumio sudo[25200]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 11:48:56 volumio sudo[25200]: pam_unix(sudo:session): session closed for user root Feb 21 11:48:56 volumio volumio[1155]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.55 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:56 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::volumioGetQueue Feb 21 11:48:56 volumio volumio[1155]: info: CoreStateMachine::getQueue Feb 21 11:48:56 volumio volumio[1155]: info: CorePlayQueue::getQueue Feb 21 11:48:56 volumio volumio[1155]: info: Listing playlists Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 11:48:56 volumio volumio[1155]: info: Received Get System Info Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:56 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:56 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:56 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 21 11:48:56 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 11:48:57 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 21 11:48:58 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 21 11:48:58 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 11:48:58 volumio volumio[1155]: info: Received Get System Info Feb 21 11:48:58 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:48:58 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:48:58 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:48:58 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:48:58 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:48:58 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:48:58 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 11:49:01 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 11:49:01 volumio volumio[1155]: info: Received Get System Info Feb 21 11:49:01 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:49:01 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:49:01 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:49:01 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:49:01 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:49:01 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 11:49:02 volumio volumio[1155]: info: Received Get System Info Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:49:02 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:49:02 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 11:49:02 volumio volumio[1155]: info: Received Get System Info Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 11:49:02 volumio volumio[1155]: info: Discovery: Getting this device information Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::volumioGetState Feb 21 11:49:02 volumio volumio[1155]: info: CorePlayQueue::getTrack 0 Feb 21 11:49:02 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 11:49:06 volumio volumio[1155]: Searching all installed plugins Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: , search Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Feb 21 11:49:06 volumio volumio[1155]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Feb 21 11:49:06 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 21 11:49:07 volumio volumio[1155]: Searching all installed plugins Feb 21 11:49:07 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 11:49:07 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: , search Feb 21 11:49:07 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 21 11:49:07 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 21 11:49:07 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Feb 21 11:49:07 volumio volumio[1155]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Feb 21 11:49:07 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 21 11:49:07 volumio volumio[1155]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Feb 21 11:49:11 volumio volumio[1155]: error: Search in plugin soundcloud timed out Feb 21 11:49:11 volumio volumio[1155]: info: All search sources collected, pushing search results Feb 21 11:49:12 volumio volumio[1155]: error: Search in plugin soundcloud timed out Feb 21 11:49:12 volumio volumio[1155]: info: All search sources collected, pushing search results Feb 21 11:49:12 volumio volumio[1155]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 21 11:49:13 volumio volumio[1155]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 21 11:49:13 volumio volumio[1155]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Stevie%20Wonder/f9a3bbc7-a600-4b5e-9dee-fb3b7ec8683a.jpg' Feb 21 11:49:13 volumio volumio[1155]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Stevie%20Nicks/68ddb533-9483-4c5d-be63-fcae7b692a5c.jpg' Feb 21 11:49:13 volumio volumio[1155]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 11:49:13 volumio volumio[1155]: Error: Client network socket disconnected before secure TLS connection was established Feb 21 11:49:13 volumio volumio[1155]: at connResetException (internal/errors.js:607:14) Feb 21 11:49:13 volumio volumio[1155]: at TLSSocket.onConnectEnd (_tls_wrap.js:1544:19) Feb 21 11:49:13 volumio volumio[1155]: at TLSSocket.emit (events.js:327:22) Feb 21 11:49:13 volumio volumio[1155]: at endReadableNT (internal/streams/readable.js:1327:12) Feb 21 11:49:13 volumio volumio[1155]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Feb 21 11:49:13 volumio volumio[1155]: code: 'ECONNRESET', Feb 21 11:49:13 volumio volumio[1155]: path: null, Feb 21 11:49:13 volumio volumio[1155]: host: 'assets.fanart.tv', Feb 21 11:49:13 volumio volumio[1155]: port: 443, Feb 21 11:49:13 volumio volumio[1155]: localAddress: undefined Feb 21 11:49:13 volumio volumio[1155]: } Feb 21 11:49:13 volumio volumio[1155]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 11:49:13 volumio sudo[25289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 11:48 Feb 21 11:49:13 volumio sudo[25289]: 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="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"