-- Logs begin at Sun 2026-01-25 23:22:54 CET, end at Thu 2026-03-26 22:59:37 CET. -- Mar 26 22:59:00 integro systemd-timedated[3348]: Changed local time to Thu Mar 26 22:59:00 2026 Mar 26 22:59:00 integro systemd[1]: Started Volumio Time Update Utility. Mar 26 22:59:00 integro volumio-time-update[2828]: volumio-time-update-util: System time updated successfully. Mar 26 22:59:00 integro sudo[3346]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:00 integro systemd[1]: Starting Daily apt download activities... Mar 26 22:59:00 integro systemd[1]: Starting Daily man-db regeneration... Mar 26 22:59:00 integro ntpd[3315]: Soliciting pool server 212.6.50.243 Mar 26 22:59:00 integro ntpd[3315]: Soliciting pool server 185.19.184.35 Mar 26 22:59:00 integro wireless.js[2822]: trying... Mar 26 22:59:00 integro sudo[3369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 26 22:59:00 integro sudo[3369]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:00 integro sudo[3369]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:00 integro systemd[1]: systemd-rfkill.service: Succeeded. Mar 26 22:59:00 integro systemd[1]: apt-daily.service: Succeeded. Mar 26 22:59:00 integro systemd[1]: Started Daily apt download activities. Mar 26 22:59:00 integro systemd[1]: Starting Daily apt upgrade and clean activities... Mar 26 22:59:00 integro dhcpcd[3316]: wlan0: leased 192.168.0.28 for 86400 seconds Mar 26 22:59:00 integro avahi-daemon[2850]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.28. Mar 26 22:59:00 integro dhcpcd[3316]: wlan0: adding route to 192.168.0.0/24 Mar 26 22:59:00 integro dhcpcd[3316]: wlan0: adding default route via 192.168.0.1 Mar 26 22:59:00 integro avahi-daemon[2850]: New relevant interface wlan0.IPv4 for mDNS. Mar 26 22:59:00 integro avahi-daemon[2850]: Registering new address record for 192.168.0.28 on wlan0.IPv4. Mar 26 22:59:00 integro systemd[1]: man-db.service: Succeeded. Mar 26 22:59:00 integro systemd[1]: Started Daily man-db regeneration. Mar 26 22:59:00 integro ntpd[3315]: ntpd exiting on signal 15 (Terminated) Mar 26 22:59:00 integro ntpd[3315]: 185.157.229.254 local addr 192.168.0.21 -> Mar 26 22:59:00 integro ntpd[3315]: 204.216.214.76 local addr 192.168.0.21 -> Mar 26 22:59:00 integro ntpd[3315]: 212.6.50.243 local addr 192.168.0.21 -> Mar 26 22:59:00 integro systemd[1]: Stopping Network Time Service... Mar 26 22:59:00 integro ntpd[3315]: 185.19.184.35 local addr 192.168.0.21 -> Mar 26 22:59:00 integro systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 26 22:59:00 integro systemd[1]: Started Daily apt upgrade and clean activities. Mar 26 22:59:00 integro systemd[1]: ntp.service: Succeeded. Mar 26 22:59:00 integro systemd[1]: Stopped Network Time Service. Mar 26 22:59:00 integro systemd[1]: Starting Network Time Service... Mar 26 22:59:00 integro ntpd[3427]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 26 22:59:00 integro ntpd[3427]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 26 22:59:00 integro systemd[1]: Started Network Time Service. Mar 26 22:59:00 integro ntpd[3433]: proto: precision = 1.250 usec (-20) Mar 26 22:59:00 integro ntpd[3433]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 26 22:59:00 integro ntpd[3433]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 26 22:59:00 integro ntpd[3433]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1185 days ago Mar 26 22:59:00 integro ntpd[3433]: Listen and drop on 0 v6wildcard [::]:123 Mar 26 22:59:00 integro ntpd[3433]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 26 22:59:00 integro ntpd[3433]: Listen normally on 2 lo 127.0.0.1:123 Mar 26 22:59:00 integro ntpd[3433]: Listen normally on 3 eth0 192.168.0.21:123 Mar 26 22:59:00 integro ntpd[3433]: Listen normally on 4 wlan0 192.168.0.28:123 Mar 26 22:59:00 integro ntpd[3433]: Listening on routing socket on fd #21 for interface updates Mar 26 22:59:00 integro ntpd[3433]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Mar 26 22:59:00 integro ntpd[3433]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Mar 26 22:59:01 integro wireless.js[2822]: trying... Mar 26 22:59:01 integro sudo[3436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 26 22:59:01 integro sudo[3436]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:01 integro sudo[3436]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:01 integro wireless.js[2822]: Connected to: ----dlink_DWR-960_FA5981 Mar 26 22:59:01 integro wireless.js[2822]: ---- Mar 26 22:59:01 integro sudo[3439]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 26 22:59:01 integro sudo[3439]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:01 integro sudo[3439]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:01 integro wireless.js[2822]: ... joined AP, wlan0 IPv4 is 192.168.0.28, ipV6 is undefined Mar 26 22:59:01 integro wireless.js[2822]: It's done! AP Mar 26 22:59:01 integro systemd[1]: Started Wireless Services. Mar 26 22:59:01 integro systemd[1]: Started Volumio Backend Module. Mar 26 22:59:01 integro systemd[1]: Started Volumio Cpu Tweaker. Mar 26 22:59:01 integro systemd[1]: Started Start Volumio Kiosk. Mar 26 22:59:01 integro systemd[1]: Reached target Multi-User System. Mar 26 22:59:01 integro systemd[1]: Reached target Graphical Interface. Mar 26 22:59:01 integro systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 26 22:59:01 integro startkiosk.sh[3447]: Starting Volumio Kiosk with arguments for cursor display Mar 26 22:59:01 integro systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 26 22:59:01 integro systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 26 22:59:01 integro systemd[1]: Startup finished in 12.851s (kernel) + 21.577s (userspace) = 34.429s. Mar 26 22:59:01 integro volumio-cpu-tweak[3446]: Setting RT Priority for mpd Mar 26 22:59:01 integro volumio-cpu-tweak[3446]: chrt: cannot obtain the list of tasks: No such file or directory Mar 26 22:59:01 integro volumio-cpu-tweak[3446]: Setting MPD Affinity Mar 26 22:59:01 integro volumio-cpu-tweak[3446]: pid 3's current affinity mask: 1 Mar 26 22:59:01 integro volumio-cpu-tweak[3446]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 26 22:59:01 integro volumio-cpu-tweak[3446]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 26 22:59:01 integro systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 26 22:59:01 integro startkiosk.sh[3447]: X.Org X Server 1.20.4 Mar 26 22:59:01 integro startkiosk.sh[3447]: X Protocol Version 11, Revision 0 Mar 26 22:59:01 integro startkiosk.sh[3447]: Build Operating System: Linux 4.19.0-18-armmp-lpae armv7l Debian Mar 26 22:59:01 integro startkiosk.sh[3447]: Current Operating System: Linux integro 4.9.241 #4 SMP PREEMPT Wed Jun 4 18:07:40 CEST 2025 aarch64 Mar 26 22:59:01 integro startkiosk.sh[3447]: 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 26 22:59:01 integro startkiosk.sh[3447]: Build Date: 18 December 2021 09:05:36AM Mar 26 22:59:01 integro startkiosk.sh[3447]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Mar 26 22:59:01 integro startkiosk.sh[3447]: Current version of pixman: 0.36.0 Mar 26 22:59:01 integro startkiosk.sh[3447]: Before reporting problems, check http://wiki.x.org Mar 26 22:59:01 integro startkiosk.sh[3447]: to make sure that you have the latest version. Mar 26 22:59:01 integro startkiosk.sh[3447]: Markers: (--) probed, (**) from config file, (==) default setting, Mar 26 22:59:01 integro startkiosk.sh[3447]: (++) from command line, (!!) notice, (II) informational, Mar 26 22:59:01 integro startkiosk.sh[3447]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Mar 26 22:59:01 integro startkiosk.sh[3447]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Mar 26 22:59:01 2026 Mar 26 22:59:01 integro startkiosk.sh[3447]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Mar 26 22:59:01 integro ntpd[3433]: Soliciting pool server 172.232.208.229 Mar 26 22:59:01 integro kernel: fb: osd[0] canvas.idx =0x40 Mar 26 22:59:01 integro kernel: fb: osd[0] canvas.addr=0x70000000 Mar 26 22:59:02 integro kernel: fb: osd[0] canvas.width=7680 Mar 26 22:59:02 integro kernel: fb: osd[0] canvas.height=1080 Mar 26 22:59:02 integro kernel: fb: osd[0] frame.width=1920 Mar 26 22:59:02 integro kernel: fb: osd[0] frame.height=1080 Mar 26 22:59:02 integro kernel: fb: osd[0] out_addr_id =0x1 Mar 26 22:59:02 integro kernel: fb: osd[0] enable: 0 (Xorg) Mar 26 22:59:02 integro ntpd[3433]: Soliciting pool server 185.157.229.254 Mar 26 22:59:02 integro ntpd[3433]: Soliciting pool server 204.216.214.76 Mar 26 22:59:03 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 26 22:59:03 integro ntpd[3433]: Soliciting pool server 212.6.50.243 Mar 26 22:59:03 integro ntpd[3433]: Soliciting pool server 129.152.16.145 Mar 26 22:59:03 integro ntpd[3433]: Soliciting pool server 151.22.209.90 Mar 26 22:59:04 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 26 22:59:04 integro volumio[3445]: info: ------------------------------------------- Mar 26 22:59:04 integro volumio[3445]: info: ----- Volumio3 ---- Mar 26 22:59:04 integro volumio[3445]: info: ------------------------------------------- Mar 26 22:59:04 integro volumio[3445]: info: ----- System startup ---- Mar 26 22:59:04 integro volumio[3445]: info: ------------------------------------------- Mar 26 22:59:04 integro ntpd[3433]: Soliciting pool server 172.232.209.103 Mar 26 22:59:04 integro ntpd[3433]: Soliciting pool server 89.46.74.148 Mar 26 22:59:05 integro ntpd[3433]: Soliciting pool server 162.159.200.123 Mar 26 22:59:05 integro ntpd[3433]: Soliciting pool server 185.19.184.35 Mar 26 22:59:05 integro ntpd[3433]: Soliciting pool server 185.19.184.35 Mar 26 22:59:05 integro volumio[3445]: info: MYVOLUMIO Environment detected Mar 26 22:59:06 integro volumio[3445]: info: Plugin folders cleanup Mar 26 22:59:06 integro volumio[3445]: info: Scanning into folder /volumio/app/plugins/ Mar 26 22:59:06 integro volumio[3445]: info: Scanning category audio_interface Mar 26 22:59:06 integro volumio[3445]: info: Scanning category miscellanea Mar 26 22:59:06 integro volumio[3445]: info: Scanning category music_service Mar 26 22:59:06 integro volumio[3445]: info: Scanning category plugins.json Mar 26 22:59:06 integro volumio[3445]: info: Scanning category system_controller Mar 26 22:59:06 integro volumio[3445]: info: Scanning category user_interface Mar 26 22:59:06 integro volumio[3445]: info: Scanning into folder /data/plugins/ Mar 26 22:59:06 integro volumio[3445]: info: Scanning category audio_interface Mar 26 22:59:06 integro volumio[3445]: info: Scanning category music_service Mar 26 22:59:06 integro volumio[3445]: info: Plugin folders cleanup completed Mar 26 22:59:06 integro volumio[3445]: info: ------------------------------------------- Mar 26 22:59:06 integro volumio[3445]: info: ----- Core plugins startup ---- Mar 26 22:59:06 integro volumio[3445]: info: ------------------------------------------- Mar 26 22:59:06 integro volumio[3445]: info: Loading plugins from folder /volumio/app/plugins/ Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin multiroom to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin upnp to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin metavolumio to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin cd_controller to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin qobuzconnect to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin raat to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 26 22:59:06 integro volumio[3445]: info: Loading plugins from folder /data/plugins/ Mar 26 22:59:06 integro volumio[3445]: info: Loading plugin "system"... Mar 26 22:59:06 integro volumio[3445]: info: Loading plugin "appearance"... Mar 26 22:59:06 integro ntpd[3433]: Soliciting pool server 95.110.254.234 Mar 26 22:59:07 integro volumio[3445]: info: Loading plugin "network"... Mar 26 22:59:07 integro volumio[3445]: info: Refreshing Cached IP Addresses Mar 26 22:59:07 integro sudo[3555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 26 22:59:07 integro sudo[3555]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:08 integro sudo[3557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 26 22:59:08 integro sudo[3557]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:08 integro sudo[3555]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "services"... Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "volumio5onboarding"... Mar 26 22:59:08 integro sudo[3557]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:08 integro sudo[3569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 26 22:59:08 integro sudo[3569]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:08 integro kernel: wl_escan_set_scan: ioctl_ver=2 Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "alsa_controller"... Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "wizard"... Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "networkfs"... Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro volumio[3445]: info: Starting Udev Watcher for removable devices Mar 26 22:59:08 integro volumio[3445]: info: Ignoring mount for partition: BOOT Mar 26 22:59:08 integro volumio[3445]: info: Ignoring mount for partition: volumio Mar 26 22:59:08 integro volumio[3445]: info: Ignoring mount for partition: volumio_data Mar 26 22:59:08 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "volumio_command_line_client"... Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "upnp"... Mar 26 22:59:08 integro volumio[3445]: info: [1774562348345] Starting Upmpd Daemon Mar 26 22:59:08 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "my_music"... Mar 26 22:59:08 integro volumio[3445]: info: Loading plugin "mpd"... Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:08 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:09 integro volumio[3445]: info: Loading plugin "upnp_browser"... Mar 26 22:59:10 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:10 integro volumio-remote-updater[2849]: [2026-03-26 22:59:10] [connect] Successful connection Mar 26 22:59:10 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:10 integro volumio[3445]: info: Starting UPNP Browser Mar 26 22:59:10 integro volumio[3445]: info: Loading plugin "alarm-clock"... Mar 26 22:59:10 integro volumio[3445]: info: Loading plugin "manifestui"... Mar 26 22:59:11 integro volumio[3445]: info: Loading plugin "metavolumio"... Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:11 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:12 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:12 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:12 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 8 Mar 26 22:59:12 integro dbus-daemon[2836]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.10' (uid=0 pid=3585 comm="/usr/bin/vivaldi --kiosk --no-sandbox --disable-ba" label="kernel") Mar 26 22:59:12 integro dbus-daemon[2836]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found. Mar 26 22:59:13 integro volumio[3445]: info: Loading plugin "airplay_emulation"... Mar 26 22:59:13 integro volumio[3445]: info: Starting Shairport Sync Mar 26 22:59:13 integro volumio[3445]: info: Loading plugin "cd_controller"... Mar 26 22:59:13 integro kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f7e2000 drv_status 0x0 e_type 69 e_states 0 Mar 26 22:59:13 integro sudo[3569]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:13 integro volumio[3445]: info: Loading plugin "last_100"... Mar 26 22:59:13 integro volumio[3445]: info: Loading plugin "qobuzconnect"... Mar 26 22:59:13 integro volumio[3445]: info: Loading plugin "raat"... Mar 26 22:59:13 integro volumio[3445]: info: RAAT Plugin loaded Mar 26 22:59:13 integro volumio[3445]: info: Adding restartRAATSocket REST API Endpoint Mar 26 22:59:13 integro volumio[3445]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Mar 26 22:59:13 integro volumio[3445]: info: Loading plugin "streaming_services"... Mar 26 22:59:14 integro systemd[1]: systemd-fsckd.service: Succeeded. Mar 26 22:59:16 integro volumio[3445]: info: Starting Streaming Service Transparent Proxy Mar 26 22:59:16 integro volumio[3445]: info: Loading plugin "tidalconnect"... Mar 26 22:59:16 integro volumio[3445]: info: Loading plugin "webradio"... Mar 26 22:59:17 integro volumio[3445]: info: Loading plugin "i2s_dacs"... Mar 26 22:59:17 integro volumio[3445]: info: I2S DAC not set, start Auto-detection Mar 26 22:59:17 integro volumio[3445]: info: Loading plugin "volumiodiscovery"... Mar 26 22:59:17 integro volumio[3445]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 26 22:59:17 integro volumio[3445]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 22:59:17 integro volumio[3445]: *** WARNING *** For more information see Mar 26 22:59:17 integro node[3445]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 26 22:59:17 integro volumio[3445]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 26 22:59:17 integro volumio[3445]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 22:59:17 integro volumio[3445]: *** WARNING *** For more information see Mar 26 22:59:17 integro node[3445]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 22:59:17 integro node[3445]: *** WARNING *** For more information see Mar 26 22:59:17 integro node[3445]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 26 22:59:17 integro node[3445]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 26 22:59:17 integro node[3445]: *** WARNING *** For more information see Mar 26 22:59:17 integro volumio[3445]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 26 22:59:17 integro volumio[3445]: info: Discovery: Started advertising with name: Integro Mar 26 22:59:17 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 26 22:59:17 integro volumio[3445]: info: Loading plugin "spop"... Mar 26 22:59:18 integro volumio[3445]: STREAMING PROXY: Starting server on port 3245 Mar 26 22:59:18 integro volumio[3445]: Node JS runtime: 14 Mar 26 22:59:19 integro volumio[3445]: info: Loading plugin "multiroom"... Mar 26 22:59:21 integro volumio[3445]: info: Applying required configuration parameters for plugin multiroom Mar 26 22:59:21 integro sudo[3785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 26 22:59:21 integro sudo[3785]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:21 integro sudo[3785]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:21 integro volumio[3445]: info: MRS: MultiRoom plugin initialized Mar 26 22:59:21 integro volumio[3445]: info: MRS: STOPPING SNAPCLIENT Mar 26 22:59:21 integro volumio[3445]: info: MRS: Snap server stop Mar 26 22:59:21 integro sudo[3802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 26 22:59:21 integro sudo[3802]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:21 integro volumio[3445]: info: MRS: STOPPING volumioStreaming Mar 26 22:59:21 integro sudo[3804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 26 22:59:21 integro sudo[3804]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:21 integro volumio[3445]: info: Loading plugin "outputs"... Mar 26 22:59:21 integro sudo[3802]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:22 integro sudo[3808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 26 22:59:22 integro volumio[3445]: info: Loading plugin "albumart"... Mar 26 22:59:22 integro sudo[3808]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:22 integro sudo[3810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 26 22:59:22 integro sudo[3804]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:22 integro sudo[3810]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:22 integro sudo[3810]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:22 integro volumio[3445]: info: Plugin example_plugin is not enabled Mar 26 22:59:22 integro volumio[3445]: info: Loading plugin "hdmi_arc"... Mar 26 22:59:22 integro sudo[3808]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:22 integro volumio[3445]: info: Loading plugin "hi_res_audio"... Mar 26 22:59:22 integro volumio[3445]: Forking 3 albumart workers Mar 26 22:59:23 integro volumio[3445]: Starting albumart workers Mar 26 22:59:23 integro volumio[3445]: Starting albumart workers Mar 26 22:59:23 integro volumio[3445]: Starting albumart workers Mar 26 22:59:24 integro volumio[3445]: info: Applying required configuration parameters for plugin hi_res_audio Mar 26 22:59:24 integro volumio[3445]: info: Loading plugin "inputs"... Mar 26 22:59:25 integro volumio-remote-updater[2849]: [2026-03-26 22:59:25] [connect] Successful connection Mar 26 22:59:25 integro volumio[3445]: info: Loading plugin "qobuz"... Mar 26 22:59:27 integro volumio[3445]: info: Loading plugin "smart_inputs"... Mar 26 22:59:27 integro volumio[3445]: info: Loading plugin "tidal"... Mar 26 22:59:29 integro volumio[3445]: info: Loading plugin "integrocontrol"... Mar 26 22:59:29 integro volumio[3445]: info: Adding this device properties Mar 26 22:59:29 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Mar 26 22:59:29 integro volumio[3445]: info: Setting Additional Device Volumio Properties: [object Object] Mar 26 22:59:29 integro volumio[3445]: info: Loading plugin "updater_comm"... Mar 26 22:59:29 integro volumio[3445]: info: Plugin mpdemulation is not enabled Mar 26 22:59:29 integro volumio[3445]: info: Loading plugin "rest_api"... Mar 26 22:59:29 integro volumio[3445]: info: Loading plugin "websocket"... Mar 26 22:59:29 integro volumio[3445]: info: Starting Socket.io Server version 2.3.0 Mar 26 22:59:29 integro volumio[3445]: info: Loading plugin "fusiondsp"... Mar 26 22:59:30 integro volumio[3445]: info: Applying required configuration parameters for plugin fusiondsp Mar 26 22:59:30 integro volumio[3445]: info: Loading i18n strings for locale it Mar 26 22:59:30 integro volumio[3445]: Updating browse sources language Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::initPlayerControls Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:30 integro kernel: fb: mem_free_work, free memory: addr:800000 Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 22:59:30 integro volumio[3445]: Express server listening on port 3000 Mar 26 22:59:30 integro volumio[3445]: [Metrics] WebUI: 26s 42.37ms Mar 26 22:59:30 integro volumio[3445]: info: CoreStateMachine::resetVolumioState Mar 26 22:59:30 integro volumio[3445]: info: CoreStateMachine::getcurrentVolume Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::volumioRetrievevolume Mar 26 22:59:30 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:30 integro sudo[3892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 26 22:59:30 integro sudo[3892]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:30 integro sudo[3892]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:30 integro volumio[3445]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 26 22:59:30 integro sudo[3895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 26 22:59:30 integro volumio[3445]: info: Completed loading Core Plugins Mar 26 22:59:30 integro sudo[3895]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:30 integro volumio[3445]: info: Preparing to generate the ALSA configuration file Mar 26 22:59:30 integro sudo[3895]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:30 integro volumio[3445]: info: Volumio Network Manager: Network status updated: 3 Mar 26 22:59:30 integro volumio[3445]: Unable to parse: Mar 26 22:59:30 integro volumio[3445]: Simple mixer control 'Audio hdmi-out mute',0 Mar 26 22:59:30 integro volumio[3445]: Capabilities: pswitch pswitch-joined Mar 26 22:59:30 integro volumio[3445]: Playback channels: Mono Mar 26 22:59:30 integro volumio[3445]: Mono: Playback [on] Mar 26 22:59:30 integro volumio[3445]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 26 22:59:30 integro volumio[3445]: info: MRS: Removed streaming files Mar 26 22:59:30 integro volumio[3445]: info: MRS: volumioStreaming STOPPED Mar 26 22:59:30 integro volumio[3445]: info: MRS: SNAPSERVER STOPPED Mar 26 22:59:30 integro volumio[3445]: info: MRS: SNAPCLIENT STOPPED Mar 26 22:59:30 integro volumio[3445]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Mar 26 22:59:30 integro volumio[3445]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 26 22:59:30 integro volumio[3445]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 26 22:59:30 integro volumio[3445]: info: Reading ALSA contributions from plugins. Mar 26 22:59:31 integro systemd[1]: systemd-timedated.service: Succeeded. Mar 26 22:59:31 integro volumio[3445]: Unable to parse: Mar 26 22:59:31 integro volumio[3445]: Simple mixer control 'Audio hdmi-out mute',0 Mar 26 22:59:31 integro volumio[3445]: Capabilities: pswitch pswitch-joined Mar 26 22:59:31 integro volumio[3445]: Playback channels: Mono Mar 26 22:59:31 integro volumio[3445]: Mono: Playback [on] Mar 26 22:59:31 integro volumio[3445]: info: VolumeController:: Volume=undefined Mute =false Mar 26 22:59:31 integro volumio[3445]: info: CoreStateMachine::pushState Mar 26 22:59:31 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::volumioPushState Mar 26 22:59:31 integro volumio[3445]: info: CoreStateMachine::updateTrackBlock Mar 26 22:59:31 integro volumio[3445]: info: CorePlayQueue::getTrackBlock Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::volumioRetrievevolume Mar 26 22:59:31 integro volumio[3445]: info: Reloading queue from file Mar 26 22:59:31 integro volumio[3445]: Unable to parse: Mar 26 22:59:31 integro volumio[3445]: Simple mixer control 'Audio hdmi-out mute',0 Mar 26 22:59:31 integro volumio[3445]: Capabilities: pswitch pswitch-joined Mar 26 22:59:31 integro volumio[3445]: Playback channels: Mono Mar 26 22:59:31 integro volumio[3445]: Mono: Playback [on] Mar 26 22:59:31 integro volumio[3445]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 26 22:59:31 integro volumio[3445]: info: CoreStateMachine::setRepeat false single undefined Mar 26 22:59:31 integro volumio[3445]: info: CoreStateMachine::pushState Mar 26 22:59:31 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::volumioPushState Mar 26 22:59:31 integro volumio[3445]: info: CoreStateMachine::setRandom undefined Mar 26 22:59:31 integro volumio[3445]: info: CoreStateMachine::pushState Mar 26 22:59:31 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::volumioPushState Mar 26 22:59:31 integro volumio[3445]: Unable to parse: Mar 26 22:59:31 integro volumio[3445]: Simple mixer control 'Audio hdmi-out mute',0 Mar 26 22:59:31 integro volumio[3445]: Capabilities: pswitch pswitch-joined Mar 26 22:59:31 integro volumio[3445]: Playback channels: Mono Mar 26 22:59:31 integro volumio[3445]: Mono: Playback [on] Mar 26 22:59:31 integro volumio[3445]: info: VolumeController:: Volume=undefined Mute =false Mar 26 22:59:31 integro volumio[3445]: info: CoreStateMachine::pushState Mar 26 22:59:31 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::volumioPushState Mar 26 22:59:31 integro volumio[3445]: info: Asound.conf file unchanged, so no further update is needed Mar 26 22:59:31 integro sudo[3912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 26 22:59:31 integro sudo[3912]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:31 integro volumio[3445]: info: Output device has changed, restarting MPD Mar 26 22:59:31 integro systemd[1]: Started UPnP Renderer front-end to MPD. Mar 26 22:59:31 integro sudo[3912]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:31 integro sudo[3916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 26 22:59:31 integro sudo[3916]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:31 integro sudo[3916]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:31 integro volumio[3445]: info: Output device has changed, restarting Shairport Sync Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:31 integro sudo[3928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 26 22:59:31 integro sudo[3928]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:31 integro volumio[3445]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 26 22:59:31 integro volumio[3445]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:31 integro systemd[1]: Listening on mpd.socket. Mar 26 22:59:31 integro systemd[1]: Starting Music Player Daemon... Mar 26 22:59:31 integro volumio[3445]: info: ___________ START PLUGINS ___________ Mar 26 22:59:31 integro kernel: aml_tdm_open Mar 26 22:59:31 integro kernel: Not init audio effects Mar 26 22:59:31 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 26 22:59:31 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 26 22:59:31 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 26 22:59:31 integro volumio[3445]: info: ControllerMpd::onStart: Initializing MPD Mar 26 22:59:31 integro volumio[3445]: info: Creating MPD Configuration file Mar 26 22:59:31 integro sudo[3938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Mar 26 22:59:31 integro sudo[3938]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 26 22:59:31 integro volumio[3445]: info: [1774562371906] CoreMusicLibrary::Adding element Server multimediali Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 26 22:59:31 integro sudo[3941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 26 22:59:31 integro sudo[3941]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:31 integro systemd[1]: Started Volumio5 Onboarding Server. Mar 26 22:59:31 integro volumio[3445]: info: UPNP Browser: Client initialized successfully Mar 26 22:59:31 integro sudo[3934]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 26 22:59:31 integro sudo[3934]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:31 integro sudo[3941]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:31 integro sudo[3938]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:31 integro sudo[3943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 26 22:59:31 integro sudo[3934]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 26 22:59:31 integro sudo[3943]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:31 integro sudo[3934]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:31 integro volumio[3445]: info: Adding METAVOLUMIO REST API Endpoints Mar 26 22:59:31 integro volumio[3445]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 26 22:59:31 integro volumio[3445]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 26 22:59:31 integro volumio[3445]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 26 22:59:31 integro volumio[3445]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:31 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:32 integro systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 26 22:59:32 integro systemd[1]: mpd.service: Succeeded. Mar 26 22:59:32 integro systemd[1]: Stopped Music Player Daemon. Mar 26 22:59:32 integro volumio[3445]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:32 integro systemd[1]: Starting Music Player Daemon... Mar 26 22:59:32 integro volumio[3445]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 26 22:59:32 integro volumio[3445]: info: Preparing CD Folders Mar 26 22:59:32 integro volumio[3445]: info: Adding CD REST API Endpoints Mar 26 22:59:32 integro volumio[3445]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Mar 26 22:59:32 integro volumio[3445]: info: Starting UDEV Watcher for CD Mar 26 22:59:32 integro volumio[3445]: info: Detecting CD presence with UDEV Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 26 22:59:32 integro volumio[3445]: info: [1774562372193] CoreMusicLibrary::Adding element Last_100 Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 26 22:59:32 integro volumio[3445]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Mar 26 22:59:32 integro sudo[3952]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 26 22:59:32 integro sudo[3952]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:32 integro volumio[3445]: info: QobuzConnect: Starting Qobuz Connect socket and service Mar 26 22:59:32 integro sudo[3952]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 26 22:59:32 integro sudo[3952]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:32 integro volumio[3445]: info: Starting RAAT Plugin Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Mar 26 22:59:32 integro volumio[3445]: info: Additional UI Settings Added for plugin music_service/raat Mar 26 22:59:32 integro volumio[3445]: info: Registering DSP Elements listener and retrieving current ones Mar 26 22:59:32 integro volumio[3445]: info: Additional DSP elements updated Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:32 integro volumio[3445]: info: Updating RAAT Signal Path Mar 26 22:59:32 integro sudo[3969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 26 22:59:32 integro sudo[3969]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:32 integro volumio[3445]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 26 22:59:32 integro volumio[3445]: info: Streaming services startup Mar 26 22:59:32 integro volumio[3445]: info: Starting Streaming Daemon Mar 26 22:59:32 integro sudo[3969]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:32 integro sudo[3974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 26 22:59:32 integro sudo[3974]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:32 integro sudo[3973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 26 22:59:32 integro sudo[3973]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:32 integro sudo[3974]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 26 22:59:32 integro volumio[3445]: info: [1774562372591] CoreMusicLibrary::Adding element Webradio Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 26 22:59:32 integro volumio[3445]: info: Initializing BBC Radios Mar 26 22:59:32 integro systemd[1]: Started Volumio Qobuz Connect Service. Mar 26 22:59:32 integro volumio5-onboarding[3945]: time=2026-03-26T22:59:32.628+01:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Mar 26 22:59:32 integro sudo[3983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 22:59:32 integro sudo[3983]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:32 integro sudo[3973]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:32 integro sudo[3983]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:32 integro volumio[3445]: info: Creating Spotify config file Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 26 22:59:32 integro volumio[3445]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:32 integro volumio[3445]: info: Starting CEC Infrastructure Mar 26 22:59:32 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:32 integro kernel: aml_tdm_open Mar 26 22:59:32 integro kernel: Not init audio effects Mar 26 22:59:32 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 26 22:59:32 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 26 22:59:32 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 26 22:59:33 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Mar 26 22:59:33 integro volumio[3445]: info: Additional UI Settings Added for plugin music_service/hdmi_arc Mar 26 22:59:33 integro volumio[3445]: error: Hi Res Audio Failed Login: Missing Login Data Mar 26 22:59:33 integro volumio[3445]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 26 22:59:33 integro volumio[3445]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 26 22:59:33 integro volumio[3445]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 26 22:59:33 integro volumio[3445]: info: Initializing Serial Communication on port /dev/ttyS3 Mar 26 22:59:33 integro volumio[3445]: info: Touch Event Listener Process Starting Mar 26 22:59:33 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Mar 26 22:59:33 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Mar 26 22:59:33 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Mar 26 22:59:33 integro volumio[3445]: info: Adding inputs REST Endpoints Mar 26 22:59:33 integro volumio[3445]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 26 22:59:33 integro volumio[3445]: info: Scanning Audio Inputs Mar 26 22:59:33 integro sudo[4005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Mar 26 22:59:33 integro sudo[4005]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:33 integro volumio[3445]: info: Checking against Known Cards name Mar 26 22:59:33 integro volumio[3445]: info: Checking against Known Cards name Mar 26 22:59:33 integro volumio[3445]: info: Checking against Known Cards name Mar 26 22:59:33 integro volumio[3445]: info: Checking against Known Cards name Mar 26 22:59:33 integro volumio[3445]: info: Checking against Known Cards name Mar 26 22:59:33 integro volumio[3445]: info: Adding Server instance for streaming Mar 26 22:59:33 integro volumio[3445]: info: Refreshing TIDAL token Mar 26 22:59:33 integro sudo[4013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Mar 26 22:59:33 integro sudo[4013]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:33 integro sudo[4013]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:33 integro sudo[4016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Mar 26 22:59:33 integro sudo[4016]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:33 integro sudo[4016]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:33 integro sudo[4019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Mar 26 22:59:33 integro sudo[4019]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:33 integro sudo[4019]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:33 integro sudo[4022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Mar 26 22:59:33 integro sudo[4022]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:33 integro sudo[4022]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:33 integro volumio[3445]: info: MP1 Muting HDMI Output Mar 26 22:59:33 integro volumio[3445]: info: Apply VIM3L Onboard LEDs Settings Mar 26 22:59:33 integro volumio[3445]: info: Turning On Onboard LEDs Mar 26 22:59:33 integro volumio[3445]: info: Loading i18n strings for locale it Mar 26 22:59:33 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 26 22:59:33 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:33 integro volumio[3445]: info: FusionDsp - mixtype--------------------- Hardware Mar 26 22:59:33 integro volumio[3445]: info: Volumio Calling Home Mar 26 22:59:33 integro sudo[4028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Mar 26 22:59:33 integro sudo[4028]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:33 integro sudo[4028]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:33 integro sudo[4043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Mar 26 22:59:33 integro sudo[4043]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:33 integro sudo[4043]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:34 integro volumio[3445]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Mar 26 22:59:34 integro volumio[3445]: (node:3445) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Mar 26 22:59:34 integro volumio[3445]: (Use `node --trace-deprecation ...` to show where the warning was created) Mar 26 22:59:34 integro volumio[3445]: info: Preparing to generate the ALSA configuration file Mar 26 22:59:34 integro volumio[3445]: info: Stopping AccessToken refresher cron for QOBUZ Mar 26 22:59:34 integro volumio[3445]: info: AccessToken refresher cron started for QOBUZ Mar 26 22:59:34 integro volumio[3445]: info: Adding QOBUZ REST API Endpoints Mar 26 22:59:34 integro volumio[3445]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 26 22:59:34 integro volumio[3445]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 26 22:59:34 integro volumio[3445]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 26 22:59:34 integro volumio[3445]: info: Serial port opened successfully Mar 26 22:59:34 integro volumio[3445]: info: Sending serial start messages Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: Reporting MCU Network Status: 3 Mar 26 22:59:34 integro volumio[3445]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 26 22:59:34 integro volumio[3445]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 26 22:59:34 integro volumio[3445]: info: Reading ALSA contributions from plugins. Mar 26 22:59:34 integro volumio[3445]: error: Cannot start Volumio Streaming Daemon Mar 26 22:59:34 integro volumio[3445]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 26 22:59:34 integro volumio[3445]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 26 22:59:34 integro volumio[3445]: info: RAAT Albumart path created successfully Mar 26 22:59:34 integro volumio[3445]: info: MPD Permissions set Mar 26 22:59:34 integro volumio[3445]: info: MPD Permissions set Mar 26 22:59:34 integro volumio[3445]: info: Upmpdcli Daemon Started Mar 26 22:59:34 integro volumio[3445]: 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: 1 Mar 26 22:59:34 integro dbus-daemon[2836]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.17' (uid=0 pid=3945 comm="/usr/bin/volumio5-onboarding " label="kernel") Mar 26 22:59:34 integro dbus-daemon[2836]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found. Mar 26 22:59:34 integro volumio5-onboarding[3945]: 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 26 22:59:34 integro systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 26 22:59:34 integro systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 26 22:59:34 integro volumio[3445]: info: Executing endpoint qc_getconfig Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.604 [3984.3984] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Mar 26 22:59:34 integro volumio[3445]: info: Volumio called home Mar 26 22:59:34 integro volumio[3445]: info: Spotify config file written Mar 26 22:59:34 integro systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Mar 26 22:59:34 integro systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Mar 26 22:59:34 integro systemd[1]: Stopped Volumio5 Onboarding Server. Mar 26 22:59:34 integro sudo[4052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 26 22:59:34 integro systemd[1]: Started Volumio5 Onboarding Server. Mar 26 22:59:34 integro sudo[4052]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:34 integro volumio5-onboarding[4053]: time=2026-03-26T22:59:34.809+01:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Mar 26 22:59:34 integro systemd[1]: Started go-librespot Daemon. Mar 26 22:59:34 integro volumio[3445]: 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: 1 Mar 26 22:59:34 integro sudo[4052]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.848 [3984.3984] INFO VolumeManager: [0xacb538f0]: Setting new playback volume: 75 Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.848 [3984.3984] INFO VolumeManager: [0xacb538f0]: Setting new mute state: 0 Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.848 [3984.3984] INFO QobuzConnect: [0xacb542c0]: Client initialized! Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.848 [3984.3984] INFO SampleApp: Starting Avahi advertising, name: Integro, service name: _qobuz-connect._tcp Mar 26 22:59:34 integro go-librespot[4060]: go-librespot daemon starting... Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.889 [3984.3984] INFO LocalConfigManager: [0xacb531d0]: Starting Local Configuration server Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.889 [3984.3984] INFO SampleApp: Starting Local configuration server Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.890 [3984.3984] INFO SampleApp: Playback volume changed: 75 Mar 26 22:59:34 integro qobuz-connect[3984]: 20260326 22:59:34.890 [3984.3984] INFO SampleApp: Connected to UNIX socket client 0xacb48ed8 Mar 26 22:59:34 integro volumio[3445]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 26 22:59:34 integro volumio[3445]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Mar 26 22:59:34 integro volumio[3445]: info: QobuzConnect: QOBUZ Connect daemon connected Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:34 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 26 22:59:35 integro go-librespot[4060]: time="2026-03-26T22:59:35+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 22:59:35 integro go-librespot[4060]: time="2026-03-26T22:59:35+01:00" level=debug msg="app state loaded" Mar 26 22:59:35 integro go-librespot[4060]: time="2026-03-26T22:59:35+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: No need to fix Spotify hosts Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Mar 26 22:59:35 integro volumio[3445]: info: Setting Device Volume Override Mar 26 22:59:35 integro volumio[3445]: info: Applying Volume Override Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 26 22:59:35 integro volumio[3445]: 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 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 26 22:59:35 integro volumio[3445]: info: Enabling external Volume Control Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreStateMachine::pushState Mar 26 22:59:35 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::volumioPushState Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::volumioGetState Mar 26 22:59:35 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Mar 26 22:59:35 integro volumio[3445]: info: Setting Additional System Software info: Hardware Revision: 1.2 Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Mar 26 22:59:35 integro volumio[3445]: info: Setting HW Firmware info: undefined Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Mar 26 22:59:35 integro volumio[3445]: info: Setting HW Version info: 1.2 Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Mar 26 22:59:35 integro volumio[3445]: info: Setting Additional System Software info: Hardware Revision: 1.2, Firmware Version: 0.7.3 Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Mar 26 22:59:35 integro volumio[3445]: info: Setting HW Firmware info: 0.7.3 Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Mar 26 22:59:35 integro volumio[3445]: info: Setting HW Version info: 1.2 Mar 26 22:59:35 integro volumio[3445]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 26 22:59:35 integro volumio[3445]: info: MCU Signalled Headphone Mode Disabled Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Mar 26 22:59:35 integro volumio[3445]: info: Reporting Headphone State: false Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:35 integro volumio[3445]: info: Updating RAAT Signal Path Mar 26 22:59:35 integro volumio[3445]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 26 22:59:35 integro volumio[3445]: info: MCU Signalled Sleep Mode Disabled Mar 26 22:59:35 integro volumio[3445]: info: Enabling Advanced system settings configuration Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Mar 26 22:59:35 integro volumio[3445]: info: Additional UI Settings Added for plugin music_service/inputs Mar 26 22:59:35 integro volumio[3445]: info: MCU Signalled Auto Boot Mode On Power Disabled Mar 26 22:59:35 integro sudo[4084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Mar 26 22:59:35 integro sudo[4084]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:35 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 26 22:59:35 integro sudo[4084]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:35 integro volumio[3445]: info: Access Token successfully retrieved Mar 26 22:59:35 integro volumio[3445]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 26 22:59:35 integro volumio[3445]: 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: 3 Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::volumioGetState Mar 26 22:59:35 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:35 integro dbus-daemon[2836]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.19' (uid=0 pid=4053 comm="/usr/bin/volumio5-onboarding " label="kernel") Mar 26 22:59:35 integro dbus-daemon[2836]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found. Mar 26 22:59:35 integro volumio5-onboarding[4053]: 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 26 22:59:35 integro volumio[3445]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Mar 26 22:59:35 integro systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 26 22:59:35 integro systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 26 22:59:35 integro volumio[3445]: 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: 3 Mar 26 22:59:35 integro volumio[3445]: info: New Spotify access tokenBQDlJdxy4A... Mar 26 22:59:35 integro volumio[3445]: info: Spotify credentials grant success - running version from March 24, 2019 Mar 26 22:59:35 integro sudo[4087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Mar 26 22:59:35 integro sudo[4087]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:35 integro sudo[4087]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:35 integro volumio[3445]: info: Starting Shairport Sync Mar 26 22:59:35 integro systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Mar 26 22:59:35 integro systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Mar 26 22:59:35 integro systemd[1]: Stopped Volumio5 Onboarding Server. Mar 26 22:59:35 integro systemd[1]: Started Volumio5 Onboarding Server. Mar 26 22:59:35 integro volumio5-onboarding[4089]: time=2026-03-26T22:59:35.757+01:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Mar 26 22:59:35 integro volumio[3445]: info: Starting Shairport Sync Mar 26 22:59:35 integro sudo[4096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 26 22:59:35 integro sudo[4096]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:35 integro volumio[3445]: info: Starting Shairport Sync Mar 26 22:59:35 integro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 26 22:59:35 integro sudo[4099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 26 22:59:35 integro sudo[4099]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:35 integro systemd[1]: shairport-sync.service: Succeeded. Mar 26 22:59:35 integro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 26 22:59:35 integro volumio[3445]: info: CoreCommandRouter::volumioGetState Mar 26 22:59:35 integro volumio[3445]: info: CorePlayQueue::getTrack 0 Mar 26 22:59:35 integro go-librespot[4060]: time="2026-03-26T22:59:35+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 26 22:59:35 integro go-librespot[4060]: time="2026-03-26T22:59:35+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 26 22:59:35 integro go-librespot[4060]: time="2026-03-26T22:59:35+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 26 22:59:35 integro go-librespot[4060]: time="2026-03-26T22:59:35+01:00" level=info msg="zeroconf server listening on port 36083" Mar 26 22:59:35 integro sudo[4101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 26 22:59:35 integro sudo[4101]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:35 integro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 26 22:59:35 integro sudo[4096]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:35 integro sudo[4099]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:35 integro mpd[3967]: Mar 26 22:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 26 22:59:35 integro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 26 22:59:35 integro systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 26 22:59:35 integro systemd[1]: shairport-sync.service: Succeeded. Mar 26 22:59:36 integro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 26 22:59:36 integro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 26 22:59:36 integro sudo[4101]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:36 integro systemd[1]: Started Music Player Daemon. Mar 26 22:59:36 integro sudo[3943]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:36 integro sudo[3928]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:36 integro volumio[3445]: info: camilladsp service started and running in background, instance 1 Mar 26 22:59:36 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:36 integro volumio[3445]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 26 22:59:36 integro volumio[3445]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 26 22:59:36 integro volumio[3445]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 26 22:59:36 integro volumio[3445]: info: FusionDsp loaded Mar 26 22:59:36 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 22:59:36 integro go-librespot[4060]: time="2026-03-26T22:59:36+01:00" level=debug msg="obtained new client token: AAAHSfG4TWl7yjJCThhAo9qJjtQALlVN/D6AC92Ehid3WB7JvzcUaoKUk6/MeOHIqklRGMPgRlrDUgRvTv5MvI53+hWny5+0g178hJrFw3i/jgp5s2T2DLMF3m/vCBLiJq3uIAAdLDs8xZcAnDeBkrMyomubOJrcNPu2I5FmZszjouGNCtV284UTvJgltSaBGzDi1ZrFxKguiFo9WvEnRFIFizSuxioXw08a9OZm9H73uOs90d4CPA==" Mar 26 22:59:36 integro sudo[4122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 26 22:59:36 integro sudo[4122]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:36 integro volumio[3445]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 26 22:59:36 integro volumio[3445]: info: Adding Signal Path Element [object Object] Mar 26 22:59:36 integro volumio[3445]: info: Adding fusiondspeq DSP Signal Path Element Mar 26 22:59:36 integro volumio[3445]: info: Additional DSP elements updated Mar 26 22:59:36 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:36 integro volumio[3445]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 22:59:36 integro volumio[3445]: info: Updating RAAT Signal Path Mar 26 22:59:36 integro volumio[3445]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 26 22:59:36 integro volumio[3445]: info: FusionDsp - ---- installed callbackRead Mar 26 22:59:36 integro volumio[3445]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 22:59:36 integro sudo[4122]: pam_unix(sudo:session): session closed for user root Mar 26 22:59:36 integro volumio[3445]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 26 22:59:36 integro volumio[3445]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Mar 26 22:59:36 integro volumio[3445]: at onErrorNT (internal/child_process.js:472:16) Mar 26 22:59:36 integro volumio[3445]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Mar 26 22:59:36 integro volumio[3445]: at runNextTicks (internal/process/task_queues.js:64:3) Mar 26 22:59:36 integro volumio[3445]: at listOnTimeout (internal/timers.js:526:9) Mar 26 22:59:36 integro volumio[3445]: at processTimers (internal/timers.js:500:7) { Mar 26 22:59:36 integro volumio[3445]: errno: -2, Mar 26 22:59:36 integro volumio[3445]: code: 'ENOENT', Mar 26 22:59:36 integro volumio[3445]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 26 22:59:36 integro volumio[3445]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 26 22:59:36 integro volumio[3445]: spawnargs: [ Mar 26 22:59:36 integro volumio[3445]: '-p', Mar 26 22:59:36 integro volumio[3445]: 9876, Mar 26 22:59:36 integro volumio[3445]: '-o', Mar 26 22:59:36 integro volumio[3445]: '/tmp/camilladsp.log', Mar 26 22:59:36 integro volumio[3445]: '-l', Mar 26 22:59:36 integro volumio[3445]: 'warn', Mar 26 22:59:36 integro volumio[3445]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 26 22:59:36 integro volumio[3445]: ] Mar 26 22:59:36 integro volumio[3445]: } Mar 26 22:59:36 integro volumio[3445]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 22:59:36 integro go-librespot[4060]: time="2026-03-26T22:59:36+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Mar 26 22:59:36 integro go-librespot[4060]: time="2026-03-26T22:59:36+01:00" level=debug msg="completed keyexchange" Mar 26 22:59:36 integro go-librespot[4060]: time="2026-03-26T22:59:36+01:00" level=debug msg="completed challenge" Mar 26 22:59:36 integro go-librespot[4060]: time="2026-03-26T22:59:36+01:00" level=info msg="authenticated AP" username="ma*******po" Mar 26 22:59:36 integro go-librespot[4060]: time="2026-03-26T22:59:36+01:00" level=info msg="authenticated Login5" username="ma*******po" Mar 26 22:59:36 integro go-librespot[4060]: time="2026-03-26T22:59:36+01:00" level=debug msg="initializing zeroconf session" username="ma*******po" Mar 26 22:59:37 integro sudo[4133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-26 22:58 Mar 26 22:59:37 integro sudo[4133]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=debug msg="dealer connection opened" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=trace msg="starting accesspoint recv loop" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=trace msg="starting dealer recv loop" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=trace msg="received accesspoint ping" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 26 22:59:37 integro go-librespot[4060]: time="2026-03-26T22:59:37+01:00" level=debug msg="received connection id: NmIwNTFkMzEtODJi...MDQ5MTY2NUE3MA==" 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"