Sep 16 15:01:00 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:00 volumio-piter-room dnsmasq[1290]: started, version 2.90 cachesize 150 Sep 16 15:01:00 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 15:01:00 volumio-piter-room dnsmasq-dhcp[1290]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:00 volumio-piter-room dnsmasq[1290]: reading /etc/resolv.conf Sep 16 15:01:00 volumio-piter-room dnsmasq[1290]: using nameserver 192.168.2.1#53 Sep 16 15:01:00 volumio-piter-room dnsmasq[1290]: using nameserver 208.67.222.222#53 Sep 16 15:01:00 volumio-piter-room dnsmasq[1290]: using nameserver 208.67.220.220#53 Sep 16 15:01:00 volumio-piter-room dnsmasq[1290]: read /etc/hosts - 6 names Sep 16 15:01:00 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:00 volumio-piter-room systemd[1]: systemd-fsckd.service: Deactivated successfully. Sep 16 15:01:01 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 7. Sep 16 15:01:02 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:02 volumio-piter-room dnsmasq[1290]: exiting on receipt of SIGTERM Sep 16 15:01:02 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:02 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:02 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:02 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:02 volumio-piter-room hostapd[1294]: rfkill: WLAN soft blocked Sep 16 15:01:02 volumio-piter-room hostapd[1294]: Failed to set beacon parameters Sep 16 15:01:02 volumio-piter-room hostapd[1294]: wlan0: Could not connect to kernel driver Sep 16 15:01:02 volumio-piter-room hostapd[1294]: Interface initialization failed Sep 16 15:01:02 volumio-piter-room hostapd[1294]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:02 volumio-piter-room hostapd[1294]: wlan0: AP-DISABLED Sep 16 15:01:02 volumio-piter-room hostapd[1294]: wlan0: Unable to setup interface. Sep 16 15:01:02 volumio-piter-room hostapd[1294]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:02 volumio-piter-room hostapd[1294]: wlan0: AP-DISABLED Sep 16 15:01:02 volumio-piter-room hostapd[1294]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:02 volumio-piter-room hostapd[1294]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:02 volumio-piter-room hostapd[1294]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:02 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:02 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:02 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:02 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:02 volumio-piter-room dnsmasq[1299]: started, version 2.90 cachesize 150 Sep 16 15:01:02 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 15:01:02 volumio-piter-room dnsmasq-dhcp[1299]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:02 volumio-piter-room dnsmasq[1299]: reading /etc/resolv.conf Sep 16 15:01:02 volumio-piter-room dnsmasq[1299]: using nameserver 192.168.2.1#53 Sep 16 15:01:02 volumio-piter-room dnsmasq[1299]: using nameserver 208.67.222.222#53 Sep 16 15:01:02 volumio-piter-room dnsmasq[1299]: using nameserver 208.67.220.220#53 Sep 16 15:01:02 volumio-piter-room dnsmasq[1299]: read /etc/hosts - 6 names Sep 16 15:01:02 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:04 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 8. Sep 16 15:01:04 volumio-piter-room volumio[1101]: info: Loading plugin "ytmusic"... Sep 16 15:01:04 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:04 volumio-piter-room dnsmasq[1299]: exiting on receipt of SIGTERM Sep 16 15:01:04 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:04 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:04 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:04 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:04 volumio-piter-room hostapd[1317]: rfkill: WLAN soft blocked Sep 16 15:01:04 volumio-piter-room hostapd[1317]: Failed to set beacon parameters Sep 16 15:01:04 volumio-piter-room hostapd[1317]: wlan0: Could not connect to kernel driver Sep 16 15:01:04 volumio-piter-room hostapd[1317]: Interface initialization failed Sep 16 15:01:04 volumio-piter-room hostapd[1317]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:04 volumio-piter-room hostapd[1317]: wlan0: AP-DISABLED Sep 16 15:01:04 volumio-piter-room hostapd[1317]: wlan0: Unable to setup interface. Sep 16 15:01:04 volumio-piter-room hostapd[1317]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:04 volumio-piter-room hostapd[1317]: wlan0: AP-DISABLED Sep 16 15:01:04 volumio-piter-room hostapd[1317]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:04 volumio-piter-room hostapd[1317]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:04 volumio-piter-room hostapd[1317]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:05 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:05 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:05 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:05 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:05 volumio-piter-room dnsmasq[1322]: started, version 2.90 cachesize 150 Sep 16 15:01:05 volumio-piter-room dnsmasq[1322]: 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 15:01:05 volumio-piter-room dnsmasq-dhcp[1322]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:05 volumio-piter-room dnsmasq[1322]: reading /etc/resolv.conf Sep 16 15:01:05 volumio-piter-room dnsmasq[1322]: using nameserver 192.168.2.1#53 Sep 16 15:01:05 volumio-piter-room dnsmasq[1322]: using nameserver 208.67.222.222#53 Sep 16 15:01:05 volumio-piter-room dnsmasq[1322]: using nameserver 208.67.220.220#53 Sep 16 15:01:05 volumio-piter-room dnsmasq[1322]: read /etc/hosts - 6 names Sep 16 15:01:05 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:07 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 9. Sep 16 15:01:07 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:07 volumio-piter-room dnsmasq[1322]: exiting on receipt of SIGTERM Sep 16 15:01:07 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:07 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:07 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:07 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:07 volumio-piter-room hostapd[1326]: rfkill: WLAN soft blocked Sep 16 15:01:07 volumio-piter-room hostapd[1326]: Failed to set beacon parameters Sep 16 15:01:07 volumio-piter-room hostapd[1326]: wlan0: Could not connect to kernel driver Sep 16 15:01:07 volumio-piter-room hostapd[1326]: Interface initialization failed Sep 16 15:01:07 volumio-piter-room hostapd[1326]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:07 volumio-piter-room hostapd[1326]: wlan0: AP-DISABLED Sep 16 15:01:07 volumio-piter-room hostapd[1326]: wlan0: Unable to setup interface. Sep 16 15:01:07 volumio-piter-room hostapd[1326]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:07 volumio-piter-room hostapd[1326]: wlan0: AP-DISABLED Sep 16 15:01:07 volumio-piter-room hostapd[1326]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:07 volumio-piter-room hostapd[1326]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:07 volumio-piter-room hostapd[1326]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:07 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:07 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:07 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:07 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:08 volumio-piter-room dnsmasq[1331]: started, version 2.90 cachesize 150 Sep 16 15:01:08 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 15:01:08 volumio-piter-room dnsmasq-dhcp[1331]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:08 volumio-piter-room dnsmasq[1331]: reading /etc/resolv.conf Sep 16 15:01:08 volumio-piter-room dnsmasq[1331]: using nameserver 192.168.2.1#53 Sep 16 15:01:08 volumio-piter-room dnsmasq[1331]: using nameserver 208.67.222.222#53 Sep 16 15:01:08 volumio-piter-room dnsmasq[1331]: using nameserver 208.67.220.220#53 Sep 16 15:01:08 volumio-piter-room dnsmasq[1331]: read /etc/hosts - 6 names Sep 16 15:01:08 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:08 volumio-piter-room systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 16 15:01:09 volumio-piter-room volumio[1101]: info: Loading plugin "autostart"... Sep 16 15:01:09 volumio-piter-room volumio[1101]: info: Applying required configuration parameters for plugin autostart Sep 16 15:01:09 volumio-piter-room volumio[1101]: info: AutoStart - onVolumioStart - read config.json Sep 16 15:01:09 volumio-piter-room volumio[1101]: info: Loading plugin "now_playing"... Sep 16 15:01:10 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 10. Sep 16 15:01:10 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:10 volumio-piter-room dnsmasq[1331]: exiting on receipt of SIGTERM Sep 16 15:01:10 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:10 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:10 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:10 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:10 volumio-piter-room hostapd[1338]: rfkill: WLAN soft blocked Sep 16 15:01:10 volumio-piter-room hostapd[1338]: Failed to set beacon parameters Sep 16 15:01:10 volumio-piter-room hostapd[1338]: wlan0: Could not connect to kernel driver Sep 16 15:01:10 volumio-piter-room hostapd[1338]: Interface initialization failed Sep 16 15:01:10 volumio-piter-room hostapd[1338]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:10 volumio-piter-room hostapd[1338]: wlan0: AP-DISABLED Sep 16 15:01:10 volumio-piter-room hostapd[1338]: wlan0: Unable to setup interface. Sep 16 15:01:10 volumio-piter-room hostapd[1338]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:10 volumio-piter-room hostapd[1338]: wlan0: AP-DISABLED Sep 16 15:01:10 volumio-piter-room hostapd[1338]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:10 volumio-piter-room hostapd[1338]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:10 volumio-piter-room hostapd[1338]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:10 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:10 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:10 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:11 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:11 volumio-piter-room dnsmasq[1343]: started, version 2.90 cachesize 150 Sep 16 15:01:11 volumio-piter-room dnsmasq[1343]: 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 15:01:11 volumio-piter-room dnsmasq-dhcp[1343]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:11 volumio-piter-room dnsmasq[1343]: reading /etc/resolv.conf Sep 16 15:01:11 volumio-piter-room dnsmasq[1343]: using nameserver 192.168.2.1#53 Sep 16 15:01:11 volumio-piter-room dnsmasq[1343]: using nameserver 208.67.222.222#53 Sep 16 15:01:11 volumio-piter-room dnsmasq[1343]: using nameserver 208.67.220.220#53 Sep 16 15:01:11 volumio-piter-room dnsmasq[1343]: read /etc/hosts - 6 names Sep 16 15:01:11 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:11 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:01:11] [connect] Successful connection Sep 16 15:01:11 volumio-piter-room systemd[1]: systemd-timedated.service: Deactivated successfully. Sep 16 15:01:11 volumio-piter-room volumio[1101]: info: Loading plugin "outputs"... Sep 16 15:01:11 volumio-piter-room volumio[1101]: info: Loading plugin "albumart"... Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Plugin example_plugin is not enabled Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Loading plugin "inputs"... Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Loading plugin "updater_comm"... Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Plugin mpdemulation is not enabled Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Loading plugin "rest_api"... Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Loading plugin "websocket"... Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Starting Socket.io Server version 1.7.4 Sep 16 15:01:12 volumio-piter-room volumio[1101]: info: Loading plugin "Bluetoothremote"... Sep 16 15:01:12 volumio-piter-room volumio[1348]: Forking 3 albumart workers Sep 16 15:01:13 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 11. Sep 16 15:01:13 volumio-piter-room volumio[1101]: info: Applying required configuration parameters for plugin Bluetoothremote Sep 16 15:01:13 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:13 volumio-piter-room dnsmasq[1343]: exiting on receipt of SIGTERM Sep 16 15:01:13 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:13 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:13 volumio-piter-room volumio[1101]: info: Loading plugin "peppymeterbasic"... Sep 16 15:01:13 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:13 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:13 volumio-piter-room hostapd[1370]: rfkill: WLAN soft blocked Sep 16 15:01:13 volumio-piter-room hostapd[1370]: Failed to set beacon parameters Sep 16 15:01:13 volumio-piter-room hostapd[1370]: wlan0: Could not connect to kernel driver Sep 16 15:01:13 volumio-piter-room hostapd[1370]: Interface initialization failed Sep 16 15:01:13 volumio-piter-room hostapd[1370]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:13 volumio-piter-room hostapd[1370]: wlan0: AP-DISABLED Sep 16 15:01:13 volumio-piter-room hostapd[1370]: wlan0: Unable to setup interface. Sep 16 15:01:13 volumio-piter-room hostapd[1370]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:13 volumio-piter-room hostapd[1370]: wlan0: AP-DISABLED Sep 16 15:01:13 volumio-piter-room hostapd[1370]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:13 volumio-piter-room hostapd[1370]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:13 volumio-piter-room hostapd[1370]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:13 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:13 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:13 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:13 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:13 volumio-piter-room dnsmasq[1393]: started, version 2.90 cachesize 150 Sep 16 15:01:13 volumio-piter-room dnsmasq[1393]: 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 15:01:13 volumio-piter-room dnsmasq-dhcp[1393]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:13 volumio-piter-room dnsmasq[1393]: reading /etc/resolv.conf Sep 16 15:01:13 volumio-piter-room dnsmasq[1393]: using nameserver 192.168.2.1#53 Sep 16 15:01:13 volumio-piter-room dnsmasq[1393]: using nameserver 208.67.222.222#53 Sep 16 15:01:13 volumio-piter-room dnsmasq[1393]: using nameserver 208.67.220.220#53 Sep 16 15:01:13 volumio-piter-room dnsmasq[1393]: read /etc/hosts - 6 names Sep 16 15:01:13 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:15 volumio-piter-room volumio[1358]: Starting albumart workers Sep 16 15:01:15 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 12. Sep 16 15:01:15 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:15 volumio-piter-room dnsmasq[1393]: exiting on receipt of SIGTERM Sep 16 15:01:15 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:15 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:15 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:15 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:15 volumio-piter-room hostapd[1412]: rfkill: WLAN soft blocked Sep 16 15:01:15 volumio-piter-room hostapd[1412]: Failed to set beacon parameters Sep 16 15:01:15 volumio-piter-room hostapd[1412]: wlan0: Could not connect to kernel driver Sep 16 15:01:15 volumio-piter-room hostapd[1412]: Interface initialization failed Sep 16 15:01:15 volumio-piter-room hostapd[1412]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:15 volumio-piter-room hostapd[1412]: wlan0: AP-DISABLED Sep 16 15:01:15 volumio-piter-room hostapd[1412]: wlan0: Unable to setup interface. Sep 16 15:01:15 volumio-piter-room hostapd[1412]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:15 volumio-piter-room hostapd[1412]: wlan0: AP-DISABLED Sep 16 15:01:15 volumio-piter-room hostapd[1412]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:15 volumio-piter-room hostapd[1412]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:15 volumio-piter-room hostapd[1412]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:15 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:15 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:15 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:15 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:16 volumio-piter-room dnsmasq[1417]: started, version 2.90 cachesize 150 Sep 16 15:01:16 volumio-piter-room dnsmasq[1417]: 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 15:01:16 volumio-piter-room dnsmasq-dhcp[1417]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:16 volumio-piter-room dnsmasq[1417]: reading /etc/resolv.conf Sep 16 15:01:16 volumio-piter-room dnsmasq[1417]: using nameserver 192.168.2.1#53 Sep 16 15:01:16 volumio-piter-room dnsmasq[1417]: using nameserver 208.67.222.222#53 Sep 16 15:01:16 volumio-piter-room dnsmasq[1417]: using nameserver 208.67.220.220#53 Sep 16 15:01:16 volumio-piter-room dnsmasq[1417]: read /etc/hosts - 6 names Sep 16 15:01:16 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:16 volumio-piter-room volumio[1101]: info: Loading plugin "touch_display"... Sep 16 15:01:18 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 13. Sep 16 15:01:18 volumio-piter-room volumio[1362]: Starting albumart workers Sep 16 15:01:18 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:18 volumio-piter-room dnsmasq[1417]: exiting on receipt of SIGTERM Sep 16 15:01:18 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:18 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:18 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:18 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:18 volumio-piter-room hostapd[1427]: rfkill: WLAN soft blocked Sep 16 15:01:18 volumio-piter-room hostapd[1427]: Failed to set beacon parameters Sep 16 15:01:18 volumio-piter-room hostapd[1427]: wlan0: Could not connect to kernel driver Sep 16 15:01:18 volumio-piter-room hostapd[1427]: Interface initialization failed Sep 16 15:01:18 volumio-piter-room hostapd[1427]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:18 volumio-piter-room hostapd[1427]: wlan0: AP-DISABLED Sep 16 15:01:18 volumio-piter-room hostapd[1427]: wlan0: Unable to setup interface. Sep 16 15:01:18 volumio-piter-room hostapd[1427]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:18 volumio-piter-room hostapd[1427]: wlan0: AP-DISABLED Sep 16 15:01:18 volumio-piter-room hostapd[1427]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:18 volumio-piter-room hostapd[1427]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:18 volumio-piter-room hostapd[1427]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:18 volumio-piter-room volumio[1368]: Starting albumart workers Sep 16 15:01:18 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:18 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:18 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:18 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:18 volumio-piter-room dnsmasq[1432]: started, version 2.90 cachesize 150 Sep 16 15:01:18 volumio-piter-room dnsmasq[1432]: 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 15:01:18 volumio-piter-room dnsmasq-dhcp[1432]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:18 volumio-piter-room dnsmasq[1432]: reading /etc/resolv.conf Sep 16 15:01:18 volumio-piter-room dnsmasq[1432]: using nameserver 192.168.2.1#53 Sep 16 15:01:18 volumio-piter-room dnsmasq[1432]: using nameserver 208.67.222.222#53 Sep 16 15:01:18 volumio-piter-room dnsmasq[1432]: using nameserver 208.67.220.220#53 Sep 16 15:01:18 volumio-piter-room dnsmasq[1432]: read /etc/hosts - 6 names Sep 16 15:01:18 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:18 volumio-piter-room volumio[1101]: info: Applying required configuration parameters for plugin touch_display Sep 16 15:01:19 volumio-piter-room volumio[1101]: info: Loading i18n strings for locale pl Sep 16 15:01:19 volumio-piter-room volumio[1101]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 15:01:19 volumio-piter-room volumio[1101]: Updating browse sources language Sep 16 15:01:19 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:20 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 14. Sep 16 15:01:20 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:20 volumio-piter-room dnsmasq[1432]: exiting on receipt of SIGTERM Sep 16 15:01:20 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:20 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:20 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:20 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:20 volumio-piter-room hostapd[1436]: rfkill: WLAN soft blocked Sep 16 15:01:20 volumio-piter-room hostapd[1436]: Failed to set beacon parameters Sep 16 15:01:20 volumio-piter-room hostapd[1436]: wlan0: Could not connect to kernel driver Sep 16 15:01:20 volumio-piter-room hostapd[1436]: Interface initialization failed Sep 16 15:01:20 volumio-piter-room hostapd[1436]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:20 volumio-piter-room hostapd[1436]: wlan0: AP-DISABLED Sep 16 15:01:20 volumio-piter-room hostapd[1436]: wlan0: Unable to setup interface. Sep 16 15:01:20 volumio-piter-room hostapd[1436]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:20 volumio-piter-room hostapd[1436]: wlan0: AP-DISABLED Sep 16 15:01:20 volumio-piter-room hostapd[1436]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:20 volumio-piter-room hostapd[1436]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:20 volumio-piter-room hostapd[1436]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:20 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:20 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:20 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:20 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:20 volumio-piter-room dnsmasq[1441]: started, version 2.90 cachesize 150 Sep 16 15:01:20 volumio-piter-room dnsmasq[1441]: 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 15:01:20 volumio-piter-room dnsmasq-dhcp[1441]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:20 volumio-piter-room dnsmasq[1441]: reading /etc/resolv.conf Sep 16 15:01:20 volumio-piter-room dnsmasq[1441]: using nameserver 192.168.2.1#53 Sep 16 15:01:20 volumio-piter-room dnsmasq[1441]: using nameserver 208.67.222.222#53 Sep 16 15:01:20 volumio-piter-room dnsmasq[1441]: using nameserver 208.67.220.220#53 Sep 16 15:01:20 volumio-piter-room dnsmasq[1441]: read /etc/hosts - 6 names Sep 16 15:01:20 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::initPlayerControls Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 15:01:21 volumio-piter-room volumio[1101]: Express server listening on port 3000 Sep 16 15:01:21 volumio-piter-room volumio[1101]: [Metrics] WebUI: 33s 376.79ms Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreStateMachine::resetVolumioState Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreStateMachine::getcurrentVolume Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:21 volumio-piter-room sudo[1461]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 15:01:21 volumio-piter-room sudo[1461]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:21 volumio-piter-room sudo[1463]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 15:01:21 volumio-piter-room sudo[1463]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:21 volumio-piter-room sudo[1461]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:21 volumio-piter-room sudo[1463]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: Volumio Network Manager: Network status updated: 1 Sep 16 15:01:21 volumio-piter-room volumio[1101]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 16 15:01:21 volumio-piter-room volumio[1101]: wlan0 Interface doesn't support scanning : Network is down Sep 16 15:01:21 volumio-piter-room volumio[1101]: info: Cannot use regular scanning, forcing with ap-force Sep 16 15:01:22 volumio-piter-room sudo[1470]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 16 15:01:22 volumio-piter-room sudo[1470]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:22 volumio-piter-room sudo[1470]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:22 volumio-piter-room volumio[1101]: command failed: Network is down (-100) Sep 16 15:01:22 volumio-piter-room volumio[1101]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 16 15:01:22 volumio-piter-room volumio[1101]: command failed: Network is down (-100) Sep 16 15:01:22 volumio-piter-room volumio[1101]: 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 15:01:22 volumio-piter-room volumio[1101]: info: VolumeController:: Volume=5 Mute =false Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreStateMachine::pushState Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioPushState Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreStateMachine::updateTrackBlock Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrackBlock Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 15:01:22 volumio-piter-room volumio[1101]: 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 15:01:22 volumio-piter-room volumio[1101]: info: Reloading queue from file Sep 16 15:01:22 volumio-piter-room volumio[1101]: 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 15:01:22 volumio-piter-room volumio[1101]: 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 15:01:22 volumio-piter-room volumio[1101]: info: Setting Device type: Raspberry PI Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreStateMachine::setRepeat null single undefined Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreStateMachine::pushState Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioPushState Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreStateMachine::setRandom null Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreStateMachine::pushState Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:22 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioPushState Sep 16 15:01:23 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 15. Sep 16 15:01:23 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:23 volumio-piter-room dnsmasq[1441]: exiting on receipt of SIGTERM Sep 16 15:01:23 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:23 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:23 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:23 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:23 volumio-piter-room hostapd[1484]: rfkill: WLAN soft blocked Sep 16 15:01:23 volumio-piter-room hostapd[1484]: Failed to set beacon parameters Sep 16 15:01:23 volumio-piter-room hostapd[1484]: wlan0: Could not connect to kernel driver Sep 16 15:01:23 volumio-piter-room hostapd[1484]: Interface initialization failed Sep 16 15:01:23 volumio-piter-room hostapd[1484]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:23 volumio-piter-room hostapd[1484]: wlan0: AP-DISABLED Sep 16 15:01:23 volumio-piter-room hostapd[1484]: wlan0: Unable to setup interface. Sep 16 15:01:23 volumio-piter-room hostapd[1484]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:23 volumio-piter-room hostapd[1484]: wlan0: AP-DISABLED Sep 16 15:01:23 volumio-piter-room hostapd[1484]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:23 volumio-piter-room hostapd[1484]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:23 volumio-piter-room hostapd[1484]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room volumio[1101]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03112 Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 16 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room volumio[1101]: info: VolumeController:: Volume=5 Mute =false Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreStateMachine::pushState Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioPushState Sep 16 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:23 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:23 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:23 volumio-piter-room sudo[1486]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 16 15:01:23 volumio-piter-room sudo[1486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:23 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room dnsmasq[1492]: started, version 2.90 cachesize 150 Sep 16 15:01:23 volumio-piter-room dnsmasq[1492]: 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 15:01:23 volumio-piter-room dnsmasq-dhcp[1492]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:23 volumio-piter-room dnsmasq[1492]: reading /etc/resolv.conf Sep 16 15:01:23 volumio-piter-room dnsmasq[1492]: using nameserver 192.168.2.1#53 Sep 16 15:01:23 volumio-piter-room dnsmasq[1492]: using nameserver 208.67.222.222#53 Sep 16 15:01:23 volumio-piter-room dnsmasq[1492]: using nameserver 208.67.220.220#53 Sep 16 15:01:23 volumio-piter-room dnsmasq[1492]: read /etc/hosts - 6 names Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:23 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:23 volumio-piter-room systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Sep 16 15:01:23 volumio-piter-room sudo[1486]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: Listing playlists Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: Discovery: adding 9992bd7f-303c-4d6b-abb1-8779e9fad663 Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: Discovery: Found device VOLUMIO PITER ROOM Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: Discovery: this is already registered, 9992bd7f-303c-4d6b-abb1-8779e9fad663 Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: Discovery: Found device VOLUMIO PITER ROOM Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room volumio[1101]: 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 15:01:23 volumio-piter-room volumio[1101]: info: Upmpdcli Daemon Started Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: Completed loading Core Plugins Sep 16 15:01:23 volumio-piter-room volumio[1101]: info: Preparing to generate the ALSA configuration file Sep 16 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 16 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Sep 16 15:01:24 volumio-piter-room volumio[1101]: info: Reading ALSA contributions from plugins. Sep 16 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:24 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 37 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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 15:01:25 volumio-piter-room volumio[1101]: 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: 46 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 47 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 48 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 49 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 50 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 51 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 52 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 53 Sep 16 15:01:25 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 16. Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 54 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 55 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 56 Sep 16 15:01:25 volumio-piter-room volumio[1101]: 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: 57 Sep 16 15:01:25 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:25 volumio-piter-room dnsmasq[1492]: exiting on receipt of SIGTERM Sep 16 15:01:25 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:25 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:25 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: Asound.conf file unchanged, so no further update is needed Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: Output device has changed, restarting MPD Sep 16 15:01:25 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:25 volumio-piter-room hostapd[1523]: rfkill: WLAN soft blocked Sep 16 15:01:25 volumio-piter-room hostapd[1523]: Failed to set beacon parameters Sep 16 15:01:25 volumio-piter-room hostapd[1523]: wlan0: Could not connect to kernel driver Sep 16 15:01:25 volumio-piter-room hostapd[1523]: Interface initialization failed Sep 16 15:01:25 volumio-piter-room hostapd[1523]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:25 volumio-piter-room hostapd[1523]: wlan0: AP-DISABLED Sep 16 15:01:25 volumio-piter-room hostapd[1523]: wlan0: Unable to setup interface. Sep 16 15:01:25 volumio-piter-room hostapd[1523]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:25 volumio-piter-room hostapd[1523]: wlan0: AP-DISABLED Sep 16 15:01:25 volumio-piter-room hostapd[1523]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:25 volumio-piter-room hostapd[1523]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:25 volumio-piter-room hostapd[1523]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: Output device has changed, restarting Shairport Sync Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:25 volumio-piter-room sudo[1527]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:01:25 volumio-piter-room sudo[1527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:25 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:25 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:25 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: ___________ START PLUGINS ___________ Sep 16 15:01:25 volumio-piter-room sudo[1525]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:01:25 volumio-piter-room sudo[1525]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: ControllerMpd::onStart: Initializing MPD Sep 16 15:01:25 volumio-piter-room volumio[1101]: info: Creating MPD Configuration file Sep 16 15:01:25 volumio-piter-room sudo[1525]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:25 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:25 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:01:25 volumio-piter-room dnsmasq[1541]: started, version 2.90 cachesize 150 Sep 16 15:01:25 volumio-piter-room dnsmasq[1541]: 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 15:01:25 volumio-piter-room dnsmasq-dhcp[1541]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:25 volumio-piter-room dnsmasq[1541]: reading /etc/resolv.conf Sep 16 15:01:26 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:01:26 volumio-piter-room dnsmasq[1541]: using nameserver 192.168.2.1#53 Sep 16 15:01:26 volumio-piter-room dnsmasq[1541]: using nameserver 208.67.222.222#53 Sep 16 15:01:26 volumio-piter-room dnsmasq[1541]: using nameserver 208.67.220.220#53 Sep 16 15:01:26 volumio-piter-room dnsmasq[1541]: read /etc/hosts - 6 names Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: [1758027686035] CoreMusicLibrary::Adding element Serwery Mediów Sep 16 15:01:26 volumio-piter-room sudo[1537]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:01:26 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:26 volumio-piter-room sudo[1537]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:26 volumio-piter-room sudo[1537]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:26 volumio-piter-room sudo[1546]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:01:26 volumio-piter-room sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:26 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 15:01:26 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 15:01:26 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 15:01:26 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 15:01:26 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:26 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:01:26 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: [1758027686571] CoreMusicLibrary::Adding element Last_100 Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: [1758027686577] CoreMusicLibrary::Adding element Webradio Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:26 volumio-piter-room sudo[1554]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 15:01:26 volumio-piter-room sudo[1554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:01:26 volumio-piter-room sudo[1559]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 16 15:01:26 volumio-piter-room sudo[1554]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: Initializing BBC Radios Sep 16 15:01:26 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:01:26] [connect] Successful connection Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:01:26 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:27 volumio-piter-room volumio[1101]: info: Creating Spotify config file Sep 16 15:01:27 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:28 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 17. Sep 16 15:01:28 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:28 volumio-piter-room dnsmasq[1541]: exiting on receipt of SIGTERM Sep 16 15:01:28 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:28 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:28 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:28 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:28 volumio-piter-room hostapd[1575]: rfkill: WLAN soft blocked Sep 16 15:01:28 volumio-piter-room hostapd[1575]: Failed to set beacon parameters Sep 16 15:01:28 volumio-piter-room hostapd[1575]: wlan0: Could not connect to kernel driver Sep 16 15:01:28 volumio-piter-room hostapd[1575]: Interface initialization failed Sep 16 15:01:28 volumio-piter-room hostapd[1575]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:28 volumio-piter-room hostapd[1575]: wlan0: AP-DISABLED Sep 16 15:01:28 volumio-piter-room hostapd[1575]: wlan0: Unable to setup interface. Sep 16 15:01:28 volumio-piter-room hostapd[1575]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:28 volumio-piter-room hostapd[1575]: wlan0: AP-DISABLED Sep 16 15:01:28 volumio-piter-room hostapd[1575]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:28 volumio-piter-room hostapd[1575]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:28 volumio-piter-room hostapd[1575]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:28 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:28 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:28 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:28 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:28 volumio-piter-room dnsmasq[1580]: started, version 2.90 cachesize 150 Sep 16 15:01:28 volumio-piter-room dnsmasq[1580]: 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 15:01:28 volumio-piter-room dnsmasq-dhcp[1580]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:28 volumio-piter-room dnsmasq[1580]: reading /etc/resolv.conf Sep 16 15:01:28 volumio-piter-room dnsmasq[1580]: using nameserver 192.168.2.1#53 Sep 16 15:01:28 volumio-piter-room dnsmasq[1580]: using nameserver 208.67.222.222#53 Sep 16 15:01:28 volumio-piter-room dnsmasq[1580]: using nameserver 208.67.220.220#53 Sep 16 15:01:28 volumio-piter-room dnsmasq[1580]: read /etc/hosts - 6 names Sep 16 15:01:28 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: [1758027688677] CoreMusicLibrary::Adding element YouTube2 Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:28 volumio-piter-room volumio[1101]: Cannot find translation for source YouTube2 Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: [1758027688735] CoreMusicLibrary::Adding element YouTube Music Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:28 volumio-piter-room volumio[1101]: Cannot find translation for source YouTube2 Sep 16 15:01:28 volumio-piter-room volumio[1101]: Cannot find translation for source YouTube Music Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: AutoStart - onStart Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: [now-playing] ConfigUpdater: config is up to date. Sep 16 15:01:28 volumio-piter-room volumio[1101]: info: Loading i18n strings for locale pl Sep 16 15:01:29 volumio-piter-room volumio[1101]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 15:01:29 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 16 15:01:29 volumio-piter-room volumio[1101]: info: Loading i18n strings for locale pl Sep 16 15:01:29 volumio-piter-room volumio[1101]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 15:01:29 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:01:29 volumio-piter-room volumio[1101]: info: Volumio Calling Home Sep 16 15:01:29 volumio-piter-room sudo[1584]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Sep 16 15:01:29 volumio-piter-room sudo[1584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:29 volumio-piter-room sudo[1584]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:29 volumio-piter-room volumio[1101]: info: Preparing to generate the ALSA configuration file Sep 16 15:01:29 volumio-piter-room sudo[1596]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Sep 16 15:01:29 volumio-piter-room sudo[1596]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:29 volumio-piter-room sudo[1599]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Sep 16 15:01:29 volumio-piter-room sudo[1599]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:29 volumio-piter-room sudo[1596]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:29 volumio-piter-room sudo[1601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Sep 16 15:01:29 volumio-piter-room systemd[1]: Reloading. Sep 16 15:01:30 volumio-piter-room sudo[1601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:30 volumio-piter-room volumio[1101]: info: [now-playing] App is listening on port 4004. Sep 16 15:01:31 volumio-piter-room volumio[1101]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Sep 16 15:01:31 volumio-piter-room volumio[1101]: 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: 58 Sep 16 15:01:31 volumio-piter-room volumio[1101]: 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: 59 Sep 16 15:01:31 volumio-piter-room volumio[1101]: 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: 60 Sep 16 15:01:31 volumio-piter-room volumio[1101]: 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: 61 Sep 16 15:01:31 volumio-piter-room volumio[1101]: 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: 62 Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: AutoStart - Plugin is starting Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetQueue Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::getQueue Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CorePlayQueue::getQueue Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: AutoStart - start playing Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: AutoStart - start playing with no specific position Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioPlay Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::play index 0 Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::stop Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::play index undefined Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CoreStateMachine::startPlaybackTimer Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:31 volumio-piter-room volumio[1101]: info: [1758027691829] ControllerUPNPBrowser::clearAddPlayTrack Sep 16 15:01:31 volumio-piter-room volumio[1101]: verbose: ControllerMpd::sendMpdCommand stop Sep 16 15:01:31 volumio-piter-room volumio[1101]: 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: 63 Sep 16 15:01:31 volumio-piter-room volumio[1101]: 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: 64 Sep 16 15:01:32 volumio-piter-room volumio[1101]: 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: 65 Sep 16 15:01:32 volumio-piter-room volumio[1101]: 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: 66 Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: Reading ALSA contributions from plugins. Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: touch_display: No backlight interface detected. Sep 16 15:01:32 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 18. Sep 16 15:01:32 volumio-piter-room systemd[1]: Reloading. Sep 16 15:01:32 volumio-piter-room sudo[1599]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: touch_display: systemctl stop getty@tty1.service succeeded. Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: snd_dummy loaded Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: MPD Permissions set Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: MPD Permissions set Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: touch_display: systemctl disable getty@tty1.service succeeded. Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: Volumio called home Sep 16 15:01:32 volumio-piter-room volumio[1101]: info: Spotify config file written Sep 16 15:01:33 volumio-piter-room sudo[1641]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Sep 16 15:01:33 volumio-piter-room sudo[1641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:34 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 19. Sep 16 15:01:34 volumio-piter-room sudo[1601]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:34 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 15:01:34 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 15:01:34 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:34 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:01:34 volumio-piter-room go-librespot[1658]: go-librespot daemon starting... Sep 16 15:01:34 volumio-piter-room dnsmasq[1580]: exiting on receipt of SIGTERM Sep 16 15:01:34 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:34 volumio-piter-room sudo[1641]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:34 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:34 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:34 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:34 volumio-piter-room hostapd[1660]: rfkill: WLAN soft blocked Sep 16 15:01:34 volumio-piter-room hostapd[1660]: Failed to set beacon parameters Sep 16 15:01:34 volumio-piter-room hostapd[1660]: wlan0: Could not connect to kernel driver Sep 16 15:01:34 volumio-piter-room hostapd[1660]: Interface initialization failed Sep 16 15:01:34 volumio-piter-room hostapd[1660]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:34 volumio-piter-room hostapd[1660]: wlan0: AP-DISABLED Sep 16 15:01:34 volumio-piter-room hostapd[1660]: wlan0: Unable to setup interface. Sep 16 15:01:34 volumio-piter-room hostapd[1660]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:34 volumio-piter-room hostapd[1660]: wlan0: AP-DISABLED Sep 16 15:01:34 volumio-piter-room hostapd[1660]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:34 volumio-piter-room hostapd[1660]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:34 volumio-piter-room hostapd[1660]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:35 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:35 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:35 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:35 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:35 volumio-piter-room dnsmasq[1670]: started, version 2.90 cachesize 150 Sep 16 15:01:35 volumio-piter-room dnsmasq[1670]: 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 15:01:35 volumio-piter-room dnsmasq-dhcp[1670]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:35 volumio-piter-room dnsmasq[1670]: reading /etc/resolv.conf Sep 16 15:01:35 volumio-piter-room dnsmasq[1670]: using nameserver 192.168.2.1#53 Sep 16 15:01:35 volumio-piter-room dnsmasq[1670]: using nameserver 208.67.222.222#53 Sep 16 15:01:35 volumio-piter-room dnsmasq[1670]: using nameserver 208.67.220.220#53 Sep 16 15:01:35 volumio-piter-room dnsmasq[1670]: read /etc/hosts - 6 names Sep 16 15:01:35 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: No need to fix Spotify hosts Sep 16 15:01:35 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:35+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:01:35 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:35+02:00" level=debug msg="app state loaded" Sep 16 15:01:35 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room mpd[1560]: 2025-09-16T15:01:35 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:35 volumio-piter-room sudo[1527]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:35 volumio-piter-room sudo[1546]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:35 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01: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 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01: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 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01: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 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:36+02:00" level=info msg="zeroconf server listening on port 45191" Sep 16 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:36+02:00" level=debug msg="obtained new client token: AAD1ysqK+oFVAD5BjsCKCj5wz9VeSsj7R/mjweOprJrP9mjLjKkFoL6LoUdn/XtBLeum298MwFavvvB9mam3Uis2nXO2G/xMAx9lJtlu+IVg6kSENrr7DRdZ1RwG3/+H9CvGi5jeTv2V0pnzOuKxSdw4NSg7CZwmCCZzKgLPSGMQmoyK2mR8ERho3V+CPOynt3yX0PboIDXEVsJAxOR83NAkavJij1ns71QsCrGv1rAVyICnKPjrD9s=" Sep 16 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:36+02:00" level=debug msg="completed keyexchange" Sep 16 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:36+02:00" level=debug msg="completed challenge" Sep 16 15:01:36 volumio-piter-room volumio[1101]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 67 Sep 16 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01:36+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 15:01:36 volumio-piter-room volumio[1101]: info: touch_display: systemctl daemon-reload succeeded. Sep 16 15:01:36 volumio-piter-room go-librespot[1659]: time="2025-09-16T15:01: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 15:01:36 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 15:01:36 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 15:01:36 volumio-piter-room sudo[1689]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Sep 16 15:01:36 volumio-piter-room sudo[1689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:36 volumio-piter-room volumio[1101]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 68 Sep 16 15:01:36 volumio-piter-room systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Sep 16 15:01:36 volumio-piter-room sudo[1689]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:36 volumio-piter-room volumio[1101]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Sep 16 15:01:36 volumio-piter-room volumio[1101]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Sep 16 15:01:36 volumio-piter-room volumio[1101]: SPOTIFY: BQAAv-kSXl3v4J8C4Tme0n6cYPzlaNvhk3EnTDNdz-hCk8oJnsMQl5RL4dmvE7N3zwbrjg3o9dfPgVFQbZhpQMV_tm5NjDpmLqvEChHnsKi04smDLk2ACh58GqYVwYHyg_t5L_ccY8RZsFqCADAfiO7az6E72Lk9OClupRRafZ-6bVAJygWB6t_-3vZ_r4RNgZtfpxP8gpdH-9ZS-GRVct5j_ffrbYQbgTByret6HeCk50a0XgXaBF72X9jvW7HDEU-3lucARkoM8BERaXjg71QWRdvf9Gu0byMZ412DdnqT6co Sep 16 15:01:36 volumio-piter-room volumio[1101]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Sep 16 15:01:36 volumio-piter-room volumio[1101]: info: New Spotify access token = BQAAv-kSXl3v4J8C4Tme0n6cYPzlaNvhk3EnTDNdz-hCk8oJnsMQl5RL4dmvE7N3zwbrjg3o9dfPgVFQbZhpQMV_tm5NjDpmLqvEChHnsKi04smDLk2ACh58GqYVwYHyg_t5L_ccY8RZsFqCADAfiO7az6E72Lk9OClupRRafZ-6bVAJygWB6t_-3vZ_r4RNgZtfpxP8gpdH-9ZS-GRVct5j_ffrbYQbgTByret6HeCk50a0XgXaBF72X9jvW7HDEU-3lucARkoM8BERaXjg71QWRdvf9Gu0byMZ412DdnqT6co Sep 16 15:01:36 volumio-piter-room volumio[1101]: info: Spotify credentials grant success - running version from March 24, 2019 Sep 16 15:01:36 volumio-piter-room sudo[1699]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Sep 16 15:01:36 volumio-piter-room sudo[1699]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:36 volumio-piter-room sudo[1699]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:37 volumio-piter-room startx[1718]: X.Org X Server 1.21.1.7 Sep 16 15:01:37 volumio-piter-room startx[1718]: X Protocol Version 11, Revision 0 Sep 16 15:01:37 volumio-piter-room startx[1718]: Current Operating System: Linux volumio-piter-room 6.12.27-v7l+ #1876 SMP Tue May 6 15:10:05 BST 2025 armv7l Sep 16 15:01:37 volumio-piter-room startx[1718]: 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 15:01:37 volumio-piter-room startx[1718]: xorg-server 2:21.1.7-3+rpt3+deb12u9 (https://www.debian.org/support) Sep 16 15:01:37 volumio-piter-room startx[1718]: Current version of pixman: 0.44.0 Sep 16 15:01:37 volumio-piter-room startx[1718]: Before reporting problems, check http://wiki.x.org Sep 16 15:01:37 volumio-piter-room startx[1718]: to make sure that you have the latest version. Sep 16 15:01:37 volumio-piter-room startx[1718]: Markers: (--) probed, (**) from config file, (==) default setting, Sep 16 15:01:37 volumio-piter-room startx[1718]: (++) from command line, (!!) notice, (II) informational, Sep 16 15:01:37 volumio-piter-room startx[1718]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Sep 16 15:01:37 volumio-piter-room startx[1718]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Sep 16 15:01:37 2025 Sep 16 15:01:37 volumio-piter-room startx[1718]: (==) Using config directory: "/etc/X11/xorg.conf.d" Sep 16 15:01:37 volumio-piter-room startx[1718]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Sep 16 15:01:37 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 20. Sep 16 15:01:37 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:37 volumio-piter-room dnsmasq[1670]: exiting on receipt of SIGTERM Sep 16 15:01:37 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:37 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:37 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:37 volumio-piter-room volumio[1101]: info: MPD running with PID1560 Sep 16 15:01:37 volumio-piter-room volumio[1101]: ,establishing connection Sep 16 15:01:37 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:37 volumio-piter-room volumio[1101]: info: Starting Shairport Sync Sep 16 15:01:37 volumio-piter-room hostapd[1720]: rfkill: WLAN soft blocked Sep 16 15:01:37 volumio-piter-room hostapd[1720]: Failed to set beacon parameters Sep 16 15:01:37 volumio-piter-room hostapd[1720]: wlan0: Could not connect to kernel driver Sep 16 15:01:37 volumio-piter-room hostapd[1720]: Interface initialization failed Sep 16 15:01:37 volumio-piter-room hostapd[1720]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:37 volumio-piter-room hostapd[1720]: wlan0: AP-DISABLED Sep 16 15:01:37 volumio-piter-room hostapd[1720]: wlan0: Unable to setup interface. Sep 16 15:01:37 volumio-piter-room hostapd[1720]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:37 volumio-piter-room hostapd[1720]: wlan0: AP-DISABLED Sep 16 15:01:37 volumio-piter-room hostapd[1720]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:37 volumio-piter-room hostapd[1720]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:37 volumio-piter-room hostapd[1720]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:37 volumio-piter-room volumio[1101]: info: Starting Shairport Sync Sep 16 15:01:37 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:37 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:37 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:37 volumio-piter-room volumio[1101]: info: Starting Shairport Sync Sep 16 15:01:37 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:37 volumio-piter-room sudo[1722]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:01:37 volumio-piter-room sudo[1722]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:37 volumio-piter-room sudo[1726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:01:37 volumio-piter-room sudo[1726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:37 volumio-piter-room dnsmasq[1733]: started, version 2.90 cachesize 150 Sep 16 15:01:37 volumio-piter-room dnsmasq[1733]: 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 15:01:37 volumio-piter-room dnsmasq-dhcp[1733]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:37 volumio-piter-room dnsmasq[1733]: reading /etc/resolv.conf Sep 16 15:01:37 volumio-piter-room dnsmasq[1733]: using nameserver 192.168.2.1#53 Sep 16 15:01:37 volumio-piter-room dnsmasq[1733]: using nameserver 208.67.222.222#53 Sep 16 15:01:37 volumio-piter-room dnsmasq[1733]: using nameserver 208.67.220.220#53 Sep 16 15:01:37 volumio-piter-room dnsmasq[1733]: read /etc/hosts - 6 names Sep 16 15:01:37 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 15:01:37 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 15:01:37 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:37 volumio-piter-room systemd[1]: shairport-sync.service: Consumed 2.129s CPU time. Sep 16 15:01:37 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:37 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:37 volumio-piter-room sudo[1726]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:37 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 15:01:37 volumio-piter-room sudo[1727]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:01:37 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 15:01:37 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:37 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:37 volumio-piter-room sudo[1722]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:37 volumio-piter-room sudo[1727]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:38 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 15:01:38 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 15:01:38 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:38 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:38 volumio-piter-room sudo[1727]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:38 volumio-piter-room volumio[1101]: error: MPD error: The expression evaluated to a falsy value: Sep 16 15:01:38 volumio-piter-room volumio[1101]: assert.ok(self.idling) Sep 16 15:01:38 volumio-piter-room volumio[1101]: error: The expression evaluated to a falsy value: Sep 16 15:01:38 volumio-piter-room volumio[1101]: assert.ok(self.idling) Sep 16 15:01:38 volumio-piter-room volumio[1101]: error: MPD error: The expression evaluated to a falsy value: Sep 16 15:01:38 volumio-piter-room volumio[1101]: assert.ok(self.idling) Sep 16 15:01:38 volumio-piter-room volumio[1101]: error: The expression evaluated to a falsy value: Sep 16 15:01:38 volumio-piter-room volumio[1101]: assert.ok(self.idling) Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: touch_display: Volumio Kiosk started. Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Completed starting Core Plugins Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: ------------------------------------------- Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: ----- MyVolumio plugins startup ---- Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: ------------------------------------------- Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Shairport-Sync Started Sep 16 15:01:38 volumio-piter-room volumio[1101]: Error adding Membership: Error: addMembership EINVAL Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Shairport-Sync Started Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Shairport-Sync Started Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Asound.conf file unchanged, so no further update is needed Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Output device has changed, restarting MPD Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Output device has changed, restarting Shairport Sync Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:38 volumio-piter-room sudo[1778]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:01:38 volumio-piter-room sudo[1778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:38 volumio-piter-room sudo[1780]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:01:38 volumio-piter-room sudo[1780]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:38 volumio-piter-room sudo[1778]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:38 volumio-piter-room volumio[1101]: error: updateQueue error: null Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: MPD Permissions set Sep 16 15:01:38 volumio-piter-room volumio[1101]: info: touch_display: X display number found: 0 Sep 16 15:01:39 volumio-piter-room systemd[1]: Stopping mpd.service - Music Player Daemon... Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: touch_display: X display number found: 0 Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Sep 16 15:01:39 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Sep 16 15:01:39 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:01:39 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:01:39 volumio-piter-room go-librespot[1813]: go-librespot daemon starting... Sep 16 15:01:39 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 15:01:39 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 15:01:39 volumio-piter-room systemd[1]: mpd.service: Consumed 7.377s CPU time. Sep 16 15:01:39 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 21. Sep 16 15:01:39 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 15:01:39 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 15:01:39 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 15:01:39 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:01:39 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:39 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:01:39 volumio-piter-room dnsmasq[1733]: exiting on receipt of SIGTERM Sep 16 15:01:39 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:39 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:39 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:39 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:39 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:39+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:01:39 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:39+02:00" level=debug msg="app state loaded" Sep 16 15:01:39 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:01:39 volumio-piter-room hostapd[1833]: rfkill: WLAN soft blocked Sep 16 15:01:39 volumio-piter-room hostapd[1833]: Failed to set beacon parameters Sep 16 15:01:39 volumio-piter-room hostapd[1833]: wlan0: Could not connect to kernel driver Sep 16 15:01:39 volumio-piter-room hostapd[1833]: Interface initialization failed Sep 16 15:01:39 volumio-piter-room hostapd[1833]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:39 volumio-piter-room hostapd[1833]: wlan0: AP-DISABLED Sep 16 15:01:39 volumio-piter-room hostapd[1833]: wlan0: Unable to setup interface. Sep 16 15:01:39 volumio-piter-room hostapd[1833]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:39 volumio-piter-room hostapd[1833]: wlan0: AP-DISABLED Sep 16 15:01:39 volumio-piter-room hostapd[1833]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:39 volumio-piter-room hostapd[1833]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:39 volumio-piter-room hostapd[1833]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: go-librespot daemon successfully initialized Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:39 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:39 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:39 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:40 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:40 volumio-piter-room sudo[1828]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 15:01:40 volumio-piter-room sudo[1828]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:01:40 volumio-piter-room sudo[1828]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:40 volumio-piter-room dnsmasq[1866]: started, version 2.90 cachesize 150 Sep 16 15:01:40 volumio-piter-room dnsmasq[1866]: 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 15:01:40 volumio-piter-room dnsmasq-dhcp[1866]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:40 volumio-piter-room dnsmasq[1866]: reading /etc/resolv.conf Sep 16 15:01:40 volumio-piter-room dnsmasq[1866]: using nameserver 192.168.2.1#53 Sep 16 15:01:40 volumio-piter-room dnsmasq[1866]: using nameserver 208.67.222.222#53 Sep 16 15:01:40 volumio-piter-room dnsmasq[1866]: using nameserver 208.67.220.220#53 Sep 16 15:01:40 volumio-piter-room dnsmasq[1866]: read /etc/hosts - 6 names Sep 16 15:01:40 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:40 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:40 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01: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 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01: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 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01: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 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:40+02:00" level=info msg="zeroconf server listening on port 45315" Sep 16 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:40+02:00" level=debug msg="obtained new client token: AAAvfapsRQnimAfSTY3+JbOz+XHRI7edFXOa/JIZ65eWtsf7p3ThZgkQudlXzGex0Wj6wRlgYyWsfamxLd7yewBLpCHdqtIeyFMhaqZEVnNa+MfNs9Mpcfk/DrYliGoXLSxvLAXcsZOwEWz6yY9oPuwbLT6TywfCx+tS9U77cpvaUmF6g7bbCmeMCiecPYMXj+SpZFcqHFuJVHPZI4JSVi2/17S63zu8gsHJ6NIhE46ni9kJF1Rr2tap8Q==" Sep 16 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:40+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:40+02:00" level=debug msg="completed keyexchange" Sep 16 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:40+02:00" level=debug msg="completed challenge" Sep 16 15:01:40 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:40+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 15:01:40 volumio-piter-room volumio[1101]: info: touch_display: X display number found: 0 Sep 16 15:01:40 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:40 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:41 volumio-piter-room volumio[1101]: info: Starting Shairport Sync Sep 16 15:01:41 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:41 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:41 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:01:41] [connect] Successful connection Sep 16 15:01:41 volumio-piter-room volumio[1101]: 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 15:01:41 volumio-piter-room volumio[1101]: info: Spotify Successfully logged in Sep 16 15:01:41 volumio-piter-room sudo[1888]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:01:41 volumio-piter-room sudo[1888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:01:41 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:01:41 volumio-piter-room volumio[1101]: info: [1758027701807] CoreMusicLibrary::Adding element Spotify Sep 16 15:01:41 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:01:41 volumio-piter-room volumio[1101]: Cannot find translation for source YouTube2 Sep 16 15:01:41 volumio-piter-room volumio[1101]: Cannot find translation for source YouTube Music Sep 16 15:01:41 volumio-piter-room volumio[1101]: Cannot find translation for source Spotify Sep 16 15:01:41 volumio-piter-room systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 16 15:01:41 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 22. Sep 16 15:01:41 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:42 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 15:01:42 volumio-piter-room dnsmasq[1866]: exiting on receipt of SIGTERM Sep 16 15:01:42 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:42 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:42 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 15:01:42 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:42 volumio-piter-room systemd[1]: shairport-sync.service: Consumed 1.284s CPU time. Sep 16 15:01:42 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:42 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:42 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:01:42 volumio-piter-room dbus-daemon[557]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.26' (uid=0 pid=1911 comm="timedatectl show --property=NTPSynchronized --valu") Sep 16 15:01:42 volumio-piter-room sudo[1888]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:42 volumio-piter-room hostapd[1914]: rfkill: WLAN soft blocked Sep 16 15:01:42 volumio-piter-room hostapd[1914]: Failed to set beacon parameters Sep 16 15:01:42 volumio-piter-room volumio[1101]: info: touch_display: Setting screensaver timeout to 10 seconds. Sep 16 15:01:42 volumio-piter-room hostapd[1914]: wlan0: Could not connect to kernel driver Sep 16 15:01:42 volumio-piter-room hostapd[1914]: Interface initialization failed Sep 16 15:01:42 volumio-piter-room hostapd[1914]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:42 volumio-piter-room hostapd[1914]: wlan0: AP-DISABLED Sep 16 15:01:42 volumio-piter-room hostapd[1914]: wlan0: Unable to setup interface. Sep 16 15:01:42 volumio-piter-room hostapd[1914]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:42 volumio-piter-room hostapd[1914]: wlan0: AP-DISABLED Sep 16 15:01:42 volumio-piter-room hostapd[1914]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:42 volumio-piter-room hostapd[1914]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:42 volumio-piter-room hostapd[1914]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:42 volumio-piter-room systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 16 15:01:42 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:42 volumio-piter-room volumio[1101]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 69 Sep 16 15:01:42 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:42 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:42 volumio-piter-room volumio[1101]: info: Shairport-Sync Started Sep 16 15:01:42 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:42 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:01:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1758027701 101 Sep 16 15:01:42 volumio-piter-room volumio[1101]: 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: 70 Sep 16 15:01:42 volumio-piter-room dnsmasq[1934]: started, version 2.90 cachesize 150 Sep 16 15:01:42 volumio-piter-room dnsmasq[1934]: 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 15:01:42 volumio-piter-room dnsmasq-dhcp[1934]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:42 volumio-piter-room dnsmasq[1934]: reading /etc/resolv.conf Sep 16 15:01:42 volumio-piter-room dnsmasq[1934]: using nameserver 192.168.2.1#53 Sep 16 15:01:42 volumio-piter-room dnsmasq[1934]: using nameserver 208.67.222.222#53 Sep 16 15:01:42 volumio-piter-room dnsmasq[1934]: using nameserver 208.67.220.220#53 Sep 16 15:01:42 volumio-piter-room dnsmasq[1934]: read /etc/hosts - 6 names Sep 16 15:01:42 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:42 volumio-piter-room dbus-daemon[557]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 16 15:01:42 volumio-piter-room systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 16 15:01:42 volumio-piter-room setdatetime-helper.sh[1910]: Time is not synchronized. Attempting to sync... Sep 16 15:01:43 volumio-piter-room volumio[1101]: info: Initializing connection to go-librespot Websocket Sep 16 15:01:43 volumio-piter-room sudo[1943]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 16 Sep 2025 13:01:43 GMT#015' Sep 16 15:01:43 volumio-piter-room sudo[1943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:01:43 volumio-piter-room setdatetime-helper.sh[1944]: Tue Sep 16 15:01:43 CEST 2025 Sep 16 15:01:43 volumio-piter-room setdatetime-helper.sh[1910]: Time synchronized successfully. Sep 16 15:01:43 volumio-piter-room sudo[1943]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:43 volumio-piter-room systemd-journald[325]: Time jumped backwards, rotating. Sep 16 15:01:43 volumio-piter-room systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 16 15:01:43 volumio-piter-room systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 16 15:01:43 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:43+02:00" level=debug msg="new websocket client" Sep 16 15:01:43 volumio-piter-room volumio[1101]: info: Connection to go-librespot Websocket established Sep 16 15:01:43 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:43 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:43 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 23. Sep 16 15:01:44 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:44 volumio-piter-room dnsmasq[1934]: exiting on receipt of SIGTERM Sep 16 15:01:44 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:44 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:44 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:44 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:44 volumio-piter-room hostapd[1947]: rfkill: WLAN soft blocked Sep 16 15:01:44 volumio-piter-room hostapd[1947]: Failed to set beacon parameters Sep 16 15:01:44 volumio-piter-room hostapd[1947]: wlan0: Could not connect to kernel driver Sep 16 15:01:44 volumio-piter-room hostapd[1947]: Interface initialization failed Sep 16 15:01:44 volumio-piter-room hostapd[1947]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:44 volumio-piter-room hostapd[1947]: wlan0: AP-DISABLED Sep 16 15:01:44 volumio-piter-room hostapd[1947]: wlan0: Unable to setup interface. Sep 16 15:01:44 volumio-piter-room hostapd[1947]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:44 volumio-piter-room hostapd[1947]: wlan0: AP-DISABLED Sep 16 15:01:44 volumio-piter-room hostapd[1947]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:44 volumio-piter-room hostapd[1947]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:44 volumio-piter-room hostapd[1947]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:44 volumio-piter-room mpd[1858]: 2025-09-16T15:01:44 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 15:01:44 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 15:01:44 volumio-piter-room sudo[1780]: pam_unix(sudo:session): session closed for user root Sep 16 15:01:44 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:44 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:44 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:44 volumio-piter-room volumio[1101]: error: updateQueue error: null Sep 16 15:01:44 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:44 volumio-piter-room dnsmasq[1960]: started, version 2.90 cachesize 150 Sep 16 15:01:44 volumio-piter-room dnsmasq[1960]: 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 15:01:44 volumio-piter-room dnsmasq-dhcp[1960]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:44 volumio-piter-room dnsmasq[1960]: reading /etc/resolv.conf Sep 16 15:01:44 volumio-piter-room dnsmasq[1960]: using nameserver 192.168.2.1#53 Sep 16 15:01:44 volumio-piter-room dnsmasq[1960]: using nameserver 208.67.222.222#53 Sep 16 15:01:44 volumio-piter-room dnsmasq[1960]: using nameserver 208.67.220.220#53 Sep 16 15:01:44 volumio-piter-room dnsmasq[1960]: read /etc/hosts - 6 names Sep 16 15:01:44 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:46 volumio-piter-room volumio[1101]: info: Getting Spotify volume Sep 16 15:01:46 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 24. Sep 16 15:01:46 volumio-piter-room volumio[1101]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 71 Sep 16 15:01:46 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:46 volumio-piter-room dnsmasq[1960]: exiting on receipt of SIGTERM Sep 16 15:01:46 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:46 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:46 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:46 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:46 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:46 volumio-piter-room volumio[1101]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Sep 16 15:01:46 volumio-piter-room volumio[1101]: SPOTIFY: SPOTIFY VOLUME undefined Sep 16 15:01:46 volumio-piter-room volumio[1101]: SPOTIFY: VOLUMIO VOLUME 5 Sep 16 15:01:46 volumio-piter-room volumio[1101]: info: Aligning Spotify Volume to Volumio Volume Sep 16 15:01:46 volumio-piter-room volumio[1101]: info: CoreCommandRouter::volumioGetState Sep 16 15:01:46 volumio-piter-room volumio[1101]: info: CorePlayQueue::getTrack 0 Sep 16 15:01:46 volumio-piter-room volumio[1101]: info: Setting Spotify Volume from Volumio: 5 Sep 16 15:01:46 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:46 volumio-piter-room hostapd[2000]: rfkill: WLAN soft blocked Sep 16 15:01:46 volumio-piter-room hostapd[2000]: Failed to set beacon parameters Sep 16 15:01:46 volumio-piter-room hostapd[2000]: wlan0: Could not connect to kernel driver Sep 16 15:01:46 volumio-piter-room hostapd[2000]: Interface initialization failed Sep 16 15:01:46 volumio-piter-room hostapd[2000]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:46 volumio-piter-room hostapd[2000]: wlan0: AP-DISABLED Sep 16 15:01:46 volumio-piter-room hostapd[2000]: wlan0: Unable to setup interface. Sep 16 15:01:46 volumio-piter-room hostapd[2000]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:46 volumio-piter-room hostapd[2000]: wlan0: AP-DISABLED Sep 16 15:01:46 volumio-piter-room hostapd[2000]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:46 volumio-piter-room hostapd[2000]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:46 volumio-piter-room hostapd[2000]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:46 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:46 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:46 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:46 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:47 volumio-piter-room dnsmasq[2007]: started, version 2.90 cachesize 150 Sep 16 15:01:47 volumio-piter-room dnsmasq[2007]: 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 15:01:47 volumio-piter-room dnsmasq-dhcp[2007]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:47 volumio-piter-room dnsmasq[2007]: reading /etc/resolv.conf Sep 16 15:01:47 volumio-piter-room dnsmasq[2007]: using nameserver 192.168.2.1#53 Sep 16 15:01:47 volumio-piter-room dnsmasq[2007]: using nameserver 208.67.222.222#53 Sep 16 15:01:47 volumio-piter-room dnsmasq[2007]: using nameserver 208.67.220.220#53 Sep 16 15:01:47 volumio-piter-room dnsmasq[2007]: read /etc/hosts - 6 names Sep 16 15:01:47 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 15:01:48 volumio-piter-room volumio[1101]: SPOTIFY: SETTING SPOTIFY VOLUME 5 Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: Sending Spotify command with payload to local API: /player/volume Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: Adding plugin bluetooth to MyMusic Plugins Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: Adding plugin multiroom to MyMusic Plugins Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: Adding plugin metavolumio to MyMusic Plugins Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: Adding plugin cd_controller to MyMusic Plugins Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 16 15:01:48 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 16 15:01:48 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 25. Sep 16 15:01:49 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:49 volumio-piter-room dnsmasq[2007]: exiting on receipt of SIGTERM Sep 16 15:01:49 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:49 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:49 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:49 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:49 volumio-piter-room hostapd[2047]: rfkill: WLAN soft blocked Sep 16 15:01:49 volumio-piter-room hostapd[2047]: Failed to set beacon parameters Sep 16 15:01:49 volumio-piter-room hostapd[2047]: wlan0: Could not connect to kernel driver Sep 16 15:01:49 volumio-piter-room hostapd[2047]: Interface initialization failed Sep 16 15:01:49 volumio-piter-room hostapd[2047]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:49 volumio-piter-room hostapd[2047]: wlan0: AP-DISABLED Sep 16 15:01:49 volumio-piter-room hostapd[2047]: wlan0: Unable to setup interface. Sep 16 15:01:49 volumio-piter-room hostapd[2047]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:49 volumio-piter-room hostapd[2047]: wlan0: AP-DISABLED Sep 16 15:01:49 volumio-piter-room hostapd[2047]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:49 volumio-piter-room hostapd[2047]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:49 volumio-piter-room hostapd[2047]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:49 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:49 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:49 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:49 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:49 volumio-piter-room dnsmasq[2055]: started, version 2.90 cachesize 150 Sep 16 15:01:49 volumio-piter-room dnsmasq[2055]: 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 15:01:49 volumio-piter-room dnsmasq-dhcp[2055]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:49 volumio-piter-room dnsmasq[2055]: reading /etc/resolv.conf Sep 16 15:01:49 volumio-piter-room dnsmasq[2055]: using nameserver 192.168.2.1#53 Sep 16 15:01:49 volumio-piter-room dnsmasq[2055]: using nameserver 208.67.222.222#53 Sep 16 15:01:49 volumio-piter-room dnsmasq[2055]: using nameserver 208.67.220.220#53 Sep 16 15:01:49 volumio-piter-room dnsmasq[2055]: read /etc/hosts - 6 names Sep 16 15:01:49 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:51 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 26. Sep 16 15:01:51 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:51 volumio-piter-room dnsmasq[2055]: exiting on receipt of SIGTERM Sep 16 15:01:51 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:51 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:51 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:51 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:51 volumio-piter-room hostapd[2093]: rfkill: WLAN soft blocked Sep 16 15:01:51 volumio-piter-room hostapd[2093]: Failed to set beacon parameters Sep 16 15:01:51 volumio-piter-room hostapd[2093]: wlan0: Could not connect to kernel driver Sep 16 15:01:51 volumio-piter-room hostapd[2093]: Interface initialization failed Sep 16 15:01:51 volumio-piter-room hostapd[2093]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:51 volumio-piter-room hostapd[2093]: wlan0: AP-DISABLED Sep 16 15:01:51 volumio-piter-room hostapd[2093]: wlan0: Unable to setup interface. Sep 16 15:01:51 volumio-piter-room hostapd[2093]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:51 volumio-piter-room hostapd[2093]: wlan0: AP-DISABLED Sep 16 15:01:51 volumio-piter-room hostapd[2093]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:51 volumio-piter-room hostapd[2093]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:51 volumio-piter-room hostapd[2093]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:51 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:51 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:51 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:51 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:52 volumio-piter-room dnsmasq[2107]: started, version 2.90 cachesize 150 Sep 16 15:01:52 volumio-piter-room dnsmasq[2107]: 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 15:01:52 volumio-piter-room dnsmasq-dhcp[2107]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:52 volumio-piter-room dnsmasq[2107]: reading /etc/resolv.conf Sep 16 15:01:52 volumio-piter-room dnsmasq[2107]: using nameserver 192.168.2.1#53 Sep 16 15:01:52 volumio-piter-room dnsmasq[2107]: using nameserver 208.67.222.222#53 Sep 16 15:01:52 volumio-piter-room dnsmasq[2107]: using nameserver 208.67.220.220#53 Sep 16 15:01:52 volumio-piter-room dnsmasq[2107]: read /etc/hosts - 6 names Sep 16 15:01:52 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:53 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 27. Sep 16 15:01:54 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:54 volumio-piter-room dnsmasq[2107]: exiting on receipt of SIGTERM Sep 16 15:01:54 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:54 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:54 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:54 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:54 volumio-piter-room hostapd[2131]: rfkill: WLAN soft blocked Sep 16 15:01:54 volumio-piter-room hostapd[2131]: Failed to set beacon parameters Sep 16 15:01:54 volumio-piter-room hostapd[2131]: wlan0: Could not connect to kernel driver Sep 16 15:01:54 volumio-piter-room hostapd[2131]: Interface initialization failed Sep 16 15:01:54 volumio-piter-room hostapd[2131]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:54 volumio-piter-room hostapd[2131]: wlan0: AP-DISABLED Sep 16 15:01:54 volumio-piter-room hostapd[2131]: wlan0: Unable to setup interface. Sep 16 15:01:54 volumio-piter-room hostapd[2131]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:54 volumio-piter-room hostapd[2131]: wlan0: AP-DISABLED Sep 16 15:01:54 volumio-piter-room hostapd[2131]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:54 volumio-piter-room hostapd[2131]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:54 volumio-piter-room hostapd[2131]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:54 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:54 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:54 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:54 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:54 volumio-piter-room dnsmasq[2136]: started, version 2.90 cachesize 150 Sep 16 15:01:54 volumio-piter-room dnsmasq[2136]: 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 15:01:54 volumio-piter-room dnsmasq-dhcp[2136]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:54 volumio-piter-room dnsmasq[2136]: reading /etc/resolv.conf Sep 16 15:01:54 volumio-piter-room dnsmasq[2136]: using nameserver 192.168.2.1#53 Sep 16 15:01:54 volumio-piter-room dnsmasq[2136]: using nameserver 208.67.222.222#53 Sep 16 15:01:54 volumio-piter-room dnsmasq[2136]: using nameserver 208.67.220.220#53 Sep 16 15:01:54 volumio-piter-room dnsmasq[2136]: read /etc/hosts - 6 names Sep 16 15:01:54 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:55 volumio-piter-room go-librespot[1820]: time="2025-09-16T15:01:55+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 15:01:55 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 15:01:55 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: Starting MyVolumio Remote Streaming Endpoints Sep 16 15:01:56 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 28. Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: MyVolumio login type: Token Sep 16 15:01:56 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:56 volumio-piter-room dnsmasq[2136]: exiting on receipt of SIGTERM Sep 16 15:01:56 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:56 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:56 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:56 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:56 volumio-piter-room hostapd[2154]: rfkill: WLAN soft blocked Sep 16 15:01:56 volumio-piter-room hostapd[2154]: Failed to set beacon parameters Sep 16 15:01:56 volumio-piter-room hostapd[2154]: wlan0: Could not connect to kernel driver Sep 16 15:01:56 volumio-piter-room hostapd[2154]: Interface initialization failed Sep 16 15:01:56 volumio-piter-room hostapd[2154]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:56 volumio-piter-room hostapd[2154]: wlan0: AP-DISABLED Sep 16 15:01:56 volumio-piter-room hostapd[2154]: wlan0: Unable to setup interface. Sep 16 15:01:56 volumio-piter-room hostapd[2154]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:56 volumio-piter-room hostapd[2154]: wlan0: AP-DISABLED Sep 16 15:01:56 volumio-piter-room hostapd[2154]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:56 volumio-piter-room hostapd[2154]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:56 volumio-piter-room hostapd[2154]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:56 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:56 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:56 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 16 15:01:56 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:56 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 16 15:01:56 volumio-piter-room dnsmasq[2159]: started, version 2.90 cachesize 150 Sep 16 15:01:56 volumio-piter-room dnsmasq[2159]: 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 15:01:56 volumio-piter-room dnsmasq-dhcp[2159]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:56 volumio-piter-room dnsmasq[2159]: reading /etc/resolv.conf Sep 16 15:01:56 volumio-piter-room dnsmasq[2159]: using nameserver 192.168.2.1#53 Sep 16 15:01:56 volumio-piter-room dnsmasq[2159]: using nameserver 208.67.222.222#53 Sep 16 15:01:56 volumio-piter-room dnsmasq[2159]: using nameserver 208.67.220.220#53 Sep 16 15:01:56 volumio-piter-room dnsmasq[2159]: read /etc/hosts - 6 names Sep 16 15:01:57 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:58 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Sep 16 15:01:58 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:01:58 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:01:58 volumio-piter-room go-librespot[2162]: go-librespot daemon starting... Sep 16 15:01:58 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:58+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:01:58 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:58+02:00" level=debug msg="app state loaded" Sep 16 15:01:58 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:58+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:01:58 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 29. Sep 16 15:01:59 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:59 volumio-piter-room dnsmasq[2159]: exiting on receipt of SIGTERM Sep 16 15:01:59 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:01:59 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:59 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:59 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:01:59 volumio-piter-room hostapd[2171]: rfkill: WLAN soft blocked Sep 16 15:01:59 volumio-piter-room hostapd[2171]: Failed to set beacon parameters Sep 16 15:01:59 volumio-piter-room hostapd[2171]: wlan0: Could not connect to kernel driver Sep 16 15:01:59 volumio-piter-room hostapd[2171]: Interface initialization failed Sep 16 15:01:59 volumio-piter-room hostapd[2171]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:01:59 volumio-piter-room hostapd[2171]: wlan0: AP-DISABLED Sep 16 15:01:59 volumio-piter-room hostapd[2171]: wlan0: Unable to setup interface. Sep 16 15:01:59 volumio-piter-room hostapd[2171]: wlan0: interface state DISABLED->DISABLED Sep 16 15:01:59 volumio-piter-room hostapd[2171]: wlan0: AP-DISABLED Sep 16 15:01:59 volumio-piter-room hostapd[2171]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:01:59 volumio-piter-room hostapd[2171]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:01:59 volumio-piter-room hostapd[2171]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+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 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+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 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+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 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+02:00" level=info msg="zeroconf server listening on port 34503" Sep 16 15:01:59 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:01:59 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:01:59 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:01:59 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+02:00" level=debug msg="obtained new client token: AACC/sG/zGu4whDzMG6B+I216nZIDHAeDskpzl2o7LkjiTozSK1l9bgevP9HJohrxSf6b9I+kiKWfgsPidPqhrL22EDNJddGnTek8DyRMNMcAGXKNAwZowU0oX5fkB7j54VbfI5QlXD7DIrpwCuyve0QTvIk6ahWjBJYae6EhV0hvGFJLnFiZrazeX6xQMtrOPz5QXehrQdydTO8KCuhU5sGzgfcJ1O9ItAprw0oHyRv9SsvDhf1kKiNLA==" Sep 16 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 15:01:59 volumio-piter-room dnsmasq[2176]: started, version 2.90 cachesize 150 Sep 16 15:01:59 volumio-piter-room dnsmasq[2176]: 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 15:01:59 volumio-piter-room dnsmasq-dhcp[2176]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:01:59 volumio-piter-room dnsmasq[2176]: reading /etc/resolv.conf Sep 16 15:01:59 volumio-piter-room dnsmasq[2176]: using nameserver 192.168.2.1#53 Sep 16 15:01:59 volumio-piter-room dnsmasq[2176]: using nameserver 208.67.222.222#53 Sep 16 15:01:59 volumio-piter-room dnsmasq[2176]: using nameserver 208.67.220.220#53 Sep 16 15:01:59 volumio-piter-room dnsmasq[2176]: read /etc/hosts - 6 names Sep 16 15:01:59 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+02:00" level=debug msg="completed keyexchange" Sep 16 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+02:00" level=debug msg="completed challenge" Sep 16 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 15:01:59 volumio-piter-room go-librespot[2163]: time="2025-09-16T15:01:59+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 15:01:59 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 15:01:59 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 15:02:00 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 16 15:02:00 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 16 15:02:00 volumio-piter-room volumio[1101]: info: Streaming services startup Sep 16 15:02:00 volumio-piter-room volumio[1101]: info: Starting Streaming Daemon Sep 16 15:02:00 volumio-piter-room volumio[1101]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 16 15:02:00 volumio-piter-room sudo[2180]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 15:02:00 volumio-piter-room sudo[2180]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:02:01 volumio-piter-room sudo[2180]: pam_unix(sudo:session): session closed for user root Sep 16 15:02:01 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:02:01 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:02:01 volumio-piter-room volumio[1101]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 15:02:01 volumio-piter-room volumio[1101]: info: Bluetoothremote--- Checking for trusted devices to reconnect... Sep 16 15:02:01 volumio-piter-room volumio[1101]: info: Bluetoothremote--- Device list cleared and placeholder written. Sep 16 15:02:01 volumio-piter-room volumio[1101]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Sep 16 15:02:01 volumio-piter-room volumio[1101]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 15:02:01 volumio-piter-room volumio[1101]: Error: socket hang up Sep 16 15:02:01 volumio-piter-room volumio[1101]: at connResetException (node:internal/errors:720:14) Sep 16 15:02:01 volumio-piter-room volumio[1101]: at Socket.socketOnEnd (node:_http_client:519:23) Sep 16 15:02:01 volumio-piter-room volumio[1101]: at Socket.emit (node:events:526:35) Sep 16 15:02:01 volumio-piter-room volumio[1101]: at endReadableNT (node:internal/streams/readable:1376:12) Sep 16 15:02:01 volumio-piter-room volumio[1101]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Sep 16 15:02:01 volumio-piter-room volumio[1101]: code: 'ECONNRESET', Sep 16 15:02:01 volumio-piter-room volumio[1101]: response: undefined Sep 16 15:02:01 volumio-piter-room volumio[1101]: } Sep 16 15:02:01 volumio-piter-room volumio[1101]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 15:02:01 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 30. Sep 16 15:02:01 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:02:01 volumio-piter-room dnsmasq[2176]: exiting on receipt of SIGTERM Sep 16 15:02:01 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:02:01 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:02:01 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:02:01 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:02:01 volumio-piter-room hostapd[2195]: rfkill: WLAN soft blocked Sep 16 15:02:01 volumio-piter-room hostapd[2195]: Failed to set beacon parameters Sep 16 15:02:01 volumio-piter-room hostapd[2195]: wlan0: Could not connect to kernel driver Sep 16 15:02:01 volumio-piter-room hostapd[2195]: Interface initialization failed Sep 16 15:02:01 volumio-piter-room hostapd[2195]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:02:01 volumio-piter-room hostapd[2195]: wlan0: AP-DISABLED Sep 16 15:02:01 volumio-piter-room hostapd[2195]: wlan0: Unable to setup interface. Sep 16 15:02:01 volumio-piter-room hostapd[2195]: wlan0: interface state DISABLED->DISABLED Sep 16 15:02:01 volumio-piter-room hostapd[2195]: wlan0: AP-DISABLED Sep 16 15:02:01 volumio-piter-room hostapd[2195]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:02:01 volumio-piter-room hostapd[2195]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:02:01 volumio-piter-room hostapd[2195]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:02:01 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:02:01 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:02:01 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:02:01 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:02:01 volumio-piter-room bluetoothd[898]: Adv Monitor app :1.33 disconnected from D-Bus Sep 16 15:02:01 volumio-piter-room dnsmasq[2209]: started, version 2.90 cachesize 150 Sep 16 15:02:02 volumio-piter-room dnsmasq[2209]: 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 15:02:02 volumio-piter-room dnsmasq-dhcp[2209]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:02:02 volumio-piter-room dnsmasq[2209]: reading /etc/resolv.conf Sep 16 15:02:02 volumio-piter-room dnsmasq[2209]: using nameserver 192.168.2.1#53 Sep 16 15:02:02 volumio-piter-room dnsmasq[2209]: using nameserver 208.67.222.222#53 Sep 16 15:02:02 volumio-piter-room dnsmasq[2209]: using nameserver 208.67.220.220#53 Sep 16 15:02:02 volumio-piter-room dnsmasq[2209]: read /etc/hosts - 6 names Sep 16 15:02:02 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:02:02 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Sep 16 15:02:02 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:02:02 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:02:02 volumio-piter-room go-librespot[2212]: go-librespot daemon starting... Sep 16 15:02:02 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:02+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:02:02 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:02+02:00" level=debug msg="app state loaded" Sep 16 15:02:02 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+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 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+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 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+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 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+02:00" level=info msg="zeroconf server listening on port 38963" Sep 16 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+02:00" level=debug msg="obtained new client token: AAAzHUuJNKsjxF8SOIdxJqhwshibrKM/X15xfDpsU7ZGGhl7KBhcYOY0SNvYHmnuaTLPPhIRxKETXyAPJQL+JDzeJ9OiJeEoMUZzjPGh1UwpTeLl8xH480Xy9B7ZQizeFRjdSkT2M1614FzZiF51OZ1BH3/Ws2iRZeDkDH61sslODbTqBVIqfRKdKqOFc12P8RQpSldcei+Q1Ifz1+7a7q+6g40WhjnagNdK4u5EC4Yk3f/jNf14T0jRNg==" Sep 16 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+02:00" level=debug msg="completed keyexchange" Sep 16 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+02:00" level=debug msg="completed challenge" Sep 16 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 15:02:03 volumio-piter-room go-librespot[2213]: time="2025-09-16T15:02:03+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 15:02:03 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 15:02:03 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 15:02:03 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 31. Sep 16 15:02:04 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:02:04 volumio-piter-room dnsmasq[2209]: exiting on receipt of SIGTERM Sep 16 15:02:04 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:02:04 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:02:04 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:02:04 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:02:04 volumio-piter-room hostapd[2222]: rfkill: WLAN soft blocked Sep 16 15:02:04 volumio-piter-room hostapd[2222]: Failed to set beacon parameters Sep 16 15:02:04 volumio-piter-room hostapd[2222]: wlan0: Could not connect to kernel driver Sep 16 15:02:04 volumio-piter-room hostapd[2222]: Interface initialization failed Sep 16 15:02:04 volumio-piter-room hostapd[2222]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:02:04 volumio-piter-room hostapd[2222]: wlan0: AP-DISABLED Sep 16 15:02:04 volumio-piter-room hostapd[2222]: wlan0: Unable to setup interface. Sep 16 15:02:04 volumio-piter-room hostapd[2222]: wlan0: interface state DISABLED->DISABLED Sep 16 15:02:04 volumio-piter-room hostapd[2222]: wlan0: AP-DISABLED Sep 16 15:02:04 volumio-piter-room hostapd[2222]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:02:04 volumio-piter-room hostapd[2222]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:02:04 volumio-piter-room hostapd[2222]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:02:04 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:02:04 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:02:04 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:02:04 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:02:04 volumio-piter-room dnsmasq[2227]: started, version 2.90 cachesize 150 Sep 16 15:02:04 volumio-piter-room dnsmasq[2227]: 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 15:02:04 volumio-piter-room dnsmasq-dhcp[2227]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:02:04 volumio-piter-room dnsmasq[2227]: reading /etc/resolv.conf Sep 16 15:02:04 volumio-piter-room dnsmasq[2227]: using nameserver 192.168.2.1#53 Sep 16 15:02:04 volumio-piter-room dnsmasq[2227]: using nameserver 208.67.222.222#53 Sep 16 15:02:04 volumio-piter-room dnsmasq[2227]: using nameserver 208.67.220.220#53 Sep 16 15:02:04 volumio-piter-room dnsmasq[2227]: read /etc/hosts - 6 names Sep 16 15:02:04 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:02:05 volumio-piter-room sudo[2246]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-16 15:01' Sep 16 15:02:05 volumio-piter-room sudo[2246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:02:06 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 32. Sep 16 15:02:06 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:02:06 volumio-piter-room dnsmasq[2227]: exiting on receipt of SIGTERM Sep 16 15:02:06 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:02:06 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:02:06 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:02:06 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:02:06 volumio-piter-room hostapd[2249]: rfkill: WLAN soft blocked Sep 16 15:02:06 volumio-piter-room hostapd[2249]: Failed to set beacon parameters Sep 16 15:02:06 volumio-piter-room hostapd[2249]: wlan0: Could not connect to kernel driver Sep 16 15:02:06 volumio-piter-room hostapd[2249]: Interface initialization failed Sep 16 15:02:06 volumio-piter-room hostapd[2249]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:02:06 volumio-piter-room hostapd[2249]: wlan0: AP-DISABLED Sep 16 15:02:06 volumio-piter-room hostapd[2249]: wlan0: Unable to setup interface. Sep 16 15:02:06 volumio-piter-room hostapd[2249]: wlan0: interface state DISABLED->DISABLED Sep 16 15:02:06 volumio-piter-room hostapd[2249]: wlan0: AP-DISABLED Sep 16 15:02:06 volumio-piter-room hostapd[2249]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:02:06 volumio-piter-room hostapd[2249]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:02:06 volumio-piter-room hostapd[2249]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:02:06 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Sep 16 15:02:06 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:02:06 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:02:06 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:02:06 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:02:06 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:02:06 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:02:06 volumio-piter-room go-librespot[2252]: go-librespot daemon starting... Sep 16 15:02:06 volumio-piter-room go-librespot[2253]: time="2025-09-16T15:02:06+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:02:06 volumio-piter-room go-librespot[2253]: time="2025-09-16T15:02:06+02:00" level=debug msg="app state loaded" Sep 16 15:02:06 volumio-piter-room go-librespot[2253]: time="2025-09-16T15:02:06+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:02:06 volumio-piter-room dnsmasq[2261]: started, version 2.90 cachesize 150 Sep 16 15:02:06 volumio-piter-room dnsmasq[2261]: 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 15:02:06 volumio-piter-room dnsmasq-dhcp[2261]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:02:06 volumio-piter-room dnsmasq[2261]: reading /etc/resolv.conf Sep 16 15:02:06 volumio-piter-room dnsmasq[2261]: using nameserver 192.168.2.1#53 Sep 16 15:02:06 volumio-piter-room dnsmasq[2261]: using nameserver 208.67.222.222#53 Sep 16 15:02:06 volumio-piter-room dnsmasq[2261]: using nameserver 208.67.220.220#53 Sep 16 15:02:06 volumio-piter-room dnsmasq[2261]: read /etc/hosts - 6 names Sep 16 15:02:06 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:02:07 volumio-piter-room go-librespot[2253]: time="2025-09-16T15:02:07+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 15:02:07 volumio-piter-room go-librespot[2253]: time="2025-09-16T15:02:07+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 15:02:07 volumio-piter-room go-librespot[2253]: time="2025-09-16T15:02:07+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]" 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"