Sep 16 14:53:00 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:53:00] [info] asio async_connect error: asio.system:111 (Connection refused) Sep 16 14:53:00 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:53:00] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Sep 16 14:53:00 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:53:00] [error] handle_connect error: Connection refused Sep 16 14:53:00 volumio-piter-room ntpd[812]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 14:53:00 volumio-piter-room ntpd[812]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Sep 16 14:53:00 volumio-piter-room ntpd[812]: DNS: Pool taking: 193.70.94.182 Sep 16 14:53:00 volumio-piter-room ntpd[812]: DNS: Pool taking: 193.59.134.156 Sep 16 14:53:00 volumio-piter-room ntpd[812]: DNS: Pool taking: 89.161.47.136 Sep 16 14:53:00 volumio-piter-room ntpd[812]: DNS: Pool taking: 162.159.200.1 Sep 16 14:53:00 volumio-piter-room ntpd[812]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Sep 16 14:53:00 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 2. Sep 16 14:53:01 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:01 volumio-piter-room dnsmasq[1185]: exiting on receipt of SIGTERM Sep 16 14:53:01 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:01 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:01 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:01 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:01 volumio-piter-room hostapd[1195]: rfkill: WLAN soft blocked Sep 16 14:53:01 volumio-piter-room hostapd[1195]: Failed to set beacon parameters Sep 16 14:53:01 volumio-piter-room hostapd[1195]: wlan0: Could not connect to kernel driver Sep 16 14:53:01 volumio-piter-room hostapd[1195]: Interface initialization failed Sep 16 14:53:01 volumio-piter-room hostapd[1195]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:01 volumio-piter-room hostapd[1195]: wlan0: AP-DISABLED Sep 16 14:53:01 volumio-piter-room hostapd[1195]: wlan0: Unable to setup interface. Sep 16 14:53:01 volumio-piter-room hostapd[1195]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:01 volumio-piter-room hostapd[1195]: wlan0: AP-DISABLED Sep 16 14:53:01 volumio-piter-room hostapd[1195]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:01 volumio-piter-room hostapd[1195]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:01 volumio-piter-room hostapd[1195]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:01 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:01 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:01 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:01 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:01 volumio-piter-room systemd[1]: Started smbd.service - Samba SMB Daemon. Sep 16 14:53:01 volumio-piter-room systemd[1]: Reached target multi-user.target - Multi-User System. Sep 16 14:53:01 volumio-piter-room systemd[1]: Reached target graphical.target - Graphical Interface. Sep 16 14:53:01 volumio-piter-room systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Sep 16 14:53:01 volumio-piter-room systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Sep 16 14:53:01 volumio-piter-room systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Sep 16 14:53:01 volumio-piter-room dnsmasq[1204]: started, version 2.90 cachesize 150 Sep 16 14:53:01 volumio-piter-room dnsmasq[1204]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:53:01 volumio-piter-room dnsmasq-dhcp[1204]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:53:01 volumio-piter-room dnsmasq[1204]: reading /etc/resolv.conf Sep 16 14:53:01 volumio-piter-room dnsmasq[1204]: using nameserver 192.168.2.1#53 Sep 16 14:53:01 volumio-piter-room dnsmasq[1204]: using nameserver 208.67.222.222#53 Sep 16 14:53:01 volumio-piter-room dnsmasq[1204]: using nameserver 208.67.220.220#53 Sep 16 14:53:01 volumio-piter-room dnsmasq[1204]: read /etc/hosts - 6 names Sep 16 14:53:01 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:01 volumio-piter-room systemd[1]: Startup finished in 19.997s (kernel) + 21.815s (userspace) = 41.813s. Sep 16 14:53:01 volumio-piter-room ntpd[812]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Sep 16 14:53:01 volumio-piter-room ntpd[812]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Sep 16 14:53:01 volumio-piter-room ntpd[812]: DNS: Pool taking: 195.46.37.22 Sep 16 14:53:01 volumio-piter-room ntpd[812]: DNS: Pool taking: 162.159.200.123 Sep 16 14:53:01 volumio-piter-room ntpd[812]: DNS: Pool taking: 51.68.141.5 Sep 16 14:53:01 volumio-piter-room ntpd[812]: DNS: Pool taking: 178.215.228.24 Sep 16 14:53:01 volumio-piter-room ntpd[812]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Sep 16 14:53:02 volumio-piter-room volumio[1056]: info: ------------------------------------------- Sep 16 14:53:02 volumio-piter-room volumio[1056]: info: ----- Volumio3 ---- Sep 16 14:53:02 volumio-piter-room volumio[1056]: info: ------------------------------------------- Sep 16 14:53:02 volumio-piter-room volumio[1056]: info: ----- System startup ---- Sep 16 14:53:02 volumio-piter-room volumio[1056]: info: ------------------------------------------- Sep 16 14:53:03 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 3. Sep 16 14:53:03 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:03 volumio-piter-room dnsmasq[1204]: exiting on receipt of SIGTERM Sep 16 14:53:03 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:03 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:03 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:03 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:03 volumio-piter-room hostapd[1216]: rfkill: WLAN soft blocked Sep 16 14:53:03 volumio-piter-room hostapd[1216]: Failed to set beacon parameters Sep 16 14:53:03 volumio-piter-room hostapd[1216]: wlan0: Could not connect to kernel driver Sep 16 14:53:03 volumio-piter-room hostapd[1216]: Interface initialization failed Sep 16 14:53:03 volumio-piter-room hostapd[1216]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:03 volumio-piter-room hostapd[1216]: wlan0: AP-DISABLED Sep 16 14:53:03 volumio-piter-room hostapd[1216]: wlan0: Unable to setup interface. Sep 16 14:53:03 volumio-piter-room hostapd[1216]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:03 volumio-piter-room hostapd[1216]: wlan0: AP-DISABLED Sep 16 14:53:03 volumio-piter-room hostapd[1216]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:03 volumio-piter-room hostapd[1216]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:03 volumio-piter-room hostapd[1216]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:04 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:04 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:04 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:04 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:04 volumio-piter-room dnsmasq[1221]: started, version 2.90 cachesize 150 Sep 16 14:53:04 volumio-piter-room dnsmasq[1221]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:53:04 volumio-piter-room dnsmasq-dhcp[1221]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:53:04 volumio-piter-room dnsmasq[1221]: reading /etc/resolv.conf Sep 16 14:53:04 volumio-piter-room dnsmasq[1221]: using nameserver 192.168.2.1#53 Sep 16 14:53:04 volumio-piter-room dnsmasq[1221]: using nameserver 208.67.222.222#53 Sep 16 14:53:04 volumio-piter-room dnsmasq[1221]: using nameserver 208.67.220.220#53 Sep 16 14:53:04 volumio-piter-room dnsmasq[1221]: read /etc/hosts - 6 names Sep 16 14:53:04 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:04 volumio-piter-room volumio[1056]: info: MYVOLUMIO Environment detected Sep 16 14:53:44 volumio-piter-room ntpd[812]: CLOCK: time stepped by 39.922700 Sep 16 14:53:44 volumio-piter-room ntpd[812]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Plugin folders cleanup Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning into folder /volumio/app/plugins/ Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category audio_interface Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category miscellanea Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category music_service Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category plugins.json Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category system_controller Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category user_interface Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning into folder /data/plugins/ Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category music_service Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category system_controller Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category system_hardware Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Scanning category user_interface Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Plugin folders cleanup completed Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: ------------------------------------------- Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: ----- Core plugins startup ---- Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: ------------------------------------------- Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Loading plugins from folder /volumio/app/plugins/ Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Adding plugin upnp to MyMusic Plugins Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Loading plugins from folder /data/plugins/ Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Loading plugin "system"... Sep 16 14:53:44 volumio-piter-room volumio[1056]: info: Loading plugin "appearance"... Sep 16 14:53:46 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 4. Sep 16 14:53:46 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:46 volumio-piter-room dnsmasq[1221]: exiting on receipt of SIGTERM Sep 16 14:53:46 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:46 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:46 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:46 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:46 volumio-piter-room hostapd[1231]: rfkill: WLAN soft blocked Sep 16 14:53:46 volumio-piter-room hostapd[1231]: Failed to set beacon parameters Sep 16 14:53:46 volumio-piter-room hostapd[1231]: wlan0: Could not connect to kernel driver Sep 16 14:53:46 volumio-piter-room hostapd[1231]: Interface initialization failed Sep 16 14:53:46 volumio-piter-room hostapd[1231]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:46 volumio-piter-room hostapd[1231]: wlan0: AP-DISABLED Sep 16 14:53:46 volumio-piter-room hostapd[1231]: wlan0: Unable to setup interface. Sep 16 14:53:46 volumio-piter-room hostapd[1231]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:46 volumio-piter-room hostapd[1231]: wlan0: AP-DISABLED Sep 16 14:53:46 volumio-piter-room hostapd[1231]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:46 volumio-piter-room hostapd[1231]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:46 volumio-piter-room hostapd[1231]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:46 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:46 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:46 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:46 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:46 volumio-piter-room dnsmasq[1236]: started, version 2.90 cachesize 150 Sep 16 14:53:46 volumio-piter-room dnsmasq[1236]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:53:46 volumio-piter-room dnsmasq-dhcp[1236]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:53:46 volumio-piter-room dnsmasq[1236]: reading /etc/resolv.conf Sep 16 14:53:46 volumio-piter-room dnsmasq[1236]: using nameserver 192.168.2.1#53 Sep 16 14:53:46 volumio-piter-room dnsmasq[1236]: using nameserver 208.67.222.222#53 Sep 16 14:53:46 volumio-piter-room dnsmasq[1236]: using nameserver 208.67.220.220#53 Sep 16 14:53:46 volumio-piter-room dnsmasq[1236]: read /etc/hosts - 6 names Sep 16 14:53:46 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "network"... Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Refreshing Cached IP Addresses Sep 16 14:53:47 volumio-piter-room sudo[1240]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "services"... Sep 16 14:53:47 volumio-piter-room sudo[1240]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "alsa_controller"... Sep 16 14:53:47 volumio-piter-room sudo[1242]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 14:53:47 volumio-piter-room sudo[1240]: pam_unix(sudo:session): session closed for user root Sep 16 14:53:47 volumio-piter-room sudo[1242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:53:47 volumio-piter-room sudo[1242]: pam_unix(sudo:session): session closed for user root Sep 16 14:53:47 volumio-piter-room sudo[1252]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 14:53:47 volumio-piter-room sudo[1252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:53:47 volumio-piter-room sudo[1252]: pam_unix(sudo:session): session closed for user root Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "wizard"... Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "networkfs"... Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Starting Udev Watcher for removable devices Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Ignoring mount for partition: boot Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Ignoring mount for partition: volumio Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Ignoring mount for partition: volumio_data Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "volumio_command_line_client"... Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "upnp"... Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: [1758027227826] Starting Upmpd Daemon Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "my_music"... Sep 16 14:53:47 volumio-piter-room volumio[1056]: info: Loading plugin "mpd"... Sep 16 14:53:48 volumio-piter-room volumio[1056]: info: Loading plugin "upnp_browser"... Sep 16 14:53:48 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 5. Sep 16 14:53:48 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:48 volumio-piter-room dnsmasq[1236]: exiting on receipt of SIGTERM Sep 16 14:53:48 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:48 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:48 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:48 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:48 volumio-piter-room hostapd[1274]: rfkill: WLAN soft blocked Sep 16 14:53:48 volumio-piter-room hostapd[1274]: Failed to set beacon parameters Sep 16 14:53:48 volumio-piter-room hostapd[1274]: wlan0: Could not connect to kernel driver Sep 16 14:53:48 volumio-piter-room hostapd[1274]: Interface initialization failed Sep 16 14:53:48 volumio-piter-room hostapd[1274]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:48 volumio-piter-room hostapd[1274]: wlan0: AP-DISABLED Sep 16 14:53:48 volumio-piter-room hostapd[1274]: wlan0: Unable to setup interface. Sep 16 14:53:48 volumio-piter-room hostapd[1274]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:48 volumio-piter-room hostapd[1274]: wlan0: AP-DISABLED Sep 16 14:53:48 volumio-piter-room hostapd[1274]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:48 volumio-piter-room hostapd[1274]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:48 volumio-piter-room hostapd[1274]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:49 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:49 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:49 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:49 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:49 volumio-piter-room dnsmasq[1279]: started, version 2.90 cachesize 150 Sep 16 14:53:49 volumio-piter-room dnsmasq[1279]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:53:49 volumio-piter-room dnsmasq-dhcp[1279]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:53:49 volumio-piter-room dnsmasq[1279]: reading /etc/resolv.conf Sep 16 14:53:49 volumio-piter-room dnsmasq[1279]: using nameserver 192.168.2.1#53 Sep 16 14:53:49 volumio-piter-room dnsmasq[1279]: using nameserver 208.67.222.222#53 Sep 16 14:53:49 volumio-piter-room dnsmasq[1279]: using nameserver 208.67.220.220#53 Sep 16 14:53:49 volumio-piter-room dnsmasq[1279]: read /etc/hosts - 6 names Sep 16 14:53:49 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:50 volumio-piter-room volumio[1056]: info: Loading plugin "alarm-clock"... Sep 16 14:53:50 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:53:50] [connect] Successful connection Sep 16 14:53:50 volumio-piter-room volumio[1056]: info: Loading plugin "airplay_emulation"... Sep 16 14:53:50 volumio-piter-room volumio[1056]: info: Starting Shairport Sync Sep 16 14:53:50 volumio-piter-room volumio[1056]: info: Loading plugin "last_100"... Sep 16 14:53:50 volumio-piter-room volumio[1056]: info: Loading plugin "webradio"... Sep 16 14:53:51 volumio-piter-room volumio[1056]: info: Loading plugin "i2s_dacs"... Sep 16 14:53:51 volumio-piter-room volumio[1056]: info: I2S DAC not set, start Auto-detection Sep 16 14:53:51 volumio-piter-room volumio[1056]: info: Loading plugin "volumiodiscovery"... Sep 16 14:53:51 volumio-piter-room volumio[1056]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 14:53:51 volumio-piter-room volumio[1056]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 14:53:51 volumio-piter-room volumio[1056]: *** WARNING *** For more information see Sep 16 14:53:51 volumio-piter-room volumio[1056]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 14:53:51 volumio-piter-room volumio[1056]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 14:53:51 volumio-piter-room node[1056]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 14:53:51 volumio-piter-room volumio[1056]: *** WARNING *** For more information see Sep 16 14:53:51 volumio-piter-room node[1056]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 14:53:51 volumio-piter-room node[1056]: *** WARNING *** For more information see Sep 16 14:53:51 volumio-piter-room node[1056]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 14:53:51 volumio-piter-room node[1056]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 14:53:51 volumio-piter-room node[1056]: *** WARNING *** For more information see Sep 16 14:53:51 volumio-piter-room volumio[1056]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 16 14:53:51 volumio-piter-room volumio[1056]: info: Discovery: Started advertising with name: VOLUMIO PITER ROOM Sep 16 14:53:51 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 6. Sep 16 14:53:51 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 14:53:51 volumio-piter-room volumio[1056]: info: Loading plugin "spop"... Sep 16 14:53:51 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:51 volumio-piter-room dnsmasq[1279]: exiting on receipt of SIGTERM Sep 16 14:53:51 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:51 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:51 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:51 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:51 volumio-piter-room hostapd[1285]: rfkill: WLAN soft blocked Sep 16 14:53:51 volumio-piter-room hostapd[1285]: Failed to set beacon parameters Sep 16 14:53:51 volumio-piter-room hostapd[1285]: wlan0: Could not connect to kernel driver Sep 16 14:53:51 volumio-piter-room hostapd[1285]: Interface initialization failed Sep 16 14:53:51 volumio-piter-room hostapd[1285]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:51 volumio-piter-room hostapd[1285]: wlan0: AP-DISABLED Sep 16 14:53:51 volumio-piter-room hostapd[1285]: wlan0: Unable to setup interface. Sep 16 14:53:51 volumio-piter-room hostapd[1285]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:51 volumio-piter-room hostapd[1285]: wlan0: AP-DISABLED Sep 16 14:53:51 volumio-piter-room hostapd[1285]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:51 volumio-piter-room hostapd[1285]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:51 volumio-piter-room hostapd[1285]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:52 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:52 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:52 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:52 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:52 volumio-piter-room dnsmasq[1290]: started, version 2.90 cachesize 150 Sep 16 14:53:52 volumio-piter-room dnsmasq[1290]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:53:52 volumio-piter-room dnsmasq-dhcp[1290]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:53:52 volumio-piter-room dnsmasq[1290]: reading /etc/resolv.conf Sep 16 14:53:52 volumio-piter-room dnsmasq[1290]: using nameserver 192.168.2.1#53 Sep 16 14:53:52 volumio-piter-room dnsmasq[1290]: using nameserver 208.67.222.222#53 Sep 16 14:53:52 volumio-piter-room dnsmasq[1290]: using nameserver 208.67.220.220#53 Sep 16 14:53:52 volumio-piter-room dnsmasq[1290]: read /etc/hosts - 6 names Sep 16 14:53:52 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:53 volumio-piter-room volumio[1056]: info: Loading plugin "youtube2"... Sep 16 14:53:54 volumio-piter-room systemd[1]: systemd-fsckd.service: Deactivated successfully. Sep 16 14:53:54 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 7. Sep 16 14:53:54 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:54 volumio-piter-room dnsmasq[1290]: exiting on receipt of SIGTERM Sep 16 14:53:54 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:54 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:54 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:54 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:54 volumio-piter-room hostapd[1294]: rfkill: WLAN soft blocked Sep 16 14:53:54 volumio-piter-room hostapd[1294]: Failed to set beacon parameters Sep 16 14:53:54 volumio-piter-room hostapd[1294]: wlan0: Could not connect to kernel driver Sep 16 14:53:54 volumio-piter-room hostapd[1294]: Interface initialization failed Sep 16 14:53:54 volumio-piter-room hostapd[1294]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:54 volumio-piter-room hostapd[1294]: wlan0: AP-DISABLED Sep 16 14:53:54 volumio-piter-room hostapd[1294]: wlan0: Unable to setup interface. Sep 16 14:53:54 volumio-piter-room hostapd[1294]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:54 volumio-piter-room hostapd[1294]: wlan0: AP-DISABLED Sep 16 14:53:54 volumio-piter-room hostapd[1294]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:54 volumio-piter-room hostapd[1294]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:54 volumio-piter-room hostapd[1294]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:54 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:54 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:54 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:55 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:55 volumio-piter-room dnsmasq[1299]: started, version 2.90 cachesize 150 Sep 16 14:53:55 volumio-piter-room dnsmasq[1299]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:53:55 volumio-piter-room dnsmasq-dhcp[1299]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:53:55 volumio-piter-room dnsmasq[1299]: reading /etc/resolv.conf Sep 16 14:53:55 volumio-piter-room dnsmasq[1299]: using nameserver 192.168.2.1#53 Sep 16 14:53:55 volumio-piter-room dnsmasq[1299]: using nameserver 208.67.222.222#53 Sep 16 14:53:55 volumio-piter-room dnsmasq[1299]: using nameserver 208.67.220.220#53 Sep 16 14:53:55 volumio-piter-room dnsmasq[1299]: read /etc/hosts - 6 names Sep 16 14:53:55 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:56 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 8. Sep 16 14:53:57 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:57 volumio-piter-room dnsmasq[1299]: exiting on receipt of SIGTERM Sep 16 14:53:57 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:57 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:57 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:57 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:57 volumio-piter-room hostapd[1303]: rfkill: WLAN soft blocked Sep 16 14:53:57 volumio-piter-room hostapd[1303]: Failed to set beacon parameters Sep 16 14:53:57 volumio-piter-room hostapd[1303]: wlan0: Could not connect to kernel driver Sep 16 14:53:57 volumio-piter-room hostapd[1303]: Interface initialization failed Sep 16 14:53:57 volumio-piter-room hostapd[1303]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:57 volumio-piter-room hostapd[1303]: wlan0: AP-DISABLED Sep 16 14:53:57 volumio-piter-room hostapd[1303]: wlan0: Unable to setup interface. Sep 16 14:53:57 volumio-piter-room hostapd[1303]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:57 volumio-piter-room hostapd[1303]: wlan0: AP-DISABLED Sep 16 14:53:57 volumio-piter-room hostapd[1303]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:57 volumio-piter-room hostapd[1303]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:57 volumio-piter-room hostapd[1303]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:57 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:57 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:57 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:57 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:57 volumio-piter-room dnsmasq[1308]: started, version 2.90 cachesize 150 Sep 16 14:53:57 volumio-piter-room dnsmasq[1308]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:53:57 volumio-piter-room dnsmasq-dhcp[1308]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:53:57 volumio-piter-room dnsmasq[1308]: reading /etc/resolv.conf Sep 16 14:53:57 volumio-piter-room dnsmasq[1308]: using nameserver 192.168.2.1#53 Sep 16 14:53:57 volumio-piter-room dnsmasq[1308]: using nameserver 208.67.222.222#53 Sep 16 14:53:57 volumio-piter-room dnsmasq[1308]: using nameserver 208.67.220.220#53 Sep 16 14:53:57 volumio-piter-room dnsmasq[1308]: read /etc/hosts - 6 names Sep 16 14:53:57 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:58 volumio-piter-room volumio[1056]: info: Loading plugin "ytmusic"... Sep 16 14:53:59 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 9. Sep 16 14:53:59 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:53:59 volumio-piter-room dnsmasq[1308]: exiting on receipt of SIGTERM Sep 16 14:53:59 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:53:59 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:53:59 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:53:59 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:53:59 volumio-piter-room hostapd[1326]: rfkill: WLAN soft blocked Sep 16 14:53:59 volumio-piter-room hostapd[1326]: Failed to set beacon parameters Sep 16 14:53:59 volumio-piter-room hostapd[1326]: wlan0: Could not connect to kernel driver Sep 16 14:53:59 volumio-piter-room hostapd[1326]: Interface initialization failed Sep 16 14:53:59 volumio-piter-room hostapd[1326]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:53:59 volumio-piter-room hostapd[1326]: wlan0: AP-DISABLED Sep 16 14:53:59 volumio-piter-room hostapd[1326]: wlan0: Unable to setup interface. Sep 16 14:53:59 volumio-piter-room hostapd[1326]: wlan0: interface state DISABLED->DISABLED Sep 16 14:53:59 volumio-piter-room hostapd[1326]: wlan0: AP-DISABLED Sep 16 14:53:59 volumio-piter-room hostapd[1326]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:53:59 volumio-piter-room hostapd[1326]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:53:59 volumio-piter-room hostapd[1326]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:53:59 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:53:59 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:53:59 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:00 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:00 volumio-piter-room dnsmasq[1331]: started, version 2.90 cachesize 150 Sep 16 14:54:00 volumio-piter-room dnsmasq[1331]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:00 volumio-piter-room dnsmasq-dhcp[1331]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:00 volumio-piter-room dnsmasq[1331]: reading /etc/resolv.conf Sep 16 14:54:00 volumio-piter-room dnsmasq[1331]: using nameserver 192.168.2.1#53 Sep 16 14:54:00 volumio-piter-room dnsmasq[1331]: using nameserver 208.67.222.222#53 Sep 16 14:54:00 volumio-piter-room dnsmasq[1331]: using nameserver 208.67.220.220#53 Sep 16 14:54:00 volumio-piter-room dnsmasq[1331]: read /etc/hosts - 6 names Sep 16 14:54:00 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:00 volumio-piter-room systemd[1]: systemd-timedated.service: Deactivated successfully. Sep 16 14:54:02 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 10. Sep 16 14:54:02 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:02 volumio-piter-room dnsmasq[1331]: exiting on receipt of SIGTERM Sep 16 14:54:02 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:02 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:02 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:02 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:02 volumio-piter-room hostapd[1337]: rfkill: WLAN soft blocked Sep 16 14:54:02 volumio-piter-room hostapd[1337]: Failed to set beacon parameters Sep 16 14:54:02 volumio-piter-room hostapd[1337]: wlan0: Could not connect to kernel driver Sep 16 14:54:02 volumio-piter-room hostapd[1337]: Interface initialization failed Sep 16 14:54:02 volumio-piter-room hostapd[1337]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:02 volumio-piter-room hostapd[1337]: wlan0: AP-DISABLED Sep 16 14:54:02 volumio-piter-room hostapd[1337]: wlan0: Unable to setup interface. Sep 16 14:54:02 volumio-piter-room hostapd[1337]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:02 volumio-piter-room hostapd[1337]: wlan0: AP-DISABLED Sep 16 14:54:02 volumio-piter-room hostapd[1337]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:02 volumio-piter-room hostapd[1337]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:02 volumio-piter-room hostapd[1337]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:02 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:02 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:02 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:02 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:02 volumio-piter-room systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 16 14:54:03 volumio-piter-room volumio[1056]: info: Loading plugin "autostart"... Sep 16 14:54:03 volumio-piter-room dnsmasq[1346]: started, version 2.90 cachesize 150 Sep 16 14:54:03 volumio-piter-room dnsmasq[1346]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:03 volumio-piter-room dnsmasq-dhcp[1346]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:03 volumio-piter-room dnsmasq[1346]: reading /etc/resolv.conf Sep 16 14:54:03 volumio-piter-room dnsmasq[1346]: using nameserver 192.168.2.1#53 Sep 16 14:54:03 volumio-piter-room dnsmasq[1346]: using nameserver 208.67.222.222#53 Sep 16 14:54:03 volumio-piter-room dnsmasq[1346]: using nameserver 208.67.220.220#53 Sep 16 14:54:03 volumio-piter-room dnsmasq[1346]: read /etc/hosts - 6 names Sep 16 14:54:03 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:03 volumio-piter-room volumio[1056]: info: Applying required configuration parameters for plugin autostart Sep 16 14:54:03 volumio-piter-room volumio[1056]: info: AutoStart - onVolumioStart - read config.json Sep 16 14:54:03 volumio-piter-room volumio[1056]: info: Loading plugin "now_playing"... Sep 16 14:54:04 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 11. Sep 16 14:54:05 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:05 volumio-piter-room dnsmasq[1346]: exiting on receipt of SIGTERM Sep 16 14:54:05 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:05 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:05 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:05 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:05 volumio-piter-room hostapd[1350]: rfkill: WLAN soft blocked Sep 16 14:54:05 volumio-piter-room hostapd[1350]: Failed to set beacon parameters Sep 16 14:54:05 volumio-piter-room hostapd[1350]: wlan0: Could not connect to kernel driver Sep 16 14:54:05 volumio-piter-room hostapd[1350]: Interface initialization failed Sep 16 14:54:05 volumio-piter-room hostapd[1350]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:05 volumio-piter-room hostapd[1350]: wlan0: AP-DISABLED Sep 16 14:54:05 volumio-piter-room hostapd[1350]: wlan0: Unable to setup interface. Sep 16 14:54:05 volumio-piter-room hostapd[1350]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:05 volumio-piter-room hostapd[1350]: wlan0: AP-DISABLED Sep 16 14:54:05 volumio-piter-room hostapd[1350]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:05 volumio-piter-room hostapd[1350]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:05 volumio-piter-room hostapd[1350]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:05 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:05 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:05 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:05 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:54:05] [connect] Successful connection Sep 16 14:54:05 volumio-piter-room volumio[1056]: info: Loading plugin "outputs"... Sep 16 14:54:05 volumio-piter-room volumio[1056]: info: Loading plugin "albumart"... Sep 16 14:54:05 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:05 volumio-piter-room volumio[1056]: info: Plugin example_plugin is not enabled Sep 16 14:54:05 volumio-piter-room volumio[1056]: info: Loading plugin "inputs"... Sep 16 14:54:05 volumio-piter-room volumio[1056]: info: Loading plugin "updater_comm"... Sep 16 14:54:05 volumio-piter-room dnsmasq[1363]: started, version 2.90 cachesize 150 Sep 16 14:54:05 volumio-piter-room dnsmasq[1363]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:05 volumio-piter-room dnsmasq-dhcp[1363]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:05 volumio-piter-room dnsmasq[1363]: reading /etc/resolv.conf Sep 16 14:54:05 volumio-piter-room dnsmasq[1363]: using nameserver 192.168.2.1#53 Sep 16 14:54:05 volumio-piter-room dnsmasq[1363]: using nameserver 208.67.222.222#53 Sep 16 14:54:05 volumio-piter-room dnsmasq[1363]: using nameserver 208.67.220.220#53 Sep 16 14:54:05 volumio-piter-room dnsmasq[1363]: read /etc/hosts - 6 names Sep 16 14:54:05 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:06 volumio-piter-room volumio[1056]: info: Plugin mpdemulation is not enabled Sep 16 14:54:06 volumio-piter-room volumio[1056]: info: Loading plugin "rest_api"... Sep 16 14:54:06 volumio-piter-room volumio[1056]: info: Loading plugin "websocket"... Sep 16 14:54:06 volumio-piter-room volumio[1056]: info: Starting Socket.io Server version 1.7.4 Sep 16 14:54:06 volumio-piter-room volumio[1056]: info: Loading plugin "Bluetoothremote"... Sep 16 14:54:06 volumio-piter-room volumio[1353]: Forking 3 albumart workers Sep 16 14:54:07 volumio-piter-room volumio[1056]: info: Applying required configuration parameters for plugin Bluetoothremote Sep 16 14:54:07 volumio-piter-room volumio[1056]: info: Loading plugin "peppymeterbasic"... Sep 16 14:54:07 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 12. Sep 16 14:54:07 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:07 volumio-piter-room dnsmasq[1363]: exiting on receipt of SIGTERM Sep 16 14:54:07 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:07 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:07 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:07 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:07 volumio-piter-room hostapd[1402]: rfkill: WLAN soft blocked Sep 16 14:54:07 volumio-piter-room hostapd[1402]: Failed to set beacon parameters Sep 16 14:54:07 volumio-piter-room hostapd[1402]: wlan0: Could not connect to kernel driver Sep 16 14:54:07 volumio-piter-room hostapd[1402]: Interface initialization failed Sep 16 14:54:07 volumio-piter-room hostapd[1402]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:07 volumio-piter-room hostapd[1402]: wlan0: AP-DISABLED Sep 16 14:54:07 volumio-piter-room hostapd[1402]: wlan0: Unable to setup interface. Sep 16 14:54:07 volumio-piter-room hostapd[1402]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:07 volumio-piter-room hostapd[1402]: wlan0: AP-DISABLED Sep 16 14:54:07 volumio-piter-room hostapd[1402]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:07 volumio-piter-room hostapd[1402]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:07 volumio-piter-room hostapd[1402]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:07 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:07 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:07 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:07 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:08 volumio-piter-room dnsmasq[1418]: started, version 2.90 cachesize 150 Sep 16 14:54:08 volumio-piter-room dnsmasq[1418]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:08 volumio-piter-room dnsmasq-dhcp[1418]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:08 volumio-piter-room dnsmasq[1418]: reading /etc/resolv.conf Sep 16 14:54:08 volumio-piter-room dnsmasq[1418]: using nameserver 192.168.2.1#53 Sep 16 14:54:08 volumio-piter-room dnsmasq[1418]: using nameserver 208.67.222.222#53 Sep 16 14:54:08 volumio-piter-room dnsmasq[1418]: using nameserver 208.67.220.220#53 Sep 16 14:54:08 volumio-piter-room dnsmasq[1418]: read /etc/hosts - 6 names Sep 16 14:54:08 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:09 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 13. Sep 16 14:54:09 volumio-piter-room volumio[1056]: info: Loading plugin "touch_display"... Sep 16 14:54:09 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:10 volumio-piter-room dnsmasq[1418]: exiting on receipt of SIGTERM Sep 16 14:54:10 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:10 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:10 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:10 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:10 volumio-piter-room hostapd[1422]: rfkill: WLAN soft blocked Sep 16 14:54:10 volumio-piter-room hostapd[1422]: Failed to set beacon parameters Sep 16 14:54:10 volumio-piter-room hostapd[1422]: wlan0: Could not connect to kernel driver Sep 16 14:54:10 volumio-piter-room hostapd[1422]: Interface initialization failed Sep 16 14:54:10 volumio-piter-room hostapd[1422]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:10 volumio-piter-room hostapd[1422]: wlan0: AP-DISABLED Sep 16 14:54:10 volumio-piter-room hostapd[1422]: wlan0: Unable to setup interface. Sep 16 14:54:10 volumio-piter-room hostapd[1422]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:10 volumio-piter-room hostapd[1422]: wlan0: AP-DISABLED Sep 16 14:54:10 volumio-piter-room hostapd[1422]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:10 volumio-piter-room hostapd[1422]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:10 volumio-piter-room hostapd[1422]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:10 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:10 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:10 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:10 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:10 volumio-piter-room dnsmasq[1427]: started, version 2.90 cachesize 150 Sep 16 14:54:10 volumio-piter-room dnsmasq[1427]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:10 volumio-piter-room dnsmasq-dhcp[1427]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:10 volumio-piter-room dnsmasq[1427]: reading /etc/resolv.conf Sep 16 14:54:10 volumio-piter-room dnsmasq[1427]: using nameserver 192.168.2.1#53 Sep 16 14:54:10 volumio-piter-room dnsmasq[1427]: using nameserver 208.67.222.222#53 Sep 16 14:54:10 volumio-piter-room dnsmasq[1427]: using nameserver 208.67.220.220#53 Sep 16 14:54:10 volumio-piter-room dnsmasq[1427]: read /etc/hosts - 6 names Sep 16 14:54:10 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:12 volumio-piter-room volumio[1056]: info: Applying required configuration parameters for plugin touch_display Sep 16 14:54:12 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 14. Sep 16 14:54:12 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:12 volumio-piter-room dnsmasq[1427]: exiting on receipt of SIGTERM Sep 16 14:54:12 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:12 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:12 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:12 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:12 volumio-piter-room hostapd[1431]: rfkill: WLAN soft blocked Sep 16 14:54:12 volumio-piter-room hostapd[1431]: Failed to set beacon parameters Sep 16 14:54:12 volumio-piter-room hostapd[1431]: wlan0: Could not connect to kernel driver Sep 16 14:54:12 volumio-piter-room hostapd[1431]: Interface initialization failed Sep 16 14:54:12 volumio-piter-room hostapd[1431]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:12 volumio-piter-room hostapd[1431]: wlan0: AP-DISABLED Sep 16 14:54:12 volumio-piter-room hostapd[1431]: wlan0: Unable to setup interface. Sep 16 14:54:12 volumio-piter-room hostapd[1431]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:12 volumio-piter-room hostapd[1431]: wlan0: AP-DISABLED Sep 16 14:54:12 volumio-piter-room hostapd[1431]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:12 volumio-piter-room hostapd[1431]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:12 volumio-piter-room hostapd[1431]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:12 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:12 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:12 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:12 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:12 volumio-piter-room dnsmasq[1436]: started, version 2.90 cachesize 150 Sep 16 14:54:12 volumio-piter-room dnsmasq[1436]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:12 volumio-piter-room dnsmasq-dhcp[1436]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:12 volumio-piter-room dnsmasq[1436]: reading /etc/resolv.conf Sep 16 14:54:12 volumio-piter-room dnsmasq[1436]: using nameserver 192.168.2.1#53 Sep 16 14:54:12 volumio-piter-room dnsmasq[1436]: using nameserver 208.67.222.222#53 Sep 16 14:54:12 volumio-piter-room dnsmasq[1436]: using nameserver 208.67.220.220#53 Sep 16 14:54:12 volumio-piter-room dnsmasq[1436]: read /etc/hosts - 6 names Sep 16 14:54:12 volumio-piter-room systemd[1]: dnsmasq.service: Supervising process 1436 which is not our child. We'll most likely not notice when it exits. Sep 16 14:54:12 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:13 volumio-piter-room volumio[1370]: Starting albumart workers Sep 16 14:54:13 volumio-piter-room volumio[1056]: info: Loading i18n strings for locale pl Sep 16 14:54:13 volumio-piter-room volumio[1056]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 14:54:13 volumio-piter-room volumio[1056]: Updating browse sources language Sep 16 14:54:13 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:13 volumio-piter-room volumio[1369]: Starting albumart workers Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::initPlayerControls Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 14:54:14 volumio-piter-room volumio[1056]: Express server listening on port 3000 Sep 16 14:54:14 volumio-piter-room volumio[1056]: [Metrics] WebUI: 32s 406.62ms Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreStateMachine::resetVolumioState Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreStateMachine::getcurrentVolume Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:14 volumio-piter-room sudo[1444]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 14:54:14 volumio-piter-room sudo[1444]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:14 volumio-piter-room sudo[1444]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:14 volumio-piter-room volumio[1368]: Starting albumart workers Sep 16 14:54:14 volumio-piter-room sudo[1446]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 14:54:14 volumio-piter-room sudo[1446]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:14 volumio-piter-room sudo[1446]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:14 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 15. Sep 16 14:54:14 volumio-piter-room volumio[1056]: info: Volumio Network Manager: Network status updated: 1 Sep 16 14:54:14 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:14 volumio-piter-room systemd[1]: dnsmasq.service: Killing process 1436 (dnsmasq) with signal SIGKILL. Sep 16 14:54:14 volumio-piter-room systemd[1]: dnsmasq.service: Killing process 1436 (dnsmasq) with signal SIGKILL. Sep 16 14:54:14 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:14 volumio-piter-room systemd[1]: dnsmasq.service: Unit process 1436 (dnsmasq) remains running after unit stopped. Sep 16 14:54:14 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:14 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:14 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:15 volumio-piter-room hostapd[1450]: rfkill: WLAN soft blocked Sep 16 14:54:15 volumio-piter-room hostapd[1450]: Failed to set beacon parameters Sep 16 14:54:15 volumio-piter-room hostapd[1450]: wlan0: Could not connect to kernel driver Sep 16 14:54:15 volumio-piter-room hostapd[1450]: Interface initialization failed Sep 16 14:54:15 volumio-piter-room hostapd[1450]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:15 volumio-piter-room hostapd[1450]: wlan0: AP-DISABLED Sep 16 14:54:15 volumio-piter-room hostapd[1450]: wlan0: Unable to setup interface. Sep 16 14:54:15 volumio-piter-room hostapd[1450]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:15 volumio-piter-room hostapd[1450]: wlan0: AP-DISABLED Sep 16 14:54:15 volumio-piter-room hostapd[1450]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:15 volumio-piter-room hostapd[1450]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:15 volumio-piter-room hostapd[1450]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:15 volumio-piter-room volumio[1056]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 16 14:54:15 volumio-piter-room volumio[1056]: wlan0 Interface doesn't support scanning : Network is down Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: Cannot use regular scanning, forcing with ap-force Sep 16 14:54:15 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:15 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:15 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:15 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:15 volumio-piter-room sudo[1455]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 16 14:54:15 volumio-piter-room sudo[1455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:15 volumio-piter-room sudo[1455]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:15 volumio-piter-room volumio[1056]: command failed: Network is down (-100) Sep 16 14:54:15 volumio-piter-room volumio[1056]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 16 14:54:15 volumio-piter-room volumio[1056]: command failed: Network is down (-100) Sep 16 14:54:15 volumio-piter-room dnsmasq[1460]: started, version 2.90 cachesize 150 Sep 16 14:54:15 volumio-piter-room dnsmasq[1460]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:15 volumio-piter-room dnsmasq-dhcp[1460]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:15 volumio-piter-room dnsmasq[1460]: reading /etc/resolv.conf Sep 16 14:54:15 volumio-piter-room dnsmasq[1460]: using nameserver 192.168.2.1#53 Sep 16 14:54:15 volumio-piter-room dnsmasq[1460]: using nameserver 208.67.222.222#53 Sep 16 14:54:15 volumio-piter-room dnsmasq[1460]: using nameserver 208.67.220.220#53 Sep 16 14:54:15 volumio-piter-room dnsmasq[1460]: read /etc/hosts - 6 names Sep 16 14:54:15 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:15 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 1 Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: VolumeController:: Volume=5 Mute =false Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: CoreStateMachine::pushState Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioPushState Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: CoreStateMachine::updateTrackBlock Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrackBlock Sep 16 14:54:15 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 14:54:16 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 2 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: Reloading queue from file Sep 16 14:54:16 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 3 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreStateMachine::setRepeat null single undefined Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreStateMachine::pushState Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioPushState Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreStateMachine::setRandom null Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreStateMachine::pushState Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioPushState Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: Setting Device type: Raspberry PI Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03112 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 16 14:54:16 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 4 Sep 16 14:54:16 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 5 Sep 16 14:54:16 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 6 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: VolumeController:: Volume=5 Mute =false Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreStateMachine::pushState Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioPushState Sep 16 14:54:16 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 7 Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetState Sep 16 14:54:16 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:16 volumio-piter-room sudo[1477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 16 14:54:16 volumio-piter-room sudo[1477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:17 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 8 Sep 16 14:54:17 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 9 Sep 16 14:54:17 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 16. Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:17 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:17 volumio-piter-room dnsmasq[1460]: exiting on receipt of SIGTERM Sep 16 14:54:17 volumio-piter-room systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Sep 16 14:54:17 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:17 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:17 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: Listing playlists Sep 16 14:54:17 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:17 volumio-piter-room sudo[1477]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:17 volumio-piter-room hostapd[1492]: rfkill: WLAN soft blocked Sep 16 14:54:17 volumio-piter-room hostapd[1492]: Failed to set beacon parameters Sep 16 14:54:17 volumio-piter-room hostapd[1492]: wlan0: Could not connect to kernel driver Sep 16 14:54:17 volumio-piter-room hostapd[1492]: Interface initialization failed Sep 16 14:54:17 volumio-piter-room hostapd[1492]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:17 volumio-piter-room hostapd[1492]: wlan0: AP-DISABLED Sep 16 14:54:17 volumio-piter-room hostapd[1492]: wlan0: Unable to setup interface. Sep 16 14:54:17 volumio-piter-room hostapd[1492]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:17 volumio-piter-room hostapd[1492]: wlan0: AP-DISABLED Sep 16 14:54:17 volumio-piter-room hostapd[1492]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:17 volumio-piter-room hostapd[1492]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:17 volumio-piter-room hostapd[1492]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: Discovery: adding 9992bd7f-303c-4d6b-abb1-8779e9fad663 Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: Discovery: Found device VOLUMIO PITER ROOM Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetState Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: Discovery: this is already registered, 9992bd7f-303c-4d6b-abb1-8779e9fad663 Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: Discovery: Found device VOLUMIO PITER ROOM Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetState Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:17 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:17 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:17 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:17 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:17 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 10 Sep 16 14:54:17 volumio-piter-room dnsmasq[1507]: started, version 2.90 cachesize 150 Sep 16 14:54:17 volumio-piter-room dnsmasq[1507]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:17 volumio-piter-room dnsmasq-dhcp[1507]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:17 volumio-piter-room dnsmasq[1507]: reading /etc/resolv.conf Sep 16 14:54:17 volumio-piter-room dnsmasq[1507]: using nameserver 192.168.2.1#53 Sep 16 14:54:17 volumio-piter-room dnsmasq[1507]: using nameserver 208.67.222.222#53 Sep 16 14:54:17 volumio-piter-room dnsmasq[1507]: using nameserver 208.67.220.220#53 Sep 16 14:54:17 volumio-piter-room dnsmasq[1507]: read /etc/hosts - 6 names Sep 16 14:54:17 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:17 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 11 Sep 16 14:54:17 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 12 Sep 16 14:54:17 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 13 Sep 16 14:54:17 volumio-piter-room volumio[1056]: info: Upmpdcli Daemon Started Sep 16 14:54:17 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 14 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 15 Sep 16 14:54:18 volumio-piter-room volumio[1056]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 16 14:54:18 volumio-piter-room volumio[1056]: info: Completed loading Core Plugins Sep 16 14:54:18 volumio-piter-room volumio[1056]: info: Preparing to generate the ALSA configuration file Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 16 Sep 16 14:54:18 volumio-piter-room volumio[1056]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Sep 16 14:54:18 volumio-piter-room volumio[1056]: info: Reading ALSA contributions from plugins. Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 17 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 18 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 19 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 20 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 21 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 22 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 23 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 24 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 25 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 26 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 27 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 28 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 29 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 30 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 31 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 32 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 33 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 34 Sep 16 14:54:18 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 35 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 36 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 37 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 38 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 39 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 40 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 41 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 42 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 43 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 44 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 192.168.2.116 from 192.168.2.114 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 45 Sep 16 14:54:19 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 46 Sep 16 14:54:19 volumio-piter-room volumio[1056]: info: Asound.conf file written Sep 16 14:54:19 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 17. Sep 16 14:54:19 volumio-piter-room sudo[1534]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 16 14:54:19 volumio-piter-room sudo[1534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:19 volumio-piter-room sudo[1534]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:19 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:19 volumio-piter-room dnsmasq[1507]: exiting on receipt of SIGTERM Sep 16 14:54:19 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:19 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:19 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:19 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:19 volumio-piter-room hostapd[1540]: rfkill: WLAN soft blocked Sep 16 14:54:19 volumio-piter-room hostapd[1540]: Failed to set beacon parameters Sep 16 14:54:19 volumio-piter-room hostapd[1540]: wlan0: Could not connect to kernel driver Sep 16 14:54:19 volumio-piter-room hostapd[1540]: Interface initialization failed Sep 16 14:54:19 volumio-piter-room hostapd[1540]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:19 volumio-piter-room hostapd[1540]: wlan0: AP-DISABLED Sep 16 14:54:19 volumio-piter-room hostapd[1540]: wlan0: Unable to setup interface. Sep 16 14:54:19 volumio-piter-room hostapd[1540]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:19 volumio-piter-room hostapd[1540]: wlan0: AP-DISABLED Sep 16 14:54:19 volumio-piter-room hostapd[1540]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:19 volumio-piter-room hostapd[1540]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:19 volumio-piter-room hostapd[1540]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:19 volumio-piter-room volumio[1056]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Sep 16 14:54:19 volumio-piter-room volumio[1056]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Sep 16 14:54:19 volumio-piter-room volumio[1056]: info: Output device has changed, restarting MPD Sep 16 14:54:19 volumio-piter-room volumio[1056]: info: Output device has changed, restarting Shairport Sync Sep 16 14:54:19 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:19 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:19 volumio-piter-room sudo[1544]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 14:54:19 volumio-piter-room sudo[1544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:19 volumio-piter-room sudo[1543]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 14:54:19 volumio-piter-room volumio[1056]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 14:54:19 volumio-piter-room volumio[1056]: info: ___________ START PLUGINS ___________ Sep 16 14:54:19 volumio-piter-room sudo[1543]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:19 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:19 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:19 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: ControllerMpd::onStart: Initializing MPD Sep 16 14:54:20 volumio-piter-room sudo[1543]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: Creating MPD Configuration file Sep 16 14:54:20 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: [1758027260150] CoreMusicLibrary::Adding element Serwery Mediów Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:20 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 14:54:20 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 14:54:20 volumio-piter-room dnsmasq[1561]: started, version 2.90 cachesize 150 Sep 16 14:54:20 volumio-piter-room dnsmasq[1561]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:20 volumio-piter-room dnsmasq-dhcp[1561]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:20 volumio-piter-room dnsmasq[1561]: reading /etc/resolv.conf Sep 16 14:54:20 volumio-piter-room dnsmasq[1561]: using nameserver 192.168.2.1#53 Sep 16 14:54:20 volumio-piter-room dnsmasq[1561]: using nameserver 208.67.222.222#53 Sep 16 14:54:20 volumio-piter-room dnsmasq[1561]: using nameserver 208.67.220.220#53 Sep 16 14:54:20 volumio-piter-room dnsmasq[1561]: read /etc/hosts - 6 names Sep 16 14:54:20 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:20 volumio-piter-room sudo[1553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 14:54:20 volumio-piter-room sudo[1553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:20 volumio-piter-room sudo[1557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 14:54:20 volumio-piter-room sudo[1553]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:20 volumio-piter-room sudo[1557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:20 volumio-piter-room sudo[1559]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 14:54:20 volumio-piter-room sudo[1559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 14:54:20 volumio-piter-room sudo[1559]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:20 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 14:54:20 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 14:54:20 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 14:54:20 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 14:54:20 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:20 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 14:54:20 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 14:54:20 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:54:20] [connect] Successful connection Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: [1758027260730] CoreMusicLibrary::Adding element Last_100 Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: [1758027260736] CoreMusicLibrary::Adding element Webradio Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:20 volumio-piter-room sudo[1572]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 14:54:20 volumio-piter-room sudo[1572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 14:54:20 volumio-piter-room sudo[1576]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 16 14:54:20 volumio-piter-room sudo[1572]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 14:54:20 volumio-piter-room volumio[1056]: info: Initializing BBC Radios Sep 16 14:54:21 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 14:54:21 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:21 volumio-piter-room volumio[1056]: info: Creating Spotify config file Sep 16 14:54:21 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:22 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 18. Sep 16 14:54:22 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:22 volumio-piter-room dnsmasq[1561]: exiting on receipt of SIGTERM Sep 16 14:54:22 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:22 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:22 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:22 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:22 volumio-piter-room hostapd[1592]: rfkill: WLAN soft blocked Sep 16 14:54:22 volumio-piter-room hostapd[1592]: Failed to set beacon parameters Sep 16 14:54:22 volumio-piter-room hostapd[1592]: wlan0: Could not connect to kernel driver Sep 16 14:54:22 volumio-piter-room hostapd[1592]: Interface initialization failed Sep 16 14:54:22 volumio-piter-room hostapd[1592]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:22 volumio-piter-room hostapd[1592]: wlan0: AP-DISABLED Sep 16 14:54:22 volumio-piter-room hostapd[1592]: wlan0: Unable to setup interface. Sep 16 14:54:22 volumio-piter-room hostapd[1592]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:22 volumio-piter-room hostapd[1592]: wlan0: AP-DISABLED Sep 16 14:54:22 volumio-piter-room hostapd[1592]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:22 volumio-piter-room hostapd[1592]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:22 volumio-piter-room hostapd[1592]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:22 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:22 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:22 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:22 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:22 volumio-piter-room dnsmasq[1597]: started, version 2.90 cachesize 150 Sep 16 14:54:22 volumio-piter-room dnsmasq[1597]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:22 volumio-piter-room dnsmasq-dhcp[1597]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:22 volumio-piter-room dnsmasq[1597]: reading /etc/resolv.conf Sep 16 14:54:22 volumio-piter-room dnsmasq[1597]: using nameserver 192.168.2.1#53 Sep 16 14:54:22 volumio-piter-room dnsmasq[1597]: using nameserver 208.67.222.222#53 Sep 16 14:54:22 volumio-piter-room dnsmasq[1597]: using nameserver 208.67.220.220#53 Sep 16 14:54:22 volumio-piter-room dnsmasq[1597]: read /etc/hosts - 6 names Sep 16 14:54:22 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: [1758027263232] CoreMusicLibrary::Adding element YouTube2 Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:23 volumio-piter-room volumio[1056]: Cannot find translation for source YouTube2 Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: [1758027263351] CoreMusicLibrary::Adding element YouTube Music Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:23 volumio-piter-room volumio[1056]: Cannot find translation for source YouTube2 Sep 16 14:54:23 volumio-piter-room volumio[1056]: Cannot find translation for source YouTube Music Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: AutoStart - onStart Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: [now-playing] ConfigUpdater: config is up to date. Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: Loading i18n strings for locale pl Sep 16 14:54:23 volumio-piter-room volumio[1056]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 14:54:23 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 16 14:54:24 volumio-piter-room volumio[1056]: info: Loading i18n strings for locale pl Sep 16 14:54:24 volumio-piter-room volumio[1056]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 14:54:24 volumio-piter-room sudo[1601]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Sep 16 14:54:24 volumio-piter-room sudo[1601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:24 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 14:54:24 volumio-piter-room volumio[1056]: info: Volumio Calling Home Sep 16 14:54:24 volumio-piter-room sudo[1601]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:24 volumio-piter-room volumio[1056]: info: Preparing to generate the ALSA configuration file Sep 16 14:54:24 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 19. Sep 16 14:54:24 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:24 volumio-piter-room dnsmasq[1597]: exiting on receipt of SIGTERM Sep 16 14:54:24 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:24 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:24 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:24 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:24 volumio-piter-room sudo[1615]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Sep 16 14:54:24 volumio-piter-room sudo[1615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:24 volumio-piter-room hostapd[1618]: rfkill: WLAN soft blocked Sep 16 14:54:24 volumio-piter-room hostapd[1618]: Failed to set beacon parameters Sep 16 14:54:24 volumio-piter-room hostapd[1618]: wlan0: Could not connect to kernel driver Sep 16 14:54:24 volumio-piter-room hostapd[1618]: Interface initialization failed Sep 16 14:54:24 volumio-piter-room hostapd[1618]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:24 volumio-piter-room hostapd[1618]: wlan0: AP-DISABLED Sep 16 14:54:24 volumio-piter-room hostapd[1618]: wlan0: Unable to setup interface. Sep 16 14:54:24 volumio-piter-room hostapd[1618]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:24 volumio-piter-room hostapd[1618]: wlan0: AP-DISABLED Sep 16 14:54:24 volumio-piter-room hostapd[1618]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:24 volumio-piter-room hostapd[1618]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:24 volumio-piter-room hostapd[1618]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:24 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:24 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:24 volumio-piter-room sudo[1619]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Sep 16 14:54:24 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:24 volumio-piter-room sudo[1619]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:25 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:25 volumio-piter-room sudo[1620]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Sep 16 14:54:25 volumio-piter-room sudo[1620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:25 volumio-piter-room dnsmasq[1628]: started, version 2.90 cachesize 150 Sep 16 14:54:25 volumio-piter-room dnsmasq[1628]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:25 volumio-piter-room dnsmasq-dhcp[1628]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:25 volumio-piter-room dnsmasq[1628]: reading /etc/resolv.conf Sep 16 14:54:25 volumio-piter-room dnsmasq[1628]: using nameserver 192.168.2.1#53 Sep 16 14:54:25 volumio-piter-room dnsmasq[1628]: using nameserver 208.67.222.222#53 Sep 16 14:54:25 volumio-piter-room dnsmasq[1628]: using nameserver 208.67.220.220#53 Sep 16 14:54:25 volumio-piter-room dnsmasq[1628]: read /etc/hosts - 6 names Sep 16 14:54:25 volumio-piter-room sudo[1615]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:25 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:25 volumio-piter-room systemd[1]: Reloading. Sep 16 14:54:25 volumio-piter-room volumio[1056]: info: [now-playing] App is listening on port 4004. Sep 16 14:54:25 volumio-piter-room volumio[1056]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: AutoStart - Plugin is starting Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetQueue Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::getQueue Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CorePlayQueue::getQueue Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: AutoStart - start playing Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: AutoStart - start playing with no specific position Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioPlay Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::play index 0 Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::stop Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::play index undefined Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CoreStateMachine::startPlaybackTimer Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: [1758027266444] ControllerUPNPBrowser::clearAddPlayTrack Sep 16 14:54:26 volumio-piter-room volumio[1056]: verbose: ControllerMpd::sendMpdCommand stop Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: Reading ALSA contributions from plugins. Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: touch_display: No backlight interface detected. Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: touch_display: systemctl stop getty@tty1.service succeeded. Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: snd_dummy loaded Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: MPD Permissions set Sep 16 14:54:26 volumio-piter-room volumio[1056]: info: MPD Permissions set Sep 16 14:54:27 volumio-piter-room volumio[1056]: info: Volumio called home Sep 16 14:54:27 volumio-piter-room volumio[1056]: info: Spotify config file written Sep 16 14:54:27 volumio-piter-room sudo[1652]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Sep 16 14:54:27 volumio-piter-room sudo[1652]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:27 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 20. Sep 16 14:54:27 volumio-piter-room systemd[1]: Reloading. Sep 16 14:54:27 volumio-piter-room sudo[1619]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:29 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 47 Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: No need to fix Spotify hosts Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:29 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:30 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:30 volumio-piter-room mpd[1577]: 2025-09-16T14:54:30 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 14:54:30 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:30 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 14:54:30 volumio-piter-room sudo[1544]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:30 volumio-piter-room 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. Sep 16 14:54:30 volumio-piter-room 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. Sep 16 14:54:30 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 21. Sep 16 14:54:30 volumio-piter-room sudo[1620]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:30 volumio-piter-room sudo[1557]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:30 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:30 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:30 volumio-piter-room sudo[1652]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:30 volumio-piter-room systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 16 14:54:30 volumio-piter-room go-librespot[1697]: go-librespot daemon starting... Sep 16 14:54:30 volumio-piter-room dnsmasq[1628]: exiting on receipt of SIGTERM Sep 16 14:54:30 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:30 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:30 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:30 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:30 volumio-piter-room hostapd[1702]: rfkill: WLAN soft blocked Sep 16 14:54:30 volumio-piter-room hostapd[1702]: Failed to set beacon parameters Sep 16 14:54:30 volumio-piter-room hostapd[1702]: wlan0: Could not connect to kernel driver Sep 16 14:54:30 volumio-piter-room hostapd[1702]: Interface initialization failed Sep 16 14:54:30 volumio-piter-room hostapd[1702]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:30 volumio-piter-room hostapd[1702]: wlan0: AP-DISABLED Sep 16 14:54:30 volumio-piter-room hostapd[1702]: wlan0: Unable to setup interface. Sep 16 14:54:30 volumio-piter-room hostapd[1702]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:30 volumio-piter-room hostapd[1702]: wlan0: AP-DISABLED Sep 16 14:54:30 volumio-piter-room hostapd[1702]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:30 volumio-piter-room hostapd[1702]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:30 volumio-piter-room hostapd[1702]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:30 volumio-piter-room dbus-daemon[528]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.18' (uid=0 pid=1700 comm="timedatectl show --property=NTPSynchronized --valu") Sep 16 14:54:30 volumio-piter-room systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 16 14:54:30 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:30 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:30 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:30 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 48 Sep 16 14:54:30 volumio-piter-room volumio[1056]: info: touch_display: systemctl disable getty@tty1.service succeeded. Sep 16 14:54:30 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=debug msg="app state loaded" Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:54:31 volumio-piter-room dnsmasq[1713]: started, version 2.90 cachesize 150 Sep 16 14:54:31 volumio-piter-room dnsmasq[1713]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:31 volumio-piter-room dnsmasq-dhcp[1713]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:31 volumio-piter-room dnsmasq[1713]: reading /etc/resolv.conf Sep 16 14:54:31 volumio-piter-room dnsmasq[1713]: using nameserver 192.168.2.1#53 Sep 16 14:54:31 volumio-piter-room dnsmasq[1713]: using nameserver 208.67.222.222#53 Sep 16 14:54:31 volumio-piter-room dnsmasq[1713]: using nameserver 208.67.220.220#53 Sep 16 14:54:31 volumio-piter-room dnsmasq[1713]: read /etc/hosts - 6 names Sep 16 14:54:31 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:31 volumio-piter-room dbus-daemon[528]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 16 14:54:31 volumio-piter-room systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 16 14:54:31 volumio-piter-room setdatetime-helper.sh[1698]: Time is already synchronized. Sep 16 14:54:31 volumio-piter-room systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 16 14:54:31 volumio-piter-room systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 16 14:54:31 volumio-piter-room volumio[1056]: info: touch_display: systemctl daemon-reload succeeded. Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+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]" Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+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]" Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+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]" Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=info msg="zeroconf server listening on port 46355" Sep 16 14:54:31 volumio-piter-room sudo[1721]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Sep 16 14:54:31 volumio-piter-room sudo[1721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:31 volumio-piter-room volumio[1056]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=debug msg="obtained new client token: AABLRJtW1092QkS64KYCBe6+deS2ow4cjgm7P76hnHMuc2BgsAjHGzZhEC1Iol4AWpmvUfwrwMx+kARSztGCEUFQJrPw+NRklfpVu7NdeLekYRjx0sgX/Iff6p+mfKCZD/e8doSRWb6Tq6weYIebfBsQq5qkZN+55fL3JKi0Oe1qv0E6NflXo041d4SK5BCxUv4YLQGFsoHrzy6jbEV3aRVXmdSePse69/fyXUGvbOEujzmiz9dv1kZz5A==" Sep 16 14:54:31 volumio-piter-room systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Sep 16 14:54:31 volumio-piter-room volumio[1056]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Sep 16 14:54:31 volumio-piter-room volumio[1056]: SPOTIFY: BQDJlGKbyLsMEaPkegupGd7fGpqf7nu6tKhwzZtxjGe2uG2jsOQfTdE7YzlmErnTv5N30K_09EoERc4yjiZbN2lDbe-vFOCzNYyyf7f6f-6BdpO27RJlAP6HXlni3izNF5PVhzA6QeaTaHr45Yuv_dUlnJ971K0Et3dC_OszmjLXAGUT0La0__FCGGsoJG1EqluhjfFvDJoNASKO2oZCWDi_WwBLzzkwid7m5u3xIPqleCHG_U5W1VFtOqxP11djzixAWa1VtX7Rsg0soJPalG6CH_QGm5Me0-_28zh3El8T4KY Sep 16 14:54:31 volumio-piter-room volumio[1056]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Sep 16 14:54:31 volumio-piter-room volumio[1056]: info: New Spotify access token = BQDJlGKbyLsMEaPkegupGd7fGpqf7nu6tKhwzZtxjGe2uG2jsOQfTdE7YzlmErnTv5N30K_09EoERc4yjiZbN2lDbe-vFOCzNYyyf7f6f-6BdpO27RJlAP6HXlni3izNF5PVhzA6QeaTaHr45Yuv_dUlnJ971K0Et3dC_OszmjLXAGUT0La0__FCGGsoJG1EqluhjfFvDJoNASKO2oZCWDi_WwBLzzkwid7m5u3xIPqleCHG_U5W1VFtOqxP11djzixAWa1VtX7Rsg0soJPalG6CH_QGm5Me0-_28zh3El8T4KY Sep 16 14:54:31 volumio-piter-room volumio[1056]: info: Spotify credentials grant success - running version from March 24, 2019 Sep 16 14:54:31 volumio-piter-room sudo[1721]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 14:54:31 volumio-piter-room sudo[1724]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Sep 16 14:54:31 volumio-piter-room sudo[1724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:31 volumio-piter-room sudo[1724]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=debug msg="completed keyexchange" Sep 16 14:54:31 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:31+02:00" level=debug msg="completed challenge" Sep 16 14:54:32 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:32+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 14:54:32 volumio-piter-room go-librespot[1699]: time="2025-09-16T14:54:32+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed requesting login5 endpoint: faield unmarshalling LoginResponse: proto:\u00a0cannot parse invalid wire-format data" Sep 16 14:54:32 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 14:54:32 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 14:54:32 volumio-piter-room volumio[1056]: info: MPD running with PID1577 Sep 16 14:54:32 volumio-piter-room volumio[1056]: ,establishing connection Sep 16 14:54:32 volumio-piter-room volumio[1056]: info: Starting Shairport Sync Sep 16 14:54:32 volumio-piter-room startx[1748]: X.Org X Server 1.21.1.7 Sep 16 14:54:32 volumio-piter-room startx[1748]: X Protocol Version 11, Revision 0 Sep 16 14:54:32 volumio-piter-room startx[1748]: Current Operating System: Linux volumio-piter-room 6.12.27-v7l+ #1876 SMP Tue May 6 15:10:05 BST 2025 armv7l Sep 16 14:54:32 volumio-piter-room startx[1748]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1024 bcm2708_fb.fbheight=600 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:AF:5B:FB vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=2d6bf3e1-3b9d-416b-94c7-51c320b903be imgfile=/volumio_current.sqsh bootpart=UUID=B901-874B datapart=UUID=f45bef28-28ad-410c-ad2e-1749f4657ac6 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Sep 16 14:54:32 volumio-piter-room startx[1748]: xorg-server 2:21.1.7-3+rpt3+deb12u9 (https://www.debian.org/support) Sep 16 14:54:32 volumio-piter-room startx[1748]: Current version of pixman: 0.44.0 Sep 16 14:54:32 volumio-piter-room startx[1748]: Before reporting problems, check http://wiki.x.org Sep 16 14:54:32 volumio-piter-room startx[1748]: to make sure that you have the latest version. Sep 16 14:54:32 volumio-piter-room startx[1748]: Markers: (--) probed, (**) from config file, (==) default setting, Sep 16 14:54:32 volumio-piter-room startx[1748]: (++) from command line, (!!) notice, (II) informational, Sep 16 14:54:32 volumio-piter-room startx[1748]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Sep 16 14:54:32 volumio-piter-room startx[1748]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Sep 16 14:54:32 2025 Sep 16 14:54:32 volumio-piter-room startx[1748]: (==) Using config directory: "/etc/X11/xorg.conf.d" Sep 16 14:54:32 volumio-piter-room startx[1748]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Sep 16 14:54:32 volumio-piter-room volumio[1056]: info: Starting Shairport Sync Sep 16 14:54:32 volumio-piter-room volumio[1056]: info: Starting Shairport Sync Sep 16 14:54:32 volumio-piter-room sudo[1750]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 14:54:32 volumio-piter-room sudo[1750]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:32 volumio-piter-room sudo[1754]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 14:54:32 volumio-piter-room sudo[1754]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:32 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 14:54:32 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 14:54:32 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 14:54:32 volumio-piter-room systemd[1]: shairport-sync.service: Consumed 2.083s CPU time. Sep 16 14:54:32 volumio-piter-room sudo[1752]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 14:54:32 volumio-piter-room sudo[1752]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:32 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 14:54:32 volumio-piter-room sudo[1750]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:32 volumio-piter-room sudo[1754]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:32 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 14:54:32 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 14:54:32 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 14:54:32 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 14:54:32 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 22. Sep 16 14:54:32 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:32 volumio-piter-room sudo[1752]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:32 volumio-piter-room dnsmasq[1713]: exiting on receipt of SIGTERM Sep 16 14:54:32 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:32 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:32 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:32 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:33 volumio-piter-room hostapd[1776]: rfkill: WLAN soft blocked Sep 16 14:54:33 volumio-piter-room hostapd[1776]: Failed to set beacon parameters Sep 16 14:54:33 volumio-piter-room hostapd[1776]: wlan0: Could not connect to kernel driver Sep 16 14:54:33 volumio-piter-room hostapd[1776]: Interface initialization failed Sep 16 14:54:33 volumio-piter-room hostapd[1776]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:33 volumio-piter-room hostapd[1776]: wlan0: AP-DISABLED Sep 16 14:54:33 volumio-piter-room hostapd[1776]: wlan0: Unable to setup interface. Sep 16 14:54:33 volumio-piter-room hostapd[1776]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:33 volumio-piter-room hostapd[1776]: wlan0: AP-DISABLED Sep 16 14:54:33 volumio-piter-room hostapd[1776]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:33 volumio-piter-room hostapd[1776]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:33 volumio-piter-room hostapd[1776]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:33 volumio-piter-room volumio[1056]: error: MPD error: The expression evaluated to a falsy value: Sep 16 14:54:33 volumio-piter-room volumio[1056]: assert.ok(self.idling) Sep 16 14:54:33 volumio-piter-room volumio[1056]: error: The expression evaluated to a falsy value: Sep 16 14:54:33 volumio-piter-room volumio[1056]: assert.ok(self.idling) Sep 16 14:54:33 volumio-piter-room volumio[1056]: error: MPD error: The expression evaluated to a falsy value: Sep 16 14:54:33 volumio-piter-room volumio[1056]: assert.ok(self.idling) Sep 16 14:54:33 volumio-piter-room volumio[1056]: error: The expression evaluated to a falsy value: Sep 16 14:54:33 volumio-piter-room volumio[1056]: assert.ok(self.idling) Sep 16 14:54:33 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:33 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:33 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Sep 16 14:54:33 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: touch_display: Volumio Kiosk started. Sep 16 14:54:33 volumio-piter-room dnsmasq[1797]: started, version 2.90 cachesize 150 Sep 16 14:54:33 volumio-piter-room dnsmasq[1797]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:33 volumio-piter-room dnsmasq-dhcp[1797]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:33 volumio-piter-room dnsmasq[1797]: reading /etc/resolv.conf Sep 16 14:54:33 volumio-piter-room dnsmasq[1797]: using nameserver 192.168.2.1#53 Sep 16 14:54:33 volumio-piter-room dnsmasq[1797]: using nameserver 208.67.222.222#53 Sep 16 14:54:33 volumio-piter-room dnsmasq[1797]: using nameserver 208.67.220.220#53 Sep 16 14:54:33 volumio-piter-room dnsmasq[1797]: read /etc/hosts - 6 names Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetState Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Completed starting Core Plugins Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: ------------------------------------------- Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: ----- MyVolumio plugins startup ---- Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: ------------------------------------------- Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 16 14:54:33 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Shairport-Sync Started Sep 16 14:54:33 volumio-piter-room volumio[1056]: Error adding Membership: Error: addMembership EINVAL Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Shairport-Sync Started Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Shairport-Sync Started Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Asound.conf file unchanged, so no further update is needed Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Output device has changed, restarting MPD Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Output device has changed, restarting Shairport Sync Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:33 volumio-piter-room sudo[1801]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 14:54:33 volumio-piter-room sudo[1801]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:33 volumio-piter-room volumio[1056]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 14:54:33 volumio-piter-room sudo[1801]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:33 volumio-piter-room sudo[1803]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 14:54:34 volumio-piter-room sudo[1803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:34 volumio-piter-room volumio[1056]: error: updateQueue error: null Sep 16 14:54:34 volumio-piter-room systemd[1]: Stopping mpd.service - Music Player Daemon... Sep 16 14:54:34 volumio-piter-room volumio[1056]: info: touch_display: X display number found: 0 Sep 16 14:54:34 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 14:54:34 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 14:54:34 volumio-piter-room systemd[1]: mpd.service: Consumed 7.444s CPU time. Sep 16 14:54:34 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 14:54:34 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 14:54:34 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 14:54:34 volumio-piter-room volumio[1056]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Sep 16 14:54:34 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 14:54:34 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 14:54:34 volumio-piter-room volumio[1056]: info: MPD Permissions set Sep 16 14:54:34 volumio-piter-room volumio[1056]: info: go-librespot daemon successfully initialized Sep 16 14:54:35 volumio-piter-room sudo[1839]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 14:54:35 volumio-piter-room sudo[1839]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 14:54:35 volumio-piter-room sudo[1839]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: touch_display: X display number found: 0 Sep 16 14:54:35 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 23. Sep 16 14:54:35 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Sep 16 14:54:35 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:35 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:35 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:35 volumio-piter-room dnsmasq[1797]: exiting on receipt of SIGTERM Sep 16 14:54:35 volumio-piter-room go-librespot[1882]: go-librespot daemon starting... Sep 16 14:54:35 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:35 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:35 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:35 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetState Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room hostapd[1887]: rfkill: WLAN soft blocked Sep 16 14:54:35 volumio-piter-room hostapd[1887]: Failed to set beacon parameters Sep 16 14:54:35 volumio-piter-room hostapd[1887]: wlan0: Could not connect to kernel driver Sep 16 14:54:35 volumio-piter-room hostapd[1887]: Interface initialization failed Sep 16 14:54:35 volumio-piter-room hostapd[1887]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:35 volumio-piter-room hostapd[1887]: wlan0: AP-DISABLED Sep 16 14:54:35 volumio-piter-room hostapd[1887]: wlan0: Unable to setup interface. Sep 16 14:54:35 volumio-piter-room hostapd[1887]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:35 volumio-piter-room hostapd[1887]: wlan0: AP-DISABLED Sep 16 14:54:35 volumio-piter-room hostapd[1887]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:35 volumio-piter-room hostapd[1887]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:35 volumio-piter-room hostapd[1887]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:35 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:35+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:35 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:35+02:00" level=debug msg="app state loaded" Sep 16 14:54:35 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:54:35 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:35 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:35 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:35 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:54:35] [connect] Successful connection Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:35 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:35 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 14:54:35 volumio-piter-room dnsmasq[1902]: started, version 2.90 cachesize 150 Sep 16 14:54:35 volumio-piter-room dnsmasq[1902]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:35 volumio-piter-room dnsmasq-dhcp[1902]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:35 volumio-piter-room dnsmasq[1902]: reading /etc/resolv.conf Sep 16 14:54:35 volumio-piter-room dnsmasq[1902]: using nameserver 192.168.2.1#53 Sep 16 14:54:35 volumio-piter-room dnsmasq[1902]: using nameserver 208.67.222.222#53 Sep 16 14:54:35 volumio-piter-room dnsmasq[1902]: using nameserver 208.67.220.220#53 Sep 16 14:54:35 volumio-piter-room dnsmasq[1902]: read /etc/hosts - 6 names Sep 16 14:54:35 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 49 Sep 16 14:54:35 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+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]" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+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]" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+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]" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+02:00" level=info msg="zeroconf server listening on port 41867" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+02:00" level=debug msg="obtained new client token: AAA9yy1asI3sl0UNzuwKlgSZHZgLxKfJnmexqAi+ALaLZqdWf9OJZAV6sR9O22yhWmOpx4kUoLMPPunWXIzTcZgOJWm1S4DgF/7LkOivEQeeySnGE8lcait9Yn/hpZ1f4r8sY80YNBCZbzdS3qOxAfl+nwNp7aTbsSGrEsOlt/pom3OsdD+5BpPGgf0uq0ULdTTYhS57/zkMIeu05pAyrK5w46o9KRAyQ4UfDUfiIaTrAbBgzpvG7cs=" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+02:00" level=debug msg="completed keyexchange" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+02:00" level=debug msg="completed challenge" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 14:54:36 volumio-piter-room go-librespot[1886]: time="2025-09-16T14:54:36+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed requesting login5 endpoint: faield unmarshalling LoginResponse: proto:\u00a0cannot parse invalid wire-format data" Sep 16 14:54:36 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 14:54:36 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 14:54:36 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetState Sep 16 14:54:36 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:36 volumio-piter-room volumio[1056]: info: touch_display: Setting screensaver timeout to 10 seconds. Sep 16 14:54:36 volumio-piter-room volumio[1056]: info: Starting Shairport Sync Sep 16 14:54:36 volumio-piter-room sudo[1914]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 14:54:36 volumio-piter-room sudo[1914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:36 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 14:54:36 volumio-piter-room volumio-remote-updater[560]: [2025-09-16 14:54:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1758027275 101 Sep 16 14:54:36 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 14:54:36 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 14:54:36 volumio-piter-room systemd[1]: shairport-sync.service: Consumed 1.330s CPU time. Sep 16 14:54:37 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 14:54:37 volumio-piter-room sudo[1914]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:37 volumio-piter-room volumio[1056]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 50 Sep 16 14:54:37 volumio-piter-room volumio[1056]: info: Shairport-Sync Started Sep 16 14:54:37 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 24. Sep 16 14:54:37 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:37 volumio-piter-room dnsmasq[1902]: exiting on receipt of SIGTERM Sep 16 14:54:37 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:37 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:37 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:37 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:37 volumio-piter-room hostapd[1948]: rfkill: WLAN soft blocked Sep 16 14:54:37 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioGetState Sep 16 14:54:37 volumio-piter-room volumio[1056]: info: CorePlayQueue::getTrack 0 Sep 16 14:54:37 volumio-piter-room hostapd[1948]: Failed to set beacon parameters Sep 16 14:54:37 volumio-piter-room hostapd[1948]: wlan0: Could not connect to kernel driver Sep 16 14:54:37 volumio-piter-room hostapd[1948]: Interface initialization failed Sep 16 14:54:37 volumio-piter-room hostapd[1948]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:37 volumio-piter-room hostapd[1948]: wlan0: AP-DISABLED Sep 16 14:54:37 volumio-piter-room hostapd[1948]: wlan0: Unable to setup interface. Sep 16 14:54:37 volumio-piter-room hostapd[1948]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:37 volumio-piter-room hostapd[1948]: wlan0: AP-DISABLED Sep 16 14:54:37 volumio-piter-room hostapd[1948]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:37 volumio-piter-room hostapd[1948]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:37 volumio-piter-room hostapd[1948]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:38 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:38 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:38 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:38 volumio-piter-room volumio[1056]: info: Initializing connection to go-librespot Websocket Sep 16 14:54:38 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:38 volumio-piter-room dnsmasq[1953]: started, version 2.90 cachesize 150 Sep 16 14:54:38 volumio-piter-room dnsmasq[1953]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:38 volumio-piter-room dnsmasq-dhcp[1953]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:38 volumio-piter-room dnsmasq[1953]: reading /etc/resolv.conf Sep 16 14:54:38 volumio-piter-room dnsmasq[1953]: using nameserver 192.168.2.1#53 Sep 16 14:54:38 volumio-piter-room dnsmasq[1953]: using nameserver 208.67.222.222#53 Sep 16 14:54:38 volumio-piter-room dnsmasq[1953]: using nameserver 208.67.220.220#53 Sep 16 14:54:38 volumio-piter-room dnsmasq[1953]: read /etc/hosts - 6 names Sep 16 14:54:38 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:38 volumio-piter-room volumio[1056]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Sep 16 14:54:38 volumio-piter-room volumio[1056]: SPOTIFY: User informations: {"country":"PL","display_name":"piotr4499","email":"piotr4499@10g.pl","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/ddmm0vyjz4epcocr86rainvro"},"followers":{"href":null,"total":2},"href":"https://api.spotify.com/v1/users/ddmm0vyjz4epcocr86rainvro","id":"ddmm0vyjz4epcocr86rainvro","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee854ec7151f6cee4d97b8a1c47e","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b824ec7151f6cee4d97b8a1c47e","width":64}],"product":"premium","type":"user","uri":"spotify:user:ddmm0vyjz4epcocr86rainvro"} Sep 16 14:54:38 volumio-piter-room volumio[1056]: info: Spotify Successfully logged in Sep 16 14:54:38 volumio-piter-room volumio[1056]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 14:54:38 volumio-piter-room volumio[1056]: info: [1758027278759] CoreMusicLibrary::Adding element Spotify Sep 16 14:54:38 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 14:54:38 volumio-piter-room volumio[1056]: Cannot find translation for source YouTube2 Sep 16 14:54:38 volumio-piter-room volumio[1056]: Cannot find translation for source YouTube Music Sep 16 14:54:38 volumio-piter-room volumio[1056]: Cannot find translation for source Spotify Sep 16 14:54:39 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Sep 16 14:54:39 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:39 volumio-piter-room mpd[1870]: 2025-09-16T14:54:39 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 14:54:39 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:39 volumio-piter-room go-librespot[1970]: go-librespot daemon starting... Sep 16 14:54:39 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 14:54:39 volumio-piter-room sudo[1803]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:39 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:39+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:39 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:39+02:00" level=debug msg="app state loaded" Sep 16 14:54:39 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:54:40 volumio-piter-room volumio[1056]: error: updateQueue error: null Sep 16 14:54:40 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 25. Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=info msg="zeroconf server listening on port 37485" Sep 16 14:54:40 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:40 volumio-piter-room dnsmasq[1953]: exiting on receipt of SIGTERM Sep 16 14:54:40 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:40 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:40 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:40 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=debug msg="obtained new client token: AAC/QNLI2i4fa0hP7YdWhgm6/A+oKGf83LYPvtD1BnHCTcn1cDQjIg0kF4XnyakTDNF9YUg8YYix5M3E+cVPq0McyCX4wFlmP34ln5ua2u7FUMIqIUiY+a0FPSX06WwOSRDFmxgdjY6iAdCaJZ6LZ2oqDgTVQn4Yt0+/V8sYOmZJzTObwg1dCCp2oYmDUzRBDtJGns/uqf7kRwJuHa1IjGbalFZLy41zHpS7v+1UxcXzXoZ/x6BKt1dMwA==" Sep 16 14:54:40 volumio-piter-room hostapd[1992]: rfkill: WLAN soft blocked Sep 16 14:54:40 volumio-piter-room hostapd[1992]: Failed to set beacon parameters Sep 16 14:54:40 volumio-piter-room hostapd[1992]: wlan0: Could not connect to kernel driver Sep 16 14:54:40 volumio-piter-room hostapd[1992]: Interface initialization failed Sep 16 14:54:40 volumio-piter-room hostapd[1992]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:40 volumio-piter-room hostapd[1992]: wlan0: AP-DISABLED Sep 16 14:54:40 volumio-piter-room hostapd[1992]: wlan0: Unable to setup interface. Sep 16 14:54:40 volumio-piter-room hostapd[1992]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:40 volumio-piter-room hostapd[1992]: wlan0: AP-DISABLED Sep 16 14:54:40 volumio-piter-room hostapd[1992]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:40 volumio-piter-room hostapd[1992]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:40 volumio-piter-room hostapd[1992]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=debug msg="completed keyexchange" Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=debug msg="completed challenge" Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 14:54:40 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:40 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:40 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:40 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 14:54:40 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:40 volumio-piter-room go-librespot[1973]: time="2025-09-16T14:54:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed requesting login5 endpoint: faield unmarshalling LoginResponse: proto:\u00a0cannot parse invalid wire-format data" Sep 16 14:54:40 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 14:54:40 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 14:54:40 volumio-piter-room dnsmasq[1997]: started, version 2.90 cachesize 150 Sep 16 14:54:40 volumio-piter-room dnsmasq[1997]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:40 volumio-piter-room dnsmasq-dhcp[1997]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:40 volumio-piter-room dnsmasq[1997]: reading /etc/resolv.conf Sep 16 14:54:40 volumio-piter-room dnsmasq[1997]: using nameserver 192.168.2.1#53 Sep 16 14:54:40 volumio-piter-room dnsmasq[1997]: using nameserver 208.67.222.222#53 Sep 16 14:54:40 volumio-piter-room dnsmasq[1997]: using nameserver 208.67.220.220#53 Sep 16 14:54:40 volumio-piter-room dnsmasq[1997]: read /etc/hosts - 6 names Sep 16 14:54:40 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:41 volumio-piter-room volumio[1056]: info: Initializing connection to go-librespot Websocket Sep 16 14:54:41 volumio-piter-room volumio[1056]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Sep 16 14:54:42 volumio-piter-room sudo[2017]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 14:54:42 volumio-piter-room sudo[2017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:42 volumio-piter-room sudo[2017]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:42 volumio-piter-room sudo[2015]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 14:54:42 volumio-piter-room sudo[2015]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:42 volumio-piter-room sudo[2015]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 16 14:54:42 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 26. Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: Adding plugin bluetooth to MyMusic Plugins Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: Adding plugin multiroom to MyMusic Plugins Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: Adding plugin metavolumio to MyMusic Plugins Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: Adding plugin cd_controller to MyMusic Plugins Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 16 14:54:42 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 16 14:54:42 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 16 14:54:42 volumio-piter-room dnsmasq[1997]: exiting on receipt of SIGTERM Sep 16 14:54:42 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:42 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:42 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:42 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:42 volumio-piter-room hostapd[2021]: rfkill: WLAN soft blocked Sep 16 14:54:42 volumio-piter-room hostapd[2021]: Failed to set beacon parameters Sep 16 14:54:42 volumio-piter-room hostapd[2021]: wlan0: Could not connect to kernel driver Sep 16 14:54:42 volumio-piter-room hostapd[2021]: Interface initialization failed Sep 16 14:54:42 volumio-piter-room hostapd[2021]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:42 volumio-piter-room hostapd[2021]: wlan0: AP-DISABLED Sep 16 14:54:42 volumio-piter-room hostapd[2021]: wlan0: Unable to setup interface. Sep 16 14:54:42 volumio-piter-room hostapd[2021]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:42 volumio-piter-room hostapd[2021]: wlan0: AP-DISABLED Sep 16 14:54:42 volumio-piter-room hostapd[2021]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:42 volumio-piter-room hostapd[2021]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:42 volumio-piter-room hostapd[2021]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:42 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:42 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:42 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:43 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:43 volumio-piter-room dnsmasq[2038]: started, version 2.90 cachesize 150 Sep 16 14:54:43 volumio-piter-room dnsmasq[2038]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:43 volumio-piter-room dnsmasq-dhcp[2038]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:43 volumio-piter-room dnsmasq[2038]: reading /etc/resolv.conf Sep 16 14:54:43 volumio-piter-room dnsmasq[2038]: using nameserver 192.168.2.1#53 Sep 16 14:54:43 volumio-piter-room dnsmasq[2038]: using nameserver 208.67.222.222#53 Sep 16 14:54:43 volumio-piter-room dnsmasq[2038]: using nameserver 208.67.220.220#53 Sep 16 14:54:43 volumio-piter-room dnsmasq[2038]: read /etc/hosts - 6 names Sep 16 14:54:43 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:43 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Sep 16 14:54:43 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:43 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:43 volumio-piter-room go-librespot[2050]: go-librespot daemon starting... Sep 16 14:54:43 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:43+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:43 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:43+02:00" level=debug msg="app state loaded" Sep 16 14:54:43 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=info msg="zeroconf server listening on port 39833" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=debug msg="obtained new client token: AAB+6G37twBrbCpM1UeqettiZsD5wKWyDsY9JATDmfHmPEeuBLLGqmwcqq414j9tbi9G1yuR7ZT3SsESUdTlqGg4rS31GdlMkxHK3p10Ymo7cRmX2e32YFq6rVuQOJpY85a1IUr3aDg+VCorUkNiosNPqqj/AadxgzTKVYEUm/+5ohBfhihf/qPbL51FfSYk2zOLp+B+CL9O/PjKncEyyvLxEgxI1tuS0euyrAMx7WVGhSw37XRT5qCqow==" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=debug msg="completed keyexchange" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=debug msg="completed challenge" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 14:54:44 volumio-piter-room go-librespot[2053]: time="2025-09-16T14:54:44+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed requesting login5 endpoint: faield unmarshalling LoginResponse: proto:\u00a0cannot parse invalid wire-format data" Sep 16 14:54:44 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 14:54:44 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 14:54:45 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 27. Sep 16 14:54:45 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:45 volumio-piter-room dnsmasq[2038]: exiting on receipt of SIGTERM Sep 16 14:54:45 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:45 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:45 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:45 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:45 volumio-piter-room hostapd[2089]: rfkill: WLAN soft blocked Sep 16 14:54:45 volumio-piter-room hostapd[2089]: Failed to set beacon parameters Sep 16 14:54:45 volumio-piter-room hostapd[2089]: wlan0: Could not connect to kernel driver Sep 16 14:54:45 volumio-piter-room hostapd[2089]: Interface initialization failed Sep 16 14:54:45 volumio-piter-room hostapd[2089]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:45 volumio-piter-room hostapd[2089]: wlan0: AP-DISABLED Sep 16 14:54:45 volumio-piter-room hostapd[2089]: wlan0: Unable to setup interface. Sep 16 14:54:45 volumio-piter-room hostapd[2089]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:45 volumio-piter-room hostapd[2089]: wlan0: AP-DISABLED Sep 16 14:54:45 volumio-piter-room hostapd[2089]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:45 volumio-piter-room hostapd[2089]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:45 volumio-piter-room hostapd[2089]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:45 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:45 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:45 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:45 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:45 volumio-piter-room dnsmasq[2105]: started, version 2.90 cachesize 150 Sep 16 14:54:45 volumio-piter-room dnsmasq[2105]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:45 volumio-piter-room dnsmasq-dhcp[2105]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:45 volumio-piter-room dnsmasq[2105]: reading /etc/resolv.conf Sep 16 14:54:45 volumio-piter-room dnsmasq[2105]: using nameserver 192.168.2.1#53 Sep 16 14:54:45 volumio-piter-room dnsmasq[2105]: using nameserver 208.67.222.222#53 Sep 16 14:54:45 volumio-piter-room dnsmasq[2105]: using nameserver 208.67.220.220#53 Sep 16 14:54:45 volumio-piter-room dnsmasq[2105]: read /etc/hosts - 6 names Sep 16 14:54:45 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:47 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 28. Sep 16 14:54:47 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:47 volumio-piter-room dnsmasq[2105]: exiting on receipt of SIGTERM Sep 16 14:54:47 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:47 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:47 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Sep 16 14:54:47 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:47 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:47 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:47 volumio-piter-room go-librespot[2148]: go-librespot daemon starting... Sep 16 14:54:47 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:47 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:47+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:47 volumio-piter-room hostapd[2150]: rfkill: WLAN soft blocked Sep 16 14:54:47 volumio-piter-room hostapd[2150]: Failed to set beacon parameters Sep 16 14:54:47 volumio-piter-room hostapd[2150]: wlan0: Could not connect to kernel driver Sep 16 14:54:47 volumio-piter-room hostapd[2150]: Interface initialization failed Sep 16 14:54:47 volumio-piter-room hostapd[2150]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:47 volumio-piter-room hostapd[2150]: wlan0: AP-DISABLED Sep 16 14:54:47 volumio-piter-room hostapd[2150]: wlan0: Unable to setup interface. Sep 16 14:54:47 volumio-piter-room hostapd[2150]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:47 volumio-piter-room hostapd[2150]: wlan0: AP-DISABLED Sep 16 14:54:47 volumio-piter-room hostapd[2150]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:47 volumio-piter-room hostapd[2150]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:47 volumio-piter-room hostapd[2150]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:47 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:47+02:00" level=debug msg="app state loaded" Sep 16 14:54:47 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:54:48 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:48 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:48 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:48 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:48 volumio-piter-room dnsmasq[2162]: started, version 2.90 cachesize 150 Sep 16 14:54:48 volumio-piter-room dnsmasq[2162]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:48 volumio-piter-room dnsmasq-dhcp[2162]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:48 volumio-piter-room dnsmasq[2162]: reading /etc/resolv.conf Sep 16 14:54:48 volumio-piter-room dnsmasq[2162]: using nameserver 192.168.2.1#53 Sep 16 14:54:48 volumio-piter-room dnsmasq[2162]: using nameserver 208.67.222.222#53 Sep 16 14:54:48 volumio-piter-room dnsmasq[2162]: using nameserver 208.67.220.220#53 Sep 16 14:54:48 volumio-piter-room dnsmasq[2162]: read /etc/hosts - 6 names Sep 16 14:54:48 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=info msg="zeroconf server listening on port 33225" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=debug msg="obtained new client token: AAAB/S66VThOrAb9Xr9snM0dZkHdqd5Tha0ReDHBxYeg07GP7Jy24adsx0CJ2Cv77kS7SRWhvQ4Zx2rrTYnXqm9CcrsEJ3AgQomsYbPOij7x76pqDakaVilG0UHwlNJZbuVO296x6U1UijGua617bpsNjnUDyNKcVYeLiV9xi32kfv842rAQZKwgDfc/4K6Ey7vFpDWn54v+Lx93354W976EVC8dc697V2nWxLFI7e9uuMl2I3N2jLk2JQ==" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=debug msg="completed keyexchange" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=debug msg="completed challenge" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 14:54:48 volumio-piter-room go-librespot[2149]: time="2025-09-16T14:54:48+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed requesting login5 endpoint: faield unmarshalling LoginResponse: proto:\u00a0cannot parse invalid wire-format data" Sep 16 14:54:48 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 14:54:48 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: Starting MyVolumio Remote Streaming Endpoints Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: MyVolumio login type: Token Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 16 14:54:49 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 16 14:54:50 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 29. Sep 16 14:54:50 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:50 volumio-piter-room dnsmasq[2162]: exiting on receipt of SIGTERM Sep 16 14:54:50 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:50 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:50 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:50 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:50 volumio-piter-room hostapd[2180]: rfkill: WLAN soft blocked Sep 16 14:54:50 volumio-piter-room hostapd[2180]: Failed to set beacon parameters Sep 16 14:54:50 volumio-piter-room hostapd[2180]: wlan0: Could not connect to kernel driver Sep 16 14:54:50 volumio-piter-room hostapd[2180]: Interface initialization failed Sep 16 14:54:50 volumio-piter-room hostapd[2180]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:50 volumio-piter-room hostapd[2180]: wlan0: AP-DISABLED Sep 16 14:54:50 volumio-piter-room hostapd[2180]: wlan0: Unable to setup interface. Sep 16 14:54:50 volumio-piter-room hostapd[2180]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:50 volumio-piter-room hostapd[2180]: wlan0: AP-DISABLED Sep 16 14:54:50 volumio-piter-room hostapd[2180]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:50 volumio-piter-room hostapd[2180]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:50 volumio-piter-room hostapd[2180]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:50 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:50 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:50 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:50 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:50 volumio-piter-room dnsmasq[2185]: started, version 2.90 cachesize 150 Sep 16 14:54:50 volumio-piter-room dnsmasq[2185]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:50 volumio-piter-room dnsmasq-dhcp[2185]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:50 volumio-piter-room dnsmasq[2185]: reading /etc/resolv.conf Sep 16 14:54:50 volumio-piter-room dnsmasq[2185]: using nameserver 192.168.2.1#53 Sep 16 14:54:50 volumio-piter-room dnsmasq[2185]: using nameserver 208.67.222.222#53 Sep 16 14:54:50 volumio-piter-room dnsmasq[2185]: using nameserver 208.67.220.220#53 Sep 16 14:54:50 volumio-piter-room dnsmasq[2185]: read /etc/hosts - 6 names Sep 16 14:54:50 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:51 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Sep 16 14:54:51 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:51 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:51 volumio-piter-room go-librespot[2188]: go-librespot daemon starting... Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="app state loaded" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=info msg="zeroconf server listening on port 33111" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="obtained new client token: AACGXfXwt91wXuAyqmGg/95Qv3z/VANS779m00GX2FBy1ecBI3SGsxA8p2E5Ir+G7N3CEjJ+rqOI+JZxagSZ6OGpmE4kAj1zS8LXvirEdbPs6rqqzIeAQpGDBzlQir1RWx9odMpyijNDp1BKORrlb0ph5kw4E2xMUXOXV98qptZatW+ZqOTUCguFGFbRi3OJXxOzB1oQbt2yPVrv93tMhvaYcRIULlXbHHeIxTP0JRClTmfSgnFcRzacSg==" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="completed keyexchange" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=debug msg="completed challenge" Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 14:54:52 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 30. Sep 16 14:54:52 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:52 volumio-piter-room go-librespot[2189]: time="2025-09-16T14:54:52+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed requesting login5 endpoint: faield unmarshalling LoginResponse: proto:\u00a0cannot parse invalid wire-format data" Sep 16 14:54:52 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 14:54:52 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 14:54:52 volumio-piter-room dnsmasq[2185]: exiting on receipt of SIGTERM Sep 16 14:54:52 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:52 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:52 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:52 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:52 volumio-piter-room hostapd[2198]: rfkill: WLAN soft blocked Sep 16 14:54:52 volumio-piter-room hostapd[2198]: Failed to set beacon parameters Sep 16 14:54:52 volumio-piter-room hostapd[2198]: wlan0: Could not connect to kernel driver Sep 16 14:54:52 volumio-piter-room hostapd[2198]: Interface initialization failed Sep 16 14:54:52 volumio-piter-room hostapd[2198]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:52 volumio-piter-room hostapd[2198]: wlan0: AP-DISABLED Sep 16 14:54:52 volumio-piter-room hostapd[2198]: wlan0: Unable to setup interface. Sep 16 14:54:52 volumio-piter-room hostapd[2198]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:52 volumio-piter-room hostapd[2198]: wlan0: AP-DISABLED Sep 16 14:54:52 volumio-piter-room hostapd[2198]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:52 volumio-piter-room hostapd[2198]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:52 volumio-piter-room hostapd[2198]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:52 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:52 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:52 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:52 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:53 volumio-piter-room dnsmasq[2203]: started, version 2.90 cachesize 150 Sep 16 14:54:53 volumio-piter-room dnsmasq[2203]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:53 volumio-piter-room dnsmasq-dhcp[2203]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:53 volumio-piter-room dnsmasq[2203]: reading /etc/resolv.conf Sep 16 14:54:53 volumio-piter-room dnsmasq[2203]: using nameserver 192.168.2.1#53 Sep 16 14:54:53 volumio-piter-room dnsmasq[2203]: using nameserver 208.67.222.222#53 Sep 16 14:54:53 volumio-piter-room dnsmasq[2203]: using nameserver 208.67.220.220#53 Sep 16 14:54:53 volumio-piter-room dnsmasq[2203]: read /etc/hosts - 6 names Sep 16 14:54:53 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: Streaming services startup Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: Starting Streaming Daemon Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 16 14:54:53 volumio-piter-room sudo[2207]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 14:54:53 volumio-piter-room sudo[2207]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:53 volumio-piter-room sudo[2207]: pam_unix(sudo:session): session closed for user root Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 14:54:53 volumio-piter-room volumio[1056]: info: Initializing connection to go-librespot Websocket Sep 16 14:54:54 volumio-piter-room volumio[1056]: info: Bluetoothremote--- Checking for trusted devices to reconnect... Sep 16 14:54:54 volumio-piter-room volumio[1056]: info: Bluetoothremote--- Device list cleared and placeholder written. Sep 16 14:54:54 volumio-piter-room volumio[1056]: error: Cannot start Volumio Streaming Daemon Sep 16 14:54:54 volumio-piter-room bluetoothd[900]: Adv Monitor app :1.32 disconnected from D-Bus Sep 16 14:54:54 volumio-piter-room volumio[1056]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 16 14:54:54 volumio-piter-room volumio[1056]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 16 14:54:54 volumio-piter-room volumio[1056]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Sep 16 14:54:54 volumio-piter-room volumio[1056]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 14:54:54 volumio-piter-room volumio[1056]: TypeError: Cannot read properties of null (reading 'message') Sep 16 14:54:54 volumio-piter-room volumio[1056]: at /data/plugins/system_hardware/Bluetoothremote/index.js:224:97 Sep 16 14:54:54 volumio-piter-room volumio[1056]: at ChildProcess.exithandler (node:child_process:413:7) Sep 16 14:54:54 volumio-piter-room volumio[1056]: at ChildProcess.emit (node:events:514:28) Sep 16 14:54:54 volumio-piter-room volumio[1056]: at maybeClose (node:internal/child_process:1105:16) Sep 16 14:54:54 volumio-piter-room volumio[1056]: at Socket. (node:internal/child_process:457:11) Sep 16 14:54:54 volumio-piter-room volumio[1056]: at Socket.emit (node:events:514:28) Sep 16 14:54:54 volumio-piter-room volumio[1056]: at Pipe. (node:net:337:12) Sep 16 14:54:54 volumio-piter-room volumio[1056]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 14:54:55 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 31. Sep 16 14:54:55 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:55 volumio-piter-room dnsmasq[2203]: exiting on receipt of SIGTERM Sep 16 14:54:55 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:55 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:55 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:55 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:55 volumio-piter-room hostapd[2231]: rfkill: WLAN soft blocked Sep 16 14:54:55 volumio-piter-room hostapd[2231]: Failed to set beacon parameters Sep 16 14:54:55 volumio-piter-room hostapd[2231]: wlan0: Could not connect to kernel driver Sep 16 14:54:55 volumio-piter-room hostapd[2231]: Interface initialization failed Sep 16 14:54:55 volumio-piter-room hostapd[2231]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:55 volumio-piter-room hostapd[2231]: wlan0: AP-DISABLED Sep 16 14:54:55 volumio-piter-room hostapd[2231]: wlan0: Unable to setup interface. Sep 16 14:54:55 volumio-piter-room hostapd[2231]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:55 volumio-piter-room hostapd[2231]: wlan0: AP-DISABLED Sep 16 14:54:55 volumio-piter-room hostapd[2231]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:55 volumio-piter-room hostapd[2231]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:55 volumio-piter-room hostapd[2231]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:55 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:55 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:55 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:55 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:55 volumio-piter-room dnsmasq[2236]: started, version 2.90 cachesize 150 Sep 16 14:54:55 volumio-piter-room dnsmasq[2236]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:55 volumio-piter-room dnsmasq-dhcp[2236]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:55 volumio-piter-room dnsmasq[2236]: reading /etc/resolv.conf Sep 16 14:54:55 volumio-piter-room dnsmasq[2236]: using nameserver 192.168.2.1#53 Sep 16 14:54:55 volumio-piter-room dnsmasq[2236]: using nameserver 208.67.222.222#53 Sep 16 14:54:55 volumio-piter-room dnsmasq[2236]: using nameserver 208.67.220.220#53 Sep 16 14:54:55 volumio-piter-room dnsmasq[2236]: read /etc/hosts - 6 names Sep 16 14:54:55 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Sep 16 14:54:55 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:55 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:55 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:55 volumio-piter-room go-librespot[2239]: go-librespot daemon starting... Sep 16 14:54:55 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:55+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:55 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:55+02:00" level=debug msg="app state loaded" Sep 16 14:54:55 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:55+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+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]" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+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]" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+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]" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+02:00" level=info msg="zeroconf server listening on port 32915" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+02:00" level=debug msg="obtained new client token: AAANVnob2kEwzNURQN4TiJdYMqcFYIhi+8gJuo/vnnq/hO1TS9alXjDXC+jhFYU1QByvGx6kq6HjCXH+hEzdYBZ+BIvf7v9KnRHQeFzYQhIpbk7JHlVUdIvyJSqOqKzv1nwhlULqu/5m8OH24rIc0WkTGkAA/179PbPEHs5pRtf9yhs+maPB/G8OVw3C2GWL8JVov0GrsZyV9Ht61yyuH4sujSWtuI8PonoH+DwdJh90pPECpz62lGk=" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+02:00" level=debug msg="completed keyexchange" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+02:00" level=debug msg="completed challenge" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 14:54:56 volumio-piter-room go-librespot[2240]: time="2025-09-16T14:54:56+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed requesting login5 endpoint: faield unmarshalling LoginResponse: proto:\u00a0cannot parse invalid wire-format data" Sep 16 14:54:56 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 14:54:56 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 14:54:57 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 32. Sep 16 14:54:57 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:57 volumio-piter-room dnsmasq[2236]: exiting on receipt of SIGTERM Sep 16 14:54:57 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 14:54:57 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:57 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:57 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 14:54:57 volumio-piter-room hostapd[2249]: rfkill: WLAN soft blocked Sep 16 14:54:57 volumio-piter-room hostapd[2249]: Failed to set beacon parameters Sep 16 14:54:57 volumio-piter-room hostapd[2249]: wlan0: Could not connect to kernel driver Sep 16 14:54:57 volumio-piter-room hostapd[2249]: Interface initialization failed Sep 16 14:54:57 volumio-piter-room hostapd[2249]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 14:54:57 volumio-piter-room hostapd[2249]: wlan0: AP-DISABLED Sep 16 14:54:57 volumio-piter-room hostapd[2249]: wlan0: Unable to setup interface. Sep 16 14:54:57 volumio-piter-room hostapd[2249]: wlan0: interface state DISABLED->DISABLED Sep 16 14:54:57 volumio-piter-room hostapd[2249]: wlan0: AP-DISABLED Sep 16 14:54:57 volumio-piter-room hostapd[2249]: wlan0: CTRL-EVENT-TERMINATING Sep 16 14:54:57 volumio-piter-room hostapd[2249]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 14:54:57 volumio-piter-room hostapd[2249]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 14:54:57 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 14:54:57 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 14:54:57 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 14:54:57 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 14:54:58 volumio-piter-room dnsmasq[2254]: started, version 2.90 cachesize 150 Sep 16 14:54:58 volumio-piter-room dnsmasq[2254]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 16 14:54:58 volumio-piter-room dnsmasq-dhcp[2254]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 14:54:58 volumio-piter-room dnsmasq[2254]: reading /etc/resolv.conf Sep 16 14:54:58 volumio-piter-room dnsmasq[2254]: using nameserver 192.168.2.1#53 Sep 16 14:54:58 volumio-piter-room dnsmasq[2254]: using nameserver 208.67.222.222#53 Sep 16 14:54:58 volumio-piter-room dnsmasq[2254]: using nameserver 208.67.220.220#53 Sep 16 14:54:58 volumio-piter-room dnsmasq[2254]: read /etc/hosts - 6 names Sep 16 14:54:58 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 14:54:59 volumio-piter-room sudo[2259]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-16 14:53' Sep 16 14:54:59 volumio-piter-room sudo[2259]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 14:54:59 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7. Sep 16 14:54:59 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:59 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 14:54:59 volumio-piter-room go-librespot[2275]: go-librespot daemon starting... Sep 16 14:54:59 volumio-piter-room go-librespot[2276]: time="2025-09-16T14:54:59+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 14:54:59 volumio-piter-room go-librespot[2276]: time="2025-09-16T14:54:59+02:00" level=debug msg="app state loaded" Sep 16 14:54:59 volumio-piter-room go-librespot[2276]: time="2025-09-16T14:54:59+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 14:55:00 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 33. Sep 16 14:55:00 volumio-piter-room go-librespot[2276]: time="2025-09-16T14:55:00+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]" Sep 16 14:55:00 volumio-piter-room go-librespot[2276]: time="2025-09-16T14:55:00+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]" Sep 16 14:55:00 volumio-piter-room go-librespot[2276]: time="2025-09-16T14:55:00+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]" Sep 16 14:55:00 volumio-piter-room go-librespot[2276]: time="2025-09-16T14:55:00+02:00" level=info msg="zeroconf server listening on port 40183" PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="1da895bfdbb6eb90d965df32a25a3568df7c84ed" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed May 28 19:10:18 UTC 2025" VOLUMIO_VERSION="4.003" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1bd40b20372a0e1ffe6ebc6d3df45570"