-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Tue 2026-06-02 22:59:54 BST. -- Jun 02 22:59:32 volumio systemd-timedated[1031]: Changed local time to Tue Jun 2 22:59:32 2026 Jun 02 22:59:32 volumio sudo[1029]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:32 volumio volumio-time-update[655]: volumio-time-update-util: System time updated successfully. Jun 02 22:59:32 volumio systemd[1]: Started Volumio Time Update Utility. Jun 02 22:59:32 volumio wireless.js[661]: trying... Jun 02 22:59:32 volumio sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 22:59:32 volumio sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:32 volumio sudo[1033]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:32 volumio nmbd[767]: [2026/06/02 22:59:32.345348, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 02 22:59:32 volumio nmbd[767]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 02 22:59:32 volumio systemd[1]: Started Samba NMB Daemon. Jun 02 22:59:32 volumio systemd[1]: Starting Samba Winbind Daemon... Jun 02 22:59:32 volumio winbindd[1036]: [2026/06/02 22:59:32.725768, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jun 02 22:59:32 volumio winbindd[1036]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 02 22:59:32 volumio winbindd[1036]: [2026/06/02 22:59:32.748463, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 02 22:59:32 volumio winbindd[1036]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 02 22:59:32 volumio systemd[1]: Started Samba Winbind Daemon. Jun 02 22:59:32 volumio systemd[1]: Starting Samba SMB Daemon... Jun 02 22:59:33 volumio wireless.js[661]: trying... Jun 02 22:59:33 volumio sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 22:59:33 volumio sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:33 volumio sudo[1043]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:33 volumio smbd[1041]: [2026/06/02 22:59:33.286023, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 02 22:59:33 volumio smbd[1041]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 02 22:59:33 volumio systemd[1]: Started Samba SMB Daemon. Jun 02 22:59:33 volumio ntpd[819]: Listen normally on 3 eth0 192.168.0.4:123 Jun 02 22:59:33 volumio ntpd[819]: new interface(s) found: waking up resolver Jun 02 22:59:34 volumio wireless.js[661]: trying... Jun 02 22:59:34 volumio sudo[1053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 22:59:34 volumio sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:34 volumio sudo[1053]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:34 volumio wpa_supplicant[908]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 02 22:59:34 volumio wpa_supplicant[908]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=GB Jun 02 22:59:35 volumio wireless.js[661]: trying... Jun 02 22:59:35 volumio sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 22:59:35 volumio sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:35 volumio sudo[1056]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:36 volumio wireless.js[661]: trying... Jun 02 22:59:36 volumio sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 22:59:36 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:36 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:36 volumio dhcpcd[1027]: wlan0: leased 192.168.0.7 for 86400 seconds Jun 02 22:59:36 volumio avahi-daemon[662]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.7. Jun 02 22:59:36 volumio dhcpcd[1027]: wlan0: adding route to 192.168.0.0/24 Jun 02 22:59:36 volumio avahi-daemon[662]: New relevant interface wlan0.IPv4 for mDNS. Jun 02 22:59:36 volumio avahi-daemon[662]: Registering new address record for 192.168.0.7 on wlan0.IPv4. Jun 02 22:59:36 volumio dhcpcd[1027]: wlan0: adding default route via 192.168.0.1 Jun 02 22:59:37 volumio wireless.js[661]: trying... Jun 02 22:59:37 volumio sudo[1083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 22:59:37 volumio sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:37 volumio sudo[1083]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:37 volumio wireless.js[661]: Connected to: ----Doris Jun 02 22:59:37 volumio wireless.js[661]: ---- Jun 02 22:59:37 volumio sudo[1086]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 22:59:37 volumio sudo[1086]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:37 volumio sudo[1086]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:37 volumio wireless.js[661]: ... joined AP, wlan0 IPv4 is 192.168.0.7, ipV6 is undefined Jun 02 22:59:37 volumio wireless.js[661]: It's done! AP Jun 02 22:59:37 volumio systemd[1]: Started Wireless Services. Jun 02 22:59:37 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 02 22:59:37 volumio systemd[1]: Started Volumio Backend Module. Jun 02 22:59:37 volumio systemd[1]: Started Volumio Cpu Tweaker. Jun 02 22:59:37 volumio systemd[1]: Reached target Multi-User System. Jun 02 22:59:37 volumio systemd[1]: Reached target Graphical Interface. Jun 02 22:59:37 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 02 22:59:37 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 02 22:59:37 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 02 22:59:37 volumio systemd[1]: Startup finished in 13.923s (kernel) + 17.857s (userspace) = 31.781s. Jun 02 22:59:37 volumio volumio-cpu-tweak[1092]: Setting RT Priority for mpd Jun 02 22:59:37 volumio volumio-cpu-tweak[1092]: pid 35's current scheduling policy: SCHED_OTHER Jun 02 22:59:37 volumio volumio-cpu-tweak[1092]: pid 35's current scheduling priority: 0 Jun 02 22:59:37 volumio volumio-cpu-tweak[1092]: Setting MPD Affinity Jun 02 22:59:37 volumio volumio-cpu-tweak[1092]: pid 3's current affinity mask: f Jun 02 22:59:37 volumio volumio-cpu-tweak[1092]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jun 02 22:59:37 volumio volumio-cpu-tweak[1092]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 02 22:59:37 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Jun 02 22:59:38 volumio volumio-remote-updater[626]: [2026-06-02 22:59:38] [info] asio async_connect error: system:111 (Connection refused) Jun 02 22:59:38 volumio volumio-remote-updater[626]: [2026-06-02 22:59:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 02 22:59:38 volumio volumio-remote-updater[626]: [2026-06-02 22:59:38] [error] handle_connect error: Underlying Transport Error Jun 02 22:59:38 volumio ntpd[819]: Listen normally on 4 wlan0 192.168.0.7:123 Jun 02 22:59:38 volumio ntpd[819]: new interface(s) found: waking up resolver Jun 02 22:59:40 volumio volumio[1091]: info: ------------------------------------------- Jun 02 22:59:40 volumio volumio[1091]: info: ----- Volumio3 ---- Jun 02 22:59:40 volumio volumio[1091]: info: ------------------------------------------- Jun 02 22:59:40 volumio volumio[1091]: info: ----- System startup ---- Jun 02 22:59:40 volumio volumio[1091]: info: ------------------------------------------- Jun 02 22:59:41 volumio volumio[1091]: info: MYVOLUMIO Environment detected Jun 02 22:59:41 volumio volumio[1091]: info: Plugin folders cleanup Jun 02 22:59:41 volumio volumio[1091]: info: Scanning into folder /volumio/app/plugins/ Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category audio_interface Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category miscellanea Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category music_service Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category plugins.json Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category system_controller Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category user_interface Jun 02 22:59:41 volumio volumio[1091]: info: Scanning into folder /data/plugins/ Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category audio_interface Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category music_service Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category system_controller Jun 02 22:59:41 volumio volumio[1091]: info: Scanning category user_interface Jun 02 22:59:41 volumio volumio[1091]: info: Plugin folders cleanup completed Jun 02 22:59:41 volumio volumio[1091]: info: ------------------------------------------- Jun 02 22:59:41 volumio volumio[1091]: info: ----- Core plugins startup ---- Jun 02 22:59:41 volumio volumio[1091]: info: ------------------------------------------- Jun 02 22:59:41 volumio volumio[1091]: info: Loading plugins from folder /volumio/app/plugins/ Jun 02 22:59:41 volumio volumio[1091]: info: Adding plugin upnp to MyMusic Plugins Jun 02 22:59:41 volumio volumio[1091]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 02 22:59:41 volumio volumio[1091]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 02 22:59:41 volumio volumio[1091]: info: Loading plugins from folder /data/plugins/ Jun 02 22:59:41 volumio volumio[1091]: info: Loading plugin "system"... Jun 02 22:59:41 volumio volumio[1091]: info: Loading plugin "appearance"... Jun 02 22:59:43 volumio volumio[1091]: info: Loading plugin "network"... Jun 02 22:59:43 volumio volumio[1091]: info: Refreshing Cached IP Addresses Jun 02 22:59:43 volumio sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 22:59:43 volumio sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:43 volumio sudo[1123]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:43 volumio sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 22:59:43 volumio sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:43 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:43 volumio volumio[1091]: info: Loading plugin "services"... Jun 02 22:59:43 volumio volumio[1091]: info: Loading plugin "volumio5onboarding"... Jun 02 22:59:43 volumio sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 02 22:59:43 volumio sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:43 volumio volumio[1091]: info: Loading plugin "alsa_controller"... Jun 02 22:59:43 volumio volumio[1091]: warn: The ALSA output card is not set, defaulting to card [object Object] Jun 02 22:59:43 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 02 22:59:43 volumio volumio[1091]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Jun 02 22:59:43 volumio volumio[1091]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 02 22:59:43 volumio volumio[1091]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 02 22:59:43 volumio volumio[1091]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 02 22:59:43 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 22:59:43 volumio volumio[1091]: info: Loading plugin "wizard"... Jun 02 22:59:43 volumio volumio[1091]: info: Loading plugin "networkfs"... Jun 02 22:59:44 volumio volumio[1091]: info: Starting Udev Watcher for removable devices Jun 02 22:59:44 volumio sudo[1159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Mark,password=katieneo1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.172/Markset/music /mnt/NAS/Truenas Jun 02 22:59:44 volumio sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:44 volumio volumio[1091]: info: Ignoring mount for partition: boot Jun 02 22:59:44 volumio volumio[1091]: info: Ignoring mount for partition: volumio Jun 02 22:59:44 volumio volumio[1091]: info: Ignoring mount for partition: volumio_data Jun 02 22:59:44 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 22:59:44 volumio volumio[1091]: info: Loading plugin "volumio_command_line_client"... Jun 02 22:59:44 volumio volumio[1091]: info: Loading plugin "upnp"... Jun 02 22:59:44 volumio volumio[1091]: info: [1780437584126] Starting Upmpd Daemon Jun 02 22:59:44 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 22:59:44 volumio volumio[1091]: info: Loading plugin "my_music"... Jun 02 22:59:44 volumio volumio[1091]: info: Loading plugin "mpd"... Jun 02 22:59:44 volumio kernel: Key type cifs.spnego registered Jun 02 22:59:44 volumio kernel: Key type cifs.idmap registered Jun 02 22:59:44 volumio 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. Jun 02 22:59:44 volumio kernel: CIFS: Attempting to mount //192.168.0.172/Markset/music Jun 02 22:59:44 volumio sudo[1137]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:44 volumio sudo[1159]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:44 volumio volumio[1091]: info: Loading plugin "upnp_browser"... Jun 02 22:59:45 volumio volumio[1091]: info: Starting UPNP Browser Jun 02 22:59:45 volumio volumio[1091]: info: Loading plugin "alarm-clock"... Jun 02 22:59:45 volumio volumio[1091]: info: Loading plugin "airplay_emulation"... Jun 02 22:59:45 volumio volumio[1091]: info: Starting Shairport Sync Jun 02 22:59:45 volumio volumio[1091]: info: Loading plugin "last_100"... Jun 02 22:59:45 volumio volumio[1091]: info: Loading plugin "webradio"... Jun 02 22:59:45 volumio volumio[1091]: info: Loading plugin "i2s_dacs"... Jun 02 22:59:45 volumio volumio[1091]: info: Loading plugin "volumiodiscovery"... Jun 02 22:59:45 volumio volumio[1091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 22:59:45 volumio volumio[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 22:59:45 volumio volumio[1091]: *** WARNING *** For more information see Jun 02 22:59:45 volumio volumio[1091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 22:59:45 volumio volumio[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 22:59:45 volumio volumio[1091]: *** WARNING *** For more information see Jun 02 22:59:45 volumio node[1091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 22:59:45 volumio node[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 22:59:45 volumio node[1091]: *** WARNING *** For more information see Jun 02 22:59:45 volumio node[1091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 22:59:45 volumio node[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 22:59:45 volumio node[1091]: *** WARNING *** For more information see Jun 02 22:59:45 volumio volumio[1091]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 02 22:59:45 volumio volumio[1091]: info: Discovery: Started advertising with name: Volumio Jun 02 22:59:45 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 22:59:45 volumio volumio[1091]: info: Loading plugin "spop"... Jun 02 22:59:47 volumio volumio[1091]: info: Loading plugin "outputs"... Jun 02 22:59:47 volumio volumio[1091]: info: Loading plugin "albumart"... Jun 02 22:59:47 volumio volumio[1091]: info: Plugin example_plugin is not enabled Jun 02 22:59:47 volumio volumio[1091]: info: Loading plugin "inputs"... Jun 02 22:59:47 volumio volumio[1091]: info: Loading plugin "updater_comm"... Jun 02 22:59:47 volumio volumio[1091]: info: Plugin mpdemulation is not enabled Jun 02 22:59:47 volumio volumio[1091]: info: Loading plugin "rest_api"... Jun 02 22:59:47 volumio volumio[1091]: info: Loading plugin "websocket"... Jun 02 22:59:47 volumio volumio[1091]: info: Starting Socket.io Server version 2.3.0 Jun 02 22:59:47 volumio volumio[1091]: info: Loading plugin "fusiondsp"... Jun 02 22:59:48 volumio volumio[1091]: Forking 3 albumart workers Jun 02 22:59:48 volumio volumio-remote-updater[626]: [2026-06-02 22:59:48] [connect] Successful connection Jun 02 22:59:48 volumio volumio[1091]: info: Applying required configuration parameters for plugin fusiondsp Jun 02 22:59:48 volumio volumio[1091]: info: Plugin 80s80s is not enabled Jun 02 22:59:48 volumio volumio[1091]: info: Plugin backup_restore is not enabled Jun 02 22:59:48 volumio volumio[1091]: info: Loading plugin "touch_display"... Jun 02 22:59:49 volumio volumio[1091]: Starting albumart workers Jun 02 22:59:49 volumio volumio[1091]: Starting albumart workers Jun 02 22:59:49 volumio volumio[1091]: Starting albumart workers Jun 02 22:59:49 volumio volumio[1091]: info: Applying required configuration parameters for plugin touch_display Jun 02 22:59:49 volumio volumio[1091]: info: Loading i18n strings for locale en Jun 02 22:59:49 volumio volumio[1091]: Updating browse sources language Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::initPlayerControls Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 22:59:49 volumio volumio[1091]: Express server listening on port 3000 Jun 02 22:59:49 volumio volumio[1091]: [Metrics] WebUI: 10s 767.89ms Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::resetVolumioState Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::getcurrentVolume Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::getcurrentVolume Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 22:59:50 volumio volumio[1091]: info: Volumio Network Manager: Network status updated: 3 Jun 02 22:59:50 volumio volumio-remote-updater[626]: [2026-06-02 22:59:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1780437588 101 Jun 02 22:59:50 volumio volumio[1091]: 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: 1 Jun 02 22:59:50 volumio volumio[1091]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:50 volumio volumio[1091]: info: Reloading queue from file Jun 02 22:59:50 volumio volumio[1091]: info: VolumeController:: Volume=86 Mute =false Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::pushState Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::updateTrackBlock Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrackBlock Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 22:59:50 volumio volumio[1091]: info: VolumeController:: Volume=86 Mute =false Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::pushState Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::updateTrackBlock Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrackBlock Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 22:59:50 volumio volumio[1091]: info: Setting Device type: Raspberry PI Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::setRepeat null single undefined Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::pushState Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::setRandom false Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::pushState Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Jun 02 22:59:50 volumio volumio[1091]: info: Completed loading Core Plugins Jun 02 22:59:50 volumio volumio[1091]: info: Preparing to generate the ALSA configuration file Jun 02 22:59:50 volumio volumio[1091]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 02 22:59:50 volumio volumio[1091]: info: Reading ALSA contributions from plugins. Jun 02 22:59:50 volumio volumio[1091]: info: VolumeController:: Volume=86 Mute =false Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::pushState Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Jun 02 22:59:50 volumio volumio[1091]: info: VolumeController:: Volume=86 Mute =false Jun 02 22:59:50 volumio volumio[1091]: info: CoreStateMachine::pushState Jun 02 22:59:50 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Jun 02 22:59:50 volumio volumio[1091]: info: Asound.conf file written Jun 02 22:59:50 volumio sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 02 22:59:50 volumio sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:50 volumio sudo[1266]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:50 volumio volumio[1091]: info: Output device has changed, restarting MPD Jun 02 22:59:50 volumio volumio[1091]: info: Output device has changed, restarting Shairport Sync Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:50 volumio sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 22:59:50 volumio sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:50 volumio sudo[1271]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:50 volumio sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 22:59:50 volumio sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:50 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 22:59:50 volumio volumio[1091]: info: ___________ START PLUGINS ___________ Jun 02 22:59:50 volumio volumio[1091]: info: ControllerMpd::onStart: Initializing MPD Jun 02 22:59:50 volumio volumio[1091]: info: Creating MPD Configuration file Jun 02 22:59:50 volumio sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Jun 02 22:59:50 volumio sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 22:59:50 volumio volumio[1091]: info: [1780437590905] CoreMusicLibrary::Adding element Media Servers Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 22:59:50 volumio sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 22:59:50 volumio sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:50 volumio systemd[1]: Listening on mpd.socket. Jun 02 22:59:50 volumio sudo[1283]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:50 volumio systemd[1]: Starting Music Player Daemon... Jun 02 22:59:50 volumio volumio[1091]: info: UPNP Browser: Client initialized successfully Jun 02 22:59:50 volumio sudo[1286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 22:59:50 volumio sudo[1286]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:50 volumio systemd[1]: Started Volumio5 Onboarding Server. Jun 02 22:59:50 volumio sudo[1281]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:50 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:50 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 02 22:59:50 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:50 volumio systemd[1]: mpd.service: Succeeded. Jun 02 22:59:50 volumio systemd[1]: Stopped Music Player Daemon. Jun 02 22:59:51 volumio systemd[1]: Starting Music Player Daemon... Jun 02 22:59:51 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 22:59:51 volumio volumio[1091]: info: [1780437591052] CoreMusicLibrary::Adding element Last_100 Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 22:59:51 volumio volumio[1091]: info: [1780437591056] CoreMusicLibrary::Adding element Webradio Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 22:59:51 volumio volumio[1091]: info: Initializing BBC Radios Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:51 volumio sudo[1295]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 02 22:59:51 volumio sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:51 volumio sudo[1295]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 02 22:59:51 volumio sudo[1295]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:51 volumio volumio[1091]: info: Creating Spotify config file Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: Loading i18n strings for locale en Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: FusionDsp - mixtype--------------------- Hardware Jun 02 22:59:51 volumio volumio[1091]: info: Loading i18n strings for locale en Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 22:59:51 volumio volumio[1091]: info: Volumio Calling Home Jun 02 22:59:51 volumio volumio[1091]: info: Preparing to generate the ALSA configuration file Jun 02 22:59:51 volumio sudo[1319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jun 02 22:59:51 volumio sudo[1319]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:51 volumio sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jun 02 22:59:51 volumio sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:51 volumio sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jun 02 22:59:51 volumio sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:51 volumio volumio[1091]: info: Discovery: adding 2a35a67d-e071-4c8d-a3fd-238374f25e20 Jun 02 22:59:51 volumio volumio[1091]: info: Discovery: Found device Volumio Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Jun 02 22:59:51 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:51 volumio volumio[1091]: info: Discovery: this is already registered, 2a35a67d-e071-4c8d-a3fd-238374f25e20 Jun 02 22:59:51 volumio volumio[1091]: info: Discovery: Found device Volumio Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Jun 02 22:59:51 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:51 volumio volumio[1091]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 02 22:59:51 volumio volumio[1091]: info: Reading ALSA contributions from plugins. Jun 02 22:59:51 volumio volumio[1091]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Jun 02 22:59:51 volumio volumio[1091]: info: MPD Permissions set Jun 02 22:59:51 volumio volumio[1091]: info: MPD Permissions set Jun 02 22:59:51 volumio volumio[1091]: info: Volumio called home Jun 02 22:59:51 volumio volumio[1091]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 02 22:59:51 volumio volumio[1091]: info: Spotify config file written Jun 02 22:59:51 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:51.655+01:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z Jun 02 22:59:51 volumio sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 22:59:51 volumio sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:51 volumio volumio[1091]: info: No need to fix Spotify hosts Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio systemd[1]: Reloading. Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:51 volumio volumio[1091]: 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 Jun 02 22:59:52 volumio volumio[1091]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jun 02 22:59:52 volumio sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jun 02 22:59:52 volumio sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio volumio[1091]: 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 Jun 02 22:59:52 volumio volumio[1091]: info: Received Get System Info Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 22:59:52 volumio volumio[1091]: info: Discovery: Getting this device information Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Jun 02 22:59:52 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 22:59:52 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:52.077+01:00 level=INFO msg="system info for d2ac07423db3b57fe14a0b881909e275" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=3.912 Jun 02 22:59:52 volumio sudo[1356]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Jun 02 22:59:52 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:52 volumio volumio[1091]: info: Starting Shairport Sync Jun 02 22:59:52 volumio volumio[1091]: info: Starting Shairport Sync Jun 02 22:59:52 volumio volumio[1091]: info: Starting Shairport Sync Jun 02 22:59:52 volumio sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 22:59:52 volumio 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. Jun 02 22:59:52 volumio sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 22:59:52 volumio sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio volumio[1091]: info: Received Get System Info Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 22:59:52 volumio volumio[1091]: info: Discovery: Getting this device information Jun 02 22:59:52 volumio sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Jun 02 22:59:52 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 22:59:52 volumio sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio volumio[1091]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jun 02 22:59:52 volumio volumio[1091]: info: New Spotify access tokenBQCpRtfVxr... Jun 02 22:59:52 volumio volumio[1091]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 02 22:59:52 volumio volumio[1091]: info: Asound.conf file unchanged, so no further update is needed Jun 02 22:59:52 volumio volumio[1091]: info: Output device has changed, restarting MPD Jun 02 22:59:52 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:52.341+01:00 level=INFO msg="enabling local network discovery" Jun 02 22:59:52 volumio volumio[1091]: info: Output device has changed, restarting Shairport Sync Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:52 volumio sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 22:59:52 volumio sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:52.382+01:00 level=INFO msg="enabling BLE discovery" Jun 02 22:59:52 volumio sudo[1369]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:52 volumio sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 22:59:52 volumio sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio bluetoothd[778]: src/adapter.c:store_adapter_info() Unable set contents for /usr/var/lib/bluetooth/B8:27:EB:61:00:BD/settings: (Failed to create file “/usr/var/lib/bluetooth/B8:27:EB:61:00:BD/settings.JFC3P3”: No such file or directory) Jun 02 22:59:52 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 22:59:52 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:52.476+01:00 level=INFO msg="bootstrapping state" hasInternet=true Jun 02 22:59:52 volumio volumio[1091]: info: Received Get System Info Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 22:59:52 volumio volumio[1091]: info: Discovery: Getting this device information Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Jun 02 22:59:52 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 22:59:52 volumio volumio[1091]: info: MPD Permissions set Jun 02 22:59:52 volumio volumio-remote-updater[626]: No test mode Jun 02 22:59:52 volumio volumio-remote-updater[626]: No alpha test mode Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:52 volumio volumio[1091]: info: Starting Shairport Sync Jun 02 22:59:52 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 22:59:52 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio volumio[1091]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 22:59:52 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:52.730+01: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" Jun 02 22:59:52 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:52.732+01: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" Jun 02 22:59:52 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:52.732+01: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" Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 22:59:52 volumio volumio[1091]: info: Spotify Successfully logged in Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 22:59:52 volumio volumio[1091]: info: [1780437592770] CoreMusicLibrary::Adding element Spotify Jun 02 22:59:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 22:59:52 volumio volumio[1091]: Cannot find translation for source Spotify Jun 02 22:59:52 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 02 22:59:52 volumio sudo[1323]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:52 volumio volumio[1091]: info: touch_display: systemctl daemon-reload succeeded. Jun 02 22:59:52 volumio sudo[1388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jun 02 22:59:52 volumio sudo[1388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:52 volumio systemd[1]: Reloading. Jun 02 22:59:53 volumio 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. Jun 02 22:59:53 volumio volumio[1091]: info: camilladsp service started and running in background, instance 1 Jun 02 22:59:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 22:59:53 volumio volumio[1091]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 02 22:59:53 volumio volumio[1091]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 02 22:59:53 volumio volumio[1091]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 02 22:59:53 volumio volumio[1091]: info: FusionDsp loaded Jun 02 22:59:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 22:59:53 volumio sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 02 22:59:53 volumio sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:53 volumio volumio[1091]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 02 22:59:53 volumio volumio[1091]: info: Adding Signal Path Element [object Object] Jun 02 22:59:53 volumio volumio[1091]: info: Adding fusiondspeq DSP Signal Path Element Jun 02 22:59:53 volumio volumio[1091]: info: FusionDsp - ---- installed callbackRead Jun 02 22:59:53 volumio volumio[1091]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 22:59:53 volumio volumio[1091]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 02 22:59:53 volumio volumio[1091]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 02 22:59:53 volumio volumio[1091]: at onErrorNT (internal/child_process.js:465:16) Jun 02 22:59:53 volumio volumio[1091]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jun 02 22:59:53 volumio volumio[1091]: errno: -2, Jun 02 22:59:53 volumio volumio[1091]: code: 'ENOENT', Jun 02 22:59:53 volumio volumio[1091]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 02 22:59:53 volumio volumio[1091]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 02 22:59:53 volumio volumio[1091]: spawnargs: [ Jun 02 22:59:53 volumio volumio[1091]: '-p', Jun 02 22:59:53 volumio volumio[1091]: 9876, Jun 02 22:59:53 volumio volumio[1091]: '-o', Jun 02 22:59:53 volumio volumio[1091]: '/tmp/camilladsp.log', Jun 02 22:59:53 volumio volumio[1091]: '-l', Jun 02 22:59:53 volumio volumio[1091]: 'warn', Jun 02 22:59:53 volumio volumio[1091]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 02 22:59:53 volumio volumio[1091]: ] Jun 02 22:59:53 volumio volumio[1091]: } Jun 02 22:59:53 volumio volumio[1091]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 22:59:53 volumio volumio5-onboarding[1293]: time=2026-06-02T22:59:53.518+01:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 02 22:59:53 volumio sudo[1321]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:54 volumio sudo[1413]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:54 volumio systemd[1]: Started Volumio Kiosk. Jun 02 22:59:54 volumio sudo[1388]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 02 22:59:54 volumio systemd[1]: Started go-librespot Daemon. Jun 02 22:59:54 volumio go-librespot[1439]: go-librespot daemon starting... Jun 02 22:59:54 volumio sudo[1329]: pam_unix(sudo:session): session closed for user root Jun 02 22:59:54 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 02 22:59:54 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 02 22:59:54 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 02 22:59:54 volumio systemd[1]: mpd.service: Succeeded. Jun 02 22:59:54 volumio systemd[1]: Stopped Music Player Daemon. Jun 02 22:59:54 volumio sudo[1453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 22:58 Jun 02 22:59:54 volumio sudo[1453]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 22:59:54 volumio sudo[1319]: pam_unix(sudo:session): session closed for user root PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"