Oct 13 00:22:01 living-room volumio[13942]: info: Upmpdcli Daemon Started Oct 13 00:22:15 living-room volumio-remote-updater[848]: [2026-10-13 00:22:15] [connect] Successful connection Oct 13 00:22:20 living-room sudo[14462]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:22 living-room volumio5-onboarding[16718]: time=2026-10-13T00:22:16.463+01:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:33736->127.0.0.1:3000: i/o timeout" Oct 13 00:22:24 living-room systemd[1]: /lib/systemd/system/roonbridge.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 00:22:24 living-room systemd[1]: /lib/systemd/system/roonbridge.service:8: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 00:22:24 living-room systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 00:22:24 living-room systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 00:22:24 living-room 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 13 00:22:24 living-room 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 13 00:22:25 living-room systemd[1]: mpd.service: start operation timed out. Terminating. Oct 13 00:22:25 living-room systemd[1]: mpd.service: Failed with result 'timeout'. Oct 13 00:22:25 living-room systemd[1]: Failed to start mpd.service - Music Player Daemon. Oct 13 00:22:25 living-room systemd[1]: mpd.service: Consumed 8.049s CPU time. Oct 13 00:22:25 living-room systemd[1]: wpa_supplicant.service: Unexpected error response from GetNameOwner(): Connection terminated Oct 13 00:22:25 living-room systemd[1]: systemd-logind.service: Unexpected error response from GetNameOwner(): Connection terminated Oct 13 00:22:25 living-room systemd[1]: avahi-daemon.service: Unexpected error response from GetNameOwner(): Connection terminated Oct 13 00:22:25 living-room systemd[1]: systemd-networkd.service: Unexpected error response from GetNameOwner(): Connection terminated Oct 13 00:22:25 living-room systemd[1]: bluetooth.service: Unexpected error response from GetNameOwner(): Connection terminated Oct 13 00:22:25 living-room systemd[1]: bluealsa.service: Unexpected error response from GetNameOwner(): Connection terminated Oct 13 00:22:25 living-room systemd[1]: upower.service: Unexpected error response from GetNameOwner(): Connection terminated Oct 13 00:22:25 living-room systemd[1]: Got disconnect on API bus. Oct 13 00:22:26 living-room bluetoothd[907]: Terminating Oct 13 00:22:26 living-room systemd[1]: systemd-logind.service: Deactivated successfully. Oct 13 00:22:26 living-room systemd[1]: systemd-logind.service: Consumed 1min 27.721s CPU time. Oct 13 00:22:26 living-room avahi-daemon[1432]: Got SIGTERM, quitting. Oct 13 00:22:26 living-room bluealsa[1012]: ../src/ba-adapter.c:144: Freeing adapter: hci0 Oct 13 00:22:26 living-room bluetoothd[907]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 Oct 13 00:22:26 living-room bluetoothd[907]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 Oct 13 00:22:26 living-room bluetoothd[907]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 Oct 13 00:22:26 living-room bluetoothd[907]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 Oct 13 00:22:26 living-room systemd[1]: systemd-logind.service: Scheduled restart job, restart counter is at 1. Oct 13 00:22:26 living-room systemd[1]: Stopped systemd-logind.service - User Login Management. Oct 13 00:22:26 living-room systemd[1]: systemd-logind.service: Consumed 1min 27.721s CPU time. Oct 13 00:22:26 living-room avahi-daemon[1432]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.50.15. Oct 13 00:22:26 living-room avahi-daemon[1432]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Oct 13 00:22:26 living-room avahi-daemon[1432]: avahi-daemon 0.8 exiting. Oct 13 00:22:26 living-room sudo[14208]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:26 living-room sudo[14341]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:26 living-room sudo[14464]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:27 living-room systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 13 00:22:27 living-room systemd[1]: upower.service: Deactivated successfully. Oct 13 00:22:27 living-room systemd[1]: avahi-daemon.service: Deactivated successfully. Oct 13 00:22:27 living-room systemd[1]: avahi-daemon.service: Consumed 6min 50.890s CPU time. Oct 13 00:22:28 living-room systemd[1]: wpa_supplicant.service: Deactivated successfully. Oct 13 00:22:28 living-room systemd[1]: wpa_supplicant.service: Consumed 21.714s CPU time. Oct 13 00:22:29 living-room systemd[1]: bluealsa.service: Deactivated successfully. Oct 13 00:22:29 living-room dbus-daemon[834]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.9753' (uid=104 pid=12843 comm="/usr/bin/shairport-sync --configfile=/tmp/shairpor") Oct 13 00:22:29 living-room bluetoothd[907]: Destroy Adv Monitor Manager Oct 13 00:22:29 living-room bluetoothd[907]: Battery Provider Manager destroyed Oct 13 00:22:29 living-room bluetoothd[907]: Stopping SDP server Oct 13 00:22:29 living-room bluetoothd[907]: Exit Oct 13 00:22:29 living-room systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Oct 13 00:22:29 living-room systemd[1]: bluetooth.service: Deactivated successfully. Oct 13 00:22:29 living-room systemd[1]: bluetooth.service: Consumed 1.659s CPU time. Oct 13 00:22:29 living-room volumiobt[2623]: 2026-10-13 00:22:29 a2dp-agent [INFO] A2DP Agent Released Oct 13 00:22:30 living-room vtcs[5620]: [2026-10-13 00:22:30.303] [tisoc] [error] [avahiImpl.cpp:113] avahiClientCallback() AVAHI_CLIENT_S_COLLISION/AVAHI_CLIENT_FAILURE Oct 13 00:22:30 living-room systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 13 00:22:30 living-room systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 13 00:22:30 living-room systemd[1]: Starting systemd-logind.service - User Login Management... Oct 13 00:22:31 living-room avahi-daemon[14654]: Process 1432 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Oct 13 00:22:31 living-room volumio-remote-updater[848]: [2026-10-13 00:22:31] [connect] Successful connection Oct 13 00:22:32 living-room avahi-daemon[14654]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Oct 13 00:22:32 living-room avahi-daemon[14654]: Successfully dropped root privileges. Oct 13 00:22:32 living-room avahi-daemon[14654]: avahi-daemon 0.8 starting up. Oct 13 00:22:32 living-room dbus-daemon[834]: [system] Successfully activated service 'org.freedesktop.Avahi' Oct 13 00:22:32 living-room systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Oct 13 00:22:32 living-room avahi-daemon[14654]: Successfully called chroot(). Oct 13 00:22:32 living-room avahi-daemon[14654]: Successfully dropped remaining capabilities. Oct 13 00:22:32 living-room avahi-daemon[14654]: Loading service file /services/volumio.service. Oct 13 00:22:32 living-room avahi-daemon[14654]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.50.15. Oct 13 00:22:32 living-room avahi-daemon[14654]: New relevant interface wlan0.IPv4 for mDNS. Oct 13 00:22:32 living-room avahi-daemon[14654]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Oct 13 00:22:32 living-room avahi-daemon[14654]: New relevant interface lo.IPv4 for mDNS. Oct 13 00:22:32 living-room avahi-daemon[14654]: Network interface enumeration completed. Oct 13 00:22:32 living-room avahi-daemon[14654]: Registering new address record for 192.168.50.15 on wlan0.IPv4. Oct 13 00:22:32 living-room avahi-daemon[14654]: Registering new address record for 127.0.0.1 on lo.IPv4. Oct 13 00:22:33 living-room avahi-daemon[14654]: Server startup complete. Host name is living-room.local. Local service cookie is 2232443072. Oct 13 00:22:34 living-room avahi-daemon[14654]: Service "Living Room" (/services/volumio.service) successfully established. Oct 13 00:22:34 living-room systemd-logind[14660]: New seat seat0. Oct 13 00:22:34 living-room systemd-logind[14660]: Watching system buttons on /dev/input/event0 (vc4-hdmi-0) Oct 13 00:22:34 living-room systemd-logind[14660]: Watching system buttons on /dev/input/event2 (vc4-hdmi-1) Oct 13 00:22:34 living-room systemd[1]: Started systemd-logind.service - User Login Management. Oct 13 00:22:35 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 00:22:35 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 00:22:35 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 00:22:35 living-room volumio5-onboarding[16718]: time=2026-10-13T00:22:35.667+01:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:37372->127.0.0.1:3000: i/o timeout" Oct 13 00:22:35 living-room volumio[13942]: error: Plugin system_controller volumio5onboarding failed to complete 'onStart' in a timely fashion Oct 13 00:22:35 living-room volumio[13942]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Oct 13 00:22:35 living-room volumio[13942]: error: Plugin music_service metaroon failed to complete 'onStart' in a timely fashion Oct 13 00:22:35 living-room volumio[13942]: error: Plugin user_interface touch_display failed to complete 'onStart' in a timely fashion Oct 13 00:22:35 living-room volumio[13942]: info: ------------------------------------------- Oct 13 00:22:35 living-room volumio[13942]: info: ----- MyVolumio plugins startup ---- Oct 13 00:22:35 living-room volumio[13942]: info: ------------------------------------------- Oct 13 00:22:35 living-room volumio[13942]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 13 00:22:37 living-room volumio[13942]: error: [now-playing] Error fetching https://api.openweathermap.org/data/3.0/onecall?appid=a1d1e64a63d6e21014477a0232370e2d&lat=53.324183503460276&lon=-6.218396202234183&units=metric: TypeError: fetch failed Oct 13 00:22:37 living-room volumio[13942]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Oct 13 00:22:37 living-room volumio[13942]: at processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 00:22:37 living-room volumio[13942]: at runNextTicks (node:internal/process/task_queues:64:3) Oct 13 00:22:37 living-room volumio[13942]: at process.processImmediate (node:internal/timers:449:9) Oct 13 00:22:37 living-room volumio[13942]: at async fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:26:26) Oct 13 00:22:37 living-room volumio[13942]: at async Promise.all (index 0) Oct 13 00:22:37 living-room volumio[13942]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:91:24) Oct 13 00:22:37 living-room volumio[13942]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:104:45) Oct 13 00:22:37 living-room volumio[13942]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:301:25 Oct 13 00:22:38 living-room volumio[13942]: error: [now-playing] Error fetching https://api.openweathermap.org/data/2.5/weather?appid=a1d1e64a63d6e21014477a0232370e2d&lat=53.324183503460276&lon=-6.218396202234183&units=metric: TypeError: fetch failed Oct 13 00:22:38 living-room volumio[13942]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Oct 13 00:22:38 living-room volumio[13942]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 00:22:38 living-room volumio[13942]: at async fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:26:26) Oct 13 00:22:38 living-room volumio[13942]: at async Promise.all (index 1) Oct 13 00:22:38 living-room volumio[13942]: info: touch_display: systemctl daemon-reload succeeded. Oct 13 00:22:38 living-room volumio[13942]: error: touch_display: Failed to disable getty@tty1.service: Error: Command failed: /usr/bin/sudo /bin/systemctl disable getty@tty1.service Oct 13 00:22:38 living-room volumio[13942]: Failed to disable unit: Transport endpoint is not connected Oct 13 00:22:38 living-room volumio[13942]: error: touch_display: Failed to stop getty@tty1.service: Error: Command failed: /usr/bin/sudo /bin/systemctl stop getty@tty1.service Oct 13 00:22:38 living-room volumio[13942]: Failed to stop getty@tty1.service: Connection timed out Oct 13 00:22:38 living-room volumio[13942]: See system logs and 'systemctl status getty@tty1.service' for details. Oct 13 00:22:38 living-room volumio[13942]: info: metaroon: RoonBridge service started Oct 13 00:22:38 living-room volumio[13942]: info: metaroon: Creating new Roon API instance Oct 13 00:22:38 living-room volumio[13942]: info: metaroon: Starting Roon discovery Oct 13 00:22:38 living-room volumio[13942]: Setting up sood Oct 13 00:22:39 living-room volumio[13942]: Starting sood Oct 13 00:22:39 living-room volumio[13942]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 13 00:22:39 living-room volumio[13942]: Job for mpd.service failed because a timeout was exceeded. Oct 13 00:22:39 living-room volumio[13942]: See "systemctl status mpd.service" and "journalctl -xeu mpd.service" for details. Oct 13 00:22:39 living-room volumio[13942]: info: MPD Permissions set Oct 13 00:22:39 living-room volumio[13942]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 13 00:22:39 living-room volumio[13942]: Job for mpd.service failed because a timeout was exceeded. Oct 13 00:22:39 living-room volumio[13942]: See "systemctl status mpd.service" and "journalctl -xeu mpd.service" for details. Oct 13 00:22:39 living-room volumio[13942]: info: MPD Permissions set Oct 13 00:22:45 living-room sudo[14684]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Oct 13 00:22:45 living-room sudo[14681]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Oct 13 00:22:45 living-room volumio[13942]: info: An error occurred while refreshing Spotify Token Error: Client network socket disconnected before secure TLS connection was established Oct 13 00:22:45 living-room sudo[14684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 00:22:45 living-room sudo[14681]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 00:22:45 living-room sudo[14684]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:45 living-room systemd[1]: Starting mpd.service - Music Player Daemon... Oct 13 00:22:46 living-room sudo[14681]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:46 living-room sudo[14721]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 13 00:22:46 living-room sudo[14721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 00:22:46 living-room sudo[14721]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:46 living-room volumio-remote-updater[848]: [2026-10-13 00:22:46] [connect] Successful connection Oct 13 00:22:46 living-room volumio[13942]: info: Volumio called home Oct 13 00:22:47 living-room volumio[13942]: info: Spotify config file written Oct 13 00:22:47 living-room sudo[14725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 13 00:22:47 living-room sudo[14725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 00:22:47 living-room systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Oct 13 00:22:47 living-room systemd[1]: go-librespot-daemon.service: Deactivated successfully. Oct 13 00:22:47 living-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 00:22:47 living-room systemd[1]: go-librespot-daemon.service: Consumed 1.078s CPU time. Oct 13 00:22:47 living-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 00:22:47 living-room sudo[14725]: pam_unix(sudo:session): session closed for user root Oct 13 00:22:47 living-room go-librespot[14727]: go-librespot daemon starting... Oct 13 00:22:51 living-room volumio[13942]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 13 00:22:53 living-room go-librespot[14728]: time="2026-10-13T00:22:53+01:00" level=info msg="running go-librespot 0.7.1" Oct 13 00:22:53 living-room go-librespot[14728]: time="2026-10-13T00:22:53+01:00" level=debug msg="app state loaded" Oct 13 00:22:53 living-room volumio5-onboarding[16718]: time=2026-10-13T00:22:52.483+01:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:59744->127.0.0.1:3000: i/o timeout" Oct 13 00:22:54 living-room go-librespot[14728]: time="2026-10-13T00:22:54+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 00:22:56 living-room go-librespot[14728]: time="2026-10-13T00:22:56+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 00:22:56 living-room go-librespot[14728]: time="2026-10-13T00:22:56+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 13 00:22:56 living-room go-librespot[14728]: time="2026-10-13T00:22:56+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 13 00:22:56 living-room go-librespot[14728]: time="2026-10-13T00:22:56+01:00" level=info msg="zeroconf server listening on port 33267" Oct 13 00:22:57 living-room go-librespot[14728]: time="2026-10-13T00:22:57+01:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 13 00:22:59 living-room volumio[13942]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Oct 13 00:22:59 living-room volumio[13942]: info: touch_display: Volumio Kiosk started. Oct 13 00:22:59 living-room volumio[13942]: info: CoreCommandRouter::volumioGetState Oct 13 00:22:59 living-room volumio[13942]: info: CorePlayQueue::getTrack 0 Oct 13 00:22:59 living-room volumio[13942]: info: touch_display: IframeKeyboardBridge extension installed successfully Oct 13 00:22:59 living-room volumio[13942]: error: MyVolumio Plugin failed to start in a timely fashion Oct 13 00:22:59 living-room volumio[13942]: [Metrics] CommandRouter: 352s 356.04ms Oct 13 00:22:59 living-room volumio[13942]: info: CoreCommandRouter::volumiosetStartupVolume Oct 13 00:22:59 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:22:59 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 00:22:59 living-room volumio[13942]: info: CoreCommandRouter::Close All Modals sent Oct 13 00:23:00 living-room volumio[13942]: info: CoreCommandRouter::Close All Modals sent Oct 13 00:23:01 living-room volumio[13942]: info: No need to fix Spotify hosts Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:01 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 00:23:02 living-room volumio-remote-updater[848]: [2026-10-13 00:23:02] [connect] Successful connection Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 00:23:02 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 00:23:09 living-room volumio5-onboarding[16718]: time=2026-10-13T00:23:09.121+01:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:37910->127.0.0.1:3000: i/o timeout" Oct 13 00:23:09 living-room volumio[13942]: -> REQUEST 0 com.roonlabs.registry:1/info Oct 13 00:23:11 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 13 00:23:11 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 00:23:11 living-room volumio[13942]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 13 00:23:12 living-room volumio[13942]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 00:23:12 living-room volumio[13942]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Oct 13 00:23:12 living-room volumio[13942]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Oct 13 00:23:12 living-room volumio[13942]: at new NodeError (node:internal/errors:405:5) Oct 13 00:23:12 living-room volumio[13942]: at assert (node:internal/assert:14:11) Oct 13 00:23:12 living-room volumio[13942]: at internalConnectMultiple (node:net:1118:3) Oct 13 00:23:12 living-room volumio[13942]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Oct 13 00:23:12 living-room volumio[13942]: at listOnTimeout (node:internal/timers:575:11) Oct 13 00:23:12 living-room volumio[13942]: at process.processTimers (node:internal/timers:514:7) { Oct 13 00:23:12 living-room volumio[13942]: code: 'ERR_INTERNAL_ASSERTION' Oct 13 00:23:12 living-room volumio[13942]: } Oct 13 00:23:12 living-room volumio[13942]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 00:23:17 living-room volumio-remote-updater[848]: [2026-10-13 00:23:17] [connect] Successful connection Oct 13 00:23:21 living-room volumio5-onboarding[16718]: time=2026-10-13T00:23:21.701+01:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:41402->127.0.0.1:3000: i/o timeout" Oct 13 00:23:28 living-room sudo[14812]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 00:22' Oct 13 00:23:29 living-room sudo[14812]: 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"