-- Logs begin at Thu 2025-03-06 18:59:30 CET, end at Thu 2025-03-06 19:01:03 CET. -- Mar 06 19:00:00 integro wireless.js[2813]: trying... Mar 06 19:00:00 integro sudo[3370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 06 19:00:00 integro sudo[3370]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:00 integro sudo[3370]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:00 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:00 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:00 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: carrier lost Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: carrier lost Mar 06 19:00:00 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:00 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:00 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:00 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: carrier acquired Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: carrier acquired Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: soliciting a DHCP lease Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: soliciting a DHCP lease Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:00 integro dhcpcd[2840]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:01 integro wireless.js[2813]: Overtime, starting plan B Mar 06 19:00:01 integro systemd[1]: Started Wireless Services. Mar 06 19:00:01 integro systemd[1]: Started Volumio Backend Module. Mar 06 19:00:01 integro systemd[1]: Started Start Volumio Kiosk. Mar 06 19:00:01 integro systemd[1]: Started Volumio Cpu Tweaker. Mar 06 19:00:01 integro startkiosk.sh[3391]: Starting Volumio Kiosk with arguments for cursor display Mar 06 19:00:01 integro volumio-cpu-tweak[3397]: Setting RT Priority for mpd Mar 06 19:00:01 integro volumio-cpu-tweak[3397]: chrt: cannot obtain the list of tasks: No such file or directory Mar 06 19:00:01 integro volumio-cpu-tweak[3397]: Setting MPD Affinity Mar 06 19:00:01 integro volumio-cpu-tweak[3397]: pid 3's current affinity mask: 1 Mar 06 19:00:01 integro dhcpcd[2840]: wlan0: soliciting an IPv6 router Mar 06 19:00:01 integro dhcpcd[2840]: wlan0: soliciting an IPv6 router Mar 06 19:00:01 integro volumio-cpu-tweak[3397]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 06 19:00:01 integro volumio-cpu-tweak[3397]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 06 19:00:01 integro systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 06 19:00:01 integro startkiosk.sh[3391]: X.Org X Server 1.20.4 Mar 06 19:00:01 integro startkiosk.sh[3391]: X Protocol Version 11, Revision 0 Mar 06 19:00:01 integro startkiosk.sh[3391]: Build Operating System: Linux 4.19.0-18-armmp-lpae armv7l Debian Mar 06 19:00:01 integro startkiosk.sh[3391]: Current Operating System: Linux integro 4.9.241 #27 SMP PREEMPT Mon Sep 16 18:15:31 CEST 2024 aarch64 Mar 06 19:00:01 integro startkiosk.sh[3391]: Kernel command line: imgpart=UUID=daf3b3ff-4440-4c7f-ac37-ce49716c3105 imgfile=/volumio_current.sqsh bootpart=UUID=3939-B20D datapart=UUID=b8403d3d-5bac-46cb-89ad-fd240fe07340 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:07:1a:01 fan=auto hwver=VIM3.V12 coherent_pool=2M quiet loglevel=0 splash plymouth.ignore-serial-consoles initramfs.clear splash bootdelay=7 Mar 06 19:00:01 integro startkiosk.sh[3391]: Build Date: 18 December 2021 09:05:36AM Mar 06 19:00:01 integro startkiosk.sh[3391]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Mar 06 19:00:01 integro startkiosk.sh[3391]: Current version of pixman: 0.36.0 Mar 06 19:00:01 integro startkiosk.sh[3391]: Before reporting problems, check http://wiki.x.org Mar 06 19:00:01 integro startkiosk.sh[3391]: to make sure that you have the latest version. Mar 06 19:00:01 integro startkiosk.sh[3391]: Markers: (--) probed, (**) from config file, (==) default setting, Mar 06 19:00:01 integro startkiosk.sh[3391]: (++) from command line, (!!) notice, (II) informational, Mar 06 19:00:01 integro startkiosk.sh[3391]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Mar 06 19:00:01 integro startkiosk.sh[3391]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Mar 6 19:00:01 2025 Mar 06 19:00:01 integro startkiosk.sh[3391]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Mar 06 19:00:01 integro kernel: fb: osd[0] canvas.idx =0x40 Mar 06 19:00:01 integro kernel: fb: osd[0] canvas.addr=0x70000000 Mar 06 19:00:01 integro kernel: fb: osd[0] canvas.width=7680 Mar 06 19:00:01 integro kernel: fb: osd[0] canvas.height=1080 Mar 06 19:00:01 integro kernel: fb: osd[0] frame.width=1920 Mar 06 19:00:01 integro kernel: fb: osd[0] frame.height=1080 Mar 06 19:00:01 integro kernel: fb: osd[0] out_addr_id =0x1 Mar 06 19:00:01 integro kernel: fb: osd[0] enable: 0 (Xorg) Mar 06 19:00:02 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:02 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:02 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: carrier lost Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: carrier lost Mar 06 19:00:02 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:02 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:02 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:02 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: carrier acquired Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: carrier acquired Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: soliciting a DHCP lease Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: soliciting a DHCP lease Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:02 integro dhcpcd[2840]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:03 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 06 19:00:03 integro dhcpcd[2840]: wlan0: soliciting an IPv6 router Mar 06 19:00:03 integro dhcpcd[2840]: wlan0: soliciting an IPv6 router Mar 06 19:00:03 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 06 19:00:03 integro systemd[1]: systemd-fsckd.service: Succeeded. Mar 06 19:00:04 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:04 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:04 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:04 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:04 integro dhcpcd[2840]: wlan0: carrier lost Mar 06 19:00:04 integro dhcpcd[2840]: wlan0: carrier lost Mar 06 19:00:04 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:04 integro volumio[3390]: info: ------------------------------------------- Mar 06 19:00:04 integro volumio[3390]: info: ----- Volumio3 ---- Mar 06 19:00:04 integro volumio[3390]: info: ------------------------------------------- Mar 06 19:00:04 integro volumio[3390]: info: ----- System startup ---- Mar 06 19:00:04 integro volumio[3390]: info: ------------------------------------------- Mar 06 19:00:04 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:04 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:04 integro dhcpcd[2840]: wlan0: carrier acquired Mar 06 19:00:04 integro dhcpcd[2840]: wlan0: carrier acquired Mar 06 19:00:04 integro dhcpcd[2840]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:04 integro dhcpcd[2840]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: soliciting a DHCP lease Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: soliciting a DHCP lease Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: soliciting an IPv6 router Mar 06 19:00:05 integro dhcpcd[2840]: wlan0: soliciting an IPv6 router Mar 06 19:00:05 integro volumio[3390]: info: MYVOLUMIO Environment detected Mar 06 19:00:05 integro sh[2742]: timed out Mar 06 19:00:05 integro sh[2742]: dhcpcd exited Mar 06 19:00:05 integro dhcpcd[2792]: timed out Mar 06 19:00:05 integro sh[2742]: ifup: failed to bring up eth0 Mar 06 19:00:05 integro dhcpcd[2792]: dhcpcd exited Mar 06 19:00:05 integro systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 06 19:00:05 integro systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 06 19:00:05 integro volumio[3390]: info: Plugin folders cleanup Mar 06 19:00:05 integro volumio[3390]: info: Scanning into folder /volumio/app/plugins/ Mar 06 19:00:05 integro volumio[3390]: info: Scanning category audio_interface Mar 06 19:00:05 integro volumio[3390]: info: Scanning category miscellanea Mar 06 19:00:05 integro volumio[3390]: info: Scanning category music_service Mar 06 19:00:05 integro volumio[3390]: info: Scanning category plugins.json Mar 06 19:00:05 integro volumio[3390]: info: Scanning category system_controller Mar 06 19:00:05 integro dhcpcd[2840]: timed out Mar 06 19:00:05 integro dhcpcd[2840]: timed out Mar 06 19:00:05 integro dhcpcd[2840]: forked to background, child pid 3534 Mar 06 19:00:05 integro dhcpcd[2840]: forked to background, child pid 3534 Mar 06 19:00:05 integro volumio[3390]: info: Scanning category user_interface Mar 06 19:00:05 integro systemd[1]: Started DHCP Client Daemon. Mar 06 19:00:05 integro volumio[3390]: info: Scanning into folder /data/plugins/ Mar 06 19:00:05 integro volumio[3390]: info: Scanning category music_service Mar 06 19:00:05 integro volumio[3390]: info: Plugin folders cleanup completed Mar 06 19:00:05 integro volumio[3390]: info: ------------------------------------------- Mar 06 19:00:05 integro volumio[3390]: info: ----- Core plugins startup ---- Mar 06 19:00:05 integro volumio[3390]: info: ------------------------------------------- Mar 06 19:00:05 integro volumio[3390]: info: Loading plugins from folder /volumio/app/plugins/ Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin multiroom to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin upnp to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin metavolumio to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin cd_controller to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin raat to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 06 19:00:05 integro volumio[3390]: info: Loading plugins from folder /data/plugins/ Mar 06 19:00:05 integro volumio[3390]: info: Loading plugin "system"... Mar 06 19:00:05 integro volumio[3390]: info: Loading plugin "appearance"... Mar 06 19:00:06 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:06 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:06 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:06 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:06 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:06 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:06 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:06 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:06 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:06 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:06 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:06 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:06 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:06 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "network"... Mar 06 19:00:07 integro volumio[3390]: info: Refreshing Cached IP Addresses Mar 06 19:00:07 integro sudo[3554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 06 19:00:07 integro sudo[3554]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "services"... Mar 06 19:00:07 integro sudo[3556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "alsa_controller"... Mar 06 19:00:07 integro sudo[3556]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:07 integro sudo[3554]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:07 integro sudo[3559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 06 19:00:07 integro sudo[3559]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:07 integro sudo[3556]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:07 integro sudo[3559]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:07 integro kernel: wl_escan_set_scan: ioctl_ver=2 Mar 06 19:00:07 integro kernel: ESCAN-ERROR) wl_escan_set_scan : Escan set error (-16) Mar 06 19:00:07 integro kernel: ESCAN-ERROR) wl_escan_set_scan : error (-16), cnt=1 Mar 06 19:00:07 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "wizard"... Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "networkfs"... Mar 06 19:00:07 integro volumio[3390]: info: Starting Udev Watcher for removable devices Mar 06 19:00:07 integro volumio[3390]: info: Ignoring mount for partition: BOOT Mar 06 19:00:07 integro volumio[3390]: info: Ignoring mount for partition: volumio Mar 06 19:00:07 integro volumio[3390]: info: Ignoring mount for partition: volumio_data Mar 06 19:00:07 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "volumio_command_line_client"... Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "upnp"... Mar 06 19:00:07 integro volumio[3390]: info: [1741284007984] Starting Upmpd Daemon Mar 06 19:00:07 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 06 19:00:07 integro volumio[3390]: info: Loading plugin "my_music"... Mar 06 19:00:08 integro volumio[3390]: info: Loading plugin "mpd"... Mar 06 19:00:08 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:08 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:08 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:08 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:08 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:08 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:08 integro volumio[3390]: info: Plugin upnp_browser is not enabled Mar 06 19:00:08 integro volumio[3390]: info: Loading plugin "alarm-clock"... Mar 06 19:00:08 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:08 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:08 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:08 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:08 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:08 integro volumio-remote-updater[2845]: [2025-03-06 19:00:08] [connect] Successful connection Mar 06 19:00:08 integro volumio[3390]: info: Loading plugin "manifestui"... Mar 06 19:00:09 integro volumio[3390]: info: Loading plugin "metavolumio"... Mar 06 19:00:09 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:09 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:09 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:10 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:10 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:10 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:10 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:10 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:10 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:10 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:10 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:10 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:10 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:10 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:10 integro volumio[3390]: info: Loading plugin "airplay_emulation"... Mar 06 19:00:10 integro volumio[3390]: info: Starting Shairport Sync Mar 06 19:00:10 integro volumio[3390]: info: Loading plugin "cd_controller"... Mar 06 19:00:11 integro volumio[3390]: info: Loading plugin "last_100"... Mar 06 19:00:11 integro volumio[3390]: info: Loading plugin "raat"... Mar 06 19:00:11 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:11 integro volumio[3390]: info: RAAT Plugin loaded Mar 06 19:00:11 integro volumio[3390]: info: Adding restartRAATSocket REST API Endpoint Mar 06 19:00:11 integro volumio[3390]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Mar 06 19:00:11 integro volumio[3390]: info: Loading plugin "streaming_services"... Mar 06 19:00:12 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:12 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:12 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:12 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:12 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:12 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:12 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:12 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:12 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:12 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:13 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:13 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:13 integro volumio[3390]: info: Starting Streaming Service Transparent Proxy Mar 06 19:00:13 integro volumio[3390]: info: Loading plugin "tidalconnect"... Mar 06 19:00:13 integro volumio[3390]: info: Loading plugin "webradio"... Mar 06 19:00:14 integro volumio[3390]: info: Loading plugin "i2s_dacs"... Mar 06 19:00:14 integro volumio[3390]: info: I2S DAC not set, start Auto-detection Mar 06 19:00:14 integro volumio[3390]: info: Loading plugin "volumiodiscovery"... Mar 06 19:00:14 integro volumio[3390]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 06 19:00:14 integro node[3390]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 06 19:00:14 integro node[3390]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 19:00:14 integro volumio[3390]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 19:00:14 integro volumio[3390]: *** WARNING *** For more information see Mar 06 19:00:14 integro volumio[3390]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 06 19:00:14 integro volumio[3390]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 19:00:14 integro volumio[3390]: *** WARNING *** For more information see Mar 06 19:00:14 integro node[3390]: *** WARNING *** For more information see Mar 06 19:00:14 integro node[3390]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 06 19:00:14 integro node[3390]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 19:00:14 integro node[3390]: *** WARNING *** For more information see Mar 06 19:00:14 integro volumio[3390]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 06 19:00:14 integro volumio[3390]: info: Discovery: Started advertising with name: Integro Mar 06 19:00:14 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 06 19:00:14 integro volumio[3390]: info: Loading plugin "multiroom"... Mar 06 19:00:14 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:14 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:14 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:14 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:14 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:14 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:14 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:14 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:14 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:14 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:15 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:15 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:15 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:15 integro volumio[3390]: STREAMING PROXY: Starting server on port 3245 Mar 06 19:00:15 integro volumio[3390]: Node JS runtime: 14 Mar 06 19:00:15 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:15 integro systemd[1]: systemd-hostnamed.service: Succeeded. Mar 06 19:00:16 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:16 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:16 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:16 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:16 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:16 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:16 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:16 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:16 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:16 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:17 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:17 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:17 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:17 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:17 integro volumio[3390]: info: Applying required configuration parameters for plugin multiroom Mar 06 19:00:17 integro sudo[3816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 06 19:00:17 integro sudo[3816]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:17 integro sudo[3816]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:17 integro volumio[3390]: info: MRS: MultiRoom plugin initialized Mar 06 19:00:17 integro volumio[3390]: info: MRS: STOPPING SNAPCLIENT Mar 06 19:00:17 integro volumio[3390]: info: MRS: Snap server stop Mar 06 19:00:17 integro volumio[3390]: info: MRS: STOPPING volumioStreaming Mar 06 19:00:17 integro sudo[3833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 06 19:00:17 integro sudo[3833]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:17 integro sudo[3835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 06 19:00:17 integro sudo[3835]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:17 integro sudo[3833]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:17 integro sudo[3838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 06 19:00:17 integro sudo[3838]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:17 integro volumio[3390]: info: Loading plugin "outputs"... Mar 06 19:00:17 integro volumio[3390]: info: Loading plugin "albumart"... Mar 06 19:00:17 integro sudo[3835]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:17 integro sudo[3842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 06 19:00:17 integro sudo[3842]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:17 integro sudo[3838]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:17 integro volumio[3390]: info: Plugin example_plugin is not enabled Mar 06 19:00:17 integro volumio[3390]: info: Loading plugin "hdmi_arc"... Mar 06 19:00:17 integro sudo[3842]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:18 integro volumio[3390]: info: Loading plugin "hi_res_audio"... Mar 06 19:00:18 integro volumio[3390]: Forking 3 albumart workers Mar 06 19:00:18 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:18 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:18 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:18 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:18 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:18 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:18 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:18 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:18 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:18 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:19 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:19 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:19 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:19 integro kernel: fb: mem_free_work, free memory: addr:800000 Mar 06 19:00:19 integro volumio[3390]: Starting albumart workers Mar 06 19:00:19 integro volumio[3390]: Starting albumart workers Mar 06 19:00:19 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:20 integro volumio[3390]: Starting albumart workers Mar 06 19:00:20 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:20 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:20 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:20 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:20 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:20 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:20 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:20 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:21 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:21 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:21 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:21 integro volumio[3390]: info: Applying required configuration parameters for plugin hi_res_audio Mar 06 19:00:21 integro volumio[3390]: info: Loading plugin "inputs"... Mar 06 19:00:21 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:21 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:21 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:21 integro volumio[3390]: info: Loading plugin "qobuz"... Mar 06 19:00:22 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:22 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:22 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:22 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:22 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:22 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:22 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:22 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:22 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:23 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:23 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:23 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:23 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:23 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:23 integro volumio[3390]: info: Loading plugin "smart_inputs"... Mar 06 19:00:23 integro volumio-remote-updater[2845]: [2025-03-06 19:00:23] [connect] Successful connection Mar 06 19:00:24 integro volumio[3390]: info: Loading plugin "tidal"... Mar 06 19:00:24 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:24 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:24 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:24 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:24 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:24 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:25 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:25 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:25 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:25 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:25 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:25 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:25 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:25 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:25 integro volumio[3390]: info: Loading plugin "integrocontrol"... Mar 06 19:00:26 integro volumio[3390]: info: Adding this device properties Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Mar 06 19:00:26 integro volumio[3390]: info: Setting Additional Device Volumio Properties: [object Object] Mar 06 19:00:26 integro volumio[3390]: info: Loading plugin "updater_comm"... Mar 06 19:00:26 integro volumio[3390]: info: Plugin mpdemulation is not enabled Mar 06 19:00:26 integro volumio[3390]: info: Loading plugin "rest_api"... Mar 06 19:00:26 integro volumio[3390]: info: Loading plugin "websocket"... Mar 06 19:00:26 integro volumio[3390]: info: Starting Socket.io Server version 2.3.0 Mar 06 19:00:26 integro volumio[3390]: info: Loading i18n strings for locale pl Mar 06 19:00:26 integro volumio[3390]: Updating browse sources language Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::initPlayerControls Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 06 19:00:26 integro volumio[3390]: Express server listening on port 3000 Mar 06 19:00:26 integro volumio[3390]: [Metrics] WebUI: 23s 343.46ms Mar 06 19:00:26 integro volumio[3390]: info: CoreStateMachine::resetVolumioState Mar 06 19:00:26 integro volumio[3390]: info: CoreStateMachine::getcurrentVolume Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::volumioRetrievevolume Mar 06 19:00:26 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:26 integro sudo[3970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 06 19:00:26 integro sudo[3970]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:26 integro sudo[3970]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:26 integro volumio[3390]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 06 19:00:26 integro volumio[3390]: info: Completed loading Core Plugins Mar 06 19:00:26 integro sudo[3972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 06 19:00:26 integro sudo[3972]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:26 integro volumio[3390]: info: Preparing to generate the ALSA configuration file Mar 06 19:00:26 integro sudo[3972]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:26 integro volumio[3390]: Unable to parse: Mar 06 19:00:26 integro volumio[3390]: Simple mixer control 'Audio hdmi-out mute',0 Mar 06 19:00:26 integro volumio[3390]: Capabilities: pswitch pswitch-joined Mar 06 19:00:26 integro volumio[3390]: Playback channels: Mono Mar 06 19:00:26 integro volumio[3390]: Mono: Playback [on] Mar 06 19:00:26 integro volumio[3390]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 06 19:00:26 integro volumio[3390]: info: MRS: Removed streaming files Mar 06 19:00:26 integro volumio[3390]: info: MRS: volumioStreaming STOPPED Mar 06 19:00:26 integro volumio[3390]: info: MRS: SNAPSERVER STOPPED Mar 06 19:00:26 integro volumio[3390]: info: MRS: SNAPCLIENT STOPPED Mar 06 19:00:26 integro volumio[3390]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 06 19:00:26 integro volumio[3390]: wlan0 Interface doesn't support scanning : Device or resource busy Mar 06 19:00:26 integro volumio[3390]: info: Cannot use regular scanning, forcing with ap-force Mar 06 19:00:27 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:27 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:27 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:27 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:27 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:27 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:27 integro sudo[3982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 06 19:00:27 integro sudo[3982]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:27 integro kernel: CFG80211-ERROR) wl_run_escan : Escan set error (-16) Mar 06 19:00:27 integro kernel: dhd_ioctl_entry_local invalid parameter Mar 06 19:00:27 integro kernel: CFG80211-ERROR) wl_run_escan : error (-16), cnt=1 Mar 06 19:00:27 integro sudo[3982]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:27 integro kernel: CFG80211-ERROR) __wl_cfg80211_scan : Scan err = (-16), busy?-16 Mar 06 19:00:27 integro kernel: CFG80211-ERROR) wl_cfg80211_scan : Mar 06 19:00:27 integro kernel: scan error (-16) Mar 06 19:00:27 integro volumio[3390]: command failed: Device or resource busy (-16) Mar 06 19:00:27 integro volumio[3390]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 06 19:00:27 integro volumio[3390]: command failed: Device or resource busy (-16) Mar 06 19:00:27 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:27 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:27 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:27 integro volumio[3390]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Mar 06 19:00:27 integro volumio[3390]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 06 19:00:27 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:27 integro volumio[3390]: info: Reading ALSA contributions from plugins. Mar 06 19:00:27 integro volumio-remote-updater[2845]: [2025-03-06 19:00:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741284023 101 Mar 06 19:00:27 integro volumio[3390]: 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 06 19:00:27 integro volumio[3390]: Unable to parse: Mar 06 19:00:27 integro volumio[3390]: Simple mixer control 'Audio hdmi-out mute',0 Mar 06 19:00:27 integro volumio[3390]: Capabilities: pswitch pswitch-joined Mar 06 19:00:27 integro volumio[3390]: Playback channels: Mono Mar 06 19:00:27 integro volumio[3390]: Mono: Playback [on] Mar 06 19:00:27 integro volumio[3390]: info: VolumeController:: Volume=undefined Mute =false Mar 06 19:00:27 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:27 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:27 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 19:00:27 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:27 integro volumio[3390]: info: CoreStateMachine::updateTrackBlock Mar 06 19:00:27 integro volumio[3390]: info: CorePlayQueue::getTrackBlock Mar 06 19:00:27 integro volumio[3390]: info: CoreCommandRouter::volumioRetrievevolume Mar 06 19:00:27 integro volumio[3390]: Unable to parse: Mar 06 19:00:27 integro volumio[3390]: Simple mixer control 'Audio hdmi-out mute',0 Mar 06 19:00:27 integro volumio[3390]: Capabilities: pswitch pswitch-joined Mar 06 19:00:27 integro volumio[3390]: Playback channels: Mono Mar 06 19:00:27 integro volumio[3390]: Mono: Playback [on] Mar 06 19:00:27 integro volumio[3390]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 06 19:00:27 integro volumio[3390]: info: Reloading queue from file Mar 06 19:00:27 integro volumio[3390]: info: CoreStateMachine::setRepeat false single undefined Mar 06 19:00:27 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:27 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:27 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 19:00:27 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:27 integro volumio[3390]: info: CoreStateMachine::setRandom null Mar 06 19:00:27 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:27 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:27 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:27 integro volumio[3390]: Unable to parse: Mar 06 19:00:27 integro volumio[3390]: Simple mixer control 'Audio hdmi-out mute',0 Mar 06 19:00:27 integro volumio[3390]: Capabilities: pswitch pswitch-joined Mar 06 19:00:27 integro volumio[3390]: Playback channels: Mono Mar 06 19:00:27 integro volumio[3390]: Mono: Playback [on] Mar 06 19:00:27 integro volumio[3390]: info: VolumeController:: Volume=undefined Mute =false Mar 06 19:00:27 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:27 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:27 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:28 integro volumio[3390]: info: Asound.conf file unchanged, so no further update is needed Mar 06 19:00:28 integro volumio[3390]: info: Output device has changed, restarting MPD Mar 06 19:00:28 integro sudo[4004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 06 19:00:28 integro sudo[4004]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:28 integro systemd[1]: Started UPnP Renderer front-end to MPD. Mar 06 19:00:28 integro sudo[4007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 06 19:00:28 integro sudo[4007]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro sudo[4004]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:28 integro volumio[3390]: info: Output device has changed, restarting Shairport Sync Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:28 integro sudo[4007]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:28 integro sudo[4010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 06 19:00:28 integro sudo[4010]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro volumio[3390]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 06 19:00:28 integro volumio[3390]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro systemd[1]: Listening on mpd.socket. Mar 06 19:00:28 integro systemd[1]: Starting Music Player Daemon... Mar 06 19:00:28 integro volumio[3390]: info: ___________ START PLUGINS ___________ Mar 06 19:00:28 integro volumio[3390]: info: ControllerMpd::onStart: Initializing MPD Mar 06 19:00:28 integro volumio[3390]: info: Creating MPD Configuration file Mar 06 19:00:28 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:28 integro kernel: aml_tdm_open Mar 06 19:00:28 integro kernel: Not init audio effects Mar 06 19:00:28 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 06 19:00:28 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 06 19:00:28 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 06 19:00:28 integro sudo[4028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 06 19:00:28 integro sudo[4028]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro sudo[4028]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:28 integro volumio[3390]: info: Adding METAVOLUMIO REST API Endpoints Mar 06 19:00:28 integro volumio[3390]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 06 19:00:28 integro volumio[3390]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 06 19:00:28 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:28 integro volumio[3390]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 06 19:00:28 integro volumio[3390]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:28 integro sudo[4031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 06 19:00:28 integro sudo[4031]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro sudo[4023]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 06 19:00:28 integro sudo[4023]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro sudo[4023]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:28 integro volumio[3390]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:28 integro systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 06 19:00:28 integro systemd[1]: mpd.service: Succeeded. Mar 06 19:00:28 integro systemd[1]: Stopped Music Player Daemon. Mar 06 19:00:28 integro systemd[1]: Starting Music Player Daemon... Mar 06 19:00:28 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:28 integro volumio[3390]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 06 19:00:28 integro volumio[3390]: info: Preparing CD Folders Mar 06 19:00:28 integro volumio[3390]: info: Adding CD REST API Endpoints Mar 06 19:00:28 integro volumio[3390]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Mar 06 19:00:28 integro volumio[3390]: info: Starting UDEV Watcher for CD Mar 06 19:00:28 integro volumio[3390]: info: Detecting CD presence with UDEV Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 06 19:00:28 integro volumio[3390]: info: [1741284028581] CoreMusicLibrary::Adding element Last_100 Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 19:00:28 integro volumio[3390]: info: Starting RAAT Plugin Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Mar 06 19:00:28 integro volumio[3390]: info: Additional UI Settings Added for plugin music_service/raat Mar 06 19:00:28 integro volumio[3390]: info: Registering DSP Elements listener and retrieving current ones Mar 06 19:00:28 integro volumio[3390]: info: Additional DSP elements updated Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: Updating RAAT Signal Path Mar 06 19:00:28 integro volumio[3390]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 06 19:00:28 integro sudo[4040]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 06 19:00:28 integro sudo[4040]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro sudo[4040]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro sudo[4040]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: Not Reporting Auto name since its the default one Mar 06 19:00:28 integro volumio[3390]: info: Streaming services startup Mar 06 19:00:28 integro volumio[3390]: info: Starting Streaming Daemon Mar 06 19:00:28 integro sudo[4051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 06 19:00:28 integro sudo[4051]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro sudo[4051]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 06 19:00:28 integro volumio[3390]: info: [1741284028830] CoreMusicLibrary::Adding element Webradio Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 19:00:28 integro volumio[3390]: info: Initializing BBC Radios Mar 06 19:00:28 integro sudo[4058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 06 19:00:28 integro sudo[4058]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:28 integro sudo[4058]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:28 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 06 19:00:28 integro volumio[3390]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 06 19:00:29 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:29 integro volumio[3390]: info: Starting CEC Infrastructure Mar 06 19:00:29 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:29 integro kernel: aml_tdm_open Mar 06 19:00:29 integro kernel: Not init audio effects Mar 06 19:00:29 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 06 19:00:29 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 06 19:00:29 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 06 19:00:29 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:29 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:29 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:29 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:29 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:29 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:29 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Mar 06 19:00:29 integro volumio[3390]: info: Additional UI Settings Added for plugin music_service/hdmi_arc Mar 06 19:00:29 integro volumio[3390]: error: Hi Res Audio Failed Login: Missing Login Data Mar 06 19:00:29 integro volumio[3390]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 06 19:00:29 integro volumio[3390]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 06 19:00:29 integro volumio[3390]: info: Initializing Serial Communication on port /dev/ttyS3 Mar 06 19:00:29 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Mar 06 19:00:29 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Mar 06 19:00:29 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Mar 06 19:00:29 integro volumio[3390]: info: Touch Event Listener Process Starting Mar 06 19:00:29 integro volumio[3390]: info: Adding inputs REST Endpoints Mar 06 19:00:29 integro volumio[3390]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 06 19:00:29 integro volumio[3390]: info: Scanning Audio Inputs Mar 06 19:00:29 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:29 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:29 integro sudo[4086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Mar 06 19:00:29 integro sudo[4086]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:29 integro volumio[3390]: info: Checking against Known Cards name Mar 06 19:00:29 integro volumio[3390]: info: Checking against Known Cards name Mar 06 19:00:29 integro volumio[3390]: info: Checking against Known Cards name Mar 06 19:00:29 integro volumio[3390]: info: Checking against Known Cards name Mar 06 19:00:29 integro volumio[3390]: info: Checking against Known Cards name Mar 06 19:00:29 integro volumio[3390]: info: Adding Server instance for streaming Mar 06 19:00:29 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:29 integro volumio[3390]: info: Refreshing TIDAL token Mar 06 19:00:29 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:29 integro sudo[4101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Mar 06 19:00:29 integro sudo[4101]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:29 integro sudo[4101]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:29 integro sudo[4104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Mar 06 19:00:29 integro sudo[4104]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:29 integro sudo[4104]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:29 integro sudo[4107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Mar 06 19:00:29 integro sudo[4107]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:29 integro sudo[4107]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:29 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:29 integro sudo[4110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Mar 06 19:00:29 integro sudo[4110]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:29 integro sudo[4110]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:29 integro volumio[3390]: info: MP1 Muting HDMI Output Mar 06 19:00:29 integro volumio[3390]: info: Apply VIM3L Onboard LEDs Settings Mar 06 19:00:29 integro volumio[3390]: info: Turning On Onboard LEDs Mar 06 19:00:29 integro volumio[3390]: info: Volumio Calling Home Mar 06 19:00:29 integro sudo[4116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Mar 06 19:00:29 integro sudo[4116]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:29 integro sudo[4116]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:29 integro sudo[4121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Mar 06 19:00:29 integro sudo[4121]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:29 integro sudo[4121]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:29 integro volumio[3390]: (node:3390) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Mar 06 19:00:29 integro volumio[3390]: (Use `node --trace-deprecation ...` to show where the warning was created) Mar 06 19:00:30 integro volumio[3390]: info: Stopping AccessToken refresher cron for QOBUZ Mar 06 19:00:30 integro volumio[3390]: info: AccessToken refresher cron started for QOBUZ Mar 06 19:00:30 integro volumio[3390]: info: Adding QOBUZ REST API Endpoints Mar 06 19:00:30 integro volumio[3390]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 06 19:00:30 integro volumio[3390]: info: Serial port opened successfully Mar 06 19:00:30 integro volumio[3390]: info: Sending serial start messages Mar 06 19:00:30 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: error: No access token received for TIDAL Mar 06 19:00:30 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:30 integro volumio[3390]: error: Cannot start Volumio Streaming Daemon Mar 06 19:00:30 integro volumio[3390]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 06 19:00:30 integro volumio[3390]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 06 19:00:30 integro volumio[3390]: info: RAAT Albumart path created successfully Mar 06 19:00:30 integro volumio[3390]: info: MPD Permissions set Mar 06 19:00:30 integro volumio[3390]: info: MPD Permissions set Mar 06 19:00:30 integro volumio[3390]: info: Upmpdcli Daemon Started Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Mar 06 19:00:30 integro volumio[3390]: info: Setting Device Volume Override Mar 06 19:00:30 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:30 integro volumio[3390]: info: Applying Volume Override Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 06 19:00:30 integro volumio[3390]: 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 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 06 19:00:30 integro volumio[3390]: info: Enabling external Volume Control Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:30 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Mar 06 19:00:30 integro volumio[3390]: info: Setting Additional System Software info: Hardware Revision: 1.3 Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Mar 06 19:00:30 integro volumio[3390]: info: Setting HW Firmware info: undefined Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Mar 06 19:00:30 integro volumio[3390]: info: Setting HW Version info: 1.3 Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Mar 06 19:00:30 integro volumio[3390]: info: Setting Additional System Software info: Hardware Revision: 1.3, Firmware Version: 0.6.4 Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Mar 06 19:00:30 integro volumio[3390]: info: Setting HW Firmware info: 0.6.4 Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Mar 06 19:00:30 integro volumio[3390]: info: Setting HW Version info: 1.3 Mar 06 19:00:30 integro volumio[3390]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 06 19:00:30 integro volumio[3390]: info: MCU Signalled Headphone Mode Disabled Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: Updating RAAT Signal Path Mar 06 19:00:30 integro volumio[3390]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Mar 06 19:00:30 integro volumio[3390]: info: MCU Signalled Sleep Mode Disabled Mar 06 19:00:30 integro volumio[3390]: info: Enabling Advanced system settings configuration Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Mar 06 19:00:30 integro volumio[3390]: info: Additional UI Settings Added for plugin music_service/inputs Mar 06 19:00:30 integro volumio[3390]: info: MCU Signalled Auto Boot Mode On Power Disabled Mar 06 19:00:30 integro volumio[3390]: 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 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro sudo[4140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro sudo[4140]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro sudo[4140]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:30 integro kernel: fb: osd[0] enable: 1 (Xorg) Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:30 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 06 19:00:31 integro volumio[3390]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Mar 06 19:00:31 integro volumio[3390]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Mar 06 19:00:31 integro volumio[3390]: 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 06 19:00:31 integro sudo[4157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Mar 06 19:00:31 integro sudo[4157]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:31 integro sudo[4157]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:31 integro sudo[4159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Mar 06 19:00:31 integro sudo[4159]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:31 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:31 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:31 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:31 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:31 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:31 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:31 integro systemd[1]: Started RAAT DAEMON. Mar 06 19:00:31 integro sudo[4159]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:31 integro kernel: aml_tdm_open Mar 06 19:00:31 integro kernel: Not init audio effects Mar 06 19:00:31 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 06 19:00:31 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 06 19:00:31 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 06 19:00:31 integro kernel: aml_tdm_open Mar 06 19:00:31 integro kernel: Not init audio effects Mar 06 19:00:31 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 06 19:00:31 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 06 19:00:31 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 06 19:00:31 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:31 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:31 integro sudo[4187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Mar 06 19:00:31 integro sudo[4187]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:31 integro sudo[4187]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:31 integro volumio[3390]: info: Raat Daemon started successfully Mar 06 19:00:31 integro volumio[3390]: info: Starting Shairport Sync Mar 06 19:00:31 integro volumio[3390]: info: Starting Shairport Sync Mar 06 19:00:31 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:31 integro sudo[4193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 06 19:00:31 integro sudo[4193]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:31 integro volumio[3390]: info: Starting Shairport Sync Mar 06 19:00:31 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:31 integro sudo[4197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 06 19:00:31 integro volumio[3390]: info: Adding Inputs via Serial API Mar 06 19:00:31 integro sudo[4197]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 06 19:00:31 integro volumio[3390]: info: [1741284031408] CoreMusicLibrary::Adding element Inputs Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 19:00:31 integro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 06 19:00:31 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:31 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:31 integro systemd[1]: shairport-sync.service: Succeeded. Mar 06 19:00:31 integro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 06 19:00:31 integro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 06 19:00:31 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:31 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:31 integro sudo[4199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 06 19:00:31 integro sudo[4199]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:31 integro sudo[4193]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:31 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:31 integro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 06 19:00:31 integro systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 06 19:00:31 integro systemd[1]: shairport-sync.service: Succeeded. Mar 06 19:00:31 integro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 06 19:00:31 integro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 06 19:00:31 integro sudo[4199]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:31 integro sudo[4197]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:31 integro volumio[3390]: info: Executing endpoint restartRAATSocket Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::servicePushState Mar 06 19:00:31 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:31 integro volumio[3390]: verbose: STATE SERVICE {"status":"play","service":"inputs","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"","seek":0,"duration":0,"samplerate":"","bitdepth":"","stream":true,"disableUiControls":true,"channels":2} Mar 06 19:00:31 integro volumio[3390]: verbose: CURRENT POSITION 0 Mar 06 19:00:31 integro volumio[3390]: info: CoreStateMachine::syncState stateService play Mar 06 19:00:31 integro volumio[3390]: info: CoreStateMachine::syncState currentStatus stop Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::volumiosetSourceActiveno-source Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 19:00:31 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:31 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:31 integro volumio[3390]: info: Shairport-Sync Started Mar 06 19:00:31 integro volumio[3390]: Error adding Membership: Error: addMembership EINVAL Mar 06 19:00:31 integro volumio[3390]: info: Shairport-Sync Started Mar 06 19:00:31 integro volumio[3390]: info: Shairport-Sync Started Mar 06 19:00:31 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:31 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:31 integro volumio[3390]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 06 19:00:31 integro volumio[3390]: info: MCU Signalled Playback Inactive Mar 06 19:00:31 integro volumio[3390]: info: TidalConnect service stoped! Mar 06 19:00:32 integro volumio[3390]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 06 19:00:32 integro volumio[3390]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 06 19:00:32 integro sudo[4217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 06 19:00:32 integro sudo[4217]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:32 integro systemd[1]: Started Volumio Tidal Connect Service. Mar 06 19:00:32 integro sudo[4217]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:32 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:32 integro volumio[3390]: info: Turning Off Onboard LEDs Mar 06 19:00:32 integro sudo[4224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Mar 06 19:00:32 integro sudo[4224]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:32 integro sudo[4224]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:32 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:32 integro sudo[4227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Mar 06 19:00:32 integro sudo[4227]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:32 integro mpd[4049]: Mar 06 19:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 06 19:00:32 integro sudo[4227]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:32 integro volumio[3390]: info: Onboard LEDs initialized Mar 06 19:00:32 integro systemd[1]: Started Music Player Daemon. Mar 06 19:00:32 integro volumio[3390]: Upnp client error: Error: This socket has been ended by the other party Mar 06 19:00:32 integro sudo[4010]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:32 integro sudo[4031]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:32 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:32 integro volumio[3390]: error: MPD error: The expression evaluated to a falsy value: Mar 06 19:00:32 integro volumio[3390]: assert.ok(self.idling) Mar 06 19:00:32 integro volumio[3390]: error: The expression evaluated to a falsy value: Mar 06 19:00:32 integro volumio[3390]: assert.ok(self.idling) Mar 06 19:00:32 integro volumio[3390]: info: Initializing I2S Bus Mar 06 19:00:32 integro volumio[3390]: error: updateQueue error: null Mar 06 19:00:32 integro volumio[3390]: info: MPD running with PID4049 Mar 06 19:00:32 integro volumio[3390]: ,establishing connection Mar 06 19:00:32 integro volumio[3390]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 5 Mar 06 19:00:32 integro volumio[3390]: info: Executing endpoint tc_getconfig Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 06 19:00:32 integro vtcs[4219]: STARTING TidalConnect services, version: 1.4.0.34 Mar 06 19:00:32 integro volumio[3390]: error: updateQueue error: null Mar 06 19:00:32 integro vtcs[4219]: STARTED TidalConnect services. Mar 06 19:00:32 integro volumio[3390]: info: Executing endpoint tc_connect Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 06 19:00:32 integro volumio[3390]: info: Connecting to TidalConnect Mar 06 19:00:32 integro kernel: aml_tdm_open Mar 06 19:00:32 integro kernel: Not init audio effects Mar 06 19:00:32 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::servicePushState Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:32 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:32 integro kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Mar 06 19:00:32 integro kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc0508cd818, id(1), clksel(1) Mar 06 19:00:32 integro kernel: aml_dai_set_tdm_fmt(), fmt not change Mar 06 19:00:32 integro kernel: dump_pcm_setting(ffffffc0508cd818) Mar 06 19:00:32 integro kernel: pcm_mode(1) Mar 06 19:00:32 integro kernel: sysclk(11289600) Mar 06 19:00:32 integro kernel: sysclk_bclk_ratio(4) Mar 06 19:00:32 integro kernel: bclk(2822400) Mar 06 19:00:32 integro kernel: bclk_lrclk_ratio(64) Mar 06 19:00:32 integro kernel: lrclk(44100) Mar 06 19:00:32 integro kernel: tx_mask(0x3) Mar 06 19:00:32 integro kernel: rx_mask(0x3) Mar 06 19:00:32 integro kernel: slots(2) Mar 06 19:00:32 integro kernel: slot_width(32) Mar 06 19:00:32 integro kernel: lane_mask_in(0x2) Mar 06 19:00:32 integro kernel: lane_mask_out(0x1) Mar 06 19:00:32 integro kernel: lane_oe_mask_in(0x0) Mar 06 19:00:32 integro kernel: lane_oe_mask_out(0x0) Mar 06 19:00:32 integro kernel: lane_lb_mask_in(0x0) Mar 06 19:00:32 integro kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Mar 06 19:00:32 integro kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Mar 06 19:00:32 integro kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Mar 06 19:00:32 integro kernel: aml_dai_set_clkdiv, div 4, clksel(1) Mar 06 19:00:32 integro kernel: aml_dai_set_bclk_ratio, select I2S mode Mar 06 19:00:32 integro kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Mar 06 19:00:32 integro kernel: aml_tdm_prepare(), reset fddr Mar 06 19:00:32 integro kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Mar 06 19:00:32 integro kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 06 19:00:32 integro kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Mar 06 19:00:32 integro kernel: tdm playback mute: 0, lane_cnt = 8 Mar 06 19:00:32 integro kernel: aml_tdm_prepare(), reset fddr Mar 06 19:00:32 integro kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Mar 06 19:00:32 integro kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 06 19:00:32 integro kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Mar 06 19:00:32 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:32 integro volumio[3390]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 06 19:00:32 integro volumio[3390]: verbose: CURRENT POSITION 0 Mar 06 19:00:32 integro kernel: tdm playback mute: 0, lane_cnt = 8 Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::syncState stateService stop Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::syncState currentStatus play Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::stPlaybackTimer Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::servicePushState Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:32 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:32 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:32 integro volumio[3390]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 06 19:00:32 integro volumio[3390]: verbose: CURRENT POSITION 0 Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::syncState stateService stop Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::syncState currentStatus stop Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:32 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:32 integro volumio[3390]: info: No code Mar 06 19:00:32 integro volumio[3390]: info: CoreStateMachine::pushState Mar 06 19:00:32 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:32 integro volumio[3390]: info: CoreCommandRouter::volumioPushState Mar 06 19:00:33 integro volumio[3390]: info: Updating RAAT Signal Path Mar 06 19:00:33 integro volumio[3390]: info: Updating RAAT Signal Path Mar 06 19:00:33 integro volumio[3390]: info: Updating RAAT Signal Path Mar 06 19:00:33 integro volumio[3390]: info: Updating RAAT Signal Path Mar 06 19:00:33 integro volumio[3390]: info: Updating RAAT Signal Path Mar 06 19:00:33 integro kernel: asoc-aml-card auge_sound: tdm playback enable Mar 06 19:00:33 integro kernel: spdif_a is set to enable Mar 06 19:00:33 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:33 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:33 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:33 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:33 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:33 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:33 integro volumio[3390]: info: Setting up CEC listeners Mar 06 19:00:33 integro volumio[3390]: info: CEC Infrastructure started successfully Mar 06 19:00:33 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:33 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:33 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:33 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:33 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 06 19:00:33 integro kernel: asoc-aml-card auge_sound: tdm playback stop Mar 06 19:00:33 integro kernel: spdif_a is set to disable Mar 06 19:00:33 integro kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Mar 06 19:00:33 integro kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B Mar 06 19:00:33 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 06 19:00:33 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 06 19:00:33 integro volumio[3390]: info: Successfully initialized Integro I2S Bus Mar 06 19:00:33 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:33 integro volumio[3390]: info: MRS: Getting audio outputs on start Mar 06 19:00:33 integro volumio[3390]: info: MRS: Requesting all other devices output Mar 06 19:00:34 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:34 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:34 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:34 integro volumio[3390]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 6 Mar 06 19:00:35 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:35 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:35 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:35 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:35 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:35 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:35 integro volumio[3390]: info: TidalConnect service started! Mar 06 19:00:35 integro volumio[3390]: info: Completed starting Core Plugins Mar 06 19:00:35 integro volumio[3390]: info: ------------------------------------------- Mar 06 19:00:35 integro volumio[3390]: info: ----- MyVolumio plugins startup ---- Mar 06 19:00:35 integro volumio[3390]: info: ------------------------------------------- Mar 06 19:00:35 integro volumio[3390]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 06 19:00:35 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:35 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 06 19:00:35 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::volumioGetVisibleSources Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:35 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 06 19:00:35 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 06 19:00:35 integro volumio[3390]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Mar 06 19:00:35 integro volumio[3390]: info: Received Get System Info Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 19:00:35 integro volumio[3390]: info: Discovery: Getting this device information Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:35 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:35 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:35 integro volumio[3390]: info: Listing playlists Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 06 19:00:35 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:35 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:35 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:36 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:36 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:36 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:36 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 06 19:00:36 integro volumio[3390]: info: Received Get System Info Mar 06 19:00:36 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 19:00:36 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 19:00:36 integro volumio[3390]: info: Discovery: Getting this device information Mar 06 19:00:36 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:36 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:36 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 19:00:37 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:37 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:37 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:37 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:37 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:37 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:37 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 06 19:00:37 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:37 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:37 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:37 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:37 integro volumio[3390]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 06 19:00:37 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:38 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:38 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:38 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:39 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:39 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:39 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:39 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:39 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:39 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:39 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:39 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:39 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:39 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:39 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:39 integro volumio[3390]: info: Checking for updated MCU Firmware Mar 06 19:00:39 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 19:00:39 integro volumio[3390]: info: Firware on device is on latest version, no need to update Mar 06 19:00:39 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:40 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:40 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:40 integro volumio[3390]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=mp1&variante=integro&version=3.757&uuid=bb881f525b2ddc4cc378aa9f99307ed0" http://updates.volumio.org/downloader-v1/track-device Mar 06 19:00:40 integro volumio[3390]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 06 19:00:40 integro volumio[3390]: Dload Upload Total Spent Left Speed Mar 06 19:00:40 integro volumio[3390]: [132B blob data] Mar 06 19:00:40 integro volumio[3390]: retrying in 5 seconds, trial 0 Mar 06 19:00:40 integro volumio[3390]: info: Volumio Calling Home Mar 06 19:00:41 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:41 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:41 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:41 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:41 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:41 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:41 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:41 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:41 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:41 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:41 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:42 integro ntpd[3025]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 06 19:00:42 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:42 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:42 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:43 integro kernel: wl_iw_event: Link UP with 08:bf:b8:b2:2a:fc Mar 06 19:00:43 integro kernel: wl_bss_roaming_done succeeded to 08:bf:b8:b2:2a:fc (ch:6) Mar 06 19:00:43 integro kernel: wl_bss_connect_done succeeded with 08:bf:b8:b2:2a:fc vndr_oui: 00-90-4C 00-0C-43 Mar 06 19:00:43 integro dhcpcd[3534]: wlan0: carrier lost Mar 06 19:00:43 integro wpa_supplicant[3189]: wlan0: Associated with 08:bf:b8:b2:2a:fc Mar 06 19:00:43 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 06 19:00:43 integro wpa_supplicant[3189]: wlan0: WPA: Key negotiation completed with 08:bf:b8:b2:2a:fc [PTK=CCMP GTK=CCMP] Mar 06 19:00:43 integro wpa_supplicant[3189]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:b2:2a:fc completed [id=0 id_str=] Mar 06 19:00:43 integro dhcpcd[3534]: wlan0: carrier acquired Mar 06 19:00:43 integro dhcpcd[3534]: wlan0: IAID 0e:ab:ca:d8 Mar 06 19:00:44 integro dhcpcd[3534]: wlan0: soliciting an IPv6 router Mar 06 19:00:44 integro dhcpcd[3534]: wlan0: soliciting a DHCP lease Mar 06 19:00:44 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 06 19:00:45 integro ntpd[3025]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 06 19:00:45 integro ntpd[3025]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 06 19:00:47 integro ntpd[3025]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 06 19:00:49 integro dhcpcd[3534]: wlan0: offered 192.168.3.74 from 192.168.3.1 Mar 06 19:00:49 integro dhcpcd[3534]: wlan0: probing for an IPv4LL address Mar 06 19:00:49 integro dhcpcd[3534]: wlan0: probing address 192.168.3.74/24 Mar 06 19:00:50 integro volumio[3390]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=mp1&variante=integro&version=3.757&uuid=bb881f525b2ddc4cc378aa9f99307ed0" http://updates.volumio.org/downloader-v1/track-device Mar 06 19:00:50 integro volumio[3390]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 06 19:00:50 integro volumio[3390]: Dload Upload Total Spent Left Speed Mar 06 19:00:50 integro volumio[3390]: [132B blob data] Mar 06 19:00:50 integro volumio[3390]: retrying in 5 seconds, trial 1 Mar 06 19:00:50 integro volumio[3390]: info: Volumio Calling Home Mar 06 19:00:53 integro dhcpcd[3534]: wlan0: using IPv4LL address 169.254.21.153 Mar 06 19:00:53 integro avahi-daemon[2817]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.21.153. Mar 06 19:00:53 integro dhcpcd[3534]: wlan0: adding route to 169.254.0.0/16 Mar 06 19:00:53 integro dhcpcd[3534]: wlan0: adding default route Mar 06 19:00:53 integro avahi-daemon[2817]: New relevant interface wlan0.IPv4 for mDNS. Mar 06 19:00:53 integro avahi-daemon[2817]: Registering new address record for 169.254.21.153 on wlan0.IPv4. Mar 06 19:00:54 integro dhcpcd[3534]: wlan0: leased 192.168.3.74 for 86400 seconds Mar 06 19:00:54 integro avahi-daemon[2817]: Registering new address record for 192.168.3.74 on wlan0.IPv4. Mar 06 19:00:54 integro dhcpcd[3534]: wlan0: adding route to 192.168.3.0/24 Mar 06 19:00:54 integro dhcpcd[3534]: wlan0: changing default route via 192.168.3.1 Mar 06 19:00:54 integro dhcpcd[3534]: wlan0: dhcp_envoption 213: Operation not supported Mar 06 19:00:54 integro dhcpcd[3534]: wlan0: dhcp_envoption 213: Operation not supported Mar 06 19:00:54 integro ntpd[3025]: ntpd exiting on signal 15 (Terminated) Mar 06 19:00:54 integro systemd[1]: Stopping Network Time Service... Mar 06 19:00:54 integro systemd[1]: ntp.service: Succeeded. Mar 06 19:00:54 integro systemd[1]: Stopped Network Time Service. Mar 06 19:00:54 integro systemd[1]: Starting Network Time Service... Mar 06 19:00:54 integro ntpd[4432]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 06 19:00:54 integro ntpd[4432]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 06 19:00:54 integro systemd[1]: Started Network Time Service. Mar 06 19:00:54 integro avahi-daemon[2817]: Withdrawing address record for 169.254.21.153 on wlan0. Mar 06 19:00:54 integro avahi-daemon[2817]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.21.153. Mar 06 19:00:54 integro dhcpcd[3534]: wlan0: deleting route to 169.254.0.0/16 Mar 06 19:00:54 integro avahi-daemon[2817]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.74. Mar 06 19:00:54 integro ntpd[4446]: proto: precision = 1.250 usec (-20) Mar 06 19:00:54 integro ntpd[4446]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 06 19:00:54 integro ntpd[4446]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 06 19:00:54 integro ntpd[4446]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 800 days ago Mar 06 19:00:54 integro ntpd[4446]: Listen and drop on 0 v6wildcard [::]:123 Mar 06 19:00:54 integro ntpd[4446]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 06 19:00:54 integro ntpd[4446]: Listen normally on 2 lo 127.0.0.1:123 Mar 06 19:00:54 integro ntpd[4446]: Listen normally on 3 wlan0 192.168.3.74:123 Mar 06 19:00:54 integro ntpd[4446]: Listening on routing socket on fd #20 for interface updates Mar 06 19:00:54 integro ntpd[4446]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 06 19:00:54 integro ntpd[4446]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 06 19:00:55 integro volumio[3390]: info: MRS: Found cast device: BRAVIA-4K-GB-ATV3-2474b29fd0228a5a0a448eb30d46d238 Mar 06 19:00:55 integro volumio[3390]: info: Adding audio output: Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 19:00:55 integro volumio[3390]: info: Discovery: Getting this device information Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:55 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 19:00:55 integro volumio[3390]: verbose: New Socket.io Connection to 192.168.3.74:3000 from 192.168.3.38 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:55 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 06 19:00:55 integro volumio[3390]: error: MyVolumio Plugin failed to start in a timely fashion Mar 06 19:00:55 integro volumio[3390]: info: BOOT COMPLETED Mar 06 19:00:55 integro volumio[3390]: [Metrics] CommandRouter: 50s 892.01ms Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::volumiosetStartupVolume Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::Close All Modals sent Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::Close All Modals sent Mar 06 19:00:55 integro kernel: aml_tdm_open Mar 06 19:00:55 integro kernel: Not init audio effects Mar 06 19:00:55 integro kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Mar 06 19:00:55 integro kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Mar 06 19:00:55 integro kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Mar 06 19:00:55 integro kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Mar 06 19:00:55 integro kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc0508cd818, id(1), clksel(1) Mar 06 19:00:55 integro kernel: aml_dai_set_tdm_fmt(), fmt not change Mar 06 19:00:55 integro kernel: dump_pcm_setting(ffffffc0508cd818) Mar 06 19:00:55 integro kernel: pcm_mode(1) Mar 06 19:00:55 integro kernel: sysclk(11289600) Mar 06 19:00:55 integro kernel: sysclk_bclk_ratio(4) Mar 06 19:00:55 integro kernel: bclk(2822400) Mar 06 19:00:55 integro kernel: bclk_lrclk_ratio(64) Mar 06 19:00:55 integro kernel: lrclk(44100) Mar 06 19:00:55 integro kernel: tx_mask(0x3) Mar 06 19:00:55 integro kernel: rx_mask(0x3) Mar 06 19:00:55 integro kernel: slots(2) Mar 06 19:00:55 integro kernel: slot_width(32) Mar 06 19:00:55 integro kernel: lane_mask_in(0x2) Mar 06 19:00:55 integro kernel: lane_mask_out(0x1) Mar 06 19:00:55 integro kernel: lane_oe_mask_in(0x0) Mar 06 19:00:55 integro kernel: lane_oe_mask_out(0x0) Mar 06 19:00:55 integro kernel: lane_lb_mask_in(0x0) Mar 06 19:00:55 integro kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Mar 06 19:00:55 integro kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Mar 06 19:00:55 integro kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Mar 06 19:00:55 integro kernel: aml_dai_set_clkdiv, div 4, clksel(1) Mar 06 19:00:55 integro kernel: aml_dai_set_bclk_ratio, select I2S mode Mar 06 19:00:55 integro kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Mar 06 19:00:55 integro kernel: aml_tdm_prepare(), reset fddr Mar 06 19:00:55 integro kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Mar 06 19:00:55 integro kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 06 19:00:55 integro kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Mar 06 19:00:55 integro kernel: tdm playback mute: 0, lane_cnt = 8 Mar 06 19:00:55 integro kernel: aml_tdm_prepare(), reset fddr Mar 06 19:00:55 integro kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Mar 06 19:00:55 integro kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 06 19:00:55 integro kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Mar 06 19:00:55 integro kernel: tdm playback mute: 0, lane_cnt = 8 Mar 06 19:00:55 integro volumio[3390]: info: Discovery: adding d9d35136-e236-4643-8dfa-252892ac495a Mar 06 19:00:55 integro volumio[3390]: info: Discovery: Found device Integro Mar 06 19:00:55 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:55 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:55 integro volumio[3390]: info: MRS: Pushing multiroomSync output for this device Mar 06 19:00:55 integro volumio[3390]: info: MRS: Pushing multiroomSync output Mar 06 19:00:55 integro volumio[3390]: info: Adding audio output: Mar 06 19:00:55 integro volumio[3390]: info: Adding audio output: Mar 06 19:00:55 integro kernel: asoc-aml-card auge_sound: tdm playback enable Mar 06 19:00:55 integro kernel: spdif_a is set to enable Mar 06 19:00:55 integro ntpd[4446]: Soliciting pool server 178.215.228.24 Mar 06 19:00:56 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 06 19:00:56 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 06 19:00:56 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 06 19:00:56 integro ntpd[4446]: Soliciting pool server 156.17.20.254 Mar 06 19:00:56 integro ntpd[4446]: Soliciting pool server 193.59.134.156 Mar 06 19:00:56 integro volumio[4009]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 06 19:00:57 integro sudo[4472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 06 19:00:57 integro sudo[4472]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:57 integro sudo[4472]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:57 integro sudo[4474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 06 19:00:57 integro sudo[4474]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:57 integro sudo[4474]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:57 integro volumio[3390]: verbose: New Socket.io Connection to 192.168.3.74 from 192.168.3.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Mar 06 19:00:57 integro sudo[4480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 06 19:00:57 integro sudo[4480]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:57 integro sudo[4480]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:57 integro sudo[4482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 06 19:00:57 integro sudo[4482]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:00:57 integro sudo[4482]: pam_unix(sudo:session): session closed for user root Mar 06 19:00:57 integro kernel: nf_conntrack: default automatic helper assignment has been turned off for security reasons and CT-based firewall rule not found. Use the iptables CT target to attach helpers instead. Mar 06 19:00:57 integro systemd[1]: Started Samba NMB Daemon. Mar 06 19:00:57 integro nmbd[3024]: [2025/03/06 19:00:57.528644, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 06 19:00:57 integro nmbd[3024]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 06 19:00:57 integro systemd[1]: Starting Samba Winbind Daemon... Mar 06 19:00:57 integro volumio[3390]: verbose: New Socket.io Connection to 192.168.3.74 from 192.168.3.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 06 19:00:57 integro ntpd[4446]: Soliciting pool server 149.156.70.60 Mar 06 19:00:57 integro ntpd[4446]: Soliciting pool server 46.175.224.7 Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::volumioGetVisibleSources Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:57 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 06 19:00:57 integro volumio[3390]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Mar 06 19:00:57 integro volumio[3390]: info: Received Get System Info Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 19:00:57 integro volumio[3390]: info: Discovery: Getting this device information Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:57 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:57 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:57 integro ntpd[4446]: Soliciting pool server 193.219.28.60 Mar 06 19:00:57 integro volumio[3390]: info: Listing playlists Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 06 19:00:57 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 06 19:00:57 integro winbindd[4487]: [2025/03/06 19:00:57.887866, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 06 19:00:57 integro winbindd[4487]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 06 19:00:57 integro winbindd[4487]: [2025/03/06 19:00:57.900358, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 06 19:00:57 integro winbindd[4487]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 06 19:00:57 integro systemd[1]: Started Samba Winbind Daemon. Mar 06 19:00:57 integro systemd[1]: Starting Samba SMB Daemon... Mar 06 19:00:58 integro smbd[4493]: [2025/03/06 19:00:58.449296, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 06 19:00:58 integro smbd[4493]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 06 19:00:58 integro systemd[1]: Started Samba SMB Daemon. Mar 06 19:00:58 integro systemd[1]: Reached target Multi-User System. Mar 06 19:00:58 integro systemd[1]: Reached target Graphical Interface. Mar 06 19:00:58 integro systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 06 19:00:58 integro systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 06 19:00:58 integro systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 06 19:00:58 integro systemd[1]: Startup finished in 12.899s (kernel) + 1min 28.371s (userspace) = 1min 41.270s. Mar 06 19:00:58 integro ntpd[4446]: Soliciting pool server 185.157.13.96 Mar 06 19:00:58 integro ntpd[4446]: Soliciting pool server 80.68.234.117 Mar 06 19:00:58 integro ntpd[4446]: Soliciting pool server 80.50.102.114 Mar 06 19:00:58 integro ntpd[4446]: Soliciting pool server 195.46.37.22 Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 06 19:00:59 integro volumio[3390]: info: Received Get System Info Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 19:00:59 integro volumio[3390]: info: Discovery: Getting this device information Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:00:59 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 06 19:00:59 integro ntpd[4446]: Soliciting pool server 212.127.78.21 Mar 06 19:00:59 integro ntpd[4446]: Soliciting pool server 91.227.212.78 Mar 06 19:00:59 integro ntpd[4446]: Soliciting pool server 54.37.233.160 Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 06 19:00:59 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 06 19:00:59 integro volumio[3390]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 06 19:01:00 integro kernel: asoc-aml-card auge_sound: tdm playback stop Mar 06 19:01:00 integro kernel: spdif_a is set to disable Mar 06 19:01:00 integro kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Mar 06 19:01:00 integro kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B Mar 06 19:01:00 integro kernel: tdm playback mute: 1, lane_cnt = 8 Mar 06 19:01:00 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Mar 06 19:01:00 integro ntpd[4446]: Soliciting pool server 212.127.95.218 Mar 06 19:01:00 integro ntpd[4446]: Soliciting pool server 2001:67c:24c:1::20 Mar 06 19:01:01 integro volumio[3390]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 06 19:01:01 integro volumio[3390]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 19:01:01 integro volumio[3390]: info: Starting MyVolumio Remote Streaming Endpoints Mar 06 19:01:01 integro volumio[3390]: info: MyVolumio login type: Token Mar 06 19:01:01 integro volumio[3390]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 06 19:01:01 integro volumio[3390]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Mar 06 19:01:01 integro ntpd[4446]: Soliciting pool server 89.250.197.242 Mar 06 19:01:01 integro volumio[3390]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=mp1&variante=integro&version=3.757&uuid=bb881f525b2ddc4cc378aa9f99307ed0" http://updates.volumio.org/downloader-v1/track-device Mar 06 19:01:01 integro volumio[3390]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 06 19:01:01 integro volumio[3390]: Dload Upload Total Spent Left Speed Mar 06 19:01:01 integro volumio[3390]: [132B blob data] Mar 06 19:01:01 integro volumio[3390]: retrying in 5 seconds, trial 2 Mar 06 19:01:01 integro volumio[3390]: info: Volumio Calling Home Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 06 19:01:01 integro volumio[3390]: info: Received Get System Info Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 19:01:01 integro volumio[3390]: info: Discovery: Getting this device information Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::volumioGetState Mar 06 19:01:01 integro volumio[3390]: info: CorePlayQueue::getTrack 0 Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 19:01:01 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 06 19:01:02 integro volumio[3390]: info: Volumio called home Mar 06 19:01:02 integro volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 06 19:01:02 integro volumio[3390]: info: MyVolumio login type: Token Mar 06 19:01:02 integro volumio[3390]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 06 19:01:03 integro volumio[3390]: info: MyVolumio token set successfully Mar 06 19:01:03 integro volumio[3390]: info: MYVOLUMIO: Adding device Mar 06 19:01:03 integro volumio[3390]: info: MYVOLUMIO: Evaluating Server Mar 06 19:01:03 integro volumio[3390]: info: MyVolumio status changed Mar 06 19:01:03 integro volumio[3390]: info: Streaming services startup Mar 06 19:01:03 integro volumio[3390]: info: Starting Streaming Daemon Mar 06 19:01:03 integro volumio[3390]: info: Removing browser output: myVolumio user plan is not superstar Mar 06 19:01:03 integro volumio[3390]: info: Removing audio output: Mar 06 19:01:03 integro volumio[3390]: info: Stoppping Tunnel 1 Mar 06 19:01:03 integro ntpd[4446]: receive: Unexpected origin timestamp 0xeb74615f.b8b6e766 does not match aorg 0000000000.00000000 from server@156.17.20.254 xmt 0xeb74615f.37cf0139 Mar 06 19:01:03 integro ntpd[4446]: receive: Unexpected origin timestamp 0xeb74615f.b8a65649 does not match aorg 0000000000.00000000 from server@91.227.212.78 xmt 0xeb74615f.378d5078 Mar 06 19:01:03 integro ntpd[4446]: receive: Unexpected origin timestamp 0xeb74615f.b8b099b6 does not match aorg 0000000000.00000000 from server@149.156.70.60 xmt 0xeb74615f.37417328 Mar 06 19:01:03 integro ntpd[4446]: receive: Unexpected origin timestamp 0xeb74615f.b8b9fb3f does not match aorg 0000000000.00000000 from server@178.215.228.24 xmt 0xeb74615f.3a777828 Mar 06 19:01:03 integro sudo[4555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 06 19:01:03 integro sudo[4555]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:01:03 integro volumio[3390]: error: Failed to ping endpoint us2.myvolumio.org : unknown error Mar 06 19:01:03 integro volumio[3390]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 06 19:01:03 integro sudo[4558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 06 19:01:03 integro sudo[4558]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 06 19:01:03 integro volumio[3390]: Error: Unable to resolve or reject the same promise twice Mar 06 19:01:03 integro volumio[3390]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 06 19:01:03 integro volumio[3390]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Mar 06 19:01:03 integro volumio[3390]: at Socket.emit (events.js:412:35) Mar 06 19:01:03 integro volumio[3390]: at endReadableNT (internal/streams/readable.js:1333:12) Mar 06 19:01:03 integro volumio[3390]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Mar 06 19:01:03 integro volumio[3390]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 06 19:01:03 integro sudo[4555]: pam_unix(sudo:session): session closed for user root Mar 06 19:01:03 integro sudo[4558]: pam_unix(sudo:session): session closed for user root Mar 06 19:01:03 integro sudo[4571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-06 19:00 Mar 06 19:01:03 integro sudo[4571]: pam_unix(sudo:session): session opened for user root by (uid=0) 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="integro" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 18 Sep 2024 09:19:50 AM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Integro" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Integro" VOLUMIO_HASH="1b9dcea34e02f69822336310f6658b58"