Oct 02 11:13:13 anneks sudo[1084]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:13 anneks systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 02 11:13:13 anneks systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 02 11:13:13 anneks systemd[1]: setdatetime-helper.service: Consumed 1.383s CPU time. Oct 02 11:13:13 anneks sudo[1092]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 02 11:13:13 anneks sudo[1092]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 02 11:13:13 anneks sudo[1092]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:13 anneks winbindd[1085]: [2026/10/02 11:13:13.573404, 0] ../../source3/winbindd/winbindd.c:1440(main) Oct 02 11:13:13 anneks winbindd[1085]: winbindd version 4.17.8-Raspbian started. Oct 02 11:13:13 anneks winbindd[1085]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Oct 02 11:13:13 anneks wireless.js[649]: WIRELESS.JS - INFO: Cleaning previous... Oct 02 11:13:13 anneks winbindd[1085]: [2026/10/02 11:13:13.608344, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) Oct 02 11:13:13 anneks winbindd[1085]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 02 11:13:13 anneks sudo[1096]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 02 11:13:13 anneks systemd[1]: Started winbind.service - Samba Winbind Daemon. Oct 02 11:13:13 anneks sudo[1096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 02 11:13:13 anneks kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 02 11:13:13 anneks sudo[1096]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:13 anneks wireless.js[649]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Oct 02 11:13:13 anneks wireless.js[649]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 5ms Oct 02 11:13:13 anneks wireless.js[649]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:ab:0f:dd) Oct 02 11:13:13 anneks sudo[1106]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Oct 02 11:13:13 anneks systemd[1]: Starting smbd.service - Samba SMB Daemon... Oct 02 11:13:13 anneks sudo[1106]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:13 anneks systemd[1]: systemd-rfkill.service: Deactivated successfully. Oct 02 11:13:13 anneks sudo[1106]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:13 anneks dhcpcd[680]: eth0: leased 192.168.1.24 for 86400 seconds Oct 02 11:13:13 anneks sh[658]: eth0: leased 192.168.1.24 for 86400 seconds Oct 02 11:13:13 anneks dhcpcd[680]: eth0: adding route to 192.168.1.0/24 Oct 02 11:13:13 anneks sh[658]: eth0: adding route to 192.168.1.0/24 Oct 02 11:13:13 anneks sh[658]: eth0: adding default route via 192.168.1.1 Oct 02 11:13:13 anneks dhcpcd[680]: eth0: adding default route via 192.168.1.1 Oct 02 11:13:13 anneks sudo[1115]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Oct 02 11:13:13 anneks sudo[1115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:13 anneks sh[658]: forked to background, child pid 679 Oct 02 11:13:14 anneks systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Oct 02 11:13:14 anneks systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Oct 02 11:13:14 anneks systemd[1]: welcome.service: Deactivated successfully. Oct 02 11:13:14 anneks systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 02 11:13:14 anneks systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 02 11:13:14 anneks systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 02 11:13:14 anneks welcome[1156]: Resolved ip:[1] 192.168.1.24 Oct 02 11:13:14 anneks systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 02 11:13:14 anneks systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Oct 02 11:13:14 anneks ifplugd(eth0)[904]: client: ifup: interface eth0 already configured Oct 02 11:13:14 anneks sh[1183]: eth0=eth0 Oct 02 11:13:14 anneks ifplugd(eth0)[904]: Program executed successfully. Oct 02 11:13:14 anneks ifplugd[814]: Network Interface Plugging Daemon...start eth0...done. Oct 02 11:13:14 anneks systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Oct 02 11:13:14 anneks smbd[1158]: [2026/10/02 11:13:14.520322, 0] ../../source3/smbd/server.c:1741(main) Oct 02 11:13:14 anneks smbd[1158]: smbd version 4.17.8-Raspbian started. Oct 02 11:13:14 anneks smbd[1158]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Oct 02 11:13:15 anneks ntpd[868]: IO: Listen normally on 3 eth0 192.168.1.24:123 Oct 02 11:13:15 anneks ntpd[868]: IO: new interface(s) found: waking up resolver Oct 02 11:13:15 anneks ntpd[868]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 02 11:13:15 anneks ntpd[868]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Oct 02 11:13:15 anneks ntpd[868]: DNS: Pool skipping: 162.159.200.123 Oct 02 11:13:15 anneks ntpd[868]: DNS: Pool skipping: 79.160.225.150 Oct 02 11:13:15 anneks ntpd[868]: DNS: Pool skipping: 80.203.110.169 Oct 02 11:13:15 anneks ntpd[868]: DNS: Pool skipping: 91.189.182.32 Oct 02 11:13:15 anneks ntpd[868]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Oct 02 11:13:15 anneks systemd[1]: Started smbd.service - Samba SMB Daemon. Oct 02 11:13:16 anneks ntpd[868]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 02 11:13:16 anneks ntpd[868]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool taking: 192.36.143.130 Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool taking: 185.35.202.197 Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool skipping: 162.159.200.123 Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool taking: 185.41.243.43 Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool taking: 2a0d:5600:30:3e::bade Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool taking: 2606:4700:f1::123 Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool taking: 2001:ac8:38:93:0:2:0:20 Oct 02 11:13:16 anneks ntpd[868]: DNS: Pool taking: 2a05:1083:bef4:f711::1 Oct 02 11:13:16 anneks ntpd[868]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Oct 02 11:13:16 anneks sudo[1115]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:16 anneks wireless.js[649]: WIRELESS.JS - INFO: SETTING APPROPRIATE REG DOMAIN: NO Oct 02 11:13:16 anneks sudo[1196]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set NO Oct 02 11:13:16 anneks sudo[1196]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:16 anneks sudo[1196]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:16 anneks wireless.js[649]: WIRELESS.JS - INFO: SUCCESSFULLY SET NEW REGDOMAIN: NO Oct 02 11:13:16 anneks wireless.js[649]: WIRELESS.JS - INFO: netconfigured file not found, starting hotspot Oct 02 11:13:16 anneks wireless.js[649]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability Oct 02 11:13:16 anneks wireless.js[649]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) Oct 02 11:13:16 anneks wireless.js[649]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active Oct 02 11:13:17 anneks sudo[1205]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 02 11:13:17 anneks sudo[1205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 02 11:13:17 anneks sudo[1205]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:17 anneks sudo[1208]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 02 11:13:17 anneks sudo[1208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 02 11:13:17 anneks sudo[1208]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:17 anneks wpa_supplicant[1211]: Successfully initialized wpa_supplicant Oct 02 11:13:17 anneks ntpd[868]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 02 11:13:17 anneks ntpd[868]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Oct 02 11:13:17 anneks ntpd[868]: DNS: Pool taking: 195.16.73.226 Oct 02 11:13:17 anneks ntpd[868]: DNS: Pool skipping: 91.189.182.32 Oct 02 11:13:17 anneks ntpd[868]: DNS: Pool taking: 185.175.56.95 Oct 02 11:13:17 anneks ntpd[868]: DNS: Pool taking: 79.160.225.13 Oct 02 11:13:17 anneks ntpd[868]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Oct 02 11:13:17 anneks wpa_supplicant[1211]: nl80211: kernel reports: Registration to specific type not supported Oct 02 11:13:17 anneks wireless.js[649]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 28188ms Oct 02 11:13:17 anneks wireless.js[649]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable Oct 02 11:13:17 anneks wireless.js[649]: Failed to connect to non-global ctrl_ifname: wlan0 error: No such file or directory Oct 02 11:13:17 anneks wireless.js[649]: WIRELESS.JS - INFO: Notified systemd about wireless ready Oct 02 11:13:17 anneks kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 02 11:13:17 anneks systemd[1]: Started wireless.service - Wireless Services. Oct 02 11:13:17 anneks systemd[1]: Started volumio.service - Volumio Backend Module. Oct 02 11:13:17 anneks systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Oct 02 11:13:17 anneks systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Oct 02 11:13:17 anneks systemd[1]: Received SIGRTMIN+21 from PID 294 (plymouthd). Oct 02 11:13:17 anneks systemd[1]: Received SIGRTMIN+21 from PID 294 (plymouthd). Oct 02 11:13:17 anneks systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Oct 02 11:13:17 anneks systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Oct 02 11:13:17 anneks systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 02 11:13:18 anneks systemd[1]: Reached target getty.target - Login Prompts. Oct 02 11:13:18 anneks systemd[1]: Reached target multi-user.target - Multi-User System. Oct 02 11:13:18 anneks systemd[1]: Reached target graphical.target - Graphical Interface. Oct 02 11:13:18 anneks systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Oct 02 11:13:18 anneks volumio-cpu-tweak[1235]: Setting RT Priority for mpd Oct 02 11:13:18 anneks volumio-cpu-tweak[1251]: pid 35's current scheduling policy: SCHED_OTHER Oct 02 11:13:18 anneks volumio-cpu-tweak[1251]: pid 35's current scheduling priority: 0 Oct 02 11:13:18 anneks volumio-cpu-tweak[1235]: Setting MPD Affinity Oct 02 11:13:18 anneks volumio-cpu-tweak[1252]: pid 3's current affinity mask: f Oct 02 11:13:18 anneks volumio-cpu-tweak[1235]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 02 11:13:18 anneks volumio-cpu-tweak[1235]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 02 11:13:18 anneks systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 02 11:13:18 anneks systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Oct 02 11:13:18 anneks systemd[1]: Startup finished in 15.299s (kernel) + 17.101s (userspace) = 32.401s. Oct 02 11:13:18 anneks systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Oct 02 11:13:18 anneks ntpd[868]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 02 11:13:18 anneks ntpd[868]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Oct 02 11:13:18 anneks ntpd[868]: DNS: Pool skipping: 192.36.143.130 Oct 02 11:13:18 anneks ntpd[868]: DNS: Pool skipping: 185.41.243.43 Oct 02 11:13:18 anneks ntpd[868]: DNS: Pool taking: 152.65.32.104 Oct 02 11:13:18 anneks ntpd[868]: DNS: Pool taking: 162.159.200.1 Oct 02 11:13:18 anneks ntpd[868]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Oct 02 11:13:19 anneks volumio-remote-updater[648]: [2026-10-02 11:13:19] [info] asio async_connect error: asio.system:111 (Connection refused) Oct 02 11:13:19 anneks volumio-remote-updater[648]: [2026-10-02 11:13:19] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Oct 02 11:13:19 anneks volumio-remote-updater[648]: [2026-10-02 11:13:19] [error] handle_connect error: Connection refused Oct 02 11:13:22 anneks ntpd[868]: CLOCK: time stepped by 0.254885 Oct 02 11:13:22 anneks ntpd[868]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Oct 02 11:13:23 anneks volumio[1233]: info: ------------------------------------------- Oct 02 11:13:23 anneks volumio[1233]: info: ----- Volumio3 ---- Oct 02 11:13:23 anneks volumio[1233]: info: ------------------------------------------- Oct 02 11:13:23 anneks volumio[1233]: info: ----- System startup ---- Oct 02 11:13:23 anneks volumio[1233]: info: ------------------------------------------- Oct 02 11:13:23 anneks systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Oct 02 11:13:23 anneks systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:13:23 anneks systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:13:23 anneks upmpdcli[1263]: Could not open config: /tmp/upmpdcli.conf Oct 02 11:13:23 anneks systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 02 11:13:23 anneks systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 02 11:13:24 anneks volumio[1233]: info: MYVOLUMIO Environment detected Oct 02 11:13:24 anneks volumio[1233]: info: Plugin folders cleanup Oct 02 11:13:24 anneks volumio[1233]: info: Scanning into folder /volumio/app/plugins/ Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category audio_interface Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category miscellanea Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category music_service Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category plugins.json Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category system_controller Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category user_interface Oct 02 11:13:24 anneks volumio[1233]: info: Scanning into folder /data/plugins/ Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category music_service Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category system_controller Oct 02 11:13:24 anneks volumio[1233]: info: Scanning category user_interface Oct 02 11:13:24 anneks volumio[1233]: info: Plugin folders cleanup completed Oct 02 11:13:24 anneks volumio[1233]: info: ------------------------------------------- Oct 02 11:13:24 anneks volumio[1233]: info: ----- Core plugins startup ---- Oct 02 11:13:24 anneks volumio[1233]: info: ------------------------------------------- Oct 02 11:13:24 anneks volumio[1233]: info: Loading plugins from folder /volumio/app/plugins/ Oct 02 11:13:24 anneks volumio[1233]: info: Adding plugin upnp to MyMusic Plugins Oct 02 11:13:24 anneks volumio[1233]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 02 11:13:24 anneks volumio[1233]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 02 11:13:24 anneks volumio[1233]: info: Loading plugins from folder /data/plugins/ Oct 02 11:13:24 anneks volumio[1233]: info: Loading plugin "system"... Oct 02 11:13:25 anneks volumio[1233]: info: Loading plugin "appearance"... Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "network"... Oct 02 11:13:27 anneks volumio[1233]: info: Refreshing Cached IP Addresses Oct 02 11:13:27 anneks sudo[1273]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 02 11:13:27 anneks sudo[1273]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:27 anneks sudo[1273]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "services"... Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "volumio5onboarding"... Oct 02 11:13:27 anneks sudo[1282]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 02 11:13:27 anneks sudo[1272]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 02 11:13:27 anneks sudo[1272]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:27 anneks sudo[1282]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "alsa_controller"... Oct 02 11:13:27 anneks sudo[1272]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:27 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "wizard"... Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "networkfs"... Oct 02 11:13:27 anneks volumio[1233]: info: Starting Udev Watcher for removable devices Oct 02 11:13:27 anneks volumio[1233]: info: Ignoring mount for partition: boot Oct 02 11:13:27 anneks volumio[1233]: info: Ignoring mount for partition: volumio Oct 02 11:13:27 anneks volumio[1233]: info: Ignoring mount for partition: volumio_data Oct 02 11:13:27 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "volumio_command_line_client"... Oct 02 11:13:27 anneks sudo[1305]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=reader,password=5oBMnYY9TkbFnhMfoDx8d5,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/music /mnt/NAS/Elrond Oct 02 11:13:27 anneks sudo[1305]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "upnp"... Oct 02 11:13:27 anneks volumio[1233]: info: [1790932407769] Starting Upmpd Daemon Oct 02 11:13:27 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "my_music"... Oct 02 11:13:27 anneks volumio[1233]: info: Loading plugin "mpd"... Oct 02 11:13:27 anneks kernel: netfs: FS-Cache loaded Oct 02 11:13:28 anneks kernel: Key type cifs.spnego registered Oct 02 11:13:28 anneks kernel: Key type cifs.idmap registered Oct 02 11:13:28 anneks kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 02 11:13:28 anneks kernel: CIFS: Attempting to mount //192.168.1.15/music Oct 02 11:13:28 anneks volumio[1233]: info: Loading plugin "upnp_browser"... Oct 02 11:13:28 anneks sudo[1305]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:29 anneks volumio-remote-updater[648]: [2026-10-02 11:13:29] [connect] Successful connection Oct 02 11:13:30 anneks sudo[1282]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:31 anneks volumio[1233]: info: Starting UPNP Browser Oct 02 11:13:31 anneks volumio[1233]: info: Loading plugin "alarm-clock"... Oct 02 11:13:31 anneks volumio[1233]: info: Loading plugin "airplay_emulation"... Oct 02 11:13:31 anneks volumio[1233]: info: Starting Shairport Sync Oct 02 11:13:31 anneks volumio[1233]: info: Loading plugin "last_100"... Oct 02 11:13:31 anneks volumio[1233]: info: Loading plugin "webradio"... Oct 02 11:13:31 anneks volumio[1233]: info: Loading plugin "i2s_dacs"... Oct 02 11:13:31 anneks volumio[1233]: info: Loading plugin "volumiodiscovery"... Oct 02 11:13:32 anneks volumio[1233]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 02 11:13:32 anneks volumio[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 02 11:13:32 anneks volumio[1233]: *** WARNING *** For more information see Oct 02 11:13:32 anneks volumio[1233]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 02 11:13:32 anneks volumio[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 02 11:13:32 anneks volumio[1233]: *** WARNING *** For more information see Oct 02 11:13:32 anneks node[1233]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 02 11:13:32 anneks node[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 02 11:13:32 anneks node[1233]: *** WARNING *** For more information see Oct 02 11:13:32 anneks node[1233]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 02 11:13:32 anneks node[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 02 11:13:32 anneks node[1233]: *** WARNING *** For more information see Oct 02 11:13:32 anneks volumio[1233]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 02 11:13:32 anneks volumio[1233]: info: Discovery: Started advertising with name: Anneks Oct 02 11:13:32 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 02 11:13:32 anneks volumio[1233]: info: Loading plugin "rp2"... Oct 02 11:13:34 anneks systemd[1]: systemd-fsckd.service: Deactivated successfully. Oct 02 11:13:37 anneks volumio[1233]: info: Loading plugin "outputs"... Oct 02 11:13:37 anneks volumio[1233]: info: Loading plugin "albumart"... Oct 02 11:13:37 anneks volumio[1233]: info: Plugin example_plugin is not enabled Oct 02 11:13:37 anneks volumio[1233]: info: Loading plugin "inputs"... Oct 02 11:13:37 anneks volumio[1233]: info: Loading plugin "updater_comm"... Oct 02 11:13:37 anneks volumio[1233]: info: Plugin mpdemulation is not enabled Oct 02 11:13:37 anneks volumio[1233]: info: Loading plugin "rest_api"... Oct 02 11:13:37 anneks volumio[1233]: info: Loading plugin "websocket"... Oct 02 11:13:37 anneks volumio[1233]: info: Starting Socket.io Server version 1.7.4 Oct 02 11:13:37 anneks volumio[1233]: info: Loading plugin "radio_paradise"... Oct 02 11:13:38 anneks systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Oct 02 11:13:38 anneks systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:13:38 anneks systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:13:38 anneks upmpdcli[1368]: Could not open config: /tmp/upmpdcli.conf Oct 02 11:13:38 anneks systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 02 11:13:38 anneks systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 02 11:13:39 anneks volumio[1344]: Forking 3 albumart workers Oct 02 11:13:39 anneks volumio[1233]: info: Applying required configuration parameters for plugin radio_paradise Oct 02 11:13:39 anneks volumio[1233]: info: [1790932419127] [RadioParadise] API delay: 2 Oct 02 11:13:39 anneks volumio[1233]: info: Loading plugin "backup_restore"... Oct 02 11:13:40 anneks systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 02 11:13:42 anneks volumio[1233]: info: Applying required configuration parameters for plugin backup_restore Oct 02 11:13:42 anneks volumio[1233]: info: Loading plugin "lastfm"... Oct 02 11:13:44 anneks volumio-remote-updater[648]: [2026-10-02 11:13:44] [connect] Successful connection Oct 02 11:13:48 anneks volumio[1371]: Starting albumart workers Oct 02 11:13:48 anneks systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 02 11:13:48 anneks volumio[1369]: Starting albumart workers Oct 02 11:13:48 anneks volumio[1370]: Starting albumart workers Oct 02 11:13:50 anneks systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 02 11:13:50 anneks systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 02 11:13:50 anneks systemd[1]: setdatetime-helper.service: Consumed 1.069s CPU time. Oct 02 11:13:50 anneks volumio[1233]: info: Loading plugin "randomizer"... Oct 02 11:13:53 anneks systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Oct 02 11:13:53 anneks systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:13:53 anneks systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:13:53 anneks upmpdcli[1442]: Could not open config: /tmp/upmpdcli.conf Oct 02 11:13:53 anneks systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 02 11:13:53 anneks systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 02 11:13:54 anneks volumio[1233]: info: Applying required configuration parameters for plugin randomizer Oct 02 11:13:56 anneks volumio[1233]: info: Loading i18n strings for locale en Oct 02 11:13:56 anneks volumio[1233]: Updating browse sources language Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::initPlayerControls Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 11:13:56 anneks volumio[1233]: Express server listening on port 3000 Oct 02 11:13:56 anneks volumio[1233]: [Metrics] WebUI: 35s 39.51ms Oct 02 11:13:57 anneks volumio[1233]: info: CoreStateMachine::resetVolumioState Oct 02 11:13:57 anneks volumio[1233]: info: CoreStateMachine::getcurrentVolume Oct 02 11:13:57 anneks volumio[1233]: info: CoreCommandRouter::volumioRetrievevolume Oct 02 11:13:57 anneks sudo[1466]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 02 11:13:57 anneks sudo[1466]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:57 anneks sudo[1467]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 02 11:13:57 anneks sudo[1467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:57 anneks sudo[1466]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:57 anneks sudo[1467]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:57 anneks volumio[1233]: info: Volumio Network Manager: Network status updated: 1 Oct 02 11:13:57 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 02 11:13:57 anneks volumio[1233]: info: VolumeController:: Volume=63 Mute =false Oct 02 11:13:57 anneks volumio[1233]: info: CoreStateMachine::pushState Oct 02 11:13:57 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:13:57 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 11:13:57 anneks volumio[1233]: info: CoreCommandRouter::volumioPushState Oct 02 11:13:58 anneks volumio[1233]: info: CoreStateMachine::updateTrackBlock Oct 02 11:13:58 anneks volumio[1233]: info: CorePlayQueue::getTrackBlock Oct 02 11:13:58 anneks volumio[1233]: info: CoreCommandRouter::volumioRetrievevolume Oct 02 11:13:58 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 02 11:13:58 anneks volumio[1233]: verbose: New Socket.io Connection to anneks.local from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 02 11:13:58 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:13:58 anneks volumio[1233]: info: Executing start script for DAC IQaudIO DAC Plus Oct 02 11:13:58 anneks volumio[1233]: info: Reloading queue from file Oct 02 11:13:58 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 02 11:13:58 anneks volumio[1233]: info: Setting Device type: Raspberry PI Oct 02 11:13:58 anneks volumio[1233]: info: CoreStateMachine::setRepeat null single undefined Oct 02 11:13:58 anneks volumio[1233]: info: CoreStateMachine::pushState Oct 02 11:13:58 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:13:58 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 11:13:58 anneks volumio[1233]: info: CoreCommandRouter::volumioPushState Oct 02 11:13:58 anneks volumio[1233]: info: CoreStateMachine::setRandom null Oct 02 11:13:58 anneks volumio[1233]: info: CoreStateMachine::pushState Oct 02 11:13:58 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:13:58 anneks volumio[1233]: info: CoreCommandRouter::volumioPushState Oct 02 11:13:58 anneks volumio[1233]: info: DAC script executed Oct 02 11:13:58 anneks volumio[1233]: info: Completed loading Core Plugins Oct 02 11:13:59 anneks volumio[1233]: info: Preparing to generate the ALSA configuration file Oct 02 11:13:59 anneks volumio[1233]: info: VolumeController:: Volume=63 Mute =false Oct 02 11:13:59 anneks volumio[1233]: info: CoreStateMachine::pushState Oct 02 11:13:59 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:13:59 anneks volumio[1233]: info: CoreCommandRouter::volumioPushState Oct 02 11:13:59 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 02 11:13:59 anneks sudo[1503]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 02 11:13:59 anneks sudo[1503]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:59 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:13:59 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:13:59 anneks volumio[1233]: info: Discovery: adding c62f1a8a-b3bc-4597-9093-35d1a698bc97 Oct 02 11:13:59 anneks volumio[1233]: info: Discovery: Found device Anneks Oct 02 11:13:59 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:13:59 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:13:59 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 02 11:13:59 anneks volumio[1233]: info: Asound.conf file unchanged, so no further update is needed Oct 02 11:13:59 anneks volumio[1233]: info: Output device has changed, restarting MPD Oct 02 11:13:59 anneks volumio[1233]: info: Output device has changed, restarting Shairport Sync Oct 02 11:13:59 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:13:59 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:13:59 anneks sudo[1508]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 02 11:13:59 anneks sudo[1508]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:59 anneks sudo[1507]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 02 11:13:59 anneks sudo[1507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:13:59 anneks sudo[1508]: pam_unix(sudo:session): session closed for user root Oct 02 11:13:59 anneks volumio-remote-updater[648]: [2026-10-02 11:13:59] [connect] Successful connection Oct 02 11:13:59 anneks volumio[1233]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 02 11:13:59 anneks volumio[1233]: info: ___________ START PLUGINS ___________ Oct 02 11:14:00 anneks volumio[1233]: info: ControllerMpd::onStart: Initializing MPD Oct 02 11:14:00 anneks systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 02 11:14:00 anneks volumio[1233]: info: Creating MPD Configuration file Oct 02 11:14:00 anneks systemd[1]: Starting mpd.service - Music Player Daemon... Oct 02 11:14:00 anneks sudo[1518]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 02 11:14:00 anneks sudo[1518]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 02 11:14:00 anneks sudo[1520]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 02 11:14:00 anneks volumio[1233]: info: [1790932440341] CoreMusicLibrary::Adding element Media Servers Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:00 anneks sudo[1517]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 02 11:14:00 anneks sudo[1517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 02 11:14:00 anneks sudo[1524]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 02 11:14:00 anneks sudo[1517]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:00 anneks sudo[1520]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:14:00 anneks volumio[1233]: info: UPNP Browser: Client initialized successfully Oct 02 11:14:00 anneks sudo[1520]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:00 anneks sudo[1523]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 02 11:14:00 anneks sudo[1523]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:14:00 anneks systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 02 11:14:00 anneks sudo[1518]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:00 anneks systemd[1]: mpd.service: Deactivated successfully. Oct 02 11:14:00 anneks systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 02 11:14:00 anneks systemd[1]: mpd.socket: Deactivated successfully. Oct 02 11:14:00 anneks systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 02 11:14:00 anneks systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 02 11:14:00 anneks systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 02 11:14:00 anneks volumio[1233]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:14:00 anneks systemd[1]: Starting mpd.service - Music Player Daemon... Oct 02 11:14:00 anneks volumio[1233]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 02 11:14:00 anneks volumio[1233]: info: [1790932440894] CoreMusicLibrary::Adding element Last_100 Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 02 11:14:00 anneks volumio[1233]: info: [1790932440898] CoreMusicLibrary::Adding element Webradio Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:00 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 02 11:14:00 anneks volumio[1233]: info: Initializing BBC Radios Oct 02 11:14:01 anneks sudo[1535]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 02 11:14:01 anneks sudo[1535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 02 11:14:01 anneks sudo[1548]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 02 11:14:01 anneks sudo[1535]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:14:01 anneks volumio5-onboarding[1532]: time=2026-10-02T11:14:01.507+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 02 11:14:01 anneks volumio[1233]: info: [1790932441594] CoreMusicLibrary::Adding element Radio Paradise (RP2) Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:01 anneks volumio[1233]: Cannot find translation for source Radio Paradise (RP2) Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 02 11:14:01 anneks volumio[1233]: info: [1790932441694] CoreMusicLibrary::Adding element Radio Paradise Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:01 anneks volumio[1233]: Cannot find translation for source Radio Paradise (RP2) Oct 02 11:14:01 anneks volumio[1233]: Cannot find translation for source Radio Paradise Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 02 11:14:01 anneks volumio[1233]: info: [1790932441735] CoreMusicLibrary::Adding element LastFM Oct 02 11:14:01 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:01 anneks volumio[1233]: Cannot find translation for source Radio Paradise (RP2) Oct 02 11:14:01 anneks volumio[1233]: Cannot find translation for source Radio Paradise Oct 02 11:14:01 anneks volumio[1233]: Cannot find translation for source LastFM Oct 02 11:14:01 anneks volumio[1233]: info: [LastFM] scrobbler initiated! Oct 02 11:14:01 anneks volumio[1233]: info: [LastFM] extended logging: false Oct 02 11:14:01 anneks volumio[1233]: info: [LastFM] try scrobble stream/radio plays: true Oct 02 11:14:01 anneks volumio[1233]: info: [LastFM] Left init routine Oct 02 11:14:01 anneks volumio[1233]: info: [LastFM] Socket already connected: false Oct 02 11:14:02 anneks volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 02 11:14:02 anneks volumio[1233]: info: [1790932442046] CoreMusicLibrary::Adding element Randomizer Oct 02 11:14:02 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:02 anneks volumio[1233]: Cannot find translation for source Radio Paradise (RP2) Oct 02 11:14:02 anneks volumio[1233]: Cannot find translation for source Radio Paradise Oct 02 11:14:02 anneks volumio[1233]: Cannot find translation for source LastFM Oct 02 11:14:02 anneks volumio[1233]: Cannot find translation for source Randomizer Oct 02 11:14:02 anneks volumio[1233]: info: Cannot retrieve data for calling home Oct 02 11:14:04 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 02 11:14:05 anneks volumio[1233]: info: Listing playlists Oct 02 11:14:05 anneks volumio[1233]: info: Listing playlists Oct 02 11:14:05 anneks volumio[1233]: info: Discovery: this is already registered, c62f1a8a-b3bc-4597-9093-35d1a698bc97 Oct 02 11:14:05 anneks volumio[1233]: info: Discovery: Found device Anneks Oct 02 11:14:05 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:05 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:05 anneks volumio[1233]: info: MPD Permissions set Oct 02 11:14:05 anneks volumio[1233]: info: MPD Permissions set Oct 02 11:14:05 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 02 11:14:05 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 02 11:14:06 anneks volumio[1233]: verbose: New Socket.io Connection to anneks.local from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:14:06 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:07 anneks volumio[1233]: info: [LastFM] finished init: Authenticated successfully! Oct 02 11:14:07 anneks volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:08 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:08 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Oct 02 11:14:08 anneks volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 13 Oct 02 11:14:08 anneks volumio[1233]: info: Starting Shairport Sync Oct 02 11:14:08 anneks volumio[1233]: info: Starting Shairport Sync Oct 02 11:14:08 anneks volumio[1233]: info: Starting Shairport Sync Oct 02 11:14:08 anneks sudo[1584]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 02 11:14:08 anneks sudo[1584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:14:08 anneks sudo[1580]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 02 11:14:08 anneks sudo[1580]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:14:08 anneks sudo[1582]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 02 11:14:08 anneks volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 13 Oct 02 11:14:08 anneks sudo[1582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:14:08 anneks systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 02 11:14:08 anneks systemd[1]: shairport-sync.service: Deactivated successfully. Oct 02 11:14:08 anneks systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 02 11:14:08 anneks systemd[1]: shairport-sync.service: Consumed 1.946s CPU time. Oct 02 11:14:08 anneks volumio[1233]: info: Received Get System Info Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 02 11:14:08 anneks volumio[1233]: info: Discovery: Getting this device information Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:08 anneks systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 02 11:14:08 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:08 anneks sudo[1584]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 02 11:14:08 anneks systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 02 11:14:08 anneks volumio5-onboarding[1532]: time=2026-10-02T11:14:08.712+02:00 level=INFO msg="system info for bf49b46d7a23f69cdf5a96fd82958d00" deviceName=Anneks deviceVariant="" deviceModel= softwareVersion="" Oct 02 11:14:08 anneks systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Oct 02 11:14:08 anneks volumio5-onboarding[1532]: time=2026-10-02T11:14:08.730+02:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 02 11:14:08 anneks systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:14:08 anneks volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Oct 02 11:14:08 anneks systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 02 11:14:08 anneks sudo[1503]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:08 anneks systemd[1]: shairport-sync.service: Deactivated successfully. Oct 02 11:14:08 anneks systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 02 11:14:08 anneks systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 02 11:14:08 anneks sudo[1580]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:08 anneks volumio[1233]: info: Received Get System Info Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 02 11:14:08 anneks systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 02 11:14:08 anneks volumio[1233]: info: Discovery: Getting this device information Oct 02 11:14:08 anneks systemd[1]: shairport-sync.service: Deactivated successfully. Oct 02 11:14:08 anneks systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:08 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:08 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 02 11:14:09 anneks systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 02 11:14:09 anneks sudo[1582]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:09 anneks volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Oct 02 11:14:09 anneks mpd[1549]: 2026-10-02T11:14:09 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 02 11:14:09 anneks volumio[1233]: info: Shairport-Sync Started Oct 02 11:14:09 anneks volumio[1233]: Error adding Membership: Error: addMembership EINVAL Oct 02 11:14:09 anneks volumio[1233]: info: Upmpdcli Daemon Started Oct 02 11:14:09 anneks volumio[1233]: info: CoreCommandRouter::volumioGetQueue Oct 02 11:14:09 anneks volumio[1233]: info: CoreStateMachine::getQueue Oct 02 11:14:09 anneks volumio[1233]: info: CorePlayQueue::getQueue Oct 02 11:14:09 anneks systemd[1]: Started mpd.service - Music Player Daemon. Oct 02 11:14:09 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Oct 02 11:14:09 anneks sudo[1507]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:09 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Oct 02 11:14:09 anneks sudo[1523]: pam_unix(sudo:session): session closed for user root Oct 02 11:14:09 anneks volumio[1233]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Oct 02 11:14:09 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Oct 02 11:14:09 anneks volumio[1233]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Oct 02 11:14:09 anneks volumio[1233]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Oct 02 11:14:09 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Oct 02 11:14:10 anneks volumio[1233]: info: Shairport-Sync Started Oct 02 11:14:10 anneks volumio[1233]: info: Shairport-Sync Started Oct 02 11:14:10 anneks volumio[1233]: info: Completed starting Core Plugins Oct 02 11:14:10 anneks volumio[1233]: info: ------------------------------------------- Oct 02 11:14:10 anneks volumio[1233]: info: ----- MyVolumio plugins startup ---- Oct 02 11:14:10 anneks volumio[1233]: info: ------------------------------------------- Oct 02 11:14:10 anneks volumio[1233]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 02 11:14:10 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:10 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:11 anneks volumio[1233]: error: MPD error: The expression evaluated to a falsy value: Oct 02 11:14:11 anneks volumio[1233]: assert.ok(self.idling) Oct 02 11:14:11 anneks volumio[1233]: error: The expression evaluated to a falsy value: Oct 02 11:14:11 anneks volumio[1233]: assert.ok(self.idling) Oct 02 11:14:11 anneks volumio[1233]: error: updateQueue error: null Oct 02 11:14:11 anneks volumio[1233]: info: MPD running with PID1549 Oct 02 11:14:11 anneks volumio[1233]: ,establishing connection Oct 02 11:14:11 anneks volumio[1233]: error: updateQueue error: null Oct 02 11:14:12 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:12 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:12 anneks volumio[1233]: verbose: New Socket.io Connection to 192.168.1.24 from 192.168.1.195 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Oct 02 11:14:12 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:12 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:12 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 02 11:14:12 anneks volumio[1233]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 11:14:12 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:12 anneks volumio[1233]: info: Listing playlists Oct 02 11:14:13 anneks volumio[1233]: info: CoreCommandRouter::volumioGetState Oct 02 11:14:13 anneks volumio[1233]: info: CorePlayQueue::getTrack 0 Oct 02 11:14:13 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 02 11:14:13 anneks volumio[1233]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 11:14:13 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 11:14:13 anneks volumio[1233]: info: Listing playlists Oct 02 11:14:14 anneks volumio-remote-updater[648]: [2026-10-02 11:14:14] [connect] Successful connection Oct 02 11:14:15 anneks volumio-remote-updater[648]: [2026-10-02 11:14:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1790932454 101 Oct 02 11:14:15 anneks volumio[1233]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 17 Oct 02 11:14:16 anneks volumio[1233]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 02 11:14:33 anneks volumio[1233]: error: MyVolumio Plugin failed to start in a timely fashion Oct 02 11:14:33 anneks volumio[1233]: [Metrics] CommandRouter: 70s 379.11ms Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::volumiosetStartupVolume Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::Close All Modals sent Oct 02 11:14:33 anneks volumio[1233]: info: CoreCommandRouter::Close All Modals sent Oct 02 11:14:38 anneks volumio5-onboarding[1532]: failed to bootstrap state: failed to check for software update: could not check for updates: context deadline exceeded Oct 02 11:14:38 anneks systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 02 11:14:38 anneks systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 02 11:14:39 anneks systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Oct 02 11:14:39 anneks systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 02 11:14:39 anneks systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 02 11:14:39 anneks volumio5-onboarding[1688]: time=2026-10-02T11:14:39.206+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 02 11:14:49 anneks volumio5-onboarding[1688]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:41768->127.0.0.1:3000: i/o timeout Oct 02 11:14:49 anneks systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 02 11:14:49 anneks systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 02 11:14:49 anneks systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Oct 02 11:14:49 anneks systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 02 11:14:49 anneks systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 02 11:14:49 anneks volumio5-onboarding[1710]: time=2026-10-02T11:14:49.662+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 02 11:14:51 anneks volumio[1233]: info: CALLMETHOD: system_controller system enableLiveLog true Oct 02 11:14:51 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog Oct 02 11:14:51 anneks volumio[1233]: info: Launching a new LiveLog session Oct 02 11:14:52 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 02 11:14:52 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 02 11:14:52 anneks volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 02 11:14:52 anneks volumio[1233]: info: BOOT COMPLETED Oct 02 11:14:52 anneks volumio[1233]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 11:14:52 anneks volumio[1233]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Oct 02 11:14:52 anneks volumio[1233]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Oct 02 11:14:52 anneks volumio[1233]: at new NodeError (node:internal/errors:405:5) Oct 02 11:14:52 anneks volumio[1233]: at assert (node:internal/assert:14:11) Oct 02 11:14:52 anneks volumio[1233]: at internalConnectMultiple (node:net:1118:3) Oct 02 11:14:52 anneks volumio[1233]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Oct 02 11:14:52 anneks volumio[1233]: at listOnTimeout (node:internal/timers:575:11) Oct 02 11:14:52 anneks volumio[1233]: at process.processTimers (node:internal/timers:514:7) { Oct 02 11:14:52 anneks volumio[1233]: code: 'ERR_INTERNAL_ASSERTION' Oct 02 11:14:52 anneks volumio[1233]: } Oct 02 11:14:52 anneks volumio[1233]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 11:14:57 anneks upmpdcli[1744]: writing RSA key Oct 02 11:14:59 anneks sudo[1750]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-02 11:13' Oct 02 11:14:59 anneks sudo[1750]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 02 11:14:59 anneks volumio5-onboarding[1710]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:45808->127.0.0.1:3000: i/o timeout Oct 02 11:14:59 anneks systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 02 11:14:59 anneks systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 02 11:14:59 anneks systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 3. Oct 02 11:14:59 anneks systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 02 11:14:59 anneks systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 02 11:14:59 anneks volumio5-onboarding[1752]: time=2026-10-02T11:14:59.916+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z 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"