-- Logs begin at Sun 2026-08-30 14:27:48 CEST, end at Sun 2026-08-30 14:29:53 CEST. -- Aug 30 14:28:00 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:00 volumiopi5 sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:00 volumiopi5 sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:00 volumiopi5 sudo[1119]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:00 volumiopi5 wpa_supplicant[1079]: wlan0: Trying to associate with SSID 'ac1900' Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: wlan0: carrier acquired Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: wlan0: connected to Access Point `ac1900' Aug 30 14:28:00 volumiopi5 wpa_supplicant[1079]: wlan0: Associated with 7c:ff:4d:d8:bf:83 Aug 30 14:28:00 volumiopi5 wpa_supplicant[1079]: wlan0: CTRL-EVENT-CONNECTED - Connection to 7c:ff:4d:d8:bf:83 completed [id=0 id_str=] Aug 30 14:28:00 volumiopi5 wpa_supplicant[1079]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 30 14:28:00 volumiopi5 wpa_supplicant[1079]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: DUID 00:01:00:01:31:5d:30:e1:2c:cf:67:14:96:94 Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: wlan0: IAID 67:14:96:95 Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: wlan0: adding address fe80::ef13:cc83:7202:8f5d Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: ipv6_addaddr1: Permission denied Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: wlan0: carrier lost Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: wlan0: carrier acquired Aug 30 14:28:00 volumiopi5 dhcpcd[1091]: wlan0: IAID 67:14:96:95 Aug 30 14:28:01 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:01 volumiopi5 sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:01 volumiopi5 sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:01 volumiopi5 sudo[1134]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:01 volumiopi5 dhcpcd[1091]: wlan0: soliciting an IPv6 router Aug 30 14:28:01 volumiopi5 dhcpcd[1091]: wlan0: rebinding lease of 192.168.1.125 Aug 30 14:28:01 volumiopi5 dhcpcd[1091]: wlan0: probing address 192.168.1.125/24 Aug 30 14:28:02 volumiopi5 volumio-remote-updater[714]: [2026-08-30 14:28:02] [info] asio async_connect error: system:111 (Connection refused) Aug 30 14:28:02 volumiopi5 volumio-remote-updater[714]: [2026-08-30 14:28:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 30 14:28:02 volumiopi5 volumio-remote-updater[714]: [2026-08-30 14:28:02] [error] handle_connect error: Underlying Transport Error Aug 30 14:28:02 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:02 volumiopi5 sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:02 volumiopi5 sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:02 volumiopi5 sudo[1137]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:03 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:03 volumiopi5 sudo[1140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:03 volumiopi5 sudo[1140]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:03 volumiopi5 sudo[1140]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:04 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:04 volumiopi5 sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:04 volumiopi5 sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:04 volumiopi5 sudo[1143]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:04 volumiopi5 volumio-time-update[745]: volumio-time-update-util: Fetching time from Volumio... Aug 30 14:28:04 volumiopi5 volumio-time-update[745]: volumio-time-update-util: Date not found in response Aug 30 14:28:04 volumiopi5 volumio-time-update[745]: volumio-time-update-util: Retrying in 5 seconds... Aug 30 14:28:05 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:05 volumiopi5 sudo[1151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:05 volumiopi5 sudo[1151]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:05 volumiopi5 sudo[1151]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:06 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:06 volumiopi5 sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:06 volumiopi5 sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:06 volumiopi5 sudo[1154]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:06 volumiopi5 dhcpcd[1091]: wlan0: leased 192.168.1.125 for 86400 seconds Aug 30 14:28:06 volumiopi5 avahi-daemon[747]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.125. Aug 30 14:28:06 volumiopi5 avahi-daemon[747]: New relevant interface wlan0.IPv4 for mDNS. Aug 30 14:28:06 volumiopi5 dhcpcd[1091]: wlan0: adding route to 192.168.1.0/24 Aug 30 14:28:06 volumiopi5 avahi-daemon[747]: Registering new address record for 192.168.1.125 on wlan0.IPv4. Aug 30 14:28:06 volumiopi5 dhcpcd[1091]: wlan0: adding default route via 192.168.1.1 Aug 30 14:28:07 volumiopi5 wireless.js[736]: trying... Aug 30 14:28:07 volumiopi5 sudo[1178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 14:28:07 volumiopi5 sudo[1178]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:07 volumiopi5 sudo[1178]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:07 volumiopi5 wireless.js[736]: Connected to: ----ac1900 Aug 30 14:28:07 volumiopi5 wireless.js[736]: ---- Aug 30 14:28:07 volumiopi5 sudo[1181]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 14:28:07 volumiopi5 sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:07 volumiopi5 sudo[1181]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:07 volumiopi5 wireless.js[736]: ... joined AP, wlan0 IPv4 is 192.168.1.125, ipV6 is undefined Aug 30 14:28:07 volumiopi5 wireless.js[736]: It's done! AP Aug 30 14:28:07 volumiopi5 systemd[1]: Started Wireless Services. Aug 30 14:28:07 volumiopi5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 30 14:28:07 volumiopi5 systemd[1]: Started Volumio Backend Module. Aug 30 14:28:07 volumiopi5 systemd[1]: Started Volumio Cpu Tweaker. Aug 30 14:28:07 volumiopi5 volumio-cpu-tweak[1187]: Setting RT Priority for mpd Aug 30 14:28:07 volumiopi5 volumio-cpu-tweak[1187]: pid 35's current scheduling policy: SCHED_OTHER Aug 30 14:28:07 volumiopi5 volumio-cpu-tweak[1187]: pid 35's current scheduling priority: 0 Aug 30 14:28:07 volumiopi5 volumio-cpu-tweak[1187]: Setting MPD Affinity Aug 30 14:28:07 volumiopi5 volumio-cpu-tweak[1187]: pid 3's current affinity mask: f Aug 30 14:28:07 volumiopi5 volumio-cpu-tweak[1187]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Aug 30 14:28:07 volumiopi5 volumio-cpu-tweak[1187]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Aug 30 14:28:07 volumiopi5 systemd[1]: volumio_cpu_tweak.service: Succeeded. Aug 30 14:28:07 volumiopi5 volumio[1186]: info: ------------------------------------------- Aug 30 14:28:07 volumiopi5 volumio[1186]: info: ----- Volumio3 ---- Aug 30 14:28:07 volumiopi5 volumio[1186]: info: ------------------------------------------- Aug 30 14:28:07 volumiopi5 volumio[1186]: info: ----- System startup ---- Aug 30 14:28:07 volumiopi5 volumio[1186]: info: ------------------------------------------- Aug 30 14:28:07 volumiopi5 ntpd[992]: Listen normally on 3 wlan0 192.168.1.125:123 Aug 30 14:28:07 volumiopi5 ntpd[992]: new interface(s) found: waking up resolver Aug 30 14:28:08 volumiopi5 volumio[1186]: info: MYVOLUMIO Environment detected Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Plugin folders cleanup Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning into folder /volumio/app/plugins/ Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category audio_interface Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category miscellanea Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category music_service Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category plugins.json Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category system_controller Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category user_interface Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning into folder /data/plugins/ Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category system_controller Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Scanning category user_interface Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Plugin folders cleanup completed Aug 30 14:28:08 volumiopi5 volumio[1186]: info: ------------------------------------------- Aug 30 14:28:08 volumiopi5 volumio[1186]: info: ----- Core plugins startup ---- Aug 30 14:28:08 volumiopi5 volumio[1186]: info: ------------------------------------------- Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Adding plugin upnp to MyMusic Plugins Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugins from folder /data/plugins/ Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "system"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "appearance"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "network"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Refreshing Cached IP Addresses Aug 30 14:28:08 volumiopi5 sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 14:28:08 volumiopi5 sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:08 volumiopi5 sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 14:28:08 volumiopi5 sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:08 volumiopi5 sudo[1217]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:08 volumiopi5 sudo[1219]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "services"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "volumio5onboarding"... Aug 30 14:28:08 volumiopi5 sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 14:28:08 volumiopi5 sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "alsa_controller"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "wizard"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "networkfs"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Starting Udev Watcher for removable devices Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Ignoring mount for partition: 66e71e75-4a76-419d-b07c-fde08d5c3b3f Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Ignoring mount for partition: 42b7fd4c-2233-4456-962c-37b2c54fbeeb Aug 30 14:28:08 volumiopi5 volumio[1186]: error: Cannot associate FS Label, not mounting Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Mounting Device Volumio5 Aug 30 14:28:08 volumiopi5 sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Volumio5 -o noatime Aug 30 14:28:08 volumiopi5 sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:08 volumiopi5 sudo[1252]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Ignoring mount for partition: boot Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Ignoring mount for partition: volumio Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Ignoring mount for partition: volumio_data Aug 30 14:28:08 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "volumio_command_line_client"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "upnp"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: [1788092888631] Starting Upmpd Daemon Aug 30 14:28:08 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "my_music"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "mpd"... Aug 30 14:28:08 volumiopi5 avahi-daemon[747]: Host name conflict, retrying with volumiopi5-2 Aug 30 14:28:08 volumiopi5 avahi-daemon[747]: Registering new address record for 192.168.1.125 on wlan0.IPv4. Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "upnp_browser"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Starting UPNP Browser Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "alarm-clock"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Plugin airplay_emulation is not enabled Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "last_100"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "webradio"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "i2s_dacs"... Aug 30 14:28:08 volumiopi5 volumio[1186]: info: I2S DAC not set, start Auto-detection Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "volumiodiscovery"... Aug 30 14:28:08 volumiopi5 volumio[1186]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 14:28:08 volumiopi5 node[1186]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 14:28:08 volumiopi5 node[1186]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 14:28:08 volumiopi5 volumio[1186]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 14:28:08 volumiopi5 volumio[1186]: *** WARNING *** For more information see Aug 30 14:28:08 volumiopi5 volumio[1186]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 14:28:08 volumiopi5 volumio[1186]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 14:28:08 volumiopi5 volumio[1186]: *** WARNING *** For more information see Aug 30 14:28:08 volumiopi5 node[1186]: *** WARNING *** For more information see Aug 30 14:28:08 volumiopi5 node[1186]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 14:28:08 volumiopi5 node[1186]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 14:28:08 volumiopi5 node[1186]: *** WARNING *** For more information see Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Discovery: Started advertising with name: VolumioPi5 Aug 30 14:28:08 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 14:28:08 volumiopi5 volumio[1186]: info: Loading plugin "autostart"... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Applying required configuration parameters for plugin autostart Aug 30 14:28:09 volumiopi5 volumio[1186]: info: AutoStart - onVolumioStart - read config.json Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "outputs"... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "albumart"... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Plugin example_plugin is not enabled Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "inputs"... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "updater_comm"... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Plugin mpdemulation is not enabled Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "rest_api"... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "websocket"... Aug 30 14:28:09 volumiopi5 volumio[1186]: Forking 3 albumart workers Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Starting Socket.io Server version 2.3.0 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "backup_restore"... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Applying required configuration parameters for plugin backup_restore Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "Systeminfo"... Aug 30 14:28:09 volumiopi5 volumio[1186]: Starting albumart workers Aug 30 14:28:09 volumiopi5 volumio[1186]: Starting albumart workers Aug 30 14:28:09 volumiopi5 volumio[1186]: Starting albumart workers Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading plugin "touch_display"... Aug 30 14:28:09 volumiopi5 avahi-daemon[747]: Server startup complete. Host name is volumiopi5-2.local. Local service cookie is 3770389160. Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Applying required configuration parameters for plugin touch_display Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading i18n strings for locale de Aug 30 14:28:09 volumiopi5 volumio[1186]: Updating browse sources language Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 14:28:09 volumiopi5 volumio-time-update[745]: volumio-time-update-util: Fetching time from Volumio... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::initPlayerControls Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: Express server listening on port 3000 Aug 30 14:28:09 volumiopi5 volumio[1186]: [Metrics] WebUI: 2s 82.35ms Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreStateMachine::resetVolumioState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreStateMachine::getcurrentVolume Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreStateMachine::pushState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioPushState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Volumio Network Manager: Network status updated: 2 Aug 30 14:28:09 volumiopi5 volumio[1186]: verbose: New Socket.io Connection to 192.168.1.125 from 192.168.1.77 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 1 Aug 30 14:28:09 volumiopi5 volumio[1186]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Reloading queue from file Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreStateMachine::setRepeat null single undefined Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreStateMachine::pushState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioPushState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreStateMachine::setRandom null Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreStateMachine::pushState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioPushState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Setting Device type: Raspberry PI Aug 30 14:28:09 volumiopi5 volumio[1186]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 30 14:28:09 volumiopi5 volumio[1186]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Completed loading Core Plugins Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Preparing to generate the ALSA configuration file Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Asound.conf file unchanged, so no further update is needed Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Output device has changed, restarting MPD Aug 30 14:28:09 volumiopi5 sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 14:28:09 volumiopi5 sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 volumio[1186]: info: ___________ START PLUGINS ___________ Aug 30 14:28:09 volumiopi5 sudo[1325]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 14:28:09 volumiopi5 sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 volumio[1186]: info: ControllerMpd::onStart: Initializing MPD Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Creating MPD Configuration file Aug 30 14:28:09 volumiopi5 sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 30 14:28:09 volumiopi5 sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 14:28:09 volumiopi5 sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 14:28:09 volumiopi5 volumio[1186]: info: [1788092889782] CoreMusicLibrary::Adding element Medienserver Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 14:28:09 volumiopi5 volumio[1186]: info: UPNP Browser: Client initialized successfully Aug 30 14:28:09 volumiopi5 sudo[1335]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 14:28:09 volumiopi5 sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 14:28:09 volumiopi5 volumio[1186]: info: [1788092889787] CoreMusicLibrary::Adding element Last_100 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 14:28:09 volumiopi5 volumio[1186]: info: [1788092889788] CoreMusicLibrary::Adding element Webradio Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Initializing BBC Radios Aug 30 14:28:09 volumiopi5 systemd[1]: Listening on mpd.socket. Aug 30 14:28:09 volumiopi5 systemd[1]: Starting Music Player Daemon... Aug 30 14:28:09 volumiopi5 systemd[1]: Started Volumio5 Onboarding Server. Aug 30 14:28:09 volumiopi5 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 14:28:09 volumiopi5 systemd[1]: mpd.service: Succeeded. Aug 30 14:28:09 volumiopi5 systemd[1]: Stopped Music Player Daemon. Aug 30 14:28:09 volumiopi5 sudo[1331]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 systemd[1]: Starting Music Player Daemon... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: AutoStart - onStart Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Loading i18n strings for locale de Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Volumio Calling Home Aug 30 14:28:09 volumiopi5 sudo[1348]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 14:28:09 volumiopi5 sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1348]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 30 14:28:09 volumiopi5 sudo[1348]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 sudo[1358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Aug 30 14:28:09 volumiopi5 sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Aug 30 14:28:09 volumiopi5 sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 30 14:28:09 volumiopi5 sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 systemd[1]: Reloading. Aug 30 14:28:09 volumiopi5 volumio[1186]: info: touch_display: No backlight interface detected. Aug 30 14:28:09 volumiopi5 volumio[1186]: info: MPD Permissions set Aug 30 14:28:09 volumiopi5 volumio[1186]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:09 volumiopi5 volumio[1186]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Aug 30 14:28:09 volumiopi5 sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Aug 30 14:28:09 volumiopi5 sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1381]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 volumio[1186]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Aug 30 14:28:10 volumiopi5 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 30 14:28:10 volumiopi5 volumio5-onboarding[1343]: time=2026-08-30T14:28:10.050+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Aug 30 14:28:10 volumiopi5 volumio[1186]: 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: 4 Aug 30 14:28:10 volumiopi5 volumio[1186]: 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: 4 Aug 30 14:28:10 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:10 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:10 volumiopi5 volumio5-onboarding[1343]: time=2026-08-30T14:28:10.079+02:00 level=INFO msg="system info for 23f1d318efdd3b5ca4907f62c2b5e0ea" deviceName=VolumioPi5 deviceVariant=volumio deviceModel= softwareVersion=3.914 Aug 30 14:28:10 volumiopi5 systemd[1]: ifup@eth0.service: Current command vanished from the unit file, execution of the command list won't be resumed. Aug 30 14:28:10 volumiopi5 systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Aug 30 14:28:10 volumiopi5 volumio5-onboarding[1343]: time=2026-08-30T14:28:10.191+02:00 level=INFO msg="bootstrapping state" hasInternet=true Aug 30 14:28:10 volumiopi5 nmbd[943]: [2026/08/30 14:28:10.192886, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 30 14:28:10 volumiopi5 nmbd[943]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:10 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:10 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:10 volumiopi5 volumio-time-update[745]: volumio-time-update-util: Setting system time to: 2026-08-30 14:28:09 Aug 30 14:28:10 volumiopi5 sudo[1402]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-08-30 14:28:09 Aug 30 14:28:10 volumiopi5 sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:10 volumiopi5 systemd[1]: Started Samba NMB Daemon. Aug 30 14:28:10 volumiopi5 systemd[1]: Reloading. Aug 30 14:28:10 volumiopi5 sudo[1365]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:10 volumiopi5 volumio[1186]: info: touch_display: systemctl daemon-reload succeeded. Aug 30 14:28:10 volumiopi5 dbus-daemon[748]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.13' (uid=0 pid=1403 comm="timedatectl set-time 2026-08-30 14:28:09 ") Aug 30 14:28:10 volumiopi5 sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Aug 30 14:28:10 volumiopi5 sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:10 volumiopi5 avahi-daemon[747]: Service "VolumioPi5" (/services/volumio.service) successfully established. Aug 30 14:28:10 volumiopi5 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 30 14:28:10 volumiopi5 volumio[1186]: info: Volumio called home Aug 30 14:28:10 volumiopi5 sudo[1362]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:10 volumiopi5 volumio[1186]: info: touch_display: systemctl disable getty@tty1.service succeeded. Aug 30 14:28:10 volumiopi5 sudo[1405]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:10 volumiopi5 volumio[1186]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Aug 30 14:28:10 volumiopi5 volumio[1186]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Aug 30 14:28:10 volumiopi5 systemd[1]: Starting Time & Date Service... Aug 30 14:28:10 volumiopi5 systemd[1]: Starting Samba Winbind Daemon... Aug 30 14:28:10 volumiopi5 sudo[1358]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:10 volumiopi5 volumio[1186]: info: touch_display: systemctl stop getty@tty1.service succeeded. Aug 30 14:28:10 volumiopi5 dbus-daemon[748]: [system] Successfully activated service 'org.freedesktop.timedate1' Aug 30 14:28:10 volumiopi5 systemd[1]: Started Time & Date Service. Aug 30 14:28:09 volumiopi5 systemd-timedated[1420]: Changed local time to Sun Aug 30 14:28:09 2026 Aug 30 14:28:09 volumiopi5 sudo[1402]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 volumio-time-update[745]: volumio-time-update-util: System time updated successfully. Aug 30 14:28:09 volumiopi5 systemd[1]: Started Volumio Time Update Utility. Aug 30 14:28:09 volumiopi5 winbindd[1421]: [2026/08/30 14:28:09.035466, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 30 14:28:09 volumiopi5 winbindd[1421]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 30 14:28:09 volumiopi5 winbindd[1421]: [2026/08/30 14:28:09.042043, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 30 14:28:09 volumiopi5 systemd[1]: Started Samba Winbind Daemon. Aug 30 14:28:09 volumiopi5 winbindd[1421]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 30 14:28:09 volumiopi5 systemd[1]: Starting Samba SMB Daemon... Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Discovery: adding da9569cf-587b-4c4c-b234-a92d52938576 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Discovery: Found device VolumioPi5 Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:09 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:09 volumiopi5 smbd[1426]: [2026/08/30 14:28:09.245679, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 30 14:28:09 volumiopi5 smbd[1426]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 30 14:28:09 volumiopi5 systemd[1]: Started Samba SMB Daemon. Aug 30 14:28:09 volumiopi5 systemd[1]: Reached target Multi-User System. Aug 30 14:28:09 volumiopi5 systemd[1]: Reached target Graphical Interface. Aug 30 14:28:09 volumiopi5 systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 30 14:28:09 volumiopi5 sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 14:28:09 volumiopi5 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 30 14:28:09 volumiopi5 sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 14:28:09 volumiopi5 sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1438]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 30 14:28:09 volumiopi5 sudo[1436]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 mpd[1356]: Aug 30 14:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 14:28:09 volumiopi5 systemd[1]: Started Music Player Daemon. Aug 30 14:28:09 volumiopi5 systemd[1]: Startup finished in 10.780s (kernel) + 22.828s (userspace) = 33.608s. Aug 30 14:28:09 volumiopi5 sudo[1338]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 sudo[1328]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 volumio[1186]: info: Completed starting Core Plugins Aug 30 14:28:09 volumiopi5 volumio[1186]: info: ------------------------------------------- Aug 30 14:28:09 volumiopi5 volumio[1186]: info: ----- MyVolumio plugins startup ---- Aug 30 14:28:09 volumiopi5 volumio[1186]: info: ------------------------------------------- Aug 30 14:28:09 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 30 14:28:09 volumiopi5 volumio[1186]: error: MPD error: The expression evaluated to a falsy value: Aug 30 14:28:09 volumiopi5 volumio[1186]: assert.ok(self.idling) Aug 30 14:28:09 volumiopi5 volumio[1186]: error: The expression evaluated to a falsy value: Aug 30 14:28:09 volumiopi5 volumio[1186]: assert.ok(self.idling) Aug 30 14:28:09 volumiopi5 volumio[1186]: info: MPD running with PID1356 Aug 30 14:28:09 volumiopi5 volumio[1186]: ,establishing connection Aug 30 14:28:09 volumiopi5 volumio[1186]: error: MPD error: The expression evaluated to a falsy value: Aug 30 14:28:09 volumiopi5 volumio[1186]: assert.ok(self.idling) Aug 30 14:28:09 volumiopi5 volumio[1186]: error: The expression evaluated to a falsy value: Aug 30 14:28:09 volumiopi5 volumio[1186]: assert.ok(self.idling) Aug 30 14:28:09 volumiopi5 volumio[1186]: error: updateQueue error: null Aug 30 14:28:09 volumiopi5 volumio[1186]: verbose: New Socket.io Connection to 192.168.1.125 from 192.168.1.77 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 5 Aug 30 14:28:09 volumiopi5 sudo[1448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 14:28:09 volumiopi5 sudo[1448]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1448]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 sudo[1450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 14:28:09 volumiopi5 sudo[1450]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:09 volumiopi5 sudo[1450]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:09 volumiopi5 volumio[1186]: verbose: New Socket.io Connection to 192.168.1.125 from 192.168.1.77 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:154.0) Gecko/20100101 Firefox/154.0 Engine version: 3 Transport: polling Total Clients: 5 Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:10 volumiopi5 sudo[1228]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 14:28:10 volumiopi5 volumio[1186]: info: Listing playlists Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 14:28:10 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 14:28:12 volumiopi5 volumio-remote-updater[714]: [2026-08-30 14:28:12] [connect] Successful connection Aug 30 14:28:12 volumiopi5 volumio-remote-updater[714]: [2026-08-30 14:28:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1788092892 101 Aug 30 14:28:12 volumiopi5 volumio[1186]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Aug 30 14:28:12 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:28:12 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:12 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:12 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:12 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:12 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:12 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:12 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:12 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 30 14:28:14 volumiopi5 volumio[1186]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 30 14:28:14 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:28:14 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:14 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:14 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:14 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:14 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:14 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:14 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:14 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 30 14:28:17 volumiopi5 sudo[1468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 14:28:17 volumiopi5 sudo[1468]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:17 volumiopi5 sudo[1468]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:17 volumiopi5 sudo[1471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 14:28:17 volumiopi5 sudo[1471]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:17 volumiopi5 sudo[1471]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:17 volumiopi5 sudo[1474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 30 14:28:17 volumiopi5 sudo[1474]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:17 volumiopi5 systemd[1]: Started UPnP Renderer front-end to MPD. Aug 30 14:28:17 volumiopi5 sudo[1474]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Upmpdcli Daemon Started Aug 30 14:28:17 volumiopi5 volumio[1476]: Generating RSA private key, 4096 bit long modulus (2 primes) Aug 30 14:28:17 volumiopi5 systemd[1]: systemd-fsckd.service: Succeeded. Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Adding plugin bluetooth to MyMusic Plugins Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Adding plugin multiroom to MyMusic Plugins Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Adding plugin metavolumio to MyMusic Plugins Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Adding plugin cd_controller to MyMusic Plugins Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Adding plugin qobuzconnect to MyMusic Plugins Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 30 14:28:17 volumiopi5 volumio[1186]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 30 14:28:17 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 30 14:28:18 volumiopi5 sh[686]: timed out Aug 30 14:28:18 volumiopi5 dhcpcd[730]: timed out Aug 30 14:28:18 volumiopi5 sh[686]: dhcpcd exited Aug 30 14:28:18 volumiopi5 dhcpcd[730]: dhcpcd exited Aug 30 14:28:18 volumiopi5 sh[686]: ifup: failed to bring up eth0 Aug 30 14:28:18 volumiopi5 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Aug 30 14:28:18 volumiopi5 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Aug 30 14:28:18 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 30 14:28:18 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 30 14:28:18 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:18 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:18 volumiopi5 volumio[1186]: info: Starting MyVolumio Remote Streaming Endpoints Aug 30 14:28:18 volumiopi5 volumio[1186]: info: MyVolumio login type: Token Aug 30 14:28:18 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 30 14:28:18 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 30 14:28:18 volumiopi5 volumio[1186]: info: Starting Streaming Service Transparent Proxy Aug 30 14:28:18 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 30 14:28:18 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 30 14:28:18 volumiopi5 volumio[1186]: info: Streaming services startup Aug 30 14:28:18 volumiopi5 volumio[1186]: info: Starting Streaming Daemon Aug 30 14:28:18 volumiopi5 sudo[1500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 30 14:28:18 volumiopi5 sudo[1500]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:18 volumiopi5 sudo[1500]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:18 volumiopi5 volumio[1186]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 30 14:28:18 volumiopi5 volumio[1186]: error: Cannot start Volumio Streaming Daemon Aug 30 14:28:18 volumiopi5 volumio[1186]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 30 14:28:18 volumiopi5 volumio[1186]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 30 14:28:18 volumiopi5 volumio[1186]: STREAMING PROXY: Starting server on port 3245 Aug 30 14:28:18 volumiopi5 volumio[1186]: Node JS runtime: 14 Aug 30 14:28:19 volumiopi5 volumio[1186]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 30 14:28:19 volumiopi5 volumio[1186]: info: MyVolumio token set successfully Aug 30 14:28:19 volumiopi5 volumio[1186]: info: MYVOLUMIO: Adding device Aug 30 14:28:19 volumiopi5 volumio[1186]: info: MYVOLUMIO: Evaluating Server Aug 30 14:28:20 volumiopi5 volumio[1186]: info: MyVolumio status changed Aug 30 14:28:20 volumiopi5 volumio[1186]: info: Streaming services startup Aug 30 14:28:20 volumiopi5 volumio[1186]: info: Starting Streaming Daemon Aug 30 14:28:20 volumiopi5 volumio[1186]: info: Removing browser output: myVolumio user plan is not superstar Aug 30 14:28:20 volumiopi5 volumio[1186]: info: Removing audio output: Aug 30 14:28:20 volumiopi5 volumio[1186]: info: Stoppping Tunnel 1 Aug 30 14:28:20 volumiopi5 sudo[1528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 30 14:28:20 volumiopi5 sudo[1528]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:20 volumiopi5 sudo[1528]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:20 volumiopi5 volumio[1186]: error: Cannot start Volumio Streaming Daemon Aug 30 14:28:20 volumiopi5 volumio[1186]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 30 14:28:20 volumiopi5 volumio[1186]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 30 14:28:20 volumiopi5 sudo[1531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 30 14:28:20 volumiopi5 sudo[1531]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:28:20 volumiopi5 sudo[1531]: pam_unix(sudo:session): session closed for user root Aug 30 14:28:20 volumiopi5 volumio[1186]: info: Remote SSH Stopped Aug 30 14:28:22 volumiopi5 volumio[1186]: info: Setting Geolocation for MyVolumio to eu11 Aug 30 14:28:22 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:22 volumiopi5 volumio[1186]: info: Successfully Added MyVolumio device Aug 30 14:28:23 volumiopi5 volumio[1186]: info: Updating MyVolumio device info Aug 30 14:28:23 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:23 volumiopi5 volumio[1186]: info: Successfully Updated MyVolumio device Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Received Get System Version Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:28 volumiopi5 volumio[1186]: info: AutoStart - Plugin is starting Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetQueue Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::getQueue Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CorePlayQueue::getQueue Aug 30 14:28:28 volumiopi5 volumio[1186]: info: AutoStart - start playing Aug 30 14:28:28 volumiopi5 volumio[1186]: info: AutoStart - start playing with no specific position Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioPlay Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::play index 0 Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::stop Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::play index undefined Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CoreStateMachine::startPlaybackTimer Aug 30 14:28:28 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:28 volumiopi5 volumio[1186]: verbose: ControllerMpd::clearAddPlayTracks USB/Volumio5/mpd-neu/-SACD-Flac/Dire_Straits_Brothers_in_Arms/01. So Far Away.mp3 Aug 30 14:28:28 volumiopi5 volumio[1186]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 14:28:28 volumiopi5 volumio[1186]: info: sendMpdCommand stop took 2 milliseconds Aug 30 14:28:28 volumiopi5 volumio[1186]: verbose: ControllerMpd::sendMpdCommand clear Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Aug 30 14:28:28 volumiopi5 volumio[1186]: ---------------------------- MPD announces system playlist update Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Ignoring MPD Status Update Aug 30 14:28:28 volumiopi5 volumio[1186]: info: sendMpdCommand clear took 1 milliseconds Aug 30 14:28:28 volumiopi5 volumio[1186]: verbose: ControllerMpd::sendMpdCommand add "USB/Volumio5/mpd-neu/-SACD-Flac/Dire_Straits_Brothers_in_Arms/01. So Far Away.mp3" Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Aug 30 14:28:28 volumiopi5 volumio[1186]: ---------------------------- MPD announces system playlist update Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Ignoring MPD Status Update Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Aug 30 14:28:28 volumiopi5 volumio[1186]: ---------------------------- MPD announces system playlist update Aug 30 14:28:28 volumiopi5 volumio[1186]: info: Ignoring MPD Status Update Aug 30 14:28:28 volumiopi5 volumio[1186]: error: updateQueue error: null Aug 30 14:28:28 volumiopi5 volumio[1186]: error: updateQueue error: null Aug 30 14:28:28 volumiopi5 volumio[1186]: error: updateQueue error: null Aug 30 14:28:28 volumiopi5 volumio[1186]: info: ------------------------------ 4ms Aug 30 14:28:28 volumiopi5 volumio[1186]: info: ------------------------------ 2ms Aug 30 14:28:28 volumiopi5 volumio[1186]: info: ------------------------------ 1ms Aug 30 14:28:33 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 14:28:33 volumiopi5 volumio[1186]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 30 14:28:33 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:33 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:36 volumiopi5 volumio[1476]: .........................................................................................................................................................................................................................................................................................................................................................................................................................++++ Aug 30 14:28:37 volumiopi5 volumio[1476]: .............++++ Aug 30 14:28:37 volumiopi5 volumio[1476]: e is 65537 (0x010001) Aug 30 14:28:37 volumiopi5 volumio[1476]: writing RSA key Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetBrowseSources Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 14:28:38 volumiopi5 volumio-remote-updater[714]: No test mode Aug 30 14:28:38 volumiopi5 volumio-remote-updater[714]: No alpha test mode Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 30 14:28:38 volumiopi5 volumio[1186]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Completed starting MyVolumio Plugin Aug 30 14:28:38 volumiopi5 volumio[1186]: [Metrics] CommandRouter: 32s 237.19ms Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumiosetStartupVolume Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::Close All Modals sent Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::Close All Modals sent Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Aug 30 14:28:38 volumiopi5 volumio[1186]: aplay: main:828: audio open error: Unknown error 524 Aug 30 14:28:38 volumiopi5 volumio5-onboarding[1343]: failed to bootstrap state: failed to check for software update: could not check for updates: context deadline exceeded Aug 30 14:28:38 volumiopi5 systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Aug 30 14:28:38 volumiopi5 systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 30 14:28:38 volumiopi5 systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Aug 30 14:28:38 volumiopi5 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Aug 30 14:28:38 volumiopi5 systemd[1]: Stopped Volumio5 Onboarding Server. Aug 30 14:28:38 volumiopi5 systemd[1]: Started Volumio5 Onboarding Server. Aug 30 14:28:38 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:38.779+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Aug 30 14:28:38 volumiopi5 volumio[1186]: 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: 6 Aug 30 14:28:38 volumiopi5 volumio[1186]: 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: 6 Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:38 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:38.792+02:00 level=INFO msg="system info for 23f1d318efdd3b5ca4907f62c2b5e0ea" deviceName=VolumioPi5 deviceVariant=volumio deviceModel= softwareVersion=3.914 Aug 30 14:28:38 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:38.805+02:00 level=INFO msg="bootstrapping state" hasInternet=true Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:38 volumiopi5 volumio-remote-updater[714]: No test mode Aug 30 14:28:38 volumiopi5 volumio-remote-updater[714]: No alpha test mode Aug 30 14:28:38 volumiopi5 volumio[1186]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:28:38 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 14:28:39 volumiopi5 systemd[1]: systemd-timedated.service: Succeeded. Aug 30 14:28:39 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 30 14:28:39 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 30 14:28:39 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 30 14:28:39 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:39.535+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Aug 30 14:28:39 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:39.535+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Aug 30 14:28:39 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:39.535+02:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Aug 30 14:28:39 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:39.535+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Aug 30 14:28:39 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:28:39 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:28:39 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 14:28:40 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:28:40 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 14:28:41 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:41.500+02:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=lC6dZ9bb9BUX3BiOiap8l7RyzFz1 tokenExpiry=2026-08-30T15:28:41.500+02:00 Aug 30 14:28:42 volumiopi5 volumio[1186]: info: Received Get System Info Aug 30 14:28:42 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 14:28:42 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 14:28:42 volumiopi5 volumio[1186]: info: Discovery: Getting this device information Aug 30 14:28:42 volumiopi5 volumio[1186]: info: CoreCommandRouter::volumioGetState Aug 30 14:28:42 volumiopi5 volumio[1186]: info: CorePlayQueue::getTrack 0 Aug 30 14:28:42 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 14:28:42 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 14:28:42 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 14:28:42 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:42.495+02:00 level=INFO msg="enabling local network discovery" Aug 30 14:28:42 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:42.500+02:00 level=INFO msg="enabling BLE discovery" Aug 30 14:28:42 volumiopi5 bluetoothd[1004]: src/adapter.c:store_adapter_info() Unable set contents for /usr/var/lib/bluetooth/2C:CF:67:14:96:96/settings: (Failed to create file “/usr/var/lib/bluetooth/2C:CF:67:14:96:96/settings.3M2UU3”: No such file or directory) Aug 30 14:28:43 volumiopi5 volumio5-onboarding[1585]: time=2026-08-30T14:28:43.312+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 14:28:45 volumiopi5 volumio[1186]: info: BOOT COMPLETED Aug 30 14:28:54 volumiopi5 ntpd[992]: Soliciting pool server 131.188.3.222 Aug 30 14:28:55 volumiopi5 ntpd[992]: Soliciting pool server 139.162.152.20 Aug 30 14:28:56 volumiopi5 ntpd[992]: Soliciting pool server 78.46.87.46 Aug 30 14:28:56 volumiopi5 ntpd[992]: Soliciting pool server 148.251.235.164 Aug 30 14:28:56 volumiopi5 ntpd[992]: Soliciting pool server 217.197.91.176 Aug 30 14:28:57 volumiopi5 ntpd[992]: Soliciting pool server 185.16.60.96 Aug 30 14:28:57 volumiopi5 ntpd[992]: Soliciting pool server 213.209.109.44 Aug 30 14:28:57 volumiopi5 ntpd[992]: Soliciting pool server 31.70.111.17 Aug 30 14:28:57 volumiopi5 ntpd[992]: Soliciting pool server 162.55.101.82 Aug 30 14:28:58 volumiopi5 ntpd[992]: Soliciting pool server 162.159.200.1 Aug 30 14:28:58 volumiopi5 ntpd[992]: Soliciting pool server 162.159.200.123 Aug 30 14:28:58 volumiopi5 ntpd[992]: Soliciting pool server 185.232.69.65 Aug 30 14:28:59 volumiopi5 ntpd[992]: Soliciting pool server 90.187.112.137 Aug 30 14:28:59 volumiopi5 ntpd[992]: Soliciting pool server 185.252.140.125 Aug 30 14:28:59 volumiopi5 ntpd[992]: Soliciting pool server 94.130.184.193 Aug 30 14:29:00 volumiopi5 ntpd[992]: Soliciting pool server 5.9.193.27 Aug 30 14:29:01 volumiopi5 ntpd[992]: Soliciting pool server 2a02:8106:21:9400::5 Aug 30 14:29:04 volumiopi5 ntpd[992]: receive: Unexpected origin timestamp 0xee3ea08f.6e9eeb02 does not match aorg 0000000000.00000000 from server@185.252.140.125 xmt 0xee3ea090.836e4070 Aug 30 14:29:04 volumiopi5 ntpd[992]: receive: Unexpected origin timestamp 0xee3ea08f.6ea0f5a2 does not match aorg 0000000000.00000000 from server@78.46.87.46 xmt 0xee3ea090.836d68dc Aug 30 14:29:04 volumiopi5 ntpd[992]: receive: Unexpected origin timestamp 0xee3ea08f.6e9d88c2 does not match aorg 0000000000.00000000 from server@5.9.193.27 xmt 0xee3ea090.835695c8 Aug 30 14:29:04 volumiopi5 ntpd[992]: receive: Unexpected origin timestamp 0xee3ea08f.6ea0994f does not match aorg 0000000000.00000000 from server@148.251.235.164 xmt 0xee3ea090.839119e4 Aug 30 14:29:04 volumiopi5 ntpd[992]: receive: Unexpected origin timestamp 0xee3ea08f.6ea03bcf does not match aorg 0000000000.00000000 from server@217.197.91.176 xmt 0xee3ea090.83e74b44 Aug 30 14:29:04 volumiopi5 ntpd[992]: receive: Unexpected origin timestamp 0xee3ea08f.6e9fd045 does not match aorg 0000000000.00000000 from server@213.209.109.44 xmt 0xee3ea090.83c7b50b Aug 30 14:29:34 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 14:29:34 volumiopi5 volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 14:29:53 volumiopi5 volumio[1186]: info: Starting Uninstall of plugin user_interface - touch_display Aug 30 14:29:53 volumiopi5 volumio[1186]: info: Uninstalling plugin touch_display Aug 30 14:29:53 volumiopi5 sudo[1778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Aug 30 14:29:53 volumiopi5 sudo[1778]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:29:53 volumiopi5 sudo[1778]: pam_unix(sudo:session): session closed for user root Aug 30 14:29:53 volumiopi5 sudo[1781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Aug 30 14:29:53 volumiopi5 sudo[1781]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:29:53 volumiopi5 sudo[1784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Aug 30 14:29:53 volumiopi5 sudo[1784]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:29:53 volumiopi5 systemd[1]: Created slice system-getty.slice. Aug 30 14:29:53 volumiopi5 volumio[1186]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Aug 30 14:29:53 volumiopi5 volumio[1186]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 14:29:53 volumiopi5 sudo[1787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Aug 30 14:29:53 volumiopi5 sudo[1787]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 14:29:53 volumiopi5 volumio[1186]: TypeError: Cannot read property 'split' of undefined Aug 30 14:29:53 volumiopi5 volumio[1186]: at /data/plugins/user_interface/touch_display/index.js:1258:37 Aug 30 14:29:53 volumiopi5 volumio[1186]: at ChildProcess.exithandler (child_process.js:299:7) Aug 30 14:29:53 volumiopi5 volumio[1186]: at ChildProcess.emit (events.js:315:20) Aug 30 14:29:53 volumiopi5 volumio[1186]: at maybeClose (internal/child_process.js:1048:16) Aug 30 14:29:53 volumiopi5 volumio[1186]: at Socket. (internal/child_process.js:439:11) Aug 30 14:29:53 volumiopi5 volumio[1186]: at Socket.emit (events.js:315:20) Aug 30 14:29:53 volumiopi5 volumio[1186]: at Pipe. (net.js:673:12) Aug 30 14:29:53 volumiopi5 volumio[1186]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 14:29:53 volumiopi5 systemd[1]: Started Getty on tty1. Aug 30 14:29:53 volumiopi5 sudo[1781]: pam_unix(sudo:session): session closed for user root Aug 30 14:29:53 volumiopi5 sudo[1787]: pam_unix(sudo:session): session closed for user root Aug 30 14:29:53 volumiopi5 systemd[1]: Reloading. Aug 30 14:29:53 volumiopi5 sudo[1812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-30 14:28 Aug 30 14:29:53 volumiopi5 sudo[1812]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5c0e72e4b5817fe66c91c9d15d75ff13b8e3f4ba" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 30 Mar 2026 02:51:29 PM CEST" VOLUMIO_VERSION="3.914" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="98fe12c88d8ff391f569279e2f874892"