Oct 03 09:31:03 harshahifi ntpd[1121]: CLOCK: time stepped by 1650100.391469 Oct 03 09:31:03 harshahifi ntpd[1121]: CLOCK: time changed from 2026-09-14 to 2026-10-03 Oct 03 09:31:03 harshahifi ntpd[1121]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Oct 03 09:31:03 harshahifi systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Oct 03 09:31:03 harshahifi systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Oct 03 09:31:03 harshahifi systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Oct 03 09:31:03 harshahifi systemd[1]: e2scrub_all.service: Deactivated successfully. Oct 03 09:31:03 harshahifi systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Oct 03 09:31:03 harshahifi systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Oct 03 09:31:03 harshahifi systemd[1]: dpkg-db-backup.service: Deactivated successfully. Oct 03 09:31:03 harshahifi systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Oct 03 09:31:03 harshahifi volumio[1369]: info: Initializing connection to go-librespot Websocket Oct 03 09:31:03 harshahifi go-librespot[1670]: time="2026-10-03T09:31:03+05:30" level=debug msg="new websocket client" Oct 03 09:31:03 harshahifi volumio[1369]: info: Connection to go-librespot Websocket established Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.056+05:30 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.31.26:59826 Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.121+05:30 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.31.26:59826 @ 0x2001980" latency=-551.172655ms timeout=20s Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.121+05:30 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.31.26:59826 @ 0x2001980" latency=-550.27234ms platform=PLATFORM_ANDROID version=6.260930.0 Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.121+05:30 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 03 09:31:04 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:04 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:04 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.124+05:30 level=INFO msg="emitting device name changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" name=HarshaHiFi Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.125+05:30 level=INFO msg="emitting device language changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" language=en Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.126+05:30 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" timezone=Asia/Calcutta Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.127+05:30 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" available=true connected=false macAddress= ip4Address= ip6Address= Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.128+05:30 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" available=true connected=true macAddress=d8:3a:dd:c5:9a:53 ip4Address=192.168.31.225/24 ip6Address= ssid=Harshavardhan Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.129+05:30 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" setupComplete=true Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 03 09:31:04 harshahifi volumio[1369]: amixer -c 2 info | grep "HiFiBerry Digi+ Pro HiFi wm8804-spdif-0" Oct 03 09:31:04 harshahifi volumio[1369]: amixer -c 0 info | grep "vc4-hdmi-0" Oct 03 09:31:04 harshahifi volumio[1369]: Card sysdefault:0 'vc4hdmi0'/'vc4-hdmi-0' Oct 03 09:31:04 harshahifi volumio[1369]: amixer -c 1 info | grep "vc4-hdmi-1" Oct 03 09:31:04 harshahifi volumio[1369]: Card sysdefault:1 'vc4hdmi1'/'vc4-hdmi-1' Oct 03 09:31:04 harshahifi volumio[1369]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 2 Oct 03 09:31:04 harshahifi volumio[1369]: /bin/sh: 1: /usr/local/bin/alsacap: not found Oct 03 09:31:04 harshahifi volumio[1369]: {"cmd":"/usr/local/bin/alsacap -C 2","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 2\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Oct 03 09:31:04 harshahifi volumio[1369]: amixer -c 2 info | grep "snd_rpi_hifiberry_digi" Oct 03 09:31:04 harshahifi volumio[1369]: Card sysdefault:2 'sndrpihifiberry'/'snd_rpi_hifiberry_digi' Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.170+05:30 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" selectedOutputId=2 Oct 03 09:31:04 harshahifi volumio[1369]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 03 09:31:04 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:04 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:04 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.260+05:30 level=INFO msg="emitting software info changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" currentVersion=4.119 latestVersion=4.119 Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.260+05:30 level=INFO msg="emitting software update progress event" component=server peer="192.168.31.26:59826 @ 0x2001980" status=UPDATE_STATUS_NONE progress=0 Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.260+05:30 level=INFO msg="emitting user changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" userId= Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.260+05:30 level=INFO msg="emitting music providers changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" providers=3 Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.261+05:30 level=INFO msg="emitting plugins changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" plugins=0 Oct 03 09:31:04 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:04 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.263+05:30 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" state=STATUS_STOPPED positionMs=0 volume=100 Oct 03 09:31:04 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:04.263+05:30 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.26:59826 @ 0x2001980" id=spotify:track:53yNQgE8EUyEtx2ChQ550W title="Vakratunda Mahakaya" Oct 03 09:31:04 harshahifi volumio[1369]: info: Volumio Network Manager: Network status updated: 2 Oct 03 09:31:06 harshahifi volumio[1369]: info: Getting Spotify volume Oct 03 09:31:06 harshahifi volumio[1369]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 03 09:31:06 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:06 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:06 harshahifi volumio[1369]: info: Discovery: Started advertising with name: HarshaHiFi Oct 03 09:31:07 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:07 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:07 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:07 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:07 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:07 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:07 harshahifi volumio[1369]: info: Discovery: adding bd492796-499d-4bea-ae5d-af26da26ef5b Oct 03 09:31:07 harshahifi volumio[1369]: info: Discovery: Found device HarshaHiFi Oct 03 09:31:07 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:07 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:07 harshahifi volumio[1369]: verbose: New Socket.io Connection to 192.168.31.225:3000 from 192.168.31.26 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 03 09:31:07 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 03 09:31:07 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 03 09:31:08 harshahifi volumio[1369]: info: Discovery: this is already registered, bd492796-499d-4bea-ae5d-af26da26ef5b Oct 03 09:31:08 harshahifi volumio[1369]: info: Discovery: Found device HarshaHiFi Oct 03 09:31:08 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:08 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:09 harshahifi systemd[1]: systemd-fsckd.service: Deactivated successfully. Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 03 09:31:10 harshahifi volumio[1369]: info: Adding plugin bluetooth to MyMusic Plugins Oct 03 09:31:10 harshahifi volumio[1369]: info: Adding plugin multiroom to MyMusic Plugins Oct 03 09:31:10 harshahifi volumio[1369]: info: Adding plugin metavolumio to MyMusic Plugins Oct 03 09:31:10 harshahifi volumio[1369]: info: Adding plugin cd_controller to MyMusic Plugins Oct 03 09:31:10 harshahifi volumio[1369]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 03 09:31:10 harshahifi volumio[1369]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 03 09:31:10 harshahifi volumio[1369]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 03 09:31:10 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 03 09:31:10 harshahifi dhcpcd[924]: timed out Oct 03 09:31:10 harshahifi sh[904]: timed out Oct 03 09:31:10 harshahifi sh[844]: ifup: failed to bring up eth0 Oct 03 09:31:10 harshahifi systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Oct 03 09:31:10 harshahifi systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Oct 03 09:31:11 harshahifi volumio[1369]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 03 09:31:11 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 03 09:31:11 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:11 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:11 harshahifi volumio[1369]: info: Starting MyVolumio Remote Streaming Endpoints Oct 03 09:31:11 harshahifi volumio[1369]: info: MyVolumio login type: Token Oct 03 09:31:11 harshahifi volumio[1369]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 03 09:31:11 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 03 09:31:11 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 03 09:31:11 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 03 09:31:11 harshahifi volumio[1369]: info: Streaming services startup Oct 03 09:31:11 harshahifi volumio[1369]: info: Starting Streaming Daemon Oct 03 09:31:11 harshahifi sudo[1782]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 03 09:31:11 harshahifi sudo[1782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:11 harshahifi volumio[1369]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 03 09:31:11 harshahifi sudo[1782]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:11 harshahifi volumio[1369]: error: Cannot start Volumio Streaming Daemon Oct 03 09:31:11 harshahifi volumio[1369]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 03 09:31:11 harshahifi volumio[1369]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 03 09:31:11 harshahifi systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 03 09:31:11 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:11.688+05:30 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.31.26:59826 @ 0x2001980" latency=-560.075755ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 03 09:31:11 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:11.779+05:30 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s Oct 03 09:31:12 harshahifi volumio[1369]: error: MyVolumio Custom Token format not valid, refreshing it Oct 03 09:31:12 harshahifi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Oct 03 09:31:12 harshahifi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 03 09:31:12 harshahifi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 03 09:31:12 harshahifi upmpdcli[1802]: Could not open config: /tmp/upmpdcli.conf Oct 03 09:31:12 harshahifi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 03 09:31:12 harshahifi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 03 09:31:12 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:12.544+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=765.513446ms Oct 03 09:31:12 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:12.694+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://www.googleapis.com duration=914.716486ms Oct 03 09:31:12 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:12.861+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://securetoken.googleapis.com duration=1.081944943s Oct 03 09:31:13 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:13.030+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=1.250371325s Oct 03 09:31:13 harshahifi sudo[1804]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 03 09:31:13 harshahifi sudo[1804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:13 harshahifi sudo[1806]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 03 09:31:13 harshahifi sudo[1806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:13 harshahifi sudo[1804]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:13 harshahifi sudo[1806]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:13 harshahifi volumio[1369]: verbose: New Socket.io Connection to 192.168.31.225 from 192.168.31.26 UA: Mozilla/5.0 (Linux; Android 17; Pixel 7 Build/CP3A.260905.009; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.36 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 03 09:31:13 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:13.375+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://database.volumio.cloud duration=1.594978419s Oct 03 09:31:13 harshahifi sudo[1811]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 03 09:31:13 harshahifi sudo[1811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:13 harshahifi sudo[1811]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:13 harshahifi sudo[1812]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 03 09:31:13 harshahifi sudo[1812]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:13 harshahifi sudo[1812]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:13 harshahifi volumio[1369]: verbose: New Socket.io Connection to 192.168.31.225 from 192.168.31.26 UA: Mozilla/5.0 (Linux; Android 17; Pixel 7 Build/CP3A.260905.009; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.36 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 03 09:31:13 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:13.744+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=1.965028167s Oct 03 09:31:13 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:13.755+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://google.com duration=1.976753105s Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetVisibleSources Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:13 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 03 09:31:13 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:13 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:13 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:13 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:13 harshahifi volumio[1369]: info: Listing playlists Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 03 09:31:13 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 03 09:31:14 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:14.031+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=http://pushupdates.volumio.org duration=2.25164151s Oct 03 09:31:14 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 03 09:31:14 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:14.795+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=3.016803124s Oct 03 09:31:15 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 03 09:31:15 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 09:31:15 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:15 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:15 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:15 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:15 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:15 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:15 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:16 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:16.836+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://functions.volumio.cloud duration=5.056766351s Oct 03 09:31:16 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:16.837+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=https://functions.volumio.cloud duration=5.057061728s Oct 03 09:31:16 harshahifi volumio[1369]: info: MyVolumio login type: Token Oct 03 09:31:18 harshahifi volumio[1369]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 03 09:31:18 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 09:31:18 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 03 09:31:18 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 09:31:18 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:18 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:18 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:18 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:18 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:18 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:18 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:18 harshahifi volumio[1369]: info: MyVolumio token set successfully Oct 03 09:31:18 harshahifi volumio[1369]: info: MYVOLUMIO: Adding device Oct 03 09:31:18 harshahifi volumio[1369]: info: MYVOLUMIO: Evaluating Server Oct 03 09:31:19 harshahifi volumio[1369]: info: MyVolumio status changed Oct 03 09:31:19 harshahifi volumio[1369]: info: Streaming services startup Oct 03 09:31:19 harshahifi volumio[1369]: info: Starting Streaming Daemon Oct 03 09:31:19 harshahifi volumio[1369]: info: Removing browser output: myVolumio user plan is not superstar Oct 03 09:31:19 harshahifi volumio[1369]: info: Removing audio output: Oct 03 09:31:19 harshahifi volumio[1369]: info: Stoppping Tunnel 1 Oct 03 09:31:19 harshahifi sudo[1850]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 03 09:31:19 harshahifi sudo[1850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:19 harshahifi sudo[1852]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 03 09:31:19 harshahifi sudo[1852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:19 harshahifi sudo[1850]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:19 harshahifi volumio[1369]: error: Cannot start Volumio Streaming Daemon Oct 03 09:31:19 harshahifi volumio[1369]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 03 09:31:19 harshahifi volumio[1369]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 03 09:31:19 harshahifi sudo[1852]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:19 harshahifi volumio[1369]: info: Remote SSH Stopped Oct 03 09:31:20 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:20.490+05:30 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=http://plugins.volumio.org duration=8.710561258s Oct 03 09:31:20 harshahifi bluealsa[1082]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_4A_CB_47_B9_EE_83, ...) Oct 03 09:31:20 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:20.964+05:30 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.31.26:59826 @ 0x2001980" latency=-554.040947ms timeout=10s endpoint=http://cddb.volumio.org duration=9.184381983s error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 03 09:31:22 harshahifi volumio[1369]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 09:31:22 harshahifi volumio5-onboarding[1648]: time=2026-10-03T09:31:22.986+05:30 level=INFO msg="new address was allocated" component=ble/conn old=1 new=2 Oct 03 09:31:23 harshahifi dbus-daemon[962]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.18" (uid=0 pid=1648 comm="/usr/bin/volumio5-onboarding") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.2" (uid=0 pid=961 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Oct 03 09:31:23 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 03 09:31:24 harshahifi volumio[1369]: info: Setting Geolocation for MyVolumio to as2 Oct 03 09:31:24 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:24 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:24 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:25 harshahifi volumio[1369]: info: Updating MyVolumio device info Oct 03 09:31:25 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:25 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:25 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:25 harshahifi volumio[1369]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 03 09:31:26 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 03 09:31:26 harshahifi volumio[1369]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 03 09:31:26 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:26 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:27 harshahifi volumio[1369]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 03 09:31:27 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 03 09:31:27 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:27 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 03 09:31:27 harshahifi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Oct 03 09:31:27 harshahifi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 03 09:31:27 harshahifi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 03 09:31:27 harshahifi upmpdcli[1874]: Could not open config: /tmp/upmpdcli.conf Oct 03 09:31:27 harshahifi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 03 09:31:27 harshahifi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 03 09:31:27 harshahifi volumio-remote-updater[974]: Test mode disabled Oct 03 09:31:27 harshahifi volumio-remote-updater[974]: Alpha mode disabled Oct 03 09:31:27 harshahifi volumio-remote-updater[974]: Alpha legacy test mode disabled Oct 03 09:31:27 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 03 09:31:28 harshahifi volumio[1369]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 03 09:31:28 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 03 09:31:28 harshahifi systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 03 09:31:29 harshahifi volumio[1369]: info: MYVOLUMIO: Adding device Oct 03 09:31:29 harshahifi volumio[1369]: info: MYVOLUMIO: Evaluating Server Oct 03 09:31:30 harshahifi volumio[1369]: info: Setting Geolocation for MyVolumio to as2 Oct 03 09:31:30 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:30 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:30 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:30 harshahifi volumio[1369]: info: Received OAUTH Data Oct 03 09:31:30 harshahifi volumio[1369]: info: Executing Spotify Oauth Login Oct 03 09:31:30 harshahifi volumio[1369]: info: Saving Spotify Refresh Token Oct 03 09:31:30 harshahifi volumio[1369]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetBrowseSources Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 03 09:31:31 harshahifi sudo[1911]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 03 09:31:31 harshahifi sudo[1911]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:31 harshahifi sudo[1913]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 03 09:31:31 harshahifi sudo[1913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:31 harshahifi sudo[1911]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:31 harshahifi sudo[1913]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:31 harshahifi volumio[1369]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 03 09:31:31 harshahifi volumio[1369]: info: Completed starting MyVolumio Plugin Oct 03 09:31:31 harshahifi volumio[1369]: [Metrics] CommandRouter: 37s 390.52ms Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::volumiosetStartupVolume Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::Close All Modals sent Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::Close All Modals sent Oct 03 09:31:31 harshahifi volumio[1369]: verbose: New Socket.io Connection to 192.168.31.225 from 192.168.31.26 UA: Mozilla/5.0 (Linux; Android 17; Pixel 7 Build/CP3A.260905.009; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.36 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetVisibleSources Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:31 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 03 09:31:31 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:31 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:31 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:31 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:31 harshahifi volumio[1369]: info: Listing playlists Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 03 09:31:31 harshahifi volumio[1369]: info: Updating MyVolumio device info Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 09:31:31 harshahifi volumio[1369]: info: New Spotify access tokenBQASFpe1Cd... Oct 03 09:31:31 harshahifi volumio[1369]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 03 09:31:31 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 03 09:31:32 harshahifi volumio[1369]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 03 09:31:32 harshahifi volumio[1369]: SPOTIFY: User informations: {"account_id":"JFyaScyQHu","country":"IN","display_name":"Harshavardhan Raju","email":"dhvraju@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/12101063779"},"followers":{"href":null,"total":6},"href":"https://api.spotify.com/v1/users/12101063779","id":"12101063779","images":[{"height":300,"url":"https://scontent-cdg4-2.xx.fbcdn.net/v/t1.6435-1/62070563_10216183754880271_6350310306224275456_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=100&ccb=1-7&_nc_sid=08baa4&_nc_ohc=pfHwj7hUltkQ7kNvwGxS5pD&_nc_oc=AdqePvVlXP5Eei7uMSzF1l9Eb1XG5FswzTnvf-RCauQXUiv0qWBesvRiPslkumege-uAd8JThc3wJkHkaB56Ub_M&_nc_zt=24&_nc_ht=scontent-cdg4-2.xx&edm=AP4hL3IEAAAA&_nc_gid=HT9PbBq1FL3n-2cEsUaj8Q&_nc_tpa=Q5bMBQJ-YKrHKm6S4NqFkQsf1mu5JbDol5umOWR2Ec91GIXVIzh3OgE5GX-EAlGV51E5n1fgazVC&oh=00_AQNharhzsSZi3ZhV7xzXW-RRy-23xTXpCo4T3J_YaNsg-g&oe=6AE79F66","width":300},{"height":64,"url":"https://scontent-cdg4-2.xx.fbcdn.net/v/t1.6435-1/62070563_10216183754880271_6350310306224275456_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=100&ccb=1-7&_nc_sid=28885b&_nc_ohc=pfHwj7hUltkQ7kNvwGxS5pD&_nc_oc=AdqePvVlXP5Eei7uMSzF1l9Eb1XG5FswzTnvf-RCauQXUiv0qWBesvRiPslkumege-uAd8JThc3wJkHkaB56Ub_M&_nc_zt=24&_nc_ht=scontent-cdg4-2.xx&edm=AP4hL3IEAAAA&_nc_gid=HT9PbBq1FL3n-2cEsUaj8Q&_nc_tpa=Q5bMBQJox9_wAZZuXL6h4gDVlG0fWWbIIHRBb7ef4Pflg7P-pmQAme5QuWinuYT6uipH7fov3_we&oh=00_AQMd84XxnmfsDUfaK33Oub2Sv-11rkWIMk-3VH153xDnXw&oe=6AE79F66","width":64}],"product":"premium","type":"user","uri":"spotify:user:12101063779"} Oct 03 09:31:32 harshahifi volumio[1369]: info: Creating Spotify config file Oct 03 09:31:32 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 09:31:32 harshahifi volumio[1369]: info: Spotify config file written Oct 03 09:31:32 harshahifi sudo[1919]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 03 09:31:32 harshahifi sudo[1919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 09:31:32 harshahifi systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Oct 03 09:31:32 harshahifi volumio[1369]: info: Connection to go-librespot Websocket closed Oct 03 09:31:32 harshahifi systemd[1]: go-librespot-daemon.service: Deactivated successfully. Oct 03 09:31:32 harshahifi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 09:31:32 harshahifi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 09:31:32 harshahifi go-librespot[1921]: go-librespot daemon starting... Oct 03 09:31:32 harshahifi sudo[1919]: pam_unix(sudo:session): session closed for user root Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=info msg="running go-librespot 0.7.1" Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=debug msg="app state loaded" Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 09:31:32 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 03 09:31:32 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 03 09:31:32 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 03 09:31:32 harshahifi volumio[1369]: info: New Spotify access tokenBQD8XIW3gq... Oct 03 09:31:32 harshahifi volumio[1369]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=info msg="zeroconf server listening on port 36693" Oct 03 09:31:32 harshahifi go-librespot[1922]: time="2026-10-03T09:31:32+05:30" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 03 09:31:33 harshahifi volumio[1369]: SPOTIFY: User informations: {"account_id":"JFyaScyQHu","country":"IN","display_name":"Harshavardhan Raju","email":"dhvraju@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/12101063779"},"followers":{"href":null,"total":6},"href":"https://api.spotify.com/v1/users/12101063779","id":"12101063779","images":[{"height":300,"url":"https://scontent-cdg4-2.xx.fbcdn.net/v/t1.6435-1/62070563_10216183754880271_6350310306224275456_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=100&ccb=1-7&_nc_sid=08baa4&_nc_ohc=pfHwj7hUltkQ7kNvwGxS5pD&_nc_oc=AdqePvVlXP5Eei7uMSzF1l9Eb1XG5FswzTnvf-RCauQXUiv0qWBesvRiPslkumege-uAd8JThc3wJkHkaB56Ub_M&_nc_zt=24&_nc_ht=scontent-cdg4-2.xx&edm=AP4hL3IEAAAA&_nc_gid=HT9PbBq1FL3n-2cEsUaj8Q&_nc_tpa=Q5bMBQJ-YKrHKm6S4NqFkQsf1mu5JbDol5umOWR2Ec91GIXVIzh3OgE5GX-EAlGV51E5n1fgazVC&oh=00_AQNharhzsSZi3ZhV7xzXW-RRy-23xTXpCo4T3J_YaNsg-g&oe=6AE79F66","width":300},{"height":64,"url":"https://scontent-cdg4-2.xx.fbcdn.net/v/t1.6435-1/62070563_10216183754880271_6350310306224275456_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=100&ccb=1-7&_nc_sid=28885b&_nc_ohc=pfHwj7hUltkQ7kNvwGxS5pD&_nc_oc=AdqePvVlXP5Eei7uMSzF1l9Eb1XG5FswzTnvf-RCauQXUiv0qWBesvRiPslkumege-uAd8JThc3wJkHkaB56Ub_M&_nc_zt=24&_nc_ht=scontent-cdg4-2.xx&edm=AP4hL3IEAAAA&_nc_gid=HT9PbBq1FL3n-2cEsUaj8Q&_nc_tpa=Q5bMBQJox9_wAZZuXL6h4gDVlG0fWWbIIHRBb7ef4Pflg7P-pmQAme5QuWinuYT6uipH7fov3_we&oh=00_AQMd84XxnmfsDUfaK33Oub2Sv-11rkWIMk-3VH153xDnXw&oe=6AE79F66","width":64}],"product":"premium","type":"user","uri":"spotify:user:12101063779"} Oct 03 09:31:33 harshahifi volumio[1369]: info: Spotify Successfully logged in Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 03 09:31:33 harshahifi volumio[1369]: info: [1791000093145] CoreMusicLibrary::Adding element Spotify Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 09:31:33 harshahifi volumio[1369]: Cannot find translation for source Spotify Oct 03 09:31:33 harshahifi go-librespot[1922]: time="2026-10-03T09:31:33+05:30" level=debug msg="obtained new client token: AAE/TbRyWSigieQ7boQcBW/2z95ijptIxCHIIMJqojcvwML4lnO8LkM+6eMtrxCamx5DbbMBHYzaUbFmWvNZ5ILuz9I8VP+k4/caW/7Xo9OQNhjDFmidEUfoGu6A79EpGeFs74ZZ+X/q4NiFFSImgoE8Z2m9RoNA+fDlY5bBKuPXcZxJL3XpT8/5GIzeUz3rIdISdspUM1tudDD7SjlerEhg1bdf3EXV0qifGjN+SrxAnBkh7pV3+CA=" Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 09:31:33 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:33 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:33 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:33 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:33 harshahifi go-librespot[1922]: time="2026-10-03T09:31:33+05:30" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 03 09:31:33 harshahifi go-librespot[1922]: time="2026-10-03T09:31:33+05:30" level=debug msg="completed keyexchange" Oct 03 09:31:33 harshahifi go-librespot[1922]: time="2026-10-03T09:31:33+05:30" level=debug msg="completed challenge" Oct 03 09:31:33 harshahifi go-librespot[1922]: time="2026-10-03T09:31:33+05:30" level=info msg="authenticated AP" username="12*******79" Oct 03 09:31:34 harshahifi go-librespot[1922]: time="2026-10-03T09:31:34+05:30" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 09:31:34 harshahifi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 09:31:34 harshahifi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 09:31:35 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 09:31:35 harshahifi volumio[1369]: info: Received Get System Info Oct 03 09:31:35 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 09:31:35 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 09:31:35 harshahifi volumio[1369]: info: Discovery: Getting this device information Oct 03 09:31:35 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetState Oct 03 09:31:35 harshahifi volumio[1369]: info: CorePlayQueue::getTrack 0 Oct 03 09:31:35 harshahifi volumio[1369]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 09:31:35 harshahifi volumio[1369]: info: Initializing connection to go-librespot Websocket Oct 03 09:31:35 harshahifi volumio[1369]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 09:31:35 harshahifi volumio[1369]: info: go-librespot daemon successfully initialized Oct 03 09:31:37 harshahifi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Oct 03 09:31:37 harshahifi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 09:31:37 harshahifi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 09:31:37 harshahifi go-librespot[1946]: go-librespot daemon starting... Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=info msg="running go-librespot 0.7.1" Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=debug msg="app state loaded" Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 09:31:37 harshahifi volumio[1369]: info: CoreCommandRouter::volumioGetQueue Oct 03 09:31:37 harshahifi volumio[1369]: info: CoreStateMachine::getQueue Oct 03 09:31:37 harshahifi volumio[1369]: info: CorePlayQueue::getQueue Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=info msg="zeroconf server listening on port 44213" Oct 03 09:31:37 harshahifi go-librespot[1947]: time="2026-10-03T09:31:37+05:30" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 09:31:38 harshahifi volumio[1369]: info: Initializing connection to go-librespot Websocket Oct 03 09:31:38 harshahifi volumio[1369]: info: Connection to go-librespot Websocket established Oct 03 09:31:38 harshahifi go-librespot[1947]: time="2026-10-03T09:31:38+05:30" level=debug msg="new websocket client" Oct 03 09:31:38 harshahifi volumio[1369]: info: Initializing connection to go-librespot Websocket Oct 03 09:31:38 harshahifi go-librespot[1947]: time="2026-10-03T09:31:38+05:30" level=debug msg="new websocket client" Oct 03 09:31:38 harshahifi volumio[1369]: info: Connection to go-librespot Websocket established Oct 03 09:31:38 harshahifi volumio[1369]: info: BOOT COMPLETED Oct 03 09:31:38 harshahifi go-librespot[1947]: time="2026-10-03T09:31:38+05:30" level=debug msg="obtained new client token: AAEVnV1zLbTFgdhHt2n7VEQNX2V7+D8TP8b8smXJNoDjsec9HZVYXAmMrMKR3wqg/9MKY/tAZLsDoNer8+ABo1xj6ywJckSW09GT5Ip+bacdcr0oeCgtH/JxlrBOsxCdFYhEhCSphdfAbUJhmWtWbKx1tO2lDKMbU9nBATNej8wW88qxaLhNEv1EvF4zFO4tidZaQV5L9Ywr0sm4yZAsw2/GJRqp9rBINNfBXtAZ2rbbTDTDy35eKrvxOQ==" Oct 03 09:31:38 harshahifi go-librespot[1947]: time="2026-10-03T09:31:38+05:30" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 03 09:31:38 harshahifi go-librespot[1947]: time="2026-10-03T09:31:38+05:30" level=debug msg="completed keyexchange" Oct 03 09:31:38 harshahifi go-librespot[1947]: time="2026-10-03T09:31:38+05:30" level=debug msg="completed challenge" Oct 03 09:31:38 harshahifi go-librespot[1947]: time="2026-10-03T09:31:38+05:30" level=info msg="authenticated AP" username="12*******79" Oct 03 09:31:39 harshahifi go-librespot[1947]: time="2026-10-03T09:31:39+05:30" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 09:31:39 harshahifi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 09:31:39 harshahifi volumio[1369]: info: Connection to go-librespot Websocket closed Oct 03 09:31:39 harshahifi volumio[1369]: info: Connection to go-librespot Websocket closed Oct 03 09:31:39 harshahifi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 09:31:41 harshahifi volumio[1369]: info: Getting Spotify volume Oct 03 09:31:41 harshahifi volumio[1369]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 09:31:41 harshahifi volumio[1369]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 09:31:41 harshahifi volumio[1369]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 03 09:31:41 harshahifi volumio[1369]: errno: -111, Oct 03 09:31:41 harshahifi volumio[1369]: code: 'ECONNREFUSED', Oct 03 09:31:41 harshahifi volumio[1369]: syscall: 'connect', Oct 03 09:31:41 harshahifi volumio[1369]: address: '127.0.0.1', Oct 03 09:31:41 harshahifi volumio[1369]: port: 9879, Oct 03 09:31:41 harshahifi volumio[1369]: response: undefined Oct 03 09:31:41 harshahifi volumio[1369]: } Oct 03 09:31:41 harshahifi volumio[1369]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 09:31:41 harshahifi sudo[1970]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-03 09:30' Oct 03 09:31:41 harshahifi sudo[1970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"