Jun 02 12:07:03 stereo wireless.js[920]: WIRELESS.JS - INFO: Failed to determine most appropriate reg domain: Error: spawnSync /bin/sh ETIMEDOUT Jun 02 12:07:03 stereo wireless.js[920]: WIRELESS.JS - INFO: Start wireless flow Jun 02 12:07:03 stereo wireless.js[920]: WIRELESS.JS - INFO: Stopped hotspot (if there).. Jun 02 12:07:03 stereo sudo[1253]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 02 12:07:03 stereo sudo[1253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:03 stereo sudo[1253]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:03 stereo sudo[1255]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 02 12:07:03 stereo sudo[1255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:03 stereo sudo[1255]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:03 stereo wireless.js[920]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Jun 02 12:07:03 stereo wireless.js[920]: WIRELESS.JS - INFO: STAGE 1: wlan0 validated and ready (MAC: b0:a4:60:ea:dc:dd, USB: false) Jun 02 12:07:03 stereo wpa_supplicant[1261]: Successfully initialized wpa_supplicant Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:2 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:1 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:4 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:6 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:7 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:8 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:3 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:9 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:10 (0x1001) Jun 02 12:07:04 stereo kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade rev:0 func:12 (0x1001) Jun 02 12:07:04 stereo wpa_supplicant[1264]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=WORLD Jun 02 12:07:04 stereo sudo[1267]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 02 12:07:04 stereo sudo[1267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:04 stereo sudo[1267]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:04 stereo volumio-remote-updater[918]: [2026-06-02 12:07:04] [info] asio async_connect error: asio.system:111 (Connection refused) Jun 02 12:07:04 stereo volumio-remote-updater[918]: [2026-06-02 12:07:04] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Jun 02 12:07:04 stereo volumio-remote-updater[918]: [2026-06-02 12:07:04] [error] handle_connect error: Connection refused Jun 02 12:07:05 stereo wireless.js[920]: WIRELESS.JS - INFO: DHCP IP fallback Jun 02 12:07:05 stereo wireless.js[920]: WIRELESS.JS - INFO: STAGE 2: Starting event-driven WPA state monitor Jun 02 12:07:05 stereo wireless.js[920]: WIRELESS.JS - INFO: WpaStateMachine: Starting state monitor for wlan0 Jun 02 12:07:05 stereo wireless.js[920]: WIRELESS.JS - INFO: WpaStateMachine: State transition: NULL -> SCANNING (duration: 0ms) Jun 02 12:07:07 stereo systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Jun 02 12:07:07 stereo systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Jun 02 12:07:07 stereo systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 12:07:07 stereo systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 12:07:07 stereo systemd[1]: e2scrub_all.service: Deactivated successfully. Jun 02 12:07:07 stereo systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Jun 02 12:07:07 stereo upmpdcli[1285]: Could not open config: /tmp/upmpdcli.conf Jun 02 12:07:07 stereo systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 02 12:07:07 stereo systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 02 12:07:07 stereo wpa_supplicant[1264]: wlan0: SME: Trying to authenticate with 66:22:32:61:0b:0b (SSID='Mansardix' freq=5180 MHz) Jun 02 12:07:07 stereo wpa_supplicant[1264]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=COUNTRY alpha2=IT Jun 02 12:07:07 stereo kernel: wlan0: authenticate with 66:22:32:61:0b:0b (local address=b0:a4:60:ea:dc:dd) Jun 02 12:07:07 stereo kernel: wlan0: send auth to 66:22:32:61:0b:0b (try 1/3) Jun 02 12:07:07 stereo wpa_supplicant[1264]: wlan0: Trying to associate with 66:22:32:61:0b:0b (SSID='Mansardix' freq=5180 MHz) Jun 02 12:07:07 stereo sudo[1206]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:07 stereo kernel: wlan0: authenticated Jun 02 12:07:07 stereo kernel: wlan0: associate with 66:22:32:61:0b:0b (try 1/3) Jun 02 12:07:07 stereo kernel: wlan0: RX AssocResp from 66:22:32:61:0b:0b (capab=0x1111 status=0 aid=7) Jun 02 12:07:07 stereo wpa_supplicant[1264]: wlan0: Associated with 66:22:32:61:0b:0b Jun 02 12:07:07 stereo wpa_supplicant[1264]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 02 12:07:07 stereo kernel: wlan0: associated Jun 02 12:07:08 stereo kernel: wlan0: Limiting TX power to 23 (23 - 0) dBm as advertised by 66:22:32:61:0b:0b Jun 02 12:07:08 stereo wpa_supplicant[1264]: wlan0: WPA: Key negotiation completed with 66:22:32:61:0b:0b [PTK=CCMP GTK=CCMP] Jun 02 12:07:08 stereo wpa_supplicant[1264]: wlan0: CTRL-EVENT-CONNECTED - Connection to 66:22:32:61:0b:0b completed [id=0 id_str=] Jun 02 12:07:08 stereo dhcpcd[968]: wlan0: carrier acquired Jun 02 12:07:08 stereo dhcpcd[968]: wlan0: connected to Access Point: Mansardix Jun 02 12:07:08 stereo dhcpcd[968]: wlan0: IAID 60:ea:dc:dd Jun 02 12:07:08 stereo dhcpcd[968]: wlan0: soliciting an IPv6 router Jun 02 12:07:08 stereo wireless.js[920]: WIRELESS.JS - INFO: WpaStateMachine: State transition: SCANNING -> COMPLETED (duration: 2538ms) Jun 02 12:07:08 stereo wireless.js[920]: WIRELESS.JS - INFO: WpaStateMachine: COMPLETED - connection successful Jun 02 12:07:08 stereo wireless.js[920]: WIRELESS.JS - INFO: STAGE 2: Connection successful - Connected to 66:22:32:61:0b:0b Jun 02 12:07:08 stereo wireless.js[920]: WIRELESS.JS - INFO: Onboard WiFi adapter detected, using standard dhcpcd flow Jun 02 12:07:08 stereo dhcpcd[968]: wlan0: soliciting a DHCP lease Jun 02 12:07:09 stereo dhcpcd[968]: wlan0: offered 192.168.9.28 from 192.168.9.1 Jun 02 12:07:09 stereo dhcpcd[968]: wlan0: probing address 192.168.9.28/24 Jun 02 12:07:09 stereo sudo[1316]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd wlan0 Jun 02 12:07:09 stereo sudo[1316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:09 stereo dhcpcd[968]: control command: /sbin/dhcpcd wlan0 Jun 02 12:07:09 stereo dhcpcd[968]: control_free: No such file or directory Jun 02 12:07:09 stereo sudo[1316]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:11 stereo wireless.js[920]: WIRELESS.JS - INFO: Start ap Jun 02 12:07:11 stereo wireless.js[920]: WIRELESS.JS - INFO: Notified systemd about wireless ready Jun 02 12:07:11 stereo systemd[1]: Started wireless.service - Wireless Services. Jun 02 12:07:11 stereo systemd[1]: Started volumio.service - Volumio Backend Module. Jun 02 12:07:11 stereo systemd[1]: Started screenshot.service - Process screenshots triggered by PrtSc-button. Jun 02 12:07:11 stereo systemd[1]: Started soundcard-init.service - Intel SST and HDA soundcard init service. Jun 02 12:07:11 stereo systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk. Jun 02 12:07:11 stereo systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Jun 02 12:07:11 stereo volumio-cpu-tweak[1340]: Setting RT Priority for mpd Jun 02 12:07:11 stereo volumio-cpu-tweak[1365]: pid 35's current scheduling policy: SCHED_OTHER Jun 02 12:07:11 stereo volumio-cpu-tweak[1365]: pid 35's current scheduling priority: 0 Jun 02 12:07:11 stereo volumio-cpu-tweak[1340]: Setting MPD Affinity Jun 02 12:07:11 stereo volumio-cpu-tweak[1369]: pid 3's current affinity mask: f Jun 02 12:07:11 stereo volumio-cpu-tweak[1340]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 02 12:07:11 stereo systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Jun 02 12:07:11 stereo startx[1390]: X.Org X Server 1.21.1.7 Jun 02 12:07:11 stereo startx[1390]: X Protocol Version 11, Revision 0 Jun 02 12:07:11 stereo startx[1390]: Current Operating System: Linux stereo 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64 Jun 02 12:07:11 stereo startx[1390]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=c75dc17d-b521-4b1c-8c87-41f797c9bb1e bootpart=UUID=9E6A-4325 datapart=UUID=fd823070-81f6-4a5b-8356-e5cbace10cfd hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no Jun 02 12:07:11 stereo startx[1390]: xorg-server 2:21.1.7-3+deb12u11 (https://www.debian.org/support) Jun 02 12:07:11 stereo startx[1390]: Current version of pixman: 0.42.2 Jun 02 12:07:11 stereo startx[1390]: Before reporting problems, check http://wiki.x.org Jun 02 12:07:11 stereo startx[1390]: to make sure that you have the latest version. Jun 02 12:07:11 stereo startx[1390]: Markers: (--) probed, (**) from config file, (==) default setting, Jun 02 12:07:11 stereo startx[1390]: (++) from command line, (!!) notice, (II) informational, Jun 02 12:07:11 stereo startx[1390]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jun 02 12:07:11 stereo startx[1390]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Jun 2 12:07:11 2026 Jun 02 12:07:11 stereo startx[1390]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jun 02 12:07:11 stereo soundcard-init.sh[1403]: Card 0 Chip ATI R6xx HDMI Name HDA ATI HDMI Jun 02 12:07:11 stereo soundcard-init.sh[1403]: Card 1 Chip Realtek Generic Name HD-Audio Generic Jun 02 12:07:11 stereo soundcard-init.sh[1426]: Simple mixer control 'Master',0 Jun 02 12:07:11 stereo soundcard-init.sh[1426]: Capabilities: pvolume pvolume-joined pswitch pswitch-joined Jun 02 12:07:11 stereo soundcard-init.sh[1426]: Playback channels: Mono Jun 02 12:07:11 stereo soundcard-init.sh[1426]: Limits: Playback 0 - 64 Jun 02 12:07:11 stereo soundcard-init.sh[1426]: Mono: Playback 48 [75%] [-16.00dB] [on] Jun 02 12:07:11 stereo soundcard-init.sh[1403]: Card 2 Chip AV200 Name Xonar STX Jun 02 12:07:11 stereo systemd[1]: soundcard-init.service: Deactivated successfully. Jun 02 12:07:11 stereo startx[1390]: (II) [KMS] Kernel modesetting enabled. Jun 02 12:07:12 stereo wireless.js[920]: WIRELESS.JS - INFO: trying... Jun 02 12:07:12 stereo sudo[1447]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 12:07:12 stereo sudo[1447]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:07:12 stereo sudo[1447]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:12 stereo sudo[1450]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 12:07:12 stereo sudo[1450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:12 stereo sudo[1450]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:12 stereo wireless.js[920]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Jun 02 12:07:13 stereo volumio[1325]: info: ------------------------------------------- Jun 02 12:07:13 stereo volumio[1325]: info: ----- Volumio3 ---- Jun 02 12:07:13 stereo volumio[1325]: info: ------------------------------------------- Jun 02 12:07:13 stereo volumio[1325]: info: ----- System startup ---- Jun 02 12:07:13 stereo volumio[1325]: info: ------------------------------------------- Jun 02 12:07:13 stereo wireless.js[920]: WIRELESS.JS - INFO: trying... Jun 02 12:07:13 stereo sudo[1475]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 12:07:13 stereo sudo[1475]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:07:13 stereo sudo[1475]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:13 stereo sudo[1478]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 12:07:13 stereo sudo[1478]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:13 stereo sudo[1478]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:13 stereo wireless.js[920]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Jun 02 12:07:13 stereo volumio[1325]: info: MYVOLUMIO Environment detected Jun 02 12:07:14 stereo volumio[1325]: info: Plugin folders cleanup Jun 02 12:07:14 stereo volumio[1325]: info: Scanning into folder /volumio/app/plugins/ Jun 02 12:07:14 stereo volumio[1325]: info: Scanning category audio_interface Jun 02 12:07:14 stereo volumio[1325]: info: Scanning category miscellanea Jun 02 12:07:14 stereo volumio[1325]: info: Scanning category music_service Jun 02 12:07:14 stereo volumio[1325]: info: Scanning category plugins.json Jun 02 12:07:14 stereo volumio[1325]: info: Scanning category system_controller Jun 02 12:07:14 stereo volumio[1325]: info: Scanning category user_interface Jun 02 12:07:14 stereo volumio[1325]: info: Scanning into folder /data/plugins/ Jun 02 12:07:14 stereo volumio[1325]: info: Scanning category music_service Jun 02 12:07:14 stereo volumio[1325]: info: Plugin folders cleanup completed Jun 02 12:07:14 stereo volumio[1325]: info: ------------------------------------------- Jun 02 12:07:14 stereo volumio[1325]: info: ----- Core plugins startup ---- Jun 02 12:07:14 stereo volumio[1325]: info: ------------------------------------------- Jun 02 12:07:14 stereo volumio[1325]: info: Loading plugins from folder /volumio/app/plugins/ Jun 02 12:07:14 stereo volumio[1325]: info: Adding plugin upnp to MyMusic Plugins Jun 02 12:07:14 stereo volumio[1325]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 02 12:07:14 stereo volumio[1325]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 02 12:07:14 stereo volumio[1325]: info: Loading plugins from folder /data/plugins/ Jun 02 12:07:14 stereo volumio[1325]: info: Loading plugin "system"... Jun 02 12:07:14 stereo volumio[1325]: info: Loading plugin "appearance"... Jun 02 12:07:14 stereo dhcpcd[968]: wlan0: leased 192.168.9.28 for 1800 seconds Jun 02 12:07:14 stereo avahi-daemon[909]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.9.28. Jun 02 12:07:14 stereo avahi-daemon[909]: New relevant interface wlan0.IPv4 for mDNS. Jun 02 12:07:14 stereo avahi-daemon[909]: Registering new address record for 192.168.9.28 on wlan0.IPv4. Jun 02 12:07:14 stereo dhcpcd[968]: wlan0: adding route to 192.168.9.0/24 Jun 02 12:07:14 stereo dhcpcd[968]: wlan0: adding default route via 192.168.9.1 Jun 02 12:07:14 stereo systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jun 02 12:07:14 stereo systemd[1]: welcome.service: Deactivated successfully. Jun 02 12:07:14 stereo systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 02 12:07:14 stereo systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 02 12:07:14 stereo systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 02 12:07:14 stereo welcome[1571]: Resolved ip:[1] 192.168.9.28 Jun 02 12:07:14 stereo systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 02 12:07:14 stereo systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 02 12:07:14 stereo wireless.js[920]: WIRELESS.JS - INFO: trying... Jun 02 12:07:14 stereo systemd[1]: Started nmbd.service - Samba NMB Daemon. Jun 02 12:07:14 stereo systemd[1]: Starting winbind.service - Samba Winbind Daemon... Jun 02 12:07:14 stereo sudo[1606]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 02 12:07:14 stereo sudo[1606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:07:14 stereo volumio-remote-updater[918]: [2026-06-02 12:07:14] [connect] Successful connection Jun 02 12:07:14 stereo sudo[1606]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:14 stereo sudo[1609]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 12:07:14 stereo sudo[1609]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:14 stereo sudo[1609]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:14 stereo wireless.js[920]: WIRELESS.JS - INFO: ... wlan0 IPv4 is 192.168.9.28, ipV6 is undefined Jun 02 12:07:14 stereo wireless.js[920]: WIRELESS.JS - INFO: Connected to SSID: Mansardix Jun 02 12:07:14 stereo wireless.js[920]: WIRELESS.JS - INFO: It's done! AP Jun 02 12:07:14 stereo wireless.js[920]: WIRELESS.JS - INFO: Restarting avahi-daemon... Jun 02 12:07:14 stereo sudo[1618]: root : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart avahi-daemon Jun 02 12:07:14 stereo sudo[1618]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:07:14 stereo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 02 12:07:14 stereo systemd[1]: shairport-sync.service: Deactivated successfully. Jun 02 12:07:14 stereo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 02 12:07:14 stereo systemd[1]: shairport-sync.service: Consumed 1.870s CPU time. Jun 02 12:07:14 stereo systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Jun 02 12:07:14 stereo avahi-daemon[909]: Got SIGTERM, quitting. Jun 02 12:07:14 stereo avahi-daemon[909]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.9.28. Jun 02 12:07:14 stereo avahi-daemon[909]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Jun 02 12:07:14 stereo avahi-daemon[909]: avahi-daemon 0.8 exiting. Jun 02 12:07:14 stereo systemd[1]: avahi-daemon.service: Deactivated successfully. Jun 02 12:07:14 stereo systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Jun 02 12:07:14 stereo systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Jun 02 12:07:14 stereo avahi-daemon[1625]: Process 909 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Jun 02 12:07:14 stereo avahi-daemon[1625]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Jun 02 12:07:14 stereo avahi-daemon[1625]: Successfully dropped root privileges. Jun 02 12:07:14 stereo avahi-daemon[1625]: avahi-daemon 0.8 starting up. Jun 02 12:07:14 stereo avahi-daemon[1625]: Successfully called chroot(). Jun 02 12:07:14 stereo avahi-daemon[1625]: Successfully dropped remaining capabilities. Jun 02 12:07:14 stereo avahi-daemon[1625]: Loading service file /services/volumio.service. Jun 02 12:07:14 stereo avahi-daemon[1625]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.9.28. Jun 02 12:07:14 stereo avahi-daemon[1625]: New relevant interface wlan0.IPv4 for mDNS. Jun 02 12:07:14 stereo avahi-daemon[1625]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Jun 02 12:07:14 stereo avahi-daemon[1625]: New relevant interface lo.IPv4 for mDNS. Jun 02 12:07:14 stereo systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Jun 02 12:07:14 stereo avahi-daemon[1625]: Network interface enumeration completed. Jun 02 12:07:14 stereo avahi-daemon[1625]: Registering new address record for 192.168.9.28 on wlan0.IPv4. Jun 02 12:07:14 stereo avahi-daemon[1625]: Registering new address record for 127.0.0.1 on lo.IPv4. Jun 02 12:07:14 stereo sudo[1618]: pam_unix(sudo:session): session closed for user root Jun 02 12:07:14 stereo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 02 12:07:14 stereo wireless.js[920]: WIRELESS.JS - INFO: Notified systemd about wireless ready Jun 02 12:08:03 stereo systemd[1]: setdatetime-helper.service: Deactivated successfully. Jun 02 12:08:03 stereo systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jun 02 12:08:03 stereo winbindd[1613]: [2026/06/02 12:08:03.006927, 0] ../../source3/winbindd/winbindd.c:1440(main) Jun 02 12:08:03 stereo winbindd[1613]: winbindd version 4.17.12-Debian started. Jun 02 12:08:03 stereo winbindd[1613]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jun 02 12:08:03 stereo winbindd[1613]: [2026/06/02 12:08:03.023577, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache) Jun 02 12:08:03 stereo winbindd[1613]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 02 12:08:03 stereo systemd[1]: Started winbind.service - Samba Winbind Daemon. Jun 02 12:08:03 stereo systemd[1]: Starting smbd.service - Samba SMB Daemon... Jun 02 12:08:03 stereo smbd[1659]: [2026/06/02 12:08:03.439337, 0] ../../source3/smbd/server.c:1741(main) Jun 02 12:08:03 stereo smbd[1659]: smbd version 4.17.12-Debian started. Jun 02 12:08:03 stereo smbd[1659]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jun 02 12:08:03 stereo avahi-daemon[1625]: Server startup complete. Host name is stereo.local. Local service cookie is 3011222347. Jun 02 12:08:04 stereo systemd[1]: Started smbd.service - Samba SMB Daemon. Jun 02 12:08:04 stereo systemd[1]: Reached target multi-user.target - Multi-User System. Jun 02 12:08:04 stereo systemd[1]: Reached target graphical.target - Graphical Interface. Jun 02 12:08:04 stereo systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Jun 02 12:08:04 stereo systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jun 02 12:08:04 stereo systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Jun 02 12:08:04 stereo systemd[1]: Startup finished in 34.591s (kernel) + 27.666s (userspace) = 1min 2.257s. Jun 02 12:08:04 stereo ntpd[1081]: IO: Listen normally on 3 wlan0 192.168.9.28:123 Jun 02 12:08:04 stereo ntpd[1081]: IO: new interface(s) found: waking up resolver Jun 02 12:08:04 stereo ntpd[1081]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "network"... Jun 02 12:08:04 stereo volumio[1325]: info: Refreshing Cached IP Addresses Jun 02 12:08:04 stereo sudo[1704]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 12:08:04 stereo sudo[1704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:04 stereo sudo[1703]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 12:08:04 stereo sudo[1703]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:04 stereo ntpd[1081]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Jun 02 12:08:04 stereo ntpd[1081]: DNS: Pool taking: 162.159.200.123 Jun 02 12:08:04 stereo ntpd[1081]: DNS: Pool taking: 172.232.209.103 Jun 02 12:08:04 stereo ntpd[1081]: DNS: Pool taking: 212.45.144.206 Jun 02 12:08:04 stereo ntpd[1081]: DNS: Pool taking: 93.94.88.51 Jun 02 12:08:04 stereo ntpd[1081]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Jun 02 12:08:04 stereo sudo[1704]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "services"... Jun 02 12:08:04 stereo sudo[1703]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "volumio5onboarding"... Jun 02 12:08:04 stereo sudo[1717]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 02 12:08:04 stereo sudo[1717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "alsa_controller"... Jun 02 12:08:04 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "wizard"... Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "networkfs"... Jun 02 12:08:04 stereo volumio[1325]: info: Starting Udev Watcher for removable devices Jun 02 12:08:04 stereo avahi-daemon[1625]: Service "Stereo" (/services/volumio.service) successfully established. Jun 02 12:08:04 stereo volumio[1325]: info: Ignoring mount for partition: boot Jun 02 12:08:04 stereo volumio[1325]: info: Ignoring mount for partition: volumio Jun 02 12:08:04 stereo volumio[1325]: info: Ignoring mount for partition: volumio_data Jun 02 12:08:04 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "volumio_command_line_client"... Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "upnp"... Jun 02 12:08:04 stereo volumio[1325]: info: [1780394884622] Starting Upmpd Daemon Jun 02 12:08:04 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "my_music"... Jun 02 12:08:04 stereo volumio[1325]: info: Loading plugin "mpd"... Jun 02 12:08:05 stereo volumio[1325]: info: Loading plugin "upnp_browser"... Jun 02 12:08:05 stereo ntpd[1081]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 02 12:08:05 stereo ntpd[1081]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool taking: 185.19.184.35 Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool taking: 89.46.74.148 Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool skipping: 172.232.209.103 Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool taking: 204.216.214.76 Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool taking: 2a00:6d41:200:2::12 Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool taking: 2600:3c0b::f03c:94ff:fe16:7f5a Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool taking: 2603:c020:8017:3e00::123:123 Jun 02 12:08:05 stereo ntpd[1081]: DNS: Pool taking: 2600:3c0b::f03c:94ff:fee2:cbb9 Jun 02 12:08:05 stereo ntpd[1081]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Jun 02 12:08:05 stereo volumio[1325]: info: Starting UPNP Browser Jun 02 12:08:05 stereo volumio[1325]: info: Loading plugin "alarm-clock"... Jun 02 12:08:06 stereo volumio[1325]: info: Loading plugin "airplay_emulation"... Jun 02 12:08:06 stereo volumio[1325]: info: Starting Shairport Sync Jun 02 12:08:06 stereo volumio[1325]: info: Loading plugin "last_100"... Jun 02 12:08:06 stereo volumio[1325]: info: Loading plugin "webradio"... Jun 02 12:08:06 stereo volumio[1325]: info: Loading plugin "i2s_dacs"... Jun 02 12:08:06 stereo volumio[1325]: info: I2S DAC not set, start Auto-detection Jun 02 12:08:06 stereo ntpd[1081]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 02 12:08:06 stereo volumio[1325]: info: Loading plugin "volumiodiscovery"... Jun 02 12:08:06 stereo volumio[1325]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 12:08:06 stereo volumio[1325]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 12:08:06 stereo volumio[1325]: *** WARNING *** For more information see Jun 02 12:08:06 stereo volumio[1325]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 12:08:06 stereo volumio[1325]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 12:08:06 stereo volumio[1325]: *** WARNING *** For more information see Jun 02 12:08:06 stereo node[1325]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 12:08:06 stereo node[1325]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 12:08:06 stereo node[1325]: *** WARNING *** For more information see Jun 02 12:08:06 stereo node[1325]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 12:08:06 stereo node[1325]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 12:08:06 stereo node[1325]: *** WARNING *** For more information see Jun 02 12:08:06 stereo volumio[1325]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 02 12:08:06 stereo volumio[1325]: info: Discovery: Started advertising with name: Stereo Jun 02 12:08:06 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 12:08:06 stereo volumio[1325]: info: Loading plugin "spop"... Jun 02 12:08:06 stereo ntpd[1081]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Jun 02 12:08:06 stereo ntpd[1081]: DNS: Pool taking: 85.199.214.99 Jun 02 12:08:06 stereo ntpd[1081]: DNS: Pool taking: 93.94.88.50 Jun 02 12:08:06 stereo ntpd[1081]: DNS: Pool taking: 185.157.229.254 Jun 02 12:08:06 stereo ntpd[1081]: DNS: Pool taking: 151.22.209.90 Jun 02 12:08:06 stereo ntpd[1081]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Jun 02 12:08:06 stereo sudo[1717]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:07 stereo volumio[1325]: info: Loading plugin "outputs"... Jun 02 12:08:07 stereo volumio[1325]: info: Loading plugin "albumart"... Jun 02 12:08:07 stereo volumio[1325]: info: Plugin example_plugin is not enabled Jun 02 12:08:07 stereo volumio[1325]: info: Loading plugin "inputs"... Jun 02 12:08:07 stereo volumio[1325]: info: Loading plugin "updater_comm"... Jun 02 12:08:07 stereo volumio[1820]: Forking 3 albumart workers Jun 02 12:08:07 stereo ntpd[1081]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Jun 02 12:08:07 stereo volumio[1325]: info: Plugin mpdemulation is not enabled Jun 02 12:08:07 stereo volumio[1325]: info: Loading plugin "rest_api"... Jun 02 12:08:07 stereo volumio[1325]: info: Loading plugin "websocket"... Jun 02 12:08:07 stereo ntpd[1081]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jun 02 12:08:07 stereo ntpd[1081]: DNS: Pool taking: 5.231.80.8 Jun 02 12:08:07 stereo ntpd[1081]: DNS: Pool skipping: 204.216.214.76 Jun 02 12:08:07 stereo ntpd[1081]: DNS: Pool taking: 37.247.53.178 Jun 02 12:08:07 stereo ntpd[1081]: DNS: Pool skipping: 172.232.209.103 Jun 02 12:08:07 stereo ntpd[1081]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Jun 02 12:08:07 stereo volumio[1325]: info: Starting Socket.io Server version 1.7.4 Jun 02 12:08:07 stereo volumio[1325]: info: Loading i18n strings for locale it Jun 02 12:08:07 stereo volumio[1325]: Updating browse sources language Jun 02 12:08:07 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:08:07 stereo systemd[1]: systemd-fsckd.service: Deactivated successfully. Jun 02 12:08:07 stereo volumio[1839]: Starting albumart workers Jun 02 12:08:07 stereo volumio[1834]: Starting albumart workers Jun 02 12:08:07 stereo volumio[1833]: Starting albumart workers Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::initPlayerControls Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: Express server listening on port 3000 Jun 02 12:08:08 stereo volumio[1325]: [Metrics] WebUI: 7s 546.18ms Jun 02 12:08:08 stereo volumio[1325]: info: Setting Device type: x86 Jun 02 12:08:08 stereo volumio[1325]: info: CoreStateMachine::resetVolumioState Jun 02 12:08:08 stereo volumio[1325]: info: CoreStateMachine::getcurrentVolume Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 02 12:08:08 stereo volumio[1325]: info: Completed loading Core Plugins Jun 02 12:08:08 stereo volumio[1325]: info: Preparing to generate the ALSA configuration file Jun 02 12:08:08 stereo volumio[1325]: info: Cannot read play queue from file Jun 02 12:08:08 stereo volumio[1325]: info: Volumio Network Manager: Network status updated: 2 Jun 02 12:08:08 stereo volumio[1325]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 02 12:08:08 stereo volumio[1325]: info: VolumeController:: Volume=79 Mute =false Jun 02 12:08:08 stereo volumio[1325]: info: CoreStateMachine::pushState Jun 02 12:08:08 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::volumioPushState Jun 02 12:08:08 stereo volumio[1325]: info: CoreStateMachine::updateTrackBlock Jun 02 12:08:08 stereo volumio[1325]: info: CorePlayQueue::getTrackBlock Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 12:08:08 stereo volumio[1325]: info: Asound.conf file unchanged, so no further update is needed Jun 02 12:08:08 stereo volumio[1325]: info: Output device has changed, restarting MPD Jun 02 12:08:08 stereo volumio[1325]: info: Output device has changed, restarting Shairport Sync Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 12:08:08 stereo sudo[1942]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 12:08:08 stereo volumio[1325]: info: ___________ START PLUGINS ___________ Jun 02 12:08:08 stereo sudo[1942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:08 stereo sudo[1944]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 12:08:08 stereo sudo[1944]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:08 stereo sudo[1942]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:08 stereo volumio[1325]: info: ControllerMpd::onStart: Initializing MPD Jun 02 12:08:08 stereo volumio[1325]: info: Creating MPD Configuration file Jun 02 12:08:08 stereo sudo[1952]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Jun 02 12:08:08 stereo sudo[1952]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 12:08:08 stereo volumio[1325]: info: [1780394888682] CoreMusicLibrary::Adding element Server multimediali Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:08:08 stereo sudo[1957]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 12:08:08 stereo sudo[1957]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:08 stereo sudo[1954]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 12:08:08 stereo sudo[1954]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:08 stereo volumio[1325]: info: UPNP Browser: Client initialized successfully Jun 02 12:08:08 stereo sudo[1954]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 12:08:08 stereo volumio[1325]: info: [1780394888740] CoreMusicLibrary::Adding element Last_100 Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:08:08 stereo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 12:08:08 stereo volumio[1325]: info: [1780394888742] CoreMusicLibrary::Adding element Webradio Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 12:08:08 stereo systemd[1]: Starting mpd.service - Music Player Daemon... Jun 02 12:08:08 stereo volumio[1325]: info: Initializing BBC Radios Jun 02 12:08:08 stereo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Jun 02 12:08:08 stereo sudo[1952]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:08:08 stereo volumio[1325]: info: Creating Spotify config file Jun 02 12:08:08 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:08 stereo sh[817]: timed out Jun 02 12:08:08 stereo dhcpcd[832]: timed out Jun 02 12:08:08 stereo dhcpcd[832]: dhcpcd exited Jun 02 12:08:08 stereo sh[746]: ifup: failed to bring up eth0 Jun 02 12:08:08 stereo systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jun 02 12:08:08 stereo systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jun 02 12:08:08 stereo sudo[1969]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 02 12:08:08 stereo sudo[1969]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 12:08:08 stereo sudo[1986]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 02 12:08:08 stereo sudo[1969]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:08 stereo volumio[1325]: info: Volumio Calling Home Jun 02 12:08:09 stereo volumio[1325]: info: CoreStateMachine::setRepeat null single undefined Jun 02 12:08:09 stereo volumio[1325]: info: CoreStateMachine::pushState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioPushState Jun 02 12:08:09 stereo volumio[1325]: info: CoreStateMachine::setRandom null Jun 02 12:08:09 stereo volumio[1325]: info: CoreStateMachine::pushState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioPushState Jun 02 12:08:09 stereo volumio5-onboarding[1971]: time=2026-06-02T12:08:09.101+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Jun 02 12:08:09 stereo volumio[1325]: info: MPD Permissions set Jun 02 12:08:09 stereo volumio[1325]: info: MPD Permissions set Jun 02 12:08:09 stereo volumio[1325]: info: Spotify config file written Jun 02 12:08:09 stereo volumio[1325]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 02 12:08:09 stereo sudo[2003]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 12:08:09 stereo sudo[2003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 02 12:08:09 stereo systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 02 12:08:09 stereo systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 02 12:08:09 stereo systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 12:08:09 stereo go-librespot[2013]: go-librespot daemon starting... Jun 02 12:08:09 stereo sudo[2003]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 12:08:09 stereo volumio[1325]: info: No need to fix Spotify hosts Jun 02 12:08:09 stereo volumio[1325]: info: Discovery: adding 822d0bce-f2ac-4bd4-af9f-fbae8d3e982f Jun 02 12:08:09 stereo volumio[1325]: info: Discovery: Found device Stereo Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo volumio[1325]: info: Discovery: this is already registered, 822d0bce-f2ac-4bd4-af9f-fbae8d3e982f Jun 02 12:08:09 stereo volumio[1325]: info: Discovery: Found device Stereo Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo volumio[1325]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 02 12:08:09 stereo volumio[1325]: info: VolumeController:: Volume=79 Mute =false Jun 02 12:08:09 stereo volumio[1325]: info: CoreStateMachine::pushState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioPushState Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=info msg="running go-librespot 0.7.1" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="app state loaded" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 12:08:09 stereo volumio[1325]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 02 12:08:09 stereo volumio[1325]: info: Received Get System Info Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:08:09 stereo volumio[1325]: info: Discovery: Getting this device information Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:08:09 stereo volumio5-onboarding[1971]: time=2026-06-02T12:08:09.350+02:00 level=INFO msg="system info for e65ba874525b2f9d1c00debb2a836706" deviceName=Stereo deviceVariant=volumio deviceModel= softwareVersion=4.119 Jun 02 12:08:09 stereo volumio[1325]: info: Volumio called home Jun 02 12:08:09 stereo volumio5-onboarding[1971]: time=2026-06-02T12:08:09.376+02:00 level=INFO msg="bootstrapping state" hasInternet=true Jun 02 12:08:09 stereo volumio[1325]: info: Starting Shairport Sync Jun 02 12:08:09 stereo volumio[1325]: info: Starting Shairport Sync Jun 02 12:08:09 stereo volumio[1325]: info: Starting Shairport Sync Jun 02 12:08:09 stereo sudo[2034]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 12:08:09 stereo sudo[2034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:09 stereo sudo[2036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 12:08:09 stereo sudo[2036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:09 stereo sudo[2038]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 02 12:08:09 stereo sudo[2038]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:09 stereo volumio[1325]: info: Received Get System Info Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:08:09 stereo volumio[1325]: info: Discovery: Getting this device information Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:08:09 stereo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 02 12:08:09 stereo systemd[1]: shairport-sync.service: Deactivated successfully. Jun 02 12:08:09 stereo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 02 12:08:09 stereo systemd[1]: shairport-sync.service: Consumed 1.473s CPU time. Jun 02 12:08:09 stereo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 02 12:08:09 stereo sudo[2034]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:09 stereo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 02 12:08:09 stereo sudo[2036]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:09 stereo systemd[1]: shairport-sync.service: Deactivated successfully. Jun 02 12:08:09 stereo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 02 12:08:09 stereo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 02 12:08:09 stereo sudo[2038]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:09 stereo volumio[1325]: info: Shairport-Sync Started Jun 02 12:08:09 stereo volumio[1325]: Error adding Membership: Error: addMembership EINVAL Jun 02 12:08:09 stereo volumio[1325]: info: Shairport-Sync Started Jun 02 12:08:09 stereo volumio[1325]: info: New Spotify access tokenBQDTDGU7tE... Jun 02 12:08:09 stereo volumio[1325]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 02 12:08:09 stereo volumio[1325]: info: Shairport-Sync Started Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:09 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=info msg="zeroconf server listening on port 39781" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="obtained new client token: AAB2bf9aURhGPC+CuqIz6gxFEPF4KA+NimPb725A9dC57E8acXz0oy5lKwfqaAqbRyWC54khCgF3pEdelHtlOUbJUXb2HSKrMXRKPapBRvtNRk6H/UCS3jiRevoiA/0cSp4Ne7J/Sfcfw0J128eP+hlqonI8o55KEimoGWZ7HUVc+iM6+meBLTXrHKABhxrCHZ8FjjAgFSiZmiAceP28QqGSeU9+2y4MAHcVJigTvZeMIjvRj40LISqL" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Jun 02 12:08:09 stereo volumio[1325]: SPOTIFY: User informations: {"account_id":"uzw99xjLft","country":"IT","display_name":"Giacomo Del Bianco","email":"g.delbianco90@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/1168825373"},"followers":{"href":null,"total":7},"href":"https://api.spotify.com/v1/users/1168825373","id":"1168825373","images":[{"height":300,"url":"https://scontent-ord5-1.xx.fbcdn.net/v/t39.30808-1/455348972_10223890047630690_1822136265104068314_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=108&ccb=1-7&_nc_sid=08baa4&_nc_ohc=vb51pLlXzCYQ7kNvwGTL14h&_nc_oc=Adq96mvtewZkNRrA7L4lpMmI0K4NgIONiHtyCDTxmaLcLjvBxflUKP9C4qOx3o7OGycJK-gCKqbdDvrimgTact-M&_nc_zt=24&_nc_ht=scontent-ord5-1.xx&edm=AP4hL3IEAAAA&_nc_gid=tJfC00FSuMy2eHCXMI-qyA&_nc_tpa=Q5bMBQE-76b5SXXr43HGa7qeD7f-lU1Y-5zYAF_uuZPiSr_2wJr8_FrQLlZv-WnN_EbGZlb-d-g1&oh=00_Af987VZHD7y6XYWC49I-DjeERBgOmETUfkBLtaOiLLcSVw&oe=6A247DDD","width":300},{"height":64,"url":"https://scontent-ord5-1.xx.fbcdn.net/v/t39.30808-1/455348972_10223890047630690_1822136265104068314_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=108&ccb=1-7&_nc_sid=fe59b0&_nc_ohc=vb51pLlXzCYQ7kNvwGTL14h&_nc_oc=Adq96mvtewZkNRrA7L4lpMmI0K4NgIONiHtyCDTxmaLcLjvBxflUKP9C4qOx3o7OGycJK-gCKqbdDvrimgTact-M&_nc_zt=24&_nc_ht=scontent-ord5-1.xx&edm=AP4hL3IEAAAA&_nc_gid=tJfC00FSuMy2eHCXMI-qyA&_nc_tpa=Q5bMBQGSYDbCMyoh09bHLVLgXvCjCHMynv3UpBjgIWx1OAFEuAvHnGyyQefeHlSJ0TbeCCSXpyzN&oh=00_Af_Zbcn9uWHHCdEMTdQvgTpvK2D4PJqjZjWW4IXbWBgZqw&oe=6A247DDD","width":64}],"product":"free","type":"user","uri":"spotify:user:1168825373"} Jun 02 12:08:09 stereo volumio[1325]: info: Spotify Successfully logged in Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 12:08:09 stereo volumio[1325]: info: [1780394889960] CoreMusicLibrary::Adding element Spotify Jun 02 12:08:09 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:08:09 stereo volumio[1325]: Cannot find translation for source Spotify Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="completed keyexchange" Jun 02 12:08:09 stereo go-librespot[2022]: time="2026-06-02T12:08:09+02:00" level=debug msg="completed challenge" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=info msg="authenticated AP" username="11******73" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=info msg="authenticated Login5" username="11******73" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="initializing zeroconf session" username="11******73" Jun 02 12:08:10 stereo systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="dealer connection opened" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=trace msg="starting accesspoint recv loop" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=trace msg="received accesspoint ping" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=trace msg="starting dealer recv loop" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=debug msg="received connection id: NzYxZmNlYzktYTE0...NUFGNEQyMjBDOQ==" Jun 02 12:08:10 stereo go-librespot[2022]: time="2026-06-02T12:08:10+02:00" level=trace msg="received accesspoint pong ack" Jun 02 12:08:11 stereo ntpd[1081]: CLOCK: time stepped by 0.753301 Jun 02 12:08:11 stereo ntpd[1081]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Jun 02 12:08:11 stereo go-librespot[2022]: time="2026-06-02T12:08:11+02:00" level=debug msg="put connect state because NEW_DEVICE" Jun 02 12:08:11 stereo systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Jun 02 12:08:11 stereo systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 12:08:11 stereo systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jun 02 12:08:11 stereo upmpdcli[2066]: Could not open config: /tmp/upmpdcli.conf Jun 02 12:08:11 stereo systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 02 12:08:11 stereo systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 02 12:08:12 stereo volumio[1325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jun 02 12:08:12 stereo mpd[1991]: 2026-06-02T12:08:12 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 02 12:08:12 stereo systemd[1]: Started mpd.service - Music Player Daemon. Jun 02 12:08:12 stereo sudo[1957]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:12 stereo sudo[1944]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:12 stereo volumio[1325]: info: Completed starting Core Plugins Jun 02 12:08:12 stereo volumio[1325]: info: ------------------------------------------- Jun 02 12:08:12 stereo volumio[1325]: info: ----- MyVolumio plugins startup ---- Jun 02 12:08:12 stereo volumio[1325]: info: ------------------------------------------- Jun 02 12:08:12 stereo volumio[1325]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 02 12:08:12 stereo volumio[1325]: error: MPD error: The expression evaluated to a falsy value: Jun 02 12:08:12 stereo volumio[1325]: assert.ok(self.idling) Jun 02 12:08:12 stereo volumio[1325]: error: The expression evaluated to a falsy value: Jun 02 12:08:12 stereo volumio[1325]: assert.ok(self.idling) Jun 02 12:08:12 stereo volumio[1325]: info: MPD running with PID1991 Jun 02 12:08:12 stereo volumio[1325]: ,establishing connection Jun 02 12:08:12 stereo volumio[1325]: error: updateQueue error: null Jun 02 12:08:12 stereo volumio[1325]: error: updateQueue error: null Jun 02 12:08:13 stereo volumio[1325]: info: go-librespot daemon successfully initialized Jun 02 12:08:13 stereo volumio[1325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:14 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 12:08:14 stereo volumio[1325]: info: Received Get System Info Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:08:14 stereo volumio[1325]: info: Discovery: Getting this device information Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:14 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:14 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:14 stereo volumio[1325]: info: Listing playlists Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 12:08:14 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:14 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:15 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 12:08:15 stereo volumio[1325]: info: Received Get System Info Jun 02 12:08:15 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:08:15 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:08:15 stereo volumio[1325]: info: Discovery: Getting this device information Jun 02 12:08:15 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:15 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:15 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="dealer connection closed" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="dealer recv loop stopped" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="obtained new client token: AAD9NTwlMeowv6RCTMjarM0uDYK76mddrLEJOW5iDFdljuEL9qK1MuyMHIRHJ2dmc/lC+D4Fa71zpPGVEn5Oz6GHQ+Np+pG2Yvi1gCnUGEioGKZlrvn2bHT7FJ6QOGdmuGRB3x1OtoB1AxSaRJ8MBV77thw9lfZxrc7TLCf7Ym2Xr9bHENRg/rlqoDpDIQG4XkctVUpot9Gi6sWADUBsLqMvXUBQH6+6TBhqjP4vVBBai4TQUnV0rA==" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="completed keyexchange" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="completed challenge" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=info msg="authenticated AP" username="gi*90" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=info msg="authenticated Login5" username="gi*90" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=info msg="accepted zeroconf from iPhone" username="gi*90" Jun 02 12:08:15 stereo sudo[2094]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 12:08:15 stereo sudo[2094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:15 stereo sudo[2094]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:15 stereo sudo[2096]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 12:08:15 stereo sudo[2096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:15 stereo sudo[2096]: pam_unix(sudo:session): session closed for user root Jun 02 12:08:15 stereo sudo[2100]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 02 12:08:15 stereo sudo[2100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="dealer connection opened" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=trace msg="starting accesspoint recv loop" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=trace msg="starting dealer recv loop" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=trace msg="received accesspoint ping" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="received connection id: NjI1MWNkNWUtOTdl...MDVGQjYwNTBDNQ==" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=trace msg="received accesspoint pong ack" Jun 02 12:08:15 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="put connect state because NEW_DEVICE" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="handling transfer player command from 82c0842c6f290897deccfea667930174b3586611" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="resolved context of track" uri="spotify:playlist:37i9dQZF1E8OcMCE2Q72DO" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=trace msg="fetched new page 0 with 50 items (list: 50)" uri="spotify:playlist:37i9dQZF1E8OcMCE2Q72DO" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="shuffled context with seed 13650241338071540701 (len: 50, keep: 23)" uri="spotify:playlist:37i9dQZF1E8OcMCE2Q72DO" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="loading track (paused: true, position: 190769ms)" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=trace msg="emitting websocket event: will_play" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 411" Jun 02 12:08:15 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="selected format OGG_VORBIS_320 (4892a388f423fb971f1f88d30b0908213c78de6f)" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:15 stereo go-librespot[2022]: time="2026-06-02T12:08:15+02:00" level=debug msg="requested aes key for file 4892a388f423fb971f1f88d30b0908213c78de6f, gid: 15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=trace msg="found 2 cdn urls" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1435" Jun 02 12:08:16 stereo volumio[1325]: info: Initializing connection to go-librespot Websocket Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="new websocket client" Jun 02 12:08:16 stereo volumio[1325]: info: Connection to go-librespot Websocket established Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched first chunk of 17, total size is 8488236 bytes" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched chunk 1/16, size: 524288" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched chunk 2/16, size: 524288" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1219" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched chunk 16/16, size: 99628" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched chunk 15/16, size: 524288" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched chunk 14/16, size: 524288" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched chunk 3/16, size: 524288" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="fetched chunk 13/16, size: 524288" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=trace msg="seek to 190769ms (diff: 195ms, samples: 8412912, bytes: 7189386)" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="created new output device" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=info msg="loaded track \"Underneath Your Clothes\" (paused: true, position: 190769ms, duration: 224066ms, prefetched: false)" uri="spotify:track:15f8Cv8RXUlOOCIf2oaceN" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=trace msg="emitting websocket event: metadata" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=trace msg="emitting websocket event: active" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="sending successful reply for dealer request" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 02 12:08:16 stereo volumio[1325]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:15f8Cv8RXUlOOCIf2oaceN","name":"Underneath Your Clothes","artist_names":["Shakira"],"album_name":"Laundry Service","album_cover_url":"https://i.scdn.co/image/ab67616d00001e021f400a1f4d821b00824cf58f","position":190769,"duration":224066,"release_date":"year:2001 month:11 day:13","track_number":2,"disc_number":1}} Jun 02 12:08:16 stereo volumio[1325]: SPOTIFY: received: {"type":"active","data":null} Jun 02 12:08:16 stereo volumio[1325]: info: Aligning Spotify Volume to Volumio Volume Jun 02 12:08:16 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:16 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:16 stereo volumio[1325]: info: Setting Spotify Volume from Volumio: 79 Jun 02 12:08:16 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 12:08:16 stereo volumio[1325]: info: Received Get System Info Jun 02 12:08:16 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 12:08:16 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 12:08:16 stereo volumio[1325]: info: Discovery: Getting this device information Jun 02 12:08:16 stereo volumio[1325]: info: CoreCommandRouter::volumioGetState Jun 02 12:08:16 stereo volumio[1325]: info: CorePlayQueue::getTrack 0 Jun 02 12:08:16 stereo volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 02 12:08:16 stereo go-librespot[2022]: time="2026-06-02T12:08:16+02:00" level=trace msg="emitting websocket event: paused" Jun 02 12:08:16 stereo volumio[1325]: SPOTIFY: received: {"type":"paused","data":{"context_uri":"spotify:playlist:37i9dQZF1E8OcMCE2Q72DO","uri":"spotify:track:15f8Cv8RXUlOOCIf2oaceN","play_origin":"com.spotify.service.carplayv2"}} Jun 02 12:08:16 stereo volumio[1325]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 12:08:16 stereo volumio[1325]: TypeError: Cannot read properties of undefined (reading 'service') Jun 02 12:08:16 stereo volumio[1325]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:346:50) Jun 02 12:08:16 stereo volumio[1325]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:280:18) Jun 02 12:08:16 stereo volumio[1325]: at WebSocket.message (/data/plugins/music_service/spop/index.js:199:14) Jun 02 12:08:16 stereo volumio[1325]: at WebSocket.emit (node:events:514:28) Jun 02 12:08:16 stereo volumio[1325]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Jun 02 12:08:16 stereo volumio[1325]: at Receiver.emit (node:events:514:28) Jun 02 12:08:16 stereo volumio[1325]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Jun 02 12:08:16 stereo volumio[1325]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Jun 02 12:08:16 stereo volumio[1325]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Jun 02 12:08:16 stereo volumio[1325]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Jun 02 12:08:16 stereo volumio[1325]: at writeOrBuffer (node:internal/streams/writable:399:12) Jun 02 12:08:16 stereo volumio[1325]: at _write (node:internal/streams/writable:340:10) Jun 02 12:08:16 stereo volumio[1325]: at Writable.write (node:internal/streams/writable:344:10) Jun 02 12:08:16 stereo volumio[1325]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Jun 02 12:08:16 stereo volumio[1325]: at Socket.emit (node:events:514:28) Jun 02 12:08:16 stereo volumio[1325]: at addChunk (node:internal/streams/readable:343:12) Jun 02 12:08:16 stereo volumio[1325]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 12:08:16 stereo sudo[2117]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-02 12:07' Jun 02 12:08:16 stereo sudo[2117]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"