-- Logs begin at Sun 2026-01-25 23:22:54 CET, end at Tue 2026-03-24 19:45:19 CET. -- Mar 24 19:44:43 integro systemd-timedated[3385]: Changed local time to Tue Mar 24 19:44:43 2026 Mar 24 19:44:43 integro systemd[1]: Started Volumio Time Update Utility. Mar 24 19:44:43 integro volumio-time-update[2834]: volumio-time-update-util: System time updated successfully. Mar 24 19:44:43 integro sudo[3373]: pam_unix(sudo:session): session closed for user root Mar 24 19:44:43 integro systemd[1]: Starting Daily apt download activities... Mar 24 19:44:43 integro systemd[1]: Starting Daily man-db regeneration... Mar 24 19:44:43 integro systemd[1]: systemd-rfkill.service: Succeeded. Mar 24 19:44:43 integro wireless.js[2825]: trying... Mar 24 19:44:43 integro sudo[3407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 24 19:44:43 integro sudo[3407]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:44:43 integro wireless.js[2825]: Connected to: ----dlink_DWR-960_FA5981 Mar 24 19:44:43 integro wireless.js[2825]: ---- Mar 24 19:44:43 integro sudo[3407]: pam_unix(sudo:session): session closed for user root Mar 24 19:44:43 integro sudo[3412]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 24 19:44:43 integro sudo[3412]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:44:43 integro sudo[3412]: pam_unix(sudo:session): session closed for user root Mar 24 19:44:43 integro systemd[1]: apt-daily.service: Succeeded. Mar 24 19:44:43 integro systemd[1]: Started Daily apt download activities. Mar 24 19:44:43 integro wireless.js[2825]: ... joined AP, wlan0 IPv4 is 192.168.0.28, ipV6 is undefined Mar 24 19:44:43 integro wireless.js[2825]: It's done! AP Mar 24 19:44:43 integro systemd[1]: Starting Daily apt upgrade and clean activities... Mar 24 19:44:43 integro systemd[1]: Started Wireless Services. Mar 24 19:44:43 integro systemd[1]: Started Volumio Backend Module. Mar 24 19:44:43 integro systemd[1]: Started Volumio Cpu Tweaker. Mar 24 19:44:43 integro systemd[1]: Started Start Volumio Kiosk. Mar 24 19:44:43 integro systemd[1]: Reached target Multi-User System. Mar 24 19:44:43 integro systemd[1]: Reached target Graphical Interface. Mar 24 19:44:43 integro startkiosk.sh[3423]: Starting Volumio Kiosk with arguments for cursor display Mar 24 19:44:43 integro systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 24 19:44:43 integro systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 24 19:44:43 integro systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 24 19:44:43 integro volumio-cpu-tweak[3422]: Setting RT Priority for mpd Mar 24 19:44:43 integro volumio-cpu-tweak[3422]: chrt: cannot obtain the list of tasks: No such file or directory Mar 24 19:44:43 integro volumio-cpu-tweak[3422]: Setting MPD Affinity Mar 24 19:44:43 integro volumio-cpu-tweak[3422]: pid 3's current affinity mask: 1 Mar 24 19:44:43 integro volumio-cpu-tweak[3422]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 24 19:44:43 integro volumio-cpu-tweak[3422]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 24 19:44:43 integro systemd[1]: man-db.service: Succeeded. Mar 24 19:44:43 integro systemd[1]: Started Daily man-db regeneration. Mar 24 19:44:43 integro systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 24 19:44:43 integro ntpd[3383]: Soliciting pool server 151.22.209.90 Mar 24 19:44:43 integro systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 24 19:44:43 integro systemd[1]: Started Daily apt upgrade and clean activities. Mar 24 19:44:43 integro systemd[1]: Startup finished in 13.001s (kernel) + 20.789s (userspace) = 33.790s. Mar 24 19:44:43 integro startkiosk.sh[3423]: X.Org X Server 1.20.4 Mar 24 19:44:43 integro startkiosk.sh[3423]: X Protocol Version 11, Revision 0 Mar 24 19:44:43 integro startkiosk.sh[3423]: Build Operating System: Linux 4.19.0-18-armmp-lpae armv7l Debian Mar 24 19:44:43 integro startkiosk.sh[3423]: Current Operating System: Linux integro 4.9.241 #4 SMP PREEMPT Wed Jun 4 18:07:40 CEST 2025 aarch64 Mar 24 19:44:43 integro startkiosk.sh[3423]: Kernel command line: imgpart=UUID=843419fa-d5ee-4466-82bd-97103798c938 imgfile=/volumio_current.sqsh bootpart=UUID=005D-F4BF datapart=UUID=9f6af51f-2817-4060-9a26-74916d3ce33e uuidconfig=env.system.txt hwdevice=VIM3L console=tty0 console=ttyS0,115200n8 no_console_suspend consoleblank=0 logo=osd0,loaded,0x3d800000,panel vout=panel,enable hdmimode=1080p60hz fsck.repair=yes net.ifnames=0 ddr_size= wol_enable= mac=02:00:00:1c:02:01 fan=auto hwver=VIM3.V12 coherent_pool=2M quiet loglevel=0 splash plymouth.ignore-serial-consoles initramfs.clear splash bootdelay=7 Mar 24 19:44:43 integro startkiosk.sh[3423]: Build Date: 18 December 2021 09:05:36AM Mar 24 19:44:43 integro startkiosk.sh[3423]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Mar 24 19:44:43 integro startkiosk.sh[3423]: Current version of pixman: 0.36.0 Mar 24 19:44:43 integro startkiosk.sh[3423]: Before reporting problems, check http://wiki.x.org Mar 24 19:44:43 integro startkiosk.sh[3423]: to make sure that you have the latest version. Mar 24 19:44:43 integro startkiosk.sh[3423]: Markers: (--) probed, (**) from config file, (==) default setting, Mar 24 19:44:43 integro startkiosk.sh[3423]: (++) from command line, (!!) notice, (II) informational, Mar 24 19:44:43 integro startkiosk.sh[3423]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Mar 24 19:44:43 integro startkiosk.sh[3423]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Mar 24 19:44:43 2026 Mar 24 19:44:43 integro startkiosk.sh[3423]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Mar 24 19:44:44 integro kernel: fb: osd[0] canvas.idx =0x40 Mar 24 19:44:44 integro kernel: fb: osd[0] canvas.addr=0x70000000 Mar 24 19:44:44 integro kernel: fb: osd[0] canvas.width=7680 Mar 24 19:44:44 integro kernel: fb: osd[0] canvas.height=1080 Mar 24 19:44:44 integro kernel: fb: osd[0] frame.width=1920 Mar 24 19:44:44 integro kernel: fb: osd[0] frame.height=1080 Mar 24 19:44:44 integro kernel: fb: osd[0] out_addr_id =0x1 Mar 24 19:44:44 integro kernel: fb: osd[0] enable: 0 (Xorg) Mar 24 19:44:44 integro ntpd[3383]: Soliciting pool server 95.110.254.234 Mar 24 19:44:44 integro ntpd[3383]: Soliciting pool server 204.216.214.76 Mar 24 19:44:45 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 24 19:44:45 integro ntpd[3383]: Soliciting pool server 172.232.209.103 Mar 24 19:44:45 integro ntpd[3383]: Soliciting pool server 93.94.88.51 Mar 24 19:44:45 integro ntpd[3383]: Soliciting pool server 162.159.200.1 Mar 24 19:44:46 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 24 19:44:46 integro volumio[3421]: info: ------------------------------------------- Mar 24 19:44:46 integro volumio[3421]: info: ----- Volumio3 ---- Mar 24 19:44:46 integro volumio[3421]: info: ------------------------------------------- Mar 24 19:44:46 integro volumio[3421]: info: ----- System startup ---- Mar 24 19:44:46 integro volumio[3421]: info: ------------------------------------------- Mar 24 19:44:46 integro ntpd[3383]: Soliciting pool server 172.232.208.229 Mar 24 19:44:46 integro ntpd[3383]: Soliciting pool server 185.157.229.254 Mar 24 19:44:46 integro ntpd[3383]: Soliciting pool server 31.14.133.122 Mar 24 19:44:46 integro ntpd[3383]: Soliciting pool server 195.32.70.195 Mar 24 19:44:47 integro ntpd[3383]: Soliciting pool server 185.19.184.35 Mar 24 19:44:47 integro ntpd[3383]: Soliciting pool server 162.159.200.123 Mar 24 19:44:47 integro ntpd[3383]: Soliciting pool server 89.46.74.148 Mar 24 19:44:48 integro volumio[3421]: info: MYVOLUMIO Environment detected Mar 24 19:44:48 integro volumio[3421]: info: Plugin folders cleanup Mar 24 19:44:48 integro volumio[3421]: info: Scanning into folder /volumio/app/plugins/ Mar 24 19:44:48 integro volumio[3421]: info: Scanning category audio_interface Mar 24 19:44:48 integro volumio[3421]: info: Scanning category miscellanea Mar 24 19:44:48 integro volumio[3421]: info: Scanning category music_service Mar 24 19:44:48 integro volumio[3421]: info: Scanning category plugins.json Mar 24 19:44:48 integro volumio[3421]: info: Scanning category system_controller Mar 24 19:44:48 integro volumio[3421]: info: Scanning category user_interface Mar 24 19:44:48 integro volumio[3421]: info: Scanning into folder /data/plugins/ Mar 24 19:44:48 integro volumio[3421]: info: Scanning category audio_interface Mar 24 19:44:48 integro volumio[3421]: info: Scanning category music_service Mar 24 19:44:48 integro volumio[3421]: info: Plugin folders cleanup completed Mar 24 19:44:48 integro volumio[3421]: info: ------------------------------------------- Mar 24 19:44:48 integro volumio[3421]: info: ----- Core plugins startup ---- Mar 24 19:44:48 integro volumio[3421]: info: ------------------------------------------- Mar 24 19:44:48 integro volumio[3421]: info: Loading plugins from folder /volumio/app/plugins/ Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin multiroom to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin upnp to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin metavolumio to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin cd_controller to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin qobuzconnect to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin raat to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 24 19:44:48 integro volumio[3421]: info: Loading plugins from folder /data/plugins/ Mar 24 19:44:48 integro volumio[3421]: info: Loading plugin "system"... Mar 24 19:44:48 integro volumio[3421]: info: Loading plugin "appearance"... Mar 24 19:44:48 integro ntpd[3383]: Soliciting pool server 37.247.53.178 Mar 24 19:44:48 integro ntpd[3383]: Soliciting pool server 85.199.214.99 Mar 24 19:44:49 integro ntpd[3383]: Soliciting pool server 80.211.238.32 Mar 24 19:44:49 integro ntpd[3383]: Soliciting pool server 2606:4700:f1::1 Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "network"... Mar 24 19:44:50 integro volumio[3421]: info: Refreshing Cached IP Addresses Mar 24 19:44:50 integro sudo[3549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 24 19:44:50 integro sudo[3549]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:44:50 integro sudo[3551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 24 19:44:50 integro sudo[3551]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:44:50 integro sudo[3549]: pam_unix(sudo:session): session closed for user root Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "services"... Mar 24 19:44:50 integro sudo[3551]: pam_unix(sudo:session): session closed for user root Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "volumio5onboarding"... Mar 24 19:44:50 integro sudo[3565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 24 19:44:50 integro sudo[3565]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "alsa_controller"... Mar 24 19:44:50 integro kernel: wl_escan_set_scan: ioctl_ver=2 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "wizard"... Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "networkfs"... Mar 24 19:44:50 integro volumio[3421]: info: Starting Udev Watcher for removable devices Mar 24 19:44:50 integro volumio[3421]: info: Ignoring mount for partition: BOOT Mar 24 19:44:50 integro volumio[3421]: info: Ignoring mount for partition: volumio Mar 24 19:44:50 integro volumio[3421]: info: Ignoring mount for partition: volumio_data Mar 24 19:44:50 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "volumio_command_line_client"... Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "upnp"... Mar 24 19:44:50 integro volumio[3421]: info: [1774377890402] Starting Upmpd Daemon Mar 24 19:44:50 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "my_music"... Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "mpd"... Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:50 integro volumio[3421]: info: Loading plugin "upnp_browser"... Mar 24 19:44:51 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:51 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:51 integro volumio[3421]: info: Starting UPNP Browser Mar 24 19:44:51 integro volumio[3421]: info: Loading plugin "alarm-clock"... Mar 24 19:44:51 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:51 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:51 integro volumio[3421]: info: Loading plugin "manifestui"... Mar 24 19:44:51 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:52 integro volumio[3421]: info: Loading plugin "metavolumio"... Mar 24 19:44:52 integro volumio-remote-updater[2823]: [2026-03-24 19:44:52] [connect] Successful connection Mar 24 19:44:52 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:52 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:52 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:52 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:52 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:53 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:53 integro ntpd[3383]: receive: Unexpected origin timestamp 0xed6d5a24.ca8eef4f does not match aorg 0000000000.00000000 from server@85.199.214.99 xmt 0xed6d5a25.c28c606d Mar 24 19:44:53 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:53 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:53 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:54 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:54 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:54 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:54 integro dbus-daemon[2828]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.10' (uid=0 pid=3581 comm="/usr/bin/vivaldi --kiosk --no-sandbox --disable-ba" label="kernel") Mar 24 19:44:54 integro dbus-daemon[2828]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found. Mar 24 19:44:54 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 8 Mar 24 19:44:55 integro volumio[3421]: info: Loading plugin "airplay_emulation"... Mar 24 19:44:55 integro volumio[3421]: info: Starting Shairport Sync Mar 24 19:44:55 integro volumio[3421]: info: Loading plugin "cd_controller"... Mar 24 19:44:55 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04d6f0000 drv_status 0x0 e_type 69 e_states 0 Mar 24 19:44:55 integro sudo[3565]: pam_unix(sudo:session): session closed for user root Mar 24 19:44:55 integro volumio[3421]: info: Loading plugin "last_100"... Mar 24 19:44:55 integro volumio[3421]: info: Loading plugin "qobuzconnect"... Mar 24 19:44:55 integro volumio[3421]: info: Loading plugin "raat"... Mar 24 19:44:55 integro volumio[3421]: info: RAAT Plugin loaded Mar 24 19:44:55 integro volumio[3421]: info: Adding restartRAATSocket REST API Endpoint Mar 24 19:44:55 integro volumio[3421]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Mar 24 19:44:55 integro volumio[3421]: info: Loading plugin "streaming_services"... Mar 24 19:44:57 integro systemd[1]: systemd-fsckd.service: Succeeded. Mar 24 19:44:58 integro volumio[3421]: info: Starting Streaming Service Transparent Proxy Mar 24 19:44:58 integro volumio[3421]: info: Loading plugin "tidalconnect"... Mar 24 19:44:58 integro volumio[3421]: info: Loading plugin "webradio"... Mar 24 19:44:59 integro volumio[3421]: info: Loading plugin "i2s_dacs"... Mar 24 19:44:59 integro volumio[3421]: info: I2S DAC not set, start Auto-detection Mar 24 19:44:59 integro volumio[3421]: info: Loading plugin "volumiodiscovery"... Mar 24 19:44:59 integro volumio[3421]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 24 19:44:59 integro volumio[3421]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 19:44:59 integro node[3421]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 24 19:44:59 integro volumio[3421]: *** WARNING *** For more information see Mar 24 19:44:59 integro volumio[3421]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 24 19:44:59 integro volumio[3421]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 19:44:59 integro volumio[3421]: *** WARNING *** For more information see Mar 24 19:44:59 integro node[3421]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 19:44:59 integro node[3421]: *** WARNING *** For more information see Mar 24 19:44:59 integro node[3421]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 24 19:44:59 integro node[3421]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 24 19:44:59 integro node[3421]: *** WARNING *** For more information see Mar 24 19:44:59 integro volumio[3421]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 24 19:44:59 integro volumio[3421]: info: Discovery: Started advertising with name: Integro Mar 24 19:44:59 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 24 19:44:59 integro volumio[3421]: info: Loading plugin "spop"... Mar 24 19:45:00 integro volumio[3421]: STREAMING PROXY: Starting server on port 3245 Mar 24 19:45:00 integro volumio[3421]: Node JS runtime: 14 Mar 24 19:45:01 integro volumio[3421]: info: Loading plugin "multiroom"... Mar 24 19:45:03 integro volumio[3421]: info: Applying required configuration parameters for plugin multiroom Mar 24 19:45:03 integro sudo[3777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 24 19:45:03 integro sudo[3777]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:03 integro sudo[3777]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:03 integro volumio[3421]: info: MRS: MultiRoom plugin initialized Mar 24 19:45:03 integro volumio[3421]: info: MRS: STOPPING SNAPCLIENT Mar 24 19:45:03 integro volumio[3421]: info: MRS: Snap server stop Mar 24 19:45:03 integro sudo[3794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 24 19:45:03 integro volumio[3421]: info: MRS: STOPPING volumioStreaming Mar 24 19:45:03 integro sudo[3794]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:03 integro sudo[3796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 24 19:45:03 integro sudo[3796]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:03 integro volumio[3421]: info: Loading plugin "outputs"... Mar 24 19:45:03 integro sudo[3800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 24 19:45:03 integro sudo[3800]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:03 integro volumio[3421]: info: Loading plugin "albumart"... Mar 24 19:45:03 integro sudo[3794]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:03 integro sudo[3802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 24 19:45:03 integro sudo[3802]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:03 integro sudo[3802]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:03 integro volumio[3421]: info: Plugin example_plugin is not enabled Mar 24 19:45:03 integro volumio[3421]: info: Loading plugin "hdmi_arc"... Mar 24 19:45:03 integro sudo[3796]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:04 integro sudo[3800]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:04 integro volumio[3421]: info: Loading plugin "hi_res_audio"... Mar 24 19:45:04 integro volumio[3421]: Forking 3 albumart workers Mar 24 19:45:05 integro volumio[3421]: Starting albumart workers Mar 24 19:45:05 integro volumio[3421]: Starting albumart workers Mar 24 19:45:05 integro volumio[3421]: Starting albumart workers Mar 24 19:45:06 integro volumio[3421]: info: Applying required configuration parameters for plugin hi_res_audio Mar 24 19:45:06 integro volumio[3421]: info: Loading plugin "inputs"... Mar 24 19:45:07 integro volumio[3421]: info: Loading plugin "qobuz"... Mar 24 19:45:08 integro volumio-remote-updater[2823]: [2026-03-24 19:45:08] [connect] Successful connection Mar 24 19:45:09 integro volumio[3421]: info: Loading plugin "smart_inputs"... Mar 24 19:45:09 integro volumio[3421]: info: Loading plugin "tidal"... Mar 24 19:45:11 integro volumio[3421]: info: Loading plugin "integrocontrol"... Mar 24 19:45:11 integro volumio[3421]: info: Adding this device properties Mar 24 19:45:11 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Mar 24 19:45:11 integro volumio[3421]: info: Setting Additional Device Volumio Properties: [object Object] Mar 24 19:45:11 integro volumio[3421]: info: Loading plugin "updater_comm"... Mar 24 19:45:11 integro volumio[3421]: info: Plugin mpdemulation is not enabled Mar 24 19:45:11 integro volumio[3421]: info: Loading plugin "rest_api"... Mar 24 19:45:11 integro volumio[3421]: info: Loading plugin "websocket"... Mar 24 19:45:11 integro volumio[3421]: info: Starting Socket.io Server version 2.3.0 Mar 24 19:45:11 integro volumio[3421]: info: Loading plugin "fusiondsp"... Mar 24 19:45:12 integro volumio[3421]: info: Applying required configuration parameters for plugin fusiondsp Mar 24 19:45:12 integro volumio[3421]: info: Loading i18n strings for locale it Mar 24 19:45:12 integro volumio[3421]: Updating browse sources language Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::initPlayerControls Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 19:45:12 integro volumio[3421]: Express server listening on port 3000 Mar 24 19:45:12 integro volumio[3421]: [Metrics] WebUI: 25s 922.61ms Mar 24 19:45:12 integro volumio[3421]: info: CoreStateMachine::resetVolumioState Mar 24 19:45:12 integro volumio[3421]: info: CoreStateMachine::getcurrentVolume Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::volumioRetrievevolume Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:12 integro sudo[3884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 24 19:45:12 integro sudo[3884]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:12 integro sudo[3884]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:12 integro volumio[3421]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 24 19:45:12 integro sudo[3886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 24 19:45:12 integro volumio[3421]: info: Completed loading Core Plugins Mar 24 19:45:12 integro sudo[3886]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:12 integro volumio[3421]: info: Preparing to generate the ALSA configuration file Mar 24 19:45:12 integro sudo[3886]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:12 integro volumio[3421]: info: Volumio Network Manager: Network status updated: 3 Mar 24 19:45:12 integro volumio[3421]: Unable to parse: Mar 24 19:45:12 integro volumio[3421]: Simple mixer control 'Audio hdmi-out mute',0 Mar 24 19:45:12 integro volumio[3421]: Capabilities: pswitch pswitch-joined Mar 24 19:45:12 integro volumio[3421]: Playback channels: Mono Mar 24 19:45:12 integro volumio[3421]: Mono: Playback [on] Mar 24 19:45:12 integro volumio[3421]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 24 19:45:12 integro volumio[3421]: info: MRS: Removed streaming files Mar 24 19:45:12 integro volumio[3421]: info: MRS: volumioStreaming STOPPED Mar 24 19:45:12 integro volumio[3421]: info: MRS: SNAPSERVER STOPPED Mar 24 19:45:12 integro volumio[3421]: info: MRS: SNAPCLIENT STOPPED Mar 24 19:45:12 integro volumio[3421]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Mar 24 19:45:12 integro volumio[3421]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 24 19:45:12 integro volumio[3421]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 24 19:45:12 integro volumio[3421]: info: Reading ALSA contributions from plugins. Mar 24 19:45:12 integro volumio-remote-updater[2823]: [2026-03-24 19:45:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1774377908 101 Mar 24 19:45:12 integro volumio[3421]: 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 Mar 24 19:45:12 integro volumio[3421]: Unable to parse: Mar 24 19:45:12 integro volumio[3421]: Simple mixer control 'Audio hdmi-out mute',0 Mar 24 19:45:12 integro volumio[3421]: Capabilities: pswitch pswitch-joined Mar 24 19:45:12 integro volumio[3421]: Playback channels: Mono Mar 24 19:45:12 integro volumio[3421]: Mono: Playback [on] Mar 24 19:45:12 integro volumio[3421]: info: VolumeController:: Volume=undefined Mute =false Mar 24 19:45:12 integro volumio[3421]: info: CoreStateMachine::pushState Mar 24 19:45:12 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::volumioPushState Mar 24 19:45:12 integro volumio[3421]: info: CoreStateMachine::updateTrackBlock Mar 24 19:45:12 integro volumio[3421]: info: CorePlayQueue::getTrackBlock Mar 24 19:45:12 integro volumio[3421]: info: CoreCommandRouter::volumioRetrievevolume Mar 24 19:45:13 integro volumio[3421]: Unable to parse: Mar 24 19:45:13 integro volumio[3421]: Simple mixer control 'Audio hdmi-out mute',0 Mar 24 19:45:13 integro volumio[3421]: Capabilities: pswitch pswitch-joined Mar 24 19:45:13 integro volumio[3421]: Playback channels: Mono Mar 24 19:45:13 integro volumio[3421]: Mono: Playback [on] Mar 24 19:45:13 integro volumio[3421]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 24 19:45:13 integro volumio[3421]: info: Reloading queue from file Mar 24 19:45:13 integro volumio[3421]: info: CoreStateMachine::setRepeat false single undefined Mar 24 19:45:13 integro volumio[3421]: info: CoreStateMachine::pushState Mar 24 19:45:13 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::volumioPushState Mar 24 19:45:13 integro volumio[3421]: info: CoreStateMachine::setRandom undefined Mar 24 19:45:13 integro volumio[3421]: info: CoreStateMachine::pushState Mar 24 19:45:13 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::volumioPushState Mar 24 19:45:13 integro volumio[3421]: Unable to parse: Mar 24 19:45:13 integro volumio[3421]: Simple mixer control 'Audio hdmi-out mute',0 Mar 24 19:45:13 integro volumio[3421]: Capabilities: pswitch pswitch-joined Mar 24 19:45:13 integro volumio[3421]: Playback channels: Mono Mar 24 19:45:13 integro volumio[3421]: Mono: Playback [on] Mar 24 19:45:13 integro volumio[3421]: info: VolumeController:: Volume=undefined Mute =false Mar 24 19:45:13 integro volumio[3421]: info: CoreStateMachine::pushState Mar 24 19:45:13 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::volumioPushState Mar 24 19:45:13 integro volumio[3421]: info: Asound.conf file unchanged, so no further update is needed Mar 24 19:45:13 integro sudo[3904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 24 19:45:13 integro volumio[3421]: info: Output device has changed, restarting MPD Mar 24 19:45:13 integro sudo[3904]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:13 integro systemd[1]: Started UPnP Renderer front-end to MPD. Mar 24 19:45:13 integro sudo[3904]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:13 integro kernel: fb: mem_free_work, free memory: addr:800000 Mar 24 19:45:13 integro sudo[3907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 24 19:45:13 integro sudo[3907]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:13 integro volumio[3421]: info: Output device has changed, restarting Shairport Sync Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:13 integro sudo[3907]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:13 integro sudo[3917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 24 19:45:13 integro sudo[3917]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:13 integro volumio[3421]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 24 19:45:13 integro volumio[3421]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:13 integro systemd[1]: Listening on mpd.socket. Mar 24 19:45:13 integro systemd[1]: Starting Music Player Daemon... Mar 24 19:45:13 integro volumio[3421]: info: ___________ START PLUGINS ___________ Mar 24 19:45:13 integro kernel: aml_tdm_open Mar 24 19:45:13 integro kernel: Not init audio effects Mar 24 19:45:13 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 24 19:45:13 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 24 19:45:13 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 24 19:45:13 integro volumio[3421]: info: ControllerMpd::onStart: Initializing MPD Mar 24 19:45:13 integro volumio[3421]: info: Creating MPD Configuration file Mar 24 19:45:13 integro sudo[3927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Mar 24 19:45:13 integro sudo[3927]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 19:45:13 integro volumio[3421]: info: [1774377913791] CoreMusicLibrary::Adding element Server multimediali Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 19:45:13 integro sudo[3930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 24 19:45:13 integro sudo[3930]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:13 integro sudo[3923]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 24 19:45:13 integro sudo[3923]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:13 integro volumio[3421]: info: UPNP Browser: Client initialized successfully Mar 24 19:45:13 integro sudo[3930]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:13 integro systemd[1]: Started Volumio5 Onboarding Server. Mar 24 19:45:13 integro sudo[3927]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:13 integro sudo[3932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 24 19:45:13 integro sudo[3932]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:13 integro sudo[3923]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 24 19:45:13 integro sudo[3923]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:13 integro volumio[3421]: info: Adding METAVOLUMIO REST API Endpoints Mar 24 19:45:13 integro volumio[3421]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 24 19:45:13 integro volumio[3421]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 24 19:45:13 integro volumio[3421]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 24 19:45:13 integro volumio[3421]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:13 integro systemd[1]: mpd.service: Succeeded. Mar 24 19:45:13 integro systemd[1]: Stopped Music Player Daemon. Mar 24 19:45:13 integro systemd[1]: Starting Music Player Daemon... Mar 24 19:45:13 integro volumio[3421]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:13 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:14 integro systemd[1]: systemd-timedated.service: Succeeded. Mar 24 19:45:14 integro volumio[3421]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 24 19:45:14 integro volumio[3421]: info: Preparing CD Folders Mar 24 19:45:14 integro volumio[3421]: info: Adding CD REST API Endpoints Mar 24 19:45:14 integro volumio[3421]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Mar 24 19:45:14 integro volumio[3421]: info: Starting UDEV Watcher for CD Mar 24 19:45:14 integro volumio[3421]: info: Detecting CD presence with UDEV Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Mar 24 19:45:14 integro sudo[3938]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 19:45:14 integro volumio[3421]: info: [1774377914117] CoreMusicLibrary::Adding element Last_100 Mar 24 19:45:14 integro sudo[3938]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 19:45:14 integro volumio[3421]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Mar 24 19:45:14 integro sudo[3938]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 24 19:45:14 integro sudo[3938]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:14 integro volumio[3421]: info: QobuzConnect: Starting Qobuz Connect socket and service Mar 24 19:45:14 integro volumio[3421]: info: Starting RAAT Plugin Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Mar 24 19:45:14 integro volumio[3421]: info: Additional UI Settings Added for plugin music_service/raat Mar 24 19:45:14 integro volumio[3421]: info: Registering DSP Elements listener and retrieving current ones Mar 24 19:45:14 integro volumio[3421]: info: Additional DSP elements updated Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:14 integro volumio[3421]: info: Updating RAAT Signal Path Mar 24 19:45:14 integro volumio[3421]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 24 19:45:14 integro volumio[3421]: info: Streaming services startup Mar 24 19:45:14 integro volumio[3421]: info: Starting Streaming Daemon Mar 24 19:45:14 integro sudo[3958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 24 19:45:14 integro sudo[3958]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:14 integro sudo[3958]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:14 integro sudo[3963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 24 19:45:14 integro sudo[3963]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:14 integro sudo[3965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 24 19:45:14 integro sudo[3965]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:14 integro sudo[3963]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:14 integro volumio5-onboarding[3934]: time=2026-03-24T19:45:14.451+01:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Mar 24 19:45:14 integro systemd[1]: Started Volumio Qobuz Connect Service. Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 19:45:14 integro volumio[3421]: info: [1774377914473] CoreMusicLibrary::Adding element Webradio Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 19:45:14 integro sudo[3965]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 24 19:45:14 integro volumio[3421]: info: Initializing BBC Radios Mar 24 19:45:14 integro sudo[3973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 24 19:45:14 integro sudo[3973]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:14 integro sudo[3973]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:14 integro volumio[3421]: info: Creating Spotify config file Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 24 19:45:14 integro volumio[3421]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:14 integro volumio[3421]: info: Starting CEC Infrastructure Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:14 integro kernel: aml_tdm_open Mar 24 19:45:14 integro kernel: Not init audio effects Mar 24 19:45:14 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 24 19:45:14 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 24 19:45:14 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 24 19:45:14 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Mar 24 19:45:14 integro volumio[3421]: info: Additional UI Settings Added for plugin music_service/hdmi_arc Mar 24 19:45:14 integro volumio[3421]: error: Hi Res Audio Failed Login: Missing Login Data Mar 24 19:45:14 integro volumio[3421]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 24 19:45:14 integro volumio[3421]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 24 19:45:14 integro volumio[3421]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 24 19:45:14 integro volumio[3421]: info: Initializing Serial Communication on port /dev/ttyS3 Mar 24 19:45:14 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Mar 24 19:45:14 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Mar 24 19:45:14 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Mar 24 19:45:14 integro volumio[3421]: info: Touch Event Listener Process Starting Mar 24 19:45:14 integro volumio[3421]: info: Adding inputs REST Endpoints Mar 24 19:45:14 integro volumio[3421]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 24 19:45:14 integro volumio[3421]: info: Scanning Audio Inputs Mar 24 19:45:15 integro sudo[3995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Mar 24 19:45:15 integro sudo[3995]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:15 integro volumio[3421]: info: Checking against Known Cards name Mar 24 19:45:15 integro volumio[3421]: info: Checking against Known Cards name Mar 24 19:45:15 integro volumio[3421]: info: Checking against Known Cards name Mar 24 19:45:15 integro volumio[3421]: info: Checking against Known Cards name Mar 24 19:45:15 integro volumio[3421]: info: Checking against Known Cards name Mar 24 19:45:15 integro volumio[3421]: info: Adding Server instance for streaming Mar 24 19:45:15 integro volumio[3421]: info: Refreshing TIDAL token Mar 24 19:45:15 integro sudo[4003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Mar 24 19:45:15 integro sudo[4003]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:15 integro sudo[4003]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:15 integro sudo[4006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Mar 24 19:45:15 integro sudo[4006]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:15 integro sudo[4006]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:15 integro sudo[4009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Mar 24 19:45:15 integro sudo[4009]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:15 integro sudo[4009]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:15 integro sudo[4012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Mar 24 19:45:15 integro sudo[4012]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:15 integro sudo[4012]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:15 integro volumio[3421]: info: MP1 Muting HDMI Output Mar 24 19:45:15 integro volumio[3421]: info: Apply VIM3L Onboard LEDs Settings Mar 24 19:45:15 integro volumio[3421]: info: Turning On Onboard LEDs Mar 24 19:45:15 integro volumio[3421]: info: Loading i18n strings for locale it Mar 24 19:45:15 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 24 19:45:15 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:15 integro volumio[3421]: info: FusionDsp - mixtype--------------------- Hardware Mar 24 19:45:15 integro volumio[3421]: info: Volumio Calling Home Mar 24 19:45:15 integro sudo[4018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Mar 24 19:45:15 integro sudo[4018]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:15 integro sudo[4018]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:15 integro sudo[4024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Mar 24 19:45:15 integro sudo[4024]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:15 integro sudo[4024]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:15 integro volumio[3421]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Mar 24 19:45:15 integro volumio[3421]: (node:3421) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Mar 24 19:45:15 integro volumio[3421]: (Use `node --trace-deprecation ...` to show where the warning was created) Mar 24 19:45:15 integro volumio[3421]: info: Preparing to generate the ALSA configuration file Mar 24 19:45:16 integro volumio[3421]: info: Stopping AccessToken refresher cron for QOBUZ Mar 24 19:45:16 integro volumio[3421]: info: AccessToken refresher cron started for QOBUZ Mar 24 19:45:16 integro volumio[3421]: info: Adding QOBUZ REST API Endpoints Mar 24 19:45:16 integro volumio[3421]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 24 19:45:16 integro volumio[3421]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 24 19:45:16 integro volumio[3421]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 24 19:45:16 integro volumio[3421]: info: Serial port opened successfully Mar 24 19:45:16 integro volumio[3421]: info: Sending serial start messages Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: Reporting MCU Network Status: 3 Mar 24 19:45:16 integro volumio[3421]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 24 19:45:16 integro volumio[3421]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 24 19:45:16 integro volumio[3421]: info: Reading ALSA contributions from plugins. Mar 24 19:45:16 integro volumio[3421]: error: Cannot start Volumio Streaming Daemon Mar 24 19:45:16 integro volumio[3421]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 24 19:45:16 integro volumio[3421]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 24 19:45:16 integro volumio[3421]: info: RAAT Albumart path created successfully Mar 24 19:45:16 integro volumio[3421]: info: MPD Permissions set Mar 24 19:45:16 integro volumio[3421]: info: MPD Permissions set Mar 24 19:45:16 integro volumio[3421]: info: Upmpdcli Daemon Started Mar 24 19:45:16 integro volumio[3421]: 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: 2 Mar 24 19:45:16 integro dbus-daemon[2828]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.17' (uid=0 pid=3934 comm="/usr/bin/volumio5-onboarding " label="kernel") Mar 24 19:45:16 integro dbus-daemon[2828]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found. Mar 24 19:45:16 integro volumio5-onboarding[3934]: failed to create app: failed to initialize BLE manager: failed to configure advertisement: could not activate BlueZ adapter: Unit dbus-org.bluez.service not found. Mar 24 19:45:16 integro systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 24 19:45:16 integro systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 24 19:45:16 integro volumio[3421]: info: Executing endpoint qc_getconfig Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.486 [3972.3972] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Mar 24 19:45:16 integro volumio[3421]: info: Volumio called home Mar 24 19:45:16 integro volumio[3421]: info: Spotify config file written Mar 24 19:45:16 integro sudo[4042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 24 19:45:16 integro sudo[4042]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:16 integro systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Mar 24 19:45:16 integro systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.651 [3972.3972] INFO VolumeManager: [0xabe8a8f0]: Setting new playback volume: 75 Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.652 [3972.3972] INFO VolumeManager: [0xabe8a8f0]: Setting new mute state: 0 Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.652 [3972.3972] INFO QobuzConnect: [0xabe8b2c0]: Client initialized! Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.653 [3972.3972] INFO SampleApp: Starting Avahi advertising, name: Integro, service name: _qobuz-connect._tcp Mar 24 19:45:16 integro systemd[1]: Started go-librespot Daemon. Mar 24 19:45:16 integro systemd[1]: Stopped Volumio5 Onboarding Server. Mar 24 19:45:16 integro systemd[1]: Started Volumio5 Onboarding Server. Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.727 [3972.3972] INFO LocalConfigManager: [0xabe8a1d0]: Starting Local Configuration server Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.727 [3972.3972] INFO SampleApp: Starting Local configuration server Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.728 [3972.3972] INFO SampleApp: Playback volume changed: 75 Mar 24 19:45:16 integro qobuz-connect[3972]: 20260324 19:45:16.728 [3972.3972] INFO SampleApp: Connected to UNIX socket client 0xabe7fed8 Mar 24 19:45:16 integro volumio[3421]: 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: 2 Mar 24 19:45:16 integro go-librespot[4044]: go-librespot daemon starting... Mar 24 19:45:16 integro sudo[4042]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:16 integro volumio[3421]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 24 19:45:16 integro volumio5-onboarding[4045]: time=2026-03-24T19:45:16.784+01:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Mar 24 19:45:16 integro volumio[3421]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Mar 24 19:45:16 integro volumio[3421]: info: QobuzConnect: QOBUZ Connect daemon connected Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 24 19:45:16 integro go-librespot[4044]: time="2026-03-24T19:45:16+01:00" level=info msg="running go-librespot 0.6.2" Mar 24 19:45:16 integro go-librespot[4044]: time="2026-03-24T19:45:16+01:00" level=debug msg="app state loaded" Mar 24 19:45:16 integro go-librespot[4044]: time="2026-03-24T19:45:16+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:16 integro volumio[3421]: info: No need to fix Spotify hosts Mar 24 19:45:16 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Mar 24 19:45:16 integro volumio[3421]: info: Setting Device Volume Override Mar 24 19:45:17 integro volumio[3421]: info: Applying Volume Override Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 24 19:45:17 integro volumio[3421]: info: Updating Volume Controller Parameters: Device: 0,0 Name: I2S Mixer: Audio hdmi-out mute Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 24 19:45:17 integro volumio[3421]: info: Enabling external Volume Control Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:17 integro volumio[3421]: info: CoreStateMachine::pushState Mar 24 19:45:17 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::volumioPushState Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::volumioGetState Mar 24 19:45:17 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Mar 24 19:45:17 integro volumio[3421]: info: Setting Additional System Software info: Hardware Revision: 1.2 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Mar 24 19:45:17 integro volumio[3421]: info: Setting HW Firmware info: undefined Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Mar 24 19:45:17 integro volumio[3421]: info: Setting HW Version info: 1.2 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Mar 24 19:45:17 integro volumio[3421]: info: Setting Additional System Software info: Hardware Revision: 1.2, Firmware Version: 0.7.3 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Mar 24 19:45:17 integro volumio[3421]: info: Setting HW Firmware info: 0.7.3 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Mar 24 19:45:17 integro volumio[3421]: info: Setting HW Version info: 1.2 Mar 24 19:45:17 integro volumio[3421]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 24 19:45:17 integro volumio[3421]: info: MCU Signalled Headphone Mode Disabled Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Mar 24 19:45:17 integro volumio[3421]: info: Reporting Headphone State: false Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:17 integro volumio[3421]: info: Updating RAAT Signal Path Mar 24 19:45:17 integro volumio[3421]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 24 19:45:17 integro volumio[3421]: info: MCU Signalled Sleep Mode Disabled Mar 24 19:45:17 integro volumio[3421]: info: Enabling Advanced system settings configuration Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Mar 24 19:45:17 integro volumio[3421]: info: Additional UI Settings Added for plugin music_service/inputs Mar 24 19:45:17 integro volumio[3421]: info: MCU Signalled Auto Boot Mode On Power Disabled Mar 24 19:45:17 integro sudo[4075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Mar 24 19:45:17 integro sudo[4075]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:17 integro sudo[4075]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:17 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 24 19:45:17 integro volumio[3421]: info: Access Token successfully retrieved Mar 24 19:45:17 integro volumio[3421]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::volumioGetState Mar 24 19:45:17 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:17 integro volumio[3421]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Mar 24 19:45:17 integro dbus-daemon[2828]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.19' (uid=0 pid=4045 comm="/usr/bin/volumio5-onboarding " label="kernel") Mar 24 19:45:17 integro dbus-daemon[2828]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found. Mar 24 19:45:17 integro volumio5-onboarding[4045]: failed to create app: failed to initialize BLE manager: failed to configure advertisement: could not activate BlueZ adapter: Unit dbus-org.bluez.service not found. Mar 24 19:45:17 integro volumio[3421]: 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 Mar 24 19:45:17 integro systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 24 19:45:17 integro systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 24 19:45:17 integro volumio[3421]: info: New Spotify access tokenBQADupEGwW... Mar 24 19:45:17 integro volumio[3421]: info: Spotify credentials grant success - running version from March 24, 2019 Mar 24 19:45:17 integro sudo[4078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Mar 24 19:45:17 integro sudo[4078]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:17 integro sudo[4078]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:17 integro volumio[3421]: 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 Mar 24 19:45:17 integro volumio[3421]: info: Starting Shairport Sync Mar 24 19:45:17 integro volumio[3421]: info: Starting Shairport Sync Mar 24 19:45:17 integro systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Mar 24 19:45:17 integro systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Mar 24 19:45:17 integro systemd[1]: Stopped Volumio5 Onboarding Server. Mar 24 19:45:17 integro systemd[1]: Started Volumio5 Onboarding Server. Mar 24 19:45:17 integro sudo[4084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 24 19:45:17 integro sudo[4084]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:17 integro volumio[3421]: info: Starting Shairport Sync Mar 24 19:45:17 integro volumio5-onboarding[4086]: time=2026-03-24T19:45:17.729+01:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Mar 24 19:45:17 integro sudo[4092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 24 19:45:17 integro sudo[4092]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:17 integro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 24 19:45:17 integro systemd[1]: shairport-sync.service: Succeeded. Mar 24 19:45:17 integro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 24 19:45:17 integro sudo[4096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 24 19:45:17 integro sudo[4096]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::volumioGetState Mar 24 19:45:17 integro volumio[3421]: info: CorePlayQueue::getTrack 0 Mar 24 19:45:17 integro go-librespot[4044]: time="2026-03-24T19:45:17+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 24 19:45:17 integro go-librespot[4044]: time="2026-03-24T19:45:17+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 24 19:45:17 integro go-librespot[4044]: time="2026-03-24T19:45:17+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 24 19:45:17 integro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 24 19:45:17 integro sudo[4084]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:17 integro go-librespot[4044]: time="2026-03-24T19:45:17+01:00" level=info msg="zeroconf server listening on port 41025" Mar 24 19:45:17 integro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 24 19:45:17 integro systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 24 19:45:17 integro systemd[1]: shairport-sync.service: Succeeded. Mar 24 19:45:17 integro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 24 19:45:17 integro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 24 19:45:17 integro sudo[4096]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:17 integro sudo[4092]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:17 integro volumio[3421]: info: camilladsp service started and running in background, instance 1 Mar 24 19:45:17 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:18 integro volumio[3421]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 24 19:45:18 integro volumio[3421]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 24 19:45:18 integro volumio[3421]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 24 19:45:18 integro mpd[3956]: Mar 24 19:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 24 19:45:18 integro volumio[3421]: info: FusionDsp loaded Mar 24 19:45:18 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="obtained new client token: AACq9mdEiDg1mXM+1xOBXrEkpRzLTl71eK/9Go7mdicbwai27J8cdOvkg5vMb2SVxO6F8rwjtqP5LpZvtnfRFI7s12wunZzmYCOp0vzB5EgtPc+o+vsDz4bPL8lsH6YPHeErqTLgySGLsPWtEi+0DzE2CVuQGHCVlLCsKbXZHq02NQts+QPcq7/49nQO9mTXdRTzLQFFkFkgK7XSQmd7tkvqEqQXuCBOC7FM5qkb+K77v68Y6WEk" Mar 24 19:45:18 integro systemd[1]: Started Music Player Daemon. Mar 24 19:45:18 integro sudo[3917]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:18 integro sudo[3932]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:18 integro sudo[4113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 24 19:45:18 integro sudo[4113]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:18 integro volumio[3421]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 24 19:45:18 integro volumio[3421]: info: Adding Signal Path Element [object Object] Mar 24 19:45:18 integro volumio[3421]: info: Adding fusiondspeq DSP Signal Path Element Mar 24 19:45:18 integro volumio[3421]: info: Additional DSP elements updated Mar 24 19:45:18 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:18 integro volumio[3421]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 19:45:18 integro volumio[3421]: info: Updating RAAT Signal Path Mar 24 19:45:18 integro volumio[3421]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 24 19:45:18 integro volumio[3421]: info: FusionDsp - ---- installed callbackRead Mar 24 19:45:18 integro volumio[3421]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 19:45:18 integro sudo[4113]: pam_unix(sudo:session): session closed for user root Mar 24 19:45:18 integro volumio[3421]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 24 19:45:18 integro volumio[3421]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Mar 24 19:45:18 integro volumio[3421]: at onErrorNT (internal/child_process.js:472:16) Mar 24 19:45:18 integro volumio[3421]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Mar 24 19:45:18 integro volumio[3421]: at runNextTicks (internal/process/task_queues.js:64:3) Mar 24 19:45:18 integro volumio[3421]: at listOnTimeout (internal/timers.js:526:9) Mar 24 19:45:18 integro volumio[3421]: at processTimers (internal/timers.js:500:7) { Mar 24 19:45:18 integro volumio[3421]: errno: -2, Mar 24 19:45:18 integro volumio[3421]: code: 'ENOENT', Mar 24 19:45:18 integro volumio[3421]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 24 19:45:18 integro volumio[3421]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 24 19:45:18 integro volumio[3421]: spawnargs: [ Mar 24 19:45:18 integro volumio[3421]: '-p', Mar 24 19:45:18 integro volumio[3421]: 9876, Mar 24 19:45:18 integro volumio[3421]: '-o', Mar 24 19:45:18 integro volumio[3421]: '/tmp/camilladsp.log', Mar 24 19:45:18 integro volumio[3421]: '-l', Mar 24 19:45:18 integro volumio[3421]: 'warn', Mar 24 19:45:18 integro volumio[3421]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 24 19:45:18 integro volumio[3421]: ] Mar 24 19:45:18 integro volumio[3421]: } Mar 24 19:45:18 integro volumio[3421]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="completed keyexchange" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="completed challenge" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=info msg="authenticated AP" username="ma*******po" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=info msg="authenticated Login5" username="ma*******po" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="initializing zeroconf session" username="ma*******po" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="dealer connection opened" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=trace msg="starting accesspoint recv loop" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=trace msg="starting dealer recv loop" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=trace msg="received accesspoint ping" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 24 19:45:18 integro go-librespot[4044]: time="2026-03-24T19:45:18+01:00" level=debug msg="received connection id: MzEwZmUyNTQtZWM3...MDYwQjM1RjUxOA==" Mar 24 19:45:19 integro sudo[4126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-24 19:44 Mar 24 19:45:19 integro sudo[4126]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:45:19 integro go-librespot[4044]: time="2026-03-24T19:45:19+01:00" level=trace msg="received accesspoint pong ack" PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="integro" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 07:30:15 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Integro" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Integro" VOLUMIO_HASH="62fb96f98f7785ac55d44ca313ccc452"