Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Listing playlists Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Sep 16 15:15:00 volumio-piter-room volumio[13582]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Sep 16 15:15:00 volumio-piter-room volumio[13582]: SPOTIFY: BQD3OevoPsQogGNBGRppv4oQO8NIxtrkZr2wjWQs7il1Xf0tj9w2SEBBiDiZXp9DtUrYHU2MOWb6_xxjBIjtTK6-nLwlmTcOvoqq7hl9YPhN5pdi7MKK-G_qhIuIQ7Hd7ku9IEMO0lT_sisQPSJgwbSRI5Py9bXGbiQwGaqw968VnhBM4EtJ1LdDjLCH7SnCw5BiyfAwX6c9kb8-ab_XIPvcPzFCrhA3iW-G-Of-lylk4-BZRyjgOAUZSysh4uMLqceA7TQYyPNMLXaHY2JWtGi9Q8j9Mvn568rdc6JgILzMah4 Sep 16 15:15:00 volumio-piter-room volumio[13582]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: New Spotify access token = BQD3OevoPsQogGNBGRppv4oQO8NIxtrkZr2wjWQs7il1Xf0tj9w2SEBBiDiZXp9DtUrYHU2MOWb6_xxjBIjtTK6-nLwlmTcOvoqq7hl9YPhN5pdi7MKK-G_qhIuIQ7Hd7ku9IEMO0lT_sisQPSJgwbSRI5Py9bXGbiQwGaqw968VnhBM4EtJ1LdDjLCH7SnCw5BiyfAwX6c9kb8-ab_XIPvcPzFCrhA3iW-G-Of-lylk4-BZRyjgOAUZSysh4uMLqceA7TQYyPNMLXaHY2JWtGi9Q8j9Mvn568rdc6JgILzMah4 Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Spotify credentials grant success - running version from March 24, 2019 Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Starting Shairport Sync Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Starting Shairport Sync Sep 16 15:15:00 volumio-piter-room sudo[13973]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Starting Shairport Sync Sep 16 15:15:00 volumio-piter-room sudo[13973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:00 volumio-piter-room sudo[13973]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:00 volumio-piter-room sudo[13977]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:00 volumio-piter-room sudo[13977]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Asound.conf file unchanged, so no further update is needed Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Output device has changed, restarting MPD Sep 16 15:15:00 volumio-piter-room sudo[13975]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:00 volumio-piter-room sudo[13975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:00 volumio-piter-room sudo[13980]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:00 volumio-piter-room sudo[13980]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Output device has changed, restarting Shairport Sync Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:00 volumio-piter-room sudo[13995]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:15:00 volumio-piter-room sudo[13995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:00 volumio-piter-room sudo[13993]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:15:00 volumio-piter-room sudo[13993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:00 volumio-piter-room volumio[13582]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:15:00 volumio-piter-room sudo[13993]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: MPD Permissions set Sep 16 15:15:01 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:01 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:01 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:15:01 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:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: Starting Shairport Sync Sep 16 15:15:01 volumio-piter-room sudo[13936]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:01 volumio-piter-room sudo[14017]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:01 volumio-piter-room sudo[14017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:01 volumio-piter-room volumio[13582]: 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:15:01 volumio-piter-room volumio[13582]: info: Spotify Successfully logged in Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: [1758028501571] CoreMusicLibrary::Adding element Spotify Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:01 volumio-piter-room volumio[13582]: Cannot find translation for source YouTube2 Sep 16 15:15:01 volumio-piter-room volumio[13582]: Cannot find translation for source YouTube Music Sep 16 15:15:01 volumio-piter-room volumio[13582]: Cannot find translation for source Spotify Sep 16 15:15:01 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 329. Sep 16 15:15:01 volumio-piter-room systemd[1]: Reloading. Sep 16 15:15:01 volumio-piter-room volumio[13582]: info: touch_display: systemctl disable getty@tty1.service succeeded. Sep 16 15:15:02 volumio-piter-room mpd[13917]: 2025-09-16T15:15:02 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 15:15:03 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:03 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:03 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:15:03 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:15:03 volumio-piter-room sudo[13939]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:03 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 15:15:03 volumio-piter-room sudo[13888]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:03 volumio-piter-room sudo[13878]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:03 volumio-piter-room volumio[13582]: info: touch_display: systemctl daemon-reload succeeded. Sep 16 15:15:03 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 330. Sep 16 15:15:03 volumio-piter-room sudo[14042]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Sep 16 15:15:03 volumio-piter-room sudo[14042]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:03 volumio-piter-room volumio[13582]: error: MPD error: The expression evaluated to a falsy value: Sep 16 15:15:03 volumio-piter-room volumio[13582]: assert.ok(self.idling) Sep 16 15:15:03 volumio-piter-room volumio[13582]: error: The expression evaluated to a falsy value: Sep 16 15:15:03 volumio-piter-room volumio[13582]: assert.ok(self.idling) Sep 16 15:15:03 volumio-piter-room volumio[13582]: error: updateQueue error: null Sep 16 15:15:03 volumio-piter-room volumio[13582]: info: MPD running with PID13917 Sep 16 15:15:03 volumio-piter-room volumio[13582]: ,establishing connection Sep 16 15:15:03 volumio-piter-room volumio[13582]: error: updateQueue error: null Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopping mpd.service - Music Player Daemon... Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 15:15:04 volumio-piter-room sudo[14042]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: Volumio Kiosk started. Sep 16 15:15:04 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:15:04 volumio-piter-room systemd[1]: shairport-sync.service: Consumed 2.053s CPU time. Sep 16 15:15:04 volumio-piter-room systemd[1]: go-librespot-daemon.service: Deactivated successfully. Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:15:04 volumio-piter-room dnsmasq[13931]: exiting on receipt of SIGTERM Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:04 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: Completed starting Core Plugins Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: ------------------------------------------- Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: ----- MyVolumio plugins startup ---- Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: ------------------------------------------- Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:04 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 15:15:04 volumio-piter-room systemd[1]: mpd.service: Consumed 4.105s CPU time. Sep 16 15:15:04 volumio-piter-room sudo[13932]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: systemctl stop getty@tty1.service succeeded. Sep 16 15:15:04 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 15:15:04 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: X display number found: 0 Sep 16 15:15:04 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:15:04 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:15:04 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:04 volumio-piter-room go-librespot[14052]: go-librespot daemon starting... Sep 16 15:15:04 volumio-piter-room sudo[13959]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Sep 16 15:15:04 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:15:04 volumio-piter-room hostapd[14055]: rfkill: WLAN soft blocked Sep 16 15:15:04 volumio-piter-room hostapd[14055]: Failed to set beacon parameters Sep 16 15:15:04 volumio-piter-room hostapd[14055]: wlan0: Could not connect to kernel driver Sep 16 15:15:04 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:15:04 volumio-piter-room hostapd[14055]: Interface initialization failed Sep 16 15:15:04 volumio-piter-room hostapd[14055]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:04 volumio-piter-room hostapd[14055]: wlan0: AP-DISABLED Sep 16 15:15:04 volumio-piter-room hostapd[14055]: wlan0: Unable to setup interface. Sep 16 15:15:04 volumio-piter-room hostapd[14055]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:04 volumio-piter-room hostapd[14055]: wlan0: AP-DISABLED Sep 16 15:15:04 volumio-piter-room hostapd[14055]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:04 volumio-piter-room hostapd[14055]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:04 volumio-piter-room hostapd[14055]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:04 volumio-piter-room sudo[13980]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:04+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:15:04 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:04+02:00" level=debug msg="app state loaded" Sep 16 15:15:04 volumio-piter-room sudo[13975]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room sudo[13977]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:15:04 volumio-piter-room sudo[14017]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: Shairport-Sync Started Sep 16 15:15:04 volumio-piter-room volumio[13582]: Error adding Membership: Error: addMembership EINVAL Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: Shairport-Sync Started Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: Shairport-Sync Started Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: Shairport-Sync Started Sep 16 15:15:04 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:04 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:04 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: X display number found: 0 Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: X display number found: 0 Sep 16 15:15:04 volumio-piter-room volumio[13582]: info: touch_display: Setting screensaver timeout to 10 seconds. Sep 16 15:15:04 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:04 volumio-piter-room dnsmasq[14087]: started, version 2.90 cachesize 150 Sep 16 15:15:04 volumio-piter-room dnsmasq[14087]: 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:15:04 volumio-piter-room dnsmasq-dhcp[14087]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:04 volumio-piter-room dnsmasq[14087]: reading /etc/resolv.conf Sep 16 15:15:04 volumio-piter-room dnsmasq[14087]: using nameserver 192.168.2.1#53 Sep 16 15:15:04 volumio-piter-room dnsmasq[14087]: using nameserver 208.67.222.222#53 Sep 16 15:15:04 volumio-piter-room dnsmasq[14087]: using nameserver 208.67.220.220#53 Sep 16 15:15:04 volumio-piter-room dnsmasq[14087]: read /etc/hosts - 6 names Sep 16 15:15:04 volumio-piter-room sudo[14059]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 15:15:04 volumio-piter-room sudo[14059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:15:04 volumio-piter-room sudo[14059]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:04 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=info msg="zeroconf server listening on port 43399" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=debug msg="obtained new client token: AACKX+e0DBQapcoA1dgRSznDlvFRNWVr0I2WVhCrArdQb6GYaOWv4t5IiGQyx8qR9UjYTNqvnwBbPlAGhW0s5fQW3SneuC4Y2+34xOp1agvrHlN6osZZiHn5IZtBeza06qWUA8+crYmmgPo4JXha/rcSKsPGJP2ARtyiXw2HrXNw4QYXycDShGz2KlpHYYvCzb2GnJqyBa3oTMwJpcF2OsJ9L9AkO9HfDzT3Be6AKqvac/zT+xOT8DU=" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=debug msg="completed keyexchange" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=debug msg="completed challenge" Sep 16 15:15:05 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:05+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 15:15:06 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 331. Sep 16 15:15:06 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:06 volumio-piter-room dnsmasq[14087]: exiting on receipt of SIGTERM Sep 16 15:15:06 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:06 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:06 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:06 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:07 volumio-piter-room hostapd[14094]: rfkill: WLAN soft blocked Sep 16 15:15:07 volumio-piter-room hostapd[14094]: Failed to set beacon parameters Sep 16 15:15:07 volumio-piter-room hostapd[14094]: wlan0: Could not connect to kernel driver Sep 16 15:15:07 volumio-piter-room hostapd[14094]: Interface initialization failed Sep 16 15:15:07 volumio-piter-room hostapd[14094]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:07 volumio-piter-room hostapd[14094]: wlan0: AP-DISABLED Sep 16 15:15:07 volumio-piter-room hostapd[14094]: wlan0: Unable to setup interface. Sep 16 15:15:07 volumio-piter-room hostapd[14094]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:07 volumio-piter-room hostapd[14094]: wlan0: AP-DISABLED Sep 16 15:15:07 volumio-piter-room hostapd[14094]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:07 volumio-piter-room hostapd[14094]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:07 volumio-piter-room hostapd[14094]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:07 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:07 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:07 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:07 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:07 volumio-piter-room dnsmasq[14099]: started, version 2.90 cachesize 150 Sep 16 15:15:07 volumio-piter-room dnsmasq[14099]: 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:15:07 volumio-piter-room dnsmasq-dhcp[14099]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:07 volumio-piter-room dnsmasq[14099]: reading /etc/resolv.conf Sep 16 15:15:07 volumio-piter-room dnsmasq[14099]: using nameserver 192.168.2.1#53 Sep 16 15:15:07 volumio-piter-room dnsmasq[14099]: using nameserver 208.67.222.222#53 Sep 16 15:15:07 volumio-piter-room dnsmasq[14099]: using nameserver 208.67.220.220#53 Sep 16 15:15:07 volumio-piter-room dnsmasq[14099]: read /etc/hosts - 6 names Sep 16 15:15:07 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:07 volumio-piter-room volumio[13582]: info: go-librespot daemon successfully initialized Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=info msg="authenticated Login5 as ddmm0vyjz4epcocr86rainvro" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="initializing zeroconf session, username: ddmm0vyjz4epcocr86rainvro" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="dealer connection opened" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=trace msg="starting accesspoint recv loop" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=trace msg="starting dealer recv loop" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=trace msg="received accesspoint ping" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="received connection id: M2Q5OTE0NGUtNTBhMi00ZTkzLTk2YWEtYmNjNDE1ZjIzNGU3K2RlYWxlcit0Y3A6Ly8wYWIxNTFlMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArRTg1OEM1REYzOEFDRTE2RDRBNTgxQ0FGQzZDODRDNTBCNzE5MzJEODM4NkJBMTYyM0EyQkFBNTYyNDE4REQ3RA==" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=trace msg="received accesspoint pong ack" Sep 16 15:15:08 volumio-piter-room mpd[14092]: 2025-09-16T15:15:08 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 15:15:08 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 15:15:08 volumio-piter-room sudo[13995]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:08 volumio-piter-room volumio[13582]: error: updateQueue error: null Sep 16 15:15:08 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:08+02:00" level=debug msg="put connect state because NEW_DEVICE" Sep 16 15:15:08 volumio-piter-room volumio[13582]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 16 15:15:09 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 332. Sep 16 15:15:09 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:09 volumio-piter-room dnsmasq[14099]: exiting on receipt of SIGTERM Sep 16 15:15:09 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:09 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:09 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:09 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:09 volumio-piter-room hostapd[14108]: rfkill: WLAN soft blocked Sep 16 15:15:09 volumio-piter-room hostapd[14108]: Failed to set beacon parameters Sep 16 15:15:09 volumio-piter-room hostapd[14108]: wlan0: Could not connect to kernel driver Sep 16 15:15:09 volumio-piter-room hostapd[14108]: Interface initialization failed Sep 16 15:15:09 volumio-piter-room hostapd[14108]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:09 volumio-piter-room hostapd[14108]: wlan0: AP-DISABLED Sep 16 15:15:09 volumio-piter-room hostapd[14108]: wlan0: Unable to setup interface. Sep 16 15:15:09 volumio-piter-room hostapd[14108]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:09 volumio-piter-room hostapd[14108]: wlan0: AP-DISABLED Sep 16 15:15:09 volumio-piter-room hostapd[14108]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:09 volumio-piter-room hostapd[14108]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:09 volumio-piter-room hostapd[14108]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:09 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:09 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:09 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:09 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:09 volumio-piter-room systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories... Sep 16 15:15:09 volumio-piter-room dnsmasq[14116]: started, version 2.90 cachesize 150 Sep 16 15:15:09 volumio-piter-room dnsmasq[14116]: 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:15:09 volumio-piter-room dnsmasq-dhcp[14116]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:09 volumio-piter-room dnsmasq[14116]: reading /etc/resolv.conf Sep 16 15:15:09 volumio-piter-room dnsmasq[14116]: using nameserver 192.168.2.1#53 Sep 16 15:15:09 volumio-piter-room dnsmasq[14116]: using nameserver 208.67.222.222#53 Sep 16 15:15:09 volumio-piter-room dnsmasq[14116]: using nameserver 208.67.220.220#53 Sep 16 15:15:09 volumio-piter-room dnsmasq[14116]: read /etc/hosts - 6 names Sep 16 15:15:09 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:09 volumio-piter-room systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully. Sep 16 15:15:09 volumio-piter-room systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories. Sep 16 15:15:09 volumio-piter-room systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully. Sep 16 15:15:10 volumio-piter-room volumio[13582]: info: Initializing connection to go-librespot Websocket Sep 16 15:15:10 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:10+02:00" level=debug msg="new websocket client" Sep 16 15:15:10 volumio-piter-room volumio[13582]: info: Connection to go-librespot Websocket established Sep 16 15:15:11 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 333. Sep 16 15:15:11 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:11 volumio-piter-room dnsmasq[14116]: exiting on receipt of SIGTERM Sep 16 15:15:11 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:11 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:11 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:11 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:11 volumio-piter-room hostapd[14136]: rfkill: WLAN soft blocked Sep 16 15:15:11 volumio-piter-room hostapd[14136]: Failed to set beacon parameters Sep 16 15:15:11 volumio-piter-room hostapd[14136]: wlan0: Could not connect to kernel driver Sep 16 15:15:11 volumio-piter-room hostapd[14136]: Interface initialization failed Sep 16 15:15:11 volumio-piter-room hostapd[14136]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:11 volumio-piter-room hostapd[14136]: wlan0: AP-DISABLED Sep 16 15:15:11 volumio-piter-room hostapd[14136]: wlan0: Unable to setup interface. Sep 16 15:15:11 volumio-piter-room hostapd[14136]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:11 volumio-piter-room hostapd[14136]: wlan0: AP-DISABLED Sep 16 15:15:11 volumio-piter-room hostapd[14136]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:11 volumio-piter-room hostapd[14136]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:11 volumio-piter-room hostapd[14136]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:11 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:11 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:11 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:11 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:12 volumio-piter-room dnsmasq[14141]: started, version 2.90 cachesize 150 Sep 16 15:15:12 volumio-piter-room dnsmasq[14141]: 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:15:12 volumio-piter-room dnsmasq-dhcp[14141]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:12 volumio-piter-room dnsmasq[14141]: reading /etc/resolv.conf Sep 16 15:15:12 volumio-piter-room dnsmasq[14141]: using nameserver 192.168.2.1#53 Sep 16 15:15:12 volumio-piter-room dnsmasq[14141]: using nameserver 208.67.222.222#53 Sep 16 15:15:12 volumio-piter-room dnsmasq[14141]: using nameserver 208.67.220.220#53 Sep 16 15:15:12 volumio-piter-room dnsmasq[14141]: read /etc/hosts - 6 names Sep 16 15:15:12 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: Adding plugin bluetooth to MyMusic Plugins Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: Adding plugin multiroom to MyMusic Plugins Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: Adding plugin metavolumio to MyMusic Plugins Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: Adding plugin cd_controller to MyMusic Plugins Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 16 15:15:12 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: Starting MyVolumio Remote Streaming Endpoints Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: MyVolumio login type: Token Sep 16 15:15:13 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 334. Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 16 15:15:13 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 16 15:15:13 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:13 volumio-piter-room dnsmasq[14141]: exiting on receipt of SIGTERM Sep 16 15:15:13 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:13 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:13 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:14 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:14 volumio-piter-room hostapd[14145]: rfkill: WLAN soft blocked Sep 16 15:15:14 volumio-piter-room hostapd[14145]: Failed to set beacon parameters Sep 16 15:15:14 volumio-piter-room hostapd[14145]: wlan0: Could not connect to kernel driver Sep 16 15:15:14 volumio-piter-room hostapd[14145]: Interface initialization failed Sep 16 15:15:14 volumio-piter-room hostapd[14145]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:14 volumio-piter-room hostapd[14145]: wlan0: AP-DISABLED Sep 16 15:15:14 volumio-piter-room hostapd[14145]: wlan0: Unable to setup interface. Sep 16 15:15:14 volumio-piter-room hostapd[14145]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:14 volumio-piter-room hostapd[14145]: wlan0: AP-DISABLED Sep 16 15:15:14 volumio-piter-room hostapd[14145]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:14 volumio-piter-room hostapd[14145]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:14 volumio-piter-room hostapd[14145]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:14 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:14 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:14 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:14 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:14 volumio-piter-room dnsmasq[14150]: started, version 2.90 cachesize 150 Sep 16 15:15:14 volumio-piter-room dnsmasq[14150]: 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:15:14 volumio-piter-room dnsmasq-dhcp[14150]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:14 volumio-piter-room dnsmasq[14150]: reading /etc/resolv.conf Sep 16 15:15:14 volumio-piter-room dnsmasq[14150]: using nameserver 192.168.2.1#53 Sep 16 15:15:14 volumio-piter-room dnsmasq[14150]: using nameserver 208.67.222.222#53 Sep 16 15:15:14 volumio-piter-room dnsmasq[14150]: using nameserver 208.67.220.220#53 Sep 16 15:15:14 volumio-piter-room dnsmasq[14150]: read /etc/hosts - 6 names Sep 16 15:15:14 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:14 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 16 15:15:14 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 16 15:15:14 volumio-piter-room volumio[13582]: info: Streaming services startup Sep 16 15:15:14 volumio-piter-room volumio[13582]: info: Starting Streaming Daemon Sep 16 15:15:14 volumio-piter-room sudo[14154]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 15:15:14 volumio-piter-room sudo[14154]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:14 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 16 15:15:15 volumio-piter-room sudo[14154]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:15 volumio-piter-room volumio[13582]: info: Getting Spotify volume Sep 16 15:15:15 volumio-piter-room volumio[13582]: error: Cannot start Volumio Streaming Daemon Sep 16 15:15:15 volumio-piter-room volumio[13582]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 16 15:15:15 volumio-piter-room volumio[13582]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 16 15:15:15 volumio-piter-room volumio[13582]: info: Spotify volume: 100 Sep 16 15:15:15 volumio-piter-room volumio[13582]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Sep 16 15:15:15 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:15 volumio-piter-room volumio[13582]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:15 volumio-piter-room volumio[13582]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Sep 16 15:15:15 volumio-piter-room volumio[13582]: SPOTIFY: SPOTIFY VOLUME 100 Sep 16 15:15:15 volumio-piter-room volumio[13582]: SPOTIFY: VOLUMIO VOLUME 5 Sep 16 15:15:15 volumio-piter-room volumio[13582]: SPOTIFY: DELTA VOLUME ENOUGH: true Sep 16 15:15:15 volumio-piter-room volumio[13582]: info: Setting Spotify Volume from Volumio: 5 Sep 16 15:15:15 volumio-piter-room volumio[13582]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 16 15:15:16 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 335. Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: MyVolumio token set successfully Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: MYVOLUMIO: Adding device Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: MYVOLUMIO: Evaluating Server Sep 16 15:15:16 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:16 volumio-piter-room dnsmasq[14150]: exiting on receipt of SIGTERM Sep 16 15:15:16 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:16 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:16 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:16 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:16 volumio-piter-room hostapd[14163]: rfkill: WLAN soft blocked Sep 16 15:15:16 volumio-piter-room hostapd[14163]: Failed to set beacon parameters Sep 16 15:15:16 volumio-piter-room hostapd[14163]: wlan0: Could not connect to kernel driver Sep 16 15:15:16 volumio-piter-room hostapd[14163]: Interface initialization failed Sep 16 15:15:16 volumio-piter-room hostapd[14163]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:16 volumio-piter-room hostapd[14163]: wlan0: AP-DISABLED Sep 16 15:15:16 volumio-piter-room hostapd[14163]: wlan0: Unable to setup interface. Sep 16 15:15:16 volumio-piter-room hostapd[14163]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:16 volumio-piter-room hostapd[14163]: wlan0: AP-DISABLED Sep 16 15:15:16 volumio-piter-room hostapd[14163]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:16 volumio-piter-room hostapd[14163]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:16 volumio-piter-room hostapd[14163]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:16 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:16 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:16 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:16 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:16 volumio-piter-room dnsmasq[14182]: started, version 2.90 cachesize 150 Sep 16 15:15:16 volumio-piter-room dnsmasq[14182]: 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:15:16 volumio-piter-room dnsmasq-dhcp[14182]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:16 volumio-piter-room dnsmasq[14182]: reading /etc/resolv.conf Sep 16 15:15:16 volumio-piter-room dnsmasq[14182]: using nameserver 192.168.2.1#53 Sep 16 15:15:16 volumio-piter-room dnsmasq[14182]: using nameserver 208.67.222.222#53 Sep 16 15:15:16 volumio-piter-room dnsmasq[14182]: using nameserver 208.67.220.220#53 Sep 16 15:15:16 volumio-piter-room dnsmasq[14182]: read /etc/hosts - 6 names Sep 16 15:15:16 volumio-piter-room volumio[13582]: SPOTIFY: SETTING SPOTIFY VOLUME 5 Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: Sending Spotify command with payload to local API: /player/volume Sep 16 15:15:16 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: MyVolumio Plan changed: premium Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: Removing browser output: myVolumio user plan is not superstar Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: Removing audio output: Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: MYVOLUMIO: Adding device Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: MYVOLUMIO: Evaluating Server Sep 16 15:15:16 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:16+02:00" level=debug msg="update volume to 3276/65535" Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: Remote config written successfully Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: Starting Tunnel 1 Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: Starting Tunnel Connection Checker Sep 16 15:15:16 volumio-piter-room volumio[13582]: info: Completed starting MyVolumio Plugin Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: MYVolumio Device enabled Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: MyVolumio status changed Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: Streaming services startup Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: Starting Streaming Daemon Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: Setting Geolocation for MyVolumio to eu6 Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:17 volumio-piter-room sudo[14202]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 15:15:17 volumio-piter-room sudo[14202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Plugin music_service/qobuzconnect is enabled for this plan, but could not be found on the local filesystem! Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Sep 16 15:15:17 volumio-piter-room sudo[14202]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:17 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Sep 16 15:15:17 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Sep 16 15:15:17 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:17+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Sep 16 15:15:17 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:17+02:00" level=trace msg="emitting websocket event: volume" Sep 16 15:15:18 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 336. Sep 16 15:15:18 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:18 volumio-piter-room dnsmasq[14182]: exiting on receipt of SIGTERM Sep 16 15:15:18 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:18 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:18 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:18 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:18 volumio-piter-room hostapd[14205]: rfkill: WLAN soft blocked Sep 16 15:15:18 volumio-piter-room hostapd[14205]: Failed to set beacon parameters Sep 16 15:15:18 volumio-piter-room hostapd[14205]: wlan0: Could not connect to kernel driver Sep 16 15:15:18 volumio-piter-room hostapd[14205]: Interface initialization failed Sep 16 15:15:18 volumio-piter-room hostapd[14205]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:18 volumio-piter-room hostapd[14205]: wlan0: AP-DISABLED Sep 16 15:15:18 volumio-piter-room hostapd[14205]: wlan0: Unable to setup interface. Sep 16 15:15:18 volumio-piter-room hostapd[14205]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:18 volumio-piter-room hostapd[14205]: wlan0: AP-DISABLED Sep 16 15:15:18 volumio-piter-room hostapd[14205]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:18 volumio-piter-room hostapd[14205]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:18 volumio-piter-room hostapd[14205]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:18 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Sep 16 15:15:18 volumio-piter-room sudo[14208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Sep 16 15:15:18 volumio-piter-room sudo[14208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:18 volumio-piter-room sudo[14208]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:18 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:18 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:18 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:18 volumio-piter-room volumio[13582]: /usr/bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Sep 16 15:15:18 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:18 volumio-piter-room volumio[13582]: info: MRS: MultiRoom plugin initialized Sep 16 15:15:18 volumio-piter-room volumio[13582]: info: MRS: STOPPING SNAPCLIENT Sep 16 15:15:18 volumio-piter-room volumio[13582]: info: MRS: Snap server stop Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: STOPPING volumioStreaming Sep 16 15:15:19 volumio-piter-room sudo[14227]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Sep 16 15:15:19 volumio-piter-room sudo[14227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Sep 16 15:15:19 volumio-piter-room dnsmasq[14236]: started, version 2.90 cachesize 150 Sep 16 15:15:19 volumio-piter-room dnsmasq[14236]: 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:15:19 volumio-piter-room dnsmasq-dhcp[14236]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:19 volumio-piter-room dnsmasq[14236]: reading /etc/resolv.conf Sep 16 15:15:19 volumio-piter-room dnsmasq[14236]: using nameserver 192.168.2.1#53 Sep 16 15:15:19 volumio-piter-room dnsmasq[14236]: using nameserver 208.67.222.222#53 Sep 16 15:15:19 volumio-piter-room dnsmasq[14236]: using nameserver 208.67.220.220#53 Sep 16 15:15:19 volumio-piter-room dnsmasq[14236]: read /etc/hosts - 6 names Sep 16 15:15:19 volumio-piter-room sudo[14230]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Sep 16 15:15:19 volumio-piter-room sudo[14230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Sep 16 15:15:19 volumio-piter-room sudo[14237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 16 15:15:19 volumio-piter-room sudo[14234]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Sep 16 15:15:19 volumio-piter-room sudo[14237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Sep 16 15:15:19 volumio-piter-room sudo[14234]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:19 volumio-piter-room sudo[14237]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Sep 16 15:15:19 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Preparing to generate the ALSA configuration file Sep 16 15:15:19 volumio-piter-room sudo[14227]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Updating MyVolumio device info Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:19 volumio-piter-room sudo[14230]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:19 volumio-piter-room sudo[14234]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Setting Geolocation for MyVolumio to eu4 Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Successfully Added MyVolumio device Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Reading ALSA contributions from plugins. Sep 16 15:15:19 volumio-piter-room volumio[13582]: SPOTIFY: received: {"type":"volume","data":{"value":5,"max":100}} Sep 16 15:15:19 volumio-piter-room volumio[13582]: SPOTIFY: RECEIVED SPOTIFY VOLUME 5 Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: Removed streaming files Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: SNAPSERVER STOPPED Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: SNAPCLIENT STOPPED Sep 16 15:15:19 volumio-piter-room volumio[13582]: error: Cannot start Volumio Streaming Daemon Sep 16 15:15:19 volumio-piter-room volumio[13582]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 16 15:15:19 volumio-piter-room volumio[13582]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: volumioStreaming STOPPED Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Asound.conf file written Sep 16 15:15:19 volumio-piter-room sudo[14246]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 16 15:15:19 volumio-piter-room sudo[14246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:19 volumio-piter-room sudo[14246]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:19 volumio-piter-room volumio[13582]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Sep 16 15:15:19 volumio-piter-room volumio[13582]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Sep 16 15:15:19 volumio-piter-room volumio[13582]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Output device has changed, restarting MPD Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Output device has changed, restarting Shairport Sync Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:19 volumio-piter-room sudo[14252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:15:19 volumio-piter-room sudo[14252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:19 volumio-piter-room sudo[14252]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:19 volumio-piter-room sudo[14254]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:15:19 volumio-piter-room sudo[14254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Sep 16 15:15:19 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: [FUNC] onStart Sep 16 15:15:19 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Sep 16 15:15:19 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Sep 16 15:15:19 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Sep 16 15:15:19 volumio-piter-room systemd[1]: Stopping mpd.service - Music Player Daemon... Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: Pushing multiroomSync output for this device Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: Pushing multiroomSync output Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:19 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 15:15:19 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 15:15:19 volumio-piter-room systemd[1]: mpd.service: Consumed 3.815s CPU time. Sep 16 15:15:19 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 15:15:19 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 15:15:19 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding METAVOLUMIO REST API Endpoints Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Preparing CD Folders Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding CD REST API Endpoints Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Starting UDEV Watcher for CD Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Detecting CD presence with UDEV Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Sep 16 15:15:19 volumio-piter-room bluetoothd[898]: Adv Monitor app :1.327 disconnected from D-Bus Sep 16 15:15:19 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding inputs REST Endpoints Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Sep 16 15:15:19 volumio-piter-room volumio[13582]: info: Scanning Audio Inputs Sep 16 15:15:19 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Checking against Known Cards name Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: [1758028520009] CoreMusicLibrary::Adding element SB Omni Surround 5.1 Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source YouTube2 Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source YouTube Music Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source Spotify Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source SB Omni Surround 5.1 Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Checking against Known Cards name Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: [1758028520015] CoreMusicLibrary::Adding element Loopback Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source YouTube2 Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source YouTube Music Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source Spotify Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source SB Omni Surround 5.1 Sep 16 15:15:20 volumio-piter-room volumio[13582]: Cannot find translation for source Loopback Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Checking against Known Cards name Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Checking against Known Cards name Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Adding Server instance for streaming Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Sep 16 15:15:20 volumio-piter-room volumio[13582]: error: Hi Res Audio Failed Login: Missing Login Data Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Adding HIGHRESAUDIO REST API Endpoints Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Sep 16 15:15:20 volumio-piter-room sudo[14274]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 16 15:15:20 volumio-piter-room sudo[14274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Stopping AccessToken refresher cron Sep 16 15:15:20 volumio-piter-room sudo[14274]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: AccessToken refresher cron started Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Stopping AccessToken refresher cron for QOBUZ Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: AccessToken refresher cron started for QOBUZ Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Adding TIDAL REST API Endpoints Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Adding QOBUZ REST API Endpoints Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Successfully Updated MyVolumio device Sep 16 15:15:20 volumio-piter-room sudo[14269]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 15:15:20 volumio-piter-room sudo[14269]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:15:20 volumio-piter-room sudo[14269]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Successfully Added MyVolumio device Sep 16 15:15:20 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: Failed to power on adapter: Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: MPD Permissions set Sep 16 15:15:20 volumio-piter-room sudo[14280]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Updating MyVolumio device info Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:20 volumio-piter-room sudo[14280]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room sudo[14280]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:20 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreCommandRouter::volumioStop Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreStateMachine::stop Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:15:20 volumio-piter-room volumio[13582]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Starting Shairport Sync Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: MRS: Found cast device: Google-Home-4f2219c5b8705a58ece4b360383b0bf4 Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:20 volumio-piter-room sudo[14292]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:20 volumio-piter-room sudo[14292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: MRS: Found cast device: Google-Cast-Group-8c7e5bb20c794e47ae0b7f9d5b21a687 Sep 16 15:15:20 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:20 volumio-piter-room systemd[1]: systemd-timedated.service: Deactivated successfully. Sep 16 15:15:20 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 337. Sep 16 15:15:20 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:20 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 15:15:21 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 15:15:21 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:15:21 volumio-piter-room systemd[1]: shairport-sync.service: Consumed 1.692s CPU time. Sep 16 15:15:21 volumio-piter-room dnsmasq[14236]: exiting on receipt of SIGTERM Sep 16 15:15:21 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:15:21 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:21 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:21 volumio-piter-room sudo[14292]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:21 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:21 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:21 volumio-piter-room hostapd[14301]: rfkill: WLAN soft blocked Sep 16 15:15:21 volumio-piter-room hostapd[14301]: Failed to set beacon parameters Sep 16 15:15:21 volumio-piter-room hostapd[14301]: wlan0: Could not connect to kernel driver Sep 16 15:15:21 volumio-piter-room hostapd[14301]: Interface initialization failed Sep 16 15:15:21 volumio-piter-room hostapd[14301]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:21 volumio-piter-room hostapd[14301]: wlan0: AP-DISABLED Sep 16 15:15:21 volumio-piter-room hostapd[14301]: wlan0: Unable to setup interface. Sep 16 15:15:21 volumio-piter-room hostapd[14301]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:21 volumio-piter-room hostapd[14301]: wlan0: AP-DISABLED Sep 16 15:15:21 volumio-piter-room hostapd[14301]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:21 volumio-piter-room hostapd[14301]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:21 volumio-piter-room hostapd[14301]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: Successfully Updated MyVolumio device Sep 16 15:15:21 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:21 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:21 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:21 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: MRS: Found cast device: Google-Home-Max-150df68bb882c28c6abb87774a67d774 Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: MRS: Found cast device: Chromecast-cb60403bb0c5fa12b7e0e2db8da46ed7 Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:21 volumio-piter-room dnsmasq[14334]: started, version 2.90 cachesize 150 Sep 16 15:15:21 volumio-piter-room dnsmasq[14334]: 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:15:21 volumio-piter-room dnsmasq-dhcp[14334]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:21 volumio-piter-room dnsmasq[14334]: reading /etc/resolv.conf Sep 16 15:15:21 volumio-piter-room dnsmasq[14334]: using nameserver 192.168.2.1#53 Sep 16 15:15:21 volumio-piter-room dnsmasq[14334]: using nameserver 208.67.222.222#53 Sep 16 15:15:21 volumio-piter-room dnsmasq[14334]: using nameserver 208.67.220.220#53 Sep 16 15:15:21 volumio-piter-room dnsmasq[14334]: read /etc/hosts - 6 names Sep 16 15:15:21 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: Shairport-Sync Started Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: MRS: Found cast device: Chromecast-d1dcb61b1a839063c51b50474d951346 Sep 16 15:15:21 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:22 volumio-piter-room volumio[13582]: info: MRS: Found cast device: GTV-64d5ae94f32742d2494b98bdc5095c99 Sep 16 15:15:22 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:22 volumio-piter-room volumio[13582]: info: MRS: Found cast device: Chromecast-6b47dc2dfb64ee00b2f184c72df9f782 Sep 16 15:15:22 volumio-piter-room volumio[13582]: info: Adding audio output: Sep 16 15:15:23 volumio-piter-room sudo[14343]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Sep 16 15:15:23 volumio-piter-room sudo[14343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:23 volumio-piter-room volumio[13582]: info: Bluetoothremote--- Checking for trusted devices to reconnect... Sep 16 15:15:23 volumio-piter-room volumio[13582]: info: Bluetoothremote--- Device list cleared and placeholder written. Sep 16 15:15:23 volumio-piter-room autossh[12016]: received signal to exit (15) Sep 16 15:15:23 volumio-piter-room systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Sep 16 15:15:23 volumio-piter-room systemd[1]: sshtunnel.service: Deactivated successfully. Sep 16 15:15:23 volumio-piter-room systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Sep 16 15:15:23 volumio-piter-room volumio[13582]: info: TidalConnect service stoped! Sep 16 15:15:23 volumio-piter-room bluetoothd[898]: Adv Monitor app :1.338 disconnected from D-Bus Sep 16 15:15:23 volumio-piter-room systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Sep 16 15:15:23 volumio-piter-room sudo[14343]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:23 volumio-piter-room volumio[13582]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 15:15:23 volumio-piter-room autossh[14349]: port set to 0, monitoring disabled Sep 16 15:15:23 volumio-piter-room autossh[14349]: starting ssh (count 1) Sep 16 15:15:23 volumio-piter-room autossh[14349]: ssh child pid is 14355 Sep 16 15:15:23 volumio-piter-room volumio[13582]: TypeError: Cannot read properties of null (reading 'message') Sep 16 15:15:23 volumio-piter-room volumio[13582]: at /data/plugins/system_hardware/Bluetoothremote/index.js:224:97 Sep 16 15:15:23 volumio-piter-room volumio[13582]: at ChildProcess.exithandler (node:child_process:413:7) Sep 16 15:15:23 volumio-piter-room volumio[13582]: at ChildProcess.emit (node:events:514:28) Sep 16 15:15:23 volumio-piter-room volumio[13582]: at maybeClose (node:internal/child_process:1105:16) Sep 16 15:15:23 volumio-piter-room volumio[13582]: at Socket. (node:internal/child_process:457:11) Sep 16 15:15:23 volumio-piter-room volumio[13582]: at Socket.emit (node:events:514:28) Sep 16 15:15:23 volumio-piter-room volumio[13582]: at Pipe. (node:net:337:12) Sep 16 15:15:23 volumio-piter-room volumio[13582]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 15:15:23 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 338. Sep 16 15:15:23 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:23 volumio-piter-room dnsmasq[14334]: exiting on receipt of SIGTERM Sep 16 15:15:23 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:23 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:23 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:23 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:23 volumio-piter-room hostapd[14369]: rfkill: WLAN soft blocked Sep 16 15:15:23 volumio-piter-room hostapd[14369]: Failed to set beacon parameters Sep 16 15:15:23 volumio-piter-room hostapd[14369]: wlan0: Could not connect to kernel driver Sep 16 15:15:23 volumio-piter-room hostapd[14369]: Interface initialization failed Sep 16 15:15:23 volumio-piter-room hostapd[14369]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:23 volumio-piter-room hostapd[14369]: wlan0: AP-DISABLED Sep 16 15:15:23 volumio-piter-room hostapd[14369]: wlan0: Unable to setup interface. Sep 16 15:15:23 volumio-piter-room hostapd[14369]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:23 volumio-piter-room hostapd[14369]: wlan0: AP-DISABLED Sep 16 15:15:23 volumio-piter-room hostapd[14369]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:23 volumio-piter-room hostapd[14369]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:23 volumio-piter-room hostapd[14369]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:23 volumio-piter-room volumiossh-tunnel[14355]: Warning: Permanently added '[eu4.myvolumio.org]:2222' (RSA) to the list of known hosts. Sep 16 15:15:23 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:23 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:23 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:23 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:23 volumio-piter-room dnsmasq[14375]: started, version 2.90 cachesize 150 Sep 16 15:15:23 volumio-piter-room dnsmasq[14375]: 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:15:23 volumio-piter-room dnsmasq-dhcp[14375]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:23 volumio-piter-room dnsmasq[14375]: reading /etc/resolv.conf Sep 16 15:15:23 volumio-piter-room dnsmasq[14375]: using nameserver 192.168.2.1#53 Sep 16 15:15:23 volumio-piter-room dnsmasq[14375]: using nameserver 208.67.222.222#53 Sep 16 15:15:23 volumio-piter-room dnsmasq[14375]: using nameserver 208.67.220.220#53 Sep 16 15:15:23 volumio-piter-room dnsmasq[14375]: read /etc/hosts - 6 names Sep 16 15:15:24 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:24 volumio-piter-room mpd[14278]: 2025-09-16T15:15:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 15:15:24 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 15:15:24 volumio-piter-room sudo[14254]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:24 volumio-piter-room sudo[14382]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-16 15:14' Sep 16 15:15:24 volumio-piter-room sudo[14382]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:25 volumio-piter-room sudo[14382]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:25 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:15:25] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Sep 16 15:15:25 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:25+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Sep 16 15:15:25 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:15:25] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Sep 16 15:15:25 volumio-piter-room systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Sep 16 15:15:25 volumio-piter-room systemd[1]: volumio.service: Failed with result 'exit-code'. Sep 16 15:15:25 volumio-piter-room systemd[1]: volumio.service: Consumed 57.336s CPU time. Sep 16 15:15:25 volumio-piter-room systemd[1]: Started dynamicswap.service - dynamicswap service. Sep 16 15:15:25 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 339. Sep 16 15:15:25 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:25 volumio-piter-room dnsmasq[14375]: exiting on receipt of SIGTERM Sep 16 15:15:25 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:25 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:25 volumio-piter-room systemd[1]: volumio.service: Scheduled restart job, restart counter is at 16. Sep 16 15:15:25 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:25 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:25 volumio-piter-room systemd[1]: Stopped volumio.service - Volumio Backend Module. Sep 16 15:15:25 volumio-piter-room systemd[1]: volumio.service: Consumed 57.336s CPU time. Sep 16 15:15:25 volumio-piter-room systemd[1]: Started volumio.service - Volumio Backend Module. Sep 16 15:15:25 volumio-piter-room systemd[1]: dynamicswap.service: Deactivated successfully. Sep 16 15:15:25 volumio-piter-room hostapd[14397]: rfkill: WLAN soft blocked Sep 16 15:15:25 volumio-piter-room hostapd[14397]: Failed to set beacon parameters Sep 16 15:15:25 volumio-piter-room hostapd[14397]: wlan0: Could not connect to kernel driver Sep 16 15:15:25 volumio-piter-room hostapd[14397]: Interface initialization failed Sep 16 15:15:25 volumio-piter-room hostapd[14397]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:25 volumio-piter-room hostapd[14397]: wlan0: AP-DISABLED Sep 16 15:15:25 volumio-piter-room hostapd[14397]: wlan0: Unable to setup interface. Sep 16 15:15:25 volumio-piter-room hostapd[14397]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:25 volumio-piter-room hostapd[14397]: wlan0: AP-DISABLED Sep 16 15:15:25 volumio-piter-room hostapd[14397]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:25 volumio-piter-room hostapd[14397]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:25 volumio-piter-room hostapd[14397]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:25 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:25 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:25 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:26 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:26 volumio-piter-room dnsmasq[14412]: started, version 2.90 cachesize 150 Sep 16 15:15:26 volumio-piter-room dnsmasq[14412]: 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:15:26 volumio-piter-room dnsmasq-dhcp[14412]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:26 volumio-piter-room dnsmasq[14412]: reading /etc/resolv.conf Sep 16 15:15:26 volumio-piter-room dnsmasq[14412]: using nameserver 192.168.2.1#53 Sep 16 15:15:26 volumio-piter-room dnsmasq[14412]: using nameserver 208.67.222.222#53 Sep 16 15:15:26 volumio-piter-room dnsmasq[14412]: using nameserver 208.67.220.220#53 Sep 16 15:15:26 volumio-piter-room dnsmasq[14412]: read /etc/hosts - 6 names Sep 16 15:15:26 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:28 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 340. Sep 16 15:15:28 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:28 volumio-piter-room volumio[14398]: info: ------------------------------------------- Sep 16 15:15:28 volumio-piter-room volumio[14398]: info: ----- Volumio3 ---- Sep 16 15:15:28 volumio-piter-room volumio[14398]: info: ------------------------------------------- Sep 16 15:15:28 volumio-piter-room volumio[14398]: info: ----- System startup ---- Sep 16 15:15:28 volumio-piter-room volumio[14398]: info: ------------------------------------------- Sep 16 15:15:28 volumio-piter-room dnsmasq[14412]: exiting on receipt of SIGTERM Sep 16 15:15:28 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:28 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:28 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:28 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:28 volumio-piter-room hostapd[14422]: rfkill: WLAN soft blocked Sep 16 15:15:28 volumio-piter-room hostapd[14422]: Failed to set beacon parameters Sep 16 15:15:28 volumio-piter-room hostapd[14422]: wlan0: Could not connect to kernel driver Sep 16 15:15:28 volumio-piter-room hostapd[14422]: Interface initialization failed Sep 16 15:15:28 volumio-piter-room hostapd[14422]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:28 volumio-piter-room hostapd[14422]: wlan0: AP-DISABLED Sep 16 15:15:28 volumio-piter-room hostapd[14422]: wlan0: Unable to setup interface. Sep 16 15:15:28 volumio-piter-room hostapd[14422]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:28 volumio-piter-room hostapd[14422]: wlan0: AP-DISABLED Sep 16 15:15:28 volumio-piter-room hostapd[14422]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:28 volumio-piter-room hostapd[14422]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:28 volumio-piter-room hostapd[14422]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:28 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:28 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:28 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:28 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:28 volumio-piter-room dnsmasq[14427]: started, version 2.90 cachesize 150 Sep 16 15:15:28 volumio-piter-room dnsmasq[14427]: 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:15:28 volumio-piter-room dnsmasq-dhcp[14427]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:28 volumio-piter-room dnsmasq[14427]: reading /etc/resolv.conf Sep 16 15:15:28 volumio-piter-room dnsmasq[14427]: using nameserver 192.168.2.1#53 Sep 16 15:15:28 volumio-piter-room dnsmasq[14427]: using nameserver 208.67.222.222#53 Sep 16 15:15:28 volumio-piter-room dnsmasq[14427]: using nameserver 208.67.220.220#53 Sep 16 15:15:28 volumio-piter-room dnsmasq[14427]: read /etc/hosts - 6 names Sep 16 15:15:28 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: MYVOLUMIO Environment detected Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Plugin folders cleanup Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning into folder /volumio/app/plugins/ Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category audio_interface Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category miscellanea Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category music_service Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category plugins.json Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category system_controller Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category user_interface Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning into folder /data/plugins/ Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category music_service Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category system_controller Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category system_hardware Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Scanning category user_interface Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Plugin folders cleanup completed Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: ------------------------------------------- Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: ----- Core plugins startup ---- Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: ------------------------------------------- Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Loading plugins from folder /volumio/app/plugins/ Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Adding plugin upnp to MyMusic Plugins Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Loading plugins from folder /data/plugins/ Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Loading plugin "system"... Sep 16 15:15:29 volumio-piter-room volumio[14398]: info: Loading plugin "appearance"... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "network"... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Refreshing Cached IP Addresses Sep 16 15:15:30 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 341. Sep 16 15:15:30 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:15:30] [connect] Successful connection Sep 16 15:15:30 volumio-piter-room sudo[14437]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 15:15:30 volumio-piter-room sudo[14437]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:30 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:30 volumio-piter-room sudo[14440]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "services"... Sep 16 15:15:30 volumio-piter-room sudo[14440]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:30 volumio-piter-room sudo[14437]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "alsa_controller"... Sep 16 15:15:30 volumio-piter-room dnsmasq[14427]: exiting on receipt of SIGTERM Sep 16 15:15:30 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:30 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:30 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:30 volumio-piter-room sudo[14440]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:30 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:30 volumio-piter-room sudo[14447]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 15:15:30 volumio-piter-room sudo[14447]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:30 volumio-piter-room sudo[14447]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:30 volumio-piter-room hostapd[14458]: rfkill: WLAN soft blocked Sep 16 15:15:30 volumio-piter-room hostapd[14458]: Failed to set beacon parameters Sep 16 15:15:30 volumio-piter-room hostapd[14458]: wlan0: Could not connect to kernel driver Sep 16 15:15:30 volumio-piter-room hostapd[14458]: Interface initialization failed Sep 16 15:15:30 volumio-piter-room hostapd[14458]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:30 volumio-piter-room hostapd[14458]: wlan0: AP-DISABLED Sep 16 15:15:30 volumio-piter-room hostapd[14458]: wlan0: Unable to setup interface. Sep 16 15:15:30 volumio-piter-room hostapd[14458]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:30 volumio-piter-room hostapd[14458]: wlan0: AP-DISABLED Sep 16 15:15:30 volumio-piter-room hostapd[14458]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:30 volumio-piter-room hostapd[14458]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:30 volumio-piter-room hostapd[14458]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "wizard"... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "networkfs"... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Starting Udev Watcher for removable devices Sep 16 15:15:30 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:30 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:30 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Ignoring mount for partition: boot Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Ignoring mount for partition: volumio Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Ignoring mount for partition: volumio_data Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "volumio_command_line_client"... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "upnp"... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: [1758028530966] Starting Upmpd Daemon Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 15:15:30 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "my_music"... Sep 16 15:15:30 volumio-piter-room volumio[14398]: info: Loading plugin "mpd"... Sep 16 15:15:31 volumio-piter-room dnsmasq[14476]: started, version 2.90 cachesize 150 Sep 16 15:15:31 volumio-piter-room dnsmasq[14476]: 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:15:31 volumio-piter-room dnsmasq-dhcp[14476]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:31 volumio-piter-room dnsmasq[14476]: reading /etc/resolv.conf Sep 16 15:15:31 volumio-piter-room dnsmasq[14476]: using nameserver 192.168.2.1#53 Sep 16 15:15:31 volumio-piter-room dnsmasq[14476]: using nameserver 208.67.222.222#53 Sep 16 15:15:31 volumio-piter-room dnsmasq[14476]: using nameserver 208.67.220.220#53 Sep 16 15:15:31 volumio-piter-room dnsmasq[14476]: read /etc/hosts - 6 names Sep 16 15:15:31 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:31 volumio-piter-room volumio[14398]: info: Loading plugin "upnp_browser"... Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Loading plugin "alarm-clock"... Sep 16 15:15:33 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 342. Sep 16 15:15:33 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:33 volumio-piter-room dnsmasq[14476]: exiting on receipt of SIGTERM Sep 16 15:15:33 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:33 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:33 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:33 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:33 volumio-piter-room hostapd[14480]: rfkill: WLAN soft blocked Sep 16 15:15:33 volumio-piter-room hostapd[14480]: Failed to set beacon parameters Sep 16 15:15:33 volumio-piter-room hostapd[14480]: wlan0: Could not connect to kernel driver Sep 16 15:15:33 volumio-piter-room hostapd[14480]: Interface initialization failed Sep 16 15:15:33 volumio-piter-room hostapd[14480]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:33 volumio-piter-room hostapd[14480]: wlan0: AP-DISABLED Sep 16 15:15:33 volumio-piter-room hostapd[14480]: wlan0: Unable to setup interface. Sep 16 15:15:33 volumio-piter-room hostapd[14480]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:33 volumio-piter-room hostapd[14480]: wlan0: AP-DISABLED Sep 16 15:15:33 volumio-piter-room hostapd[14480]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:33 volumio-piter-room hostapd[14480]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:33 volumio-piter-room hostapd[14480]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Loading plugin "airplay_emulation"... Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Starting Shairport Sync Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Loading plugin "last_100"... Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Loading plugin "webradio"... Sep 16 15:15:33 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:33 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:33 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Loading plugin "i2s_dacs"... Sep 16 15:15:33 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: I2S DAC not set, start Auto-detection Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Loading plugin "volumiodiscovery"... Sep 16 15:15:33 volumio-piter-room volumio[14398]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 15:15:33 volumio-piter-room volumio[14398]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 15:15:33 volumio-piter-room volumio[14398]: *** WARNING *** For more information see Sep 16 15:15:33 volumio-piter-room volumio[14398]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 15:15:33 volumio-piter-room volumio[14398]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 15:15:33 volumio-piter-room node[14398]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 15:15:33 volumio-piter-room volumio[14398]: *** WARNING *** For more information see Sep 16 15:15:33 volumio-piter-room node[14398]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 15:15:33 volumio-piter-room node[14398]: *** WARNING *** For more information see Sep 16 15:15:33 volumio-piter-room node[14398]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 15:15:33 volumio-piter-room node[14398]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 15:15:33 volumio-piter-room node[14398]: *** WARNING *** For more information see Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Discovery: Started advertising with name: VOLUMIO PITER ROOM Sep 16 15:15:33 volumio-piter-room dnsmasq[14486]: started, version 2.90 cachesize 150 Sep 16 15:15:33 volumio-piter-room dnsmasq[14486]: 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:15:33 volumio-piter-room dnsmasq-dhcp[14486]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:33 volumio-piter-room dnsmasq[14486]: reading /etc/resolv.conf Sep 16 15:15:33 volumio-piter-room dnsmasq[14486]: using nameserver 192.168.2.1#53 Sep 16 15:15:33 volumio-piter-room dnsmasq[14486]: using nameserver 208.67.222.222#53 Sep 16 15:15:33 volumio-piter-room dnsmasq[14486]: using nameserver 208.67.220.220#53 Sep 16 15:15:33 volumio-piter-room dnsmasq[14486]: read /etc/hosts - 6 names Sep 16 15:15:33 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 15:15:33 volumio-piter-room volumio[14398]: info: Loading plugin "spop"... Sep 16 15:15:34 volumio-piter-room volumio[14398]: info: Loading plugin "youtube2"... Sep 16 15:15:35 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 343. Sep 16 15:15:35 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:35 volumio-piter-room dnsmasq[14486]: exiting on receipt of SIGTERM Sep 16 15:15:35 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:35 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:35 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:35 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:35 volumio-piter-room hostapd[14491]: rfkill: WLAN soft blocked Sep 16 15:15:35 volumio-piter-room hostapd[14491]: Failed to set beacon parameters Sep 16 15:15:35 volumio-piter-room hostapd[14491]: wlan0: Could not connect to kernel driver Sep 16 15:15:35 volumio-piter-room hostapd[14491]: Interface initialization failed Sep 16 15:15:35 volumio-piter-room hostapd[14491]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:35 volumio-piter-room hostapd[14491]: wlan0: AP-DISABLED Sep 16 15:15:35 volumio-piter-room hostapd[14491]: wlan0: Unable to setup interface. Sep 16 15:15:35 volumio-piter-room hostapd[14491]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:35 volumio-piter-room hostapd[14491]: wlan0: AP-DISABLED Sep 16 15:15:35 volumio-piter-room hostapd[14491]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:35 volumio-piter-room hostapd[14491]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:35 volumio-piter-room hostapd[14491]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:35 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:35 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:35 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:35 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:36 volumio-piter-room dnsmasq[14496]: started, version 2.90 cachesize 150 Sep 16 15:15:36 volumio-piter-room dnsmasq[14496]: 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:15:36 volumio-piter-room dnsmasq-dhcp[14496]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:36 volumio-piter-room dnsmasq[14496]: reading /etc/resolv.conf Sep 16 15:15:36 volumio-piter-room dnsmasq[14496]: using nameserver 192.168.2.1#53 Sep 16 15:15:36 volumio-piter-room dnsmasq[14496]: using nameserver 208.67.222.222#53 Sep 16 15:15:36 volumio-piter-room dnsmasq[14496]: using nameserver 208.67.220.220#53 Sep 16 15:15:36 volumio-piter-room dnsmasq[14496]: read /etc/hosts - 6 names Sep 16 15:15:36 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:38 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 344. Sep 16 15:15:38 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:38 volumio-piter-room dnsmasq[14496]: exiting on receipt of SIGTERM Sep 16 15:15:38 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:38 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:38 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:38 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:38 volumio-piter-room hostapd[14500]: rfkill: WLAN soft blocked Sep 16 15:15:38 volumio-piter-room hostapd[14500]: Failed to set beacon parameters Sep 16 15:15:38 volumio-piter-room hostapd[14500]: wlan0: Could not connect to kernel driver Sep 16 15:15:38 volumio-piter-room hostapd[14500]: Interface initialization failed Sep 16 15:15:38 volumio-piter-room hostapd[14500]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:38 volumio-piter-room hostapd[14500]: wlan0: AP-DISABLED Sep 16 15:15:38 volumio-piter-room hostapd[14500]: wlan0: Unable to setup interface. Sep 16 15:15:38 volumio-piter-room hostapd[14500]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:38 volumio-piter-room hostapd[14500]: wlan0: AP-DISABLED Sep 16 15:15:38 volumio-piter-room hostapd[14500]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:38 volumio-piter-room hostapd[14500]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:38 volumio-piter-room hostapd[14500]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:38 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:38+02:00" level=trace msg="sent dealer ping" Sep 16 15:15:38 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:38 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:38 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:38 volumio-piter-room go-librespot[14053]: time="2025-09-16T15:15:38+02:00" level=trace msg="received dealer pong" Sep 16 15:15:38 volumio-piter-room volumio[14398]: info: Loading plugin "ytmusic"... Sep 16 15:15:38 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:38 volumio-piter-room dnsmasq[14505]: started, version 2.90 cachesize 150 Sep 16 15:15:38 volumio-piter-room dnsmasq[14505]: 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:15:38 volumio-piter-room dnsmasq-dhcp[14505]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:38 volumio-piter-room dnsmasq[14505]: reading /etc/resolv.conf Sep 16 15:15:38 volumio-piter-room dnsmasq[14505]: using nameserver 192.168.2.1#53 Sep 16 15:15:38 volumio-piter-room dnsmasq[14505]: using nameserver 208.67.222.222#53 Sep 16 15:15:38 volumio-piter-room dnsmasq[14505]: using nameserver 208.67.220.220#53 Sep 16 15:15:38 volumio-piter-room dnsmasq[14505]: read /etc/hosts - 6 names Sep 16 15:15:38 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:40 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 345. Sep 16 15:15:40 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:40 volumio-piter-room dnsmasq[14505]: exiting on receipt of SIGTERM Sep 16 15:15:40 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:40 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:40 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:40 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:40 volumio-piter-room hostapd[14509]: rfkill: WLAN soft blocked Sep 16 15:15:40 volumio-piter-room hostapd[14509]: Failed to set beacon parameters Sep 16 15:15:40 volumio-piter-room hostapd[14509]: wlan0: Could not connect to kernel driver Sep 16 15:15:40 volumio-piter-room hostapd[14509]: Interface initialization failed Sep 16 15:15:40 volumio-piter-room hostapd[14509]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:40 volumio-piter-room hostapd[14509]: wlan0: AP-DISABLED Sep 16 15:15:40 volumio-piter-room hostapd[14509]: wlan0: Unable to setup interface. Sep 16 15:15:40 volumio-piter-room hostapd[14509]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:40 volumio-piter-room hostapd[14509]: wlan0: AP-DISABLED Sep 16 15:15:40 volumio-piter-room hostapd[14509]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:40 volumio-piter-room hostapd[14509]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:40 volumio-piter-room hostapd[14509]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:40 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:40 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:40 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:40 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:41 volumio-piter-room dnsmasq[14528]: started, version 2.90 cachesize 150 Sep 16 15:15:41 volumio-piter-room dnsmasq[14528]: 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:15:41 volumio-piter-room dnsmasq-dhcp[14528]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:41 volumio-piter-room dnsmasq[14528]: reading /etc/resolv.conf Sep 16 15:15:41 volumio-piter-room dnsmasq[14528]: using nameserver 192.168.2.1#53 Sep 16 15:15:41 volumio-piter-room dnsmasq[14528]: using nameserver 208.67.222.222#53 Sep 16 15:15:41 volumio-piter-room dnsmasq[14528]: using nameserver 208.67.220.220#53 Sep 16 15:15:41 volumio-piter-room dnsmasq[14528]: read /etc/hosts - 6 names Sep 16 15:15:41 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:41 volumio-piter-room volumio[14398]: info: Loading plugin "autostart"... Sep 16 15:15:41 volumio-piter-room volumio[14398]: info: Applying required configuration parameters for plugin autostart Sep 16 15:15:41 volumio-piter-room volumio[14398]: info: AutoStart - onVolumioStart - read config.json Sep 16 15:15:41 volumio-piter-room volumio[14398]: info: Loading plugin "now_playing"... Sep 16 15:15:43 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 346. Sep 16 15:15:43 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:15:43] [connect] Successful connection Sep 16 15:15:43 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:43 volumio-piter-room dnsmasq[14528]: exiting on receipt of SIGTERM Sep 16 15:15:43 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:43 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:43 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:43 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:43 volumio-piter-room hostapd[14532]: rfkill: WLAN soft blocked Sep 16 15:15:43 volumio-piter-room hostapd[14532]: Failed to set beacon parameters Sep 16 15:15:43 volumio-piter-room hostapd[14532]: wlan0: Could not connect to kernel driver Sep 16 15:15:43 volumio-piter-room hostapd[14532]: Interface initialization failed Sep 16 15:15:43 volumio-piter-room hostapd[14532]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:43 volumio-piter-room hostapd[14532]: wlan0: AP-DISABLED Sep 16 15:15:43 volumio-piter-room hostapd[14532]: wlan0: Unable to setup interface. Sep 16 15:15:43 volumio-piter-room hostapd[14532]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:43 volumio-piter-room hostapd[14532]: wlan0: AP-DISABLED Sep 16 15:15:43 volumio-piter-room hostapd[14532]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:43 volumio-piter-room hostapd[14532]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:43 volumio-piter-room hostapd[14532]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "outputs"... Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "albumart"... Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Plugin example_plugin is not enabled Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "inputs"... Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "updater_comm"... Sep 16 15:15:43 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:43 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:43 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Plugin mpdemulation is not enabled Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "rest_api"... Sep 16 15:15:43 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "websocket"... Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Starting Socket.io Server version 1.7.4 Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "Bluetoothremote"... Sep 16 15:15:43 volumio-piter-room dnsmasq[14547]: started, version 2.90 cachesize 150 Sep 16 15:15:43 volumio-piter-room dnsmasq[14547]: 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:15:43 volumio-piter-room dnsmasq-dhcp[14547]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:43 volumio-piter-room dnsmasq[14547]: reading /etc/resolv.conf Sep 16 15:15:43 volumio-piter-room dnsmasq[14547]: using nameserver 192.168.2.1#53 Sep 16 15:15:43 volumio-piter-room dnsmasq[14547]: using nameserver 208.67.222.222#53 Sep 16 15:15:43 volumio-piter-room dnsmasq[14547]: using nameserver 208.67.220.220#53 Sep 16 15:15:43 volumio-piter-room dnsmasq[14547]: read /etc/hosts - 6 names Sep 16 15:15:43 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Applying required configuration parameters for plugin Bluetoothremote Sep 16 15:15:43 volumio-piter-room volumio[14398]: info: Loading plugin "peppymeterbasic"... Sep 16 15:15:44 volumio-piter-room volumio[14533]: Forking 3 albumart workers Sep 16 15:15:44 volumio-piter-room volumio[14398]: info: Loading plugin "touch_display"... Sep 16 15:15:44 volumio-piter-room volumio[14398]: info: Applying required configuration parameters for plugin touch_display Sep 16 15:15:44 volumio-piter-room volumio[14398]: info: Loading i18n strings for locale pl Sep 16 15:15:44 volumio-piter-room volumio[14398]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 15:15:44 volumio-piter-room volumio[14398]: Updating browse sources language Sep 16 15:15:44 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:44 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 15:15:44 volumio-piter-room volumio[14398]: info: CoreCommandRouter::initPlayerControls Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 15:15:45 volumio-piter-room volumio[14398]: Express server listening on port 3000 Sep 16 15:15:45 volumio-piter-room volumio[14398]: [Metrics] WebUI: 17s 448.33ms Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreStateMachine::resetVolumioState Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreStateMachine::getcurrentVolume Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:45 volumio-piter-room sudo[14585]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 15:15:45 volumio-piter-room sudo[14585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:45 volumio-piter-room sudo[14585]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:45 volumio-piter-room sudo[14587]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 15:15:45 volumio-piter-room sudo[14587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: Volumio Network Manager: Network status updated: 1 Sep 16 15:15:45 volumio-piter-room sudo[14587]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:45 volumio-piter-room volumio[14398]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 16 15:15:45 volumio-piter-room volumio[14398]: wlan0 Interface doesn't support scanning : Network is down Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: Cannot use regular scanning, forcing with ap-force Sep 16 15:15:45 volumio-piter-room sudo[14593]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 16 15:15:45 volumio-piter-room sudo[14593]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:45 volumio-piter-room sudo[14593]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:45 volumio-piter-room volumio[14398]: command failed: Network is down (-100) Sep 16 15:15:45 volumio-piter-room volumio[14398]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 16 15:15:45 volumio-piter-room volumio[14398]: command failed: Network is down (-100) Sep 16 15:15:45 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 347. Sep 16 15:15:45 volumio-piter-room volumio[14398]: 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:15:45 volumio-piter-room volumio[14398]: info: VolumeController:: Volume=5 Mute =false Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreStateMachine::pushState Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioPushState Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreStateMachine::updateTrackBlock Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrackBlock Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 15:15:45 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:45 volumio-piter-room dnsmasq[14547]: exiting on receipt of SIGTERM Sep 16 15:15:45 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:45 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:45 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:45 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:45 volumio-piter-room volumio[14398]: 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:15:45 volumio-piter-room volumio[14398]: 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:15:45 volumio-piter-room hostapd[14597]: rfkill: WLAN soft blocked Sep 16 15:15:45 volumio-piter-room hostapd[14597]: Failed to set beacon parameters Sep 16 15:15:45 volumio-piter-room hostapd[14597]: wlan0: Could not connect to kernel driver Sep 16 15:15:45 volumio-piter-room hostapd[14597]: Interface initialization failed Sep 16 15:15:45 volumio-piter-room hostapd[14597]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:45 volumio-piter-room hostapd[14597]: wlan0: AP-DISABLED Sep 16 15:15:45 volumio-piter-room hostapd[14597]: wlan0: Unable to setup interface. Sep 16 15:15:45 volumio-piter-room hostapd[14597]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:45 volumio-piter-room hostapd[14597]: wlan0: AP-DISABLED Sep 16 15:15:45 volumio-piter-room hostapd[14597]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:45 volumio-piter-room hostapd[14597]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:45 volumio-piter-room hostapd[14597]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: Reloading queue from file Sep 16 15:15:45 volumio-piter-room volumio[14398]: 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:15:45 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:45 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:45 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:45 volumio-piter-room volumio[14398]: 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:15:45 volumio-piter-room volumio[14551]: Starting albumart workers Sep 16 15:15:45 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 16 15:15:45 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreStateMachine::setRepeat null single undefined Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreStateMachine::pushState Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 15:15:45 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioPushState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreStateMachine::setRandom null Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreStateMachine::pushState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioPushState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Setting Device type: Raspberry PI Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03112 Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 16 15:15:46 volumio-piter-room volumio[14552]: Starting albumart workers Sep 16 15:15:46 volumio-piter-room dnsmasq[14608]: started, version 2.90 cachesize 150 Sep 16 15:15:46 volumio-piter-room dnsmasq[14608]: 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:15:46 volumio-piter-room dnsmasq-dhcp[14608]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:46 volumio-piter-room dnsmasq[14608]: reading /etc/resolv.conf Sep 16 15:15:46 volumio-piter-room dnsmasq[14608]: using nameserver 192.168.2.1#53 Sep 16 15:15:46 volumio-piter-room dnsmasq[14608]: using nameserver 208.67.222.222#53 Sep 16 15:15:46 volumio-piter-room dnsmasq[14608]: using nameserver 208.67.220.220#53 Sep 16 15:15:46 volumio-piter-room dnsmasq[14608]: read /etc/hosts - 6 names Sep 16 15:15:46 volumio-piter-room volumio[14398]: 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:15:46 volumio-piter-room volumio[14550]: Starting albumart workers Sep 16 15:15:46 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:46 volumio-piter-room volumio[14398]: 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:15:46 volumio-piter-room volumio[14398]: info: VolumeController:: Volume=5 Mute =false Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreStateMachine::pushState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioPushState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:46 volumio-piter-room volumio[14398]: 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:15:46 volumio-piter-room sudo[14613]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 16 15:15:46 volumio-piter-room sudo[14613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Listing playlists Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetQueue Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreStateMachine::getQueue Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CorePlayQueue::getQueue Sep 16 15:15:46 volumio-piter-room sudo[14613]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:46 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Discovery: adding 9992bd7f-303c-4d6b-abb1-8779e9fad663 Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Discovery: Found device VOLUMIO PITER ROOM Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:46 volumio-piter-room volumio[14398]: 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:15:46 volumio-piter-room volumio[14398]: info: Upmpdcli Daemon Started Sep 16 15:15:46 volumio-piter-room volumio[14398]: 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:15:46 volumio-piter-room volumio[14398]: info: Completed loading Core Plugins Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Preparing to generate the ALSA configuration file Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Discovery: this is already registered, 9992bd7f-303c-4d6b-abb1-8779e9fad663 Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Discovery: Found device VOLUMIO PITER ROOM Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Sep 16 15:15:46 volumio-piter-room volumio[14398]: info: Reading ALSA contributions from plugins. Sep 16 15:15:46 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Sep 16 15:15:47 volumio-piter-room volumio-remote-updater[600]: [2025-09-16 15:15:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1758028543 101 Sep 16 15:15:47 volumio-piter-room volumio[14398]: 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: 14 Sep 16 15:15:47 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Sep 16 15:15:47 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Asound.conf file written Sep 16 15:15:47 volumio-piter-room sudo[14638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 16 15:15:47 volumio-piter-room sudo[14638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:47 volumio-piter-room sudo[14638]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:47 volumio-piter-room volumio[14398]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Sep 16 15:15:47 volumio-piter-room volumio[14398]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Sep 16 15:15:47 volumio-piter-room volumio[14398]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Output device has changed, restarting MPD Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Output device has changed, restarting Shairport Sync Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:47 volumio-piter-room sudo[14644]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:15:47 volumio-piter-room sudo[14644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:47 volumio-piter-room sudo[14644]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:15:47 volumio-piter-room sudo[14646]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:15:47 volumio-piter-room sudo[14646]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: ___________ START PLUGINS ___________ Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: ControllerMpd::onStart: Initializing MPD Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Creating MPD Configuration file Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: [1758028547659] CoreMusicLibrary::Adding element Serwery Mediów Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopping mpd.service - Music Player Daemon... Sep 16 15:15:47 volumio-piter-room sudo[14654]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:15:47 volumio-piter-room sudo[14654]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:47 volumio-piter-room sudo[14654]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:47 volumio-piter-room sudo[14656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:15:47 volumio-piter-room sudo[14656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:47 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 15:15:47 volumio-piter-room systemd[1]: mpd.service: Consumed 4.074s CPU time. Sep 16 15:15:47 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 15:15:47 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: [1758028547806] CoreMusicLibrary::Adding element Last_100 Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: [1758028547811] CoreMusicLibrary::Adding element Webradio Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Initializing BBC Radios Sep 16 15:15:47 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:15:47 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:15:47 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 15:15:47 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 15:15:47 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 15:15:47 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:15:47 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:15:47 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 348. Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:15:47 volumio-piter-room dnsmasq[14608]: exiting on receipt of SIGTERM Sep 16 15:15:47 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:47 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:47 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: Creating Spotify config file Sep 16 15:15:47 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:48 volumio-piter-room hostapd[14685]: rfkill: WLAN soft blocked Sep 16 15:15:48 volumio-piter-room hostapd[14685]: Failed to set beacon parameters Sep 16 15:15:48 volumio-piter-room hostapd[14685]: wlan0: Could not connect to kernel driver Sep 16 15:15:48 volumio-piter-room hostapd[14685]: Interface initialization failed Sep 16 15:15:48 volumio-piter-room hostapd[14685]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:48 volumio-piter-room hostapd[14685]: wlan0: AP-DISABLED Sep 16 15:15:48 volumio-piter-room hostapd[14685]: wlan0: Unable to setup interface. Sep 16 15:15:48 volumio-piter-room hostapd[14685]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:48 volumio-piter-room hostapd[14685]: wlan0: AP-DISABLED Sep 16 15:15:48 volumio-piter-room hostapd[14685]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:48 volumio-piter-room hostapd[14685]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:48 volumio-piter-room hostapd[14685]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:48 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:48 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:48 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:48 volumio-piter-room sudo[14679]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 15:15:48 volumio-piter-room sudo[14679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:15:48 volumio-piter-room sudo[14679]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:48 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:48 volumio-piter-room dnsmasq[14692]: started, version 2.90 cachesize 150 Sep 16 15:15:48 volumio-piter-room dnsmasq[14692]: 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:15:48 volumio-piter-room dnsmasq-dhcp[14692]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:48 volumio-piter-room dnsmasq[14692]: reading /etc/resolv.conf Sep 16 15:15:48 volumio-piter-room dnsmasq[14692]: using nameserver 192.168.2.1#53 Sep 16 15:15:48 volumio-piter-room dnsmasq[14692]: using nameserver 208.67.222.222#53 Sep 16 15:15:48 volumio-piter-room dnsmasq[14692]: using nameserver 208.67.220.220#53 Sep 16 15:15:48 volumio-piter-room dnsmasq[14692]: read /etc/hosts - 6 names Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: [1758028548344] CoreMusicLibrary::Adding element YouTube2 Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:48 volumio-piter-room volumio[14398]: Cannot find translation for source YouTube2 Sep 16 15:15:48 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: [1758028548358] CoreMusicLibrary::Adding element YouTube Music Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:48 volumio-piter-room volumio[14398]: Cannot find translation for source YouTube2 Sep 16 15:15:48 volumio-piter-room volumio[14398]: Cannot find translation for source YouTube Music Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: AutoStart - onStart Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: [now-playing] ConfigUpdater: config is up to date. Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: Loading i18n strings for locale pl Sep 16 15:15:48 volumio-piter-room volumio[14398]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: Loading i18n strings for locale pl Sep 16 15:15:48 volumio-piter-room volumio[14398]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: Volumio Calling Home Sep 16 15:15:48 volumio-piter-room sudo[14696]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Sep 16 15:15:48 volumio-piter-room sudo[14696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:48 volumio-piter-room sudo[14696]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: Preparing to generate the ALSA configuration file Sep 16 15:15:48 volumio-piter-room sudo[14703]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Sep 16 15:15:48 volumio-piter-room sudo[14703]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:48 volumio-piter-room sudo[14704]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Sep 16 15:15:48 volumio-piter-room sudo[14704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:48 volumio-piter-room sudo[14706]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Sep 16 15:15:48 volumio-piter-room sudo[14706]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:48 volumio-piter-room systemd[1]: Reloading. Sep 16 15:15:48 volumio-piter-room volumio[14398]: info: [now-playing] App is listening on port 4004. Sep 16 15:15:48 volumio-piter-room volumio[14398]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: AutoStart - Plugin is starting Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetQueue Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::getQueue Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CorePlayQueue::getQueue Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: AutoStart - start playing Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: AutoStart - start playing with no specific position Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioPlay Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::play index 0 Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::stop Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::play index undefined Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreStateMachine::startPlaybackTimer Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: [1758028549097] ControllerUPNPBrowser::clearAddPlayTrack Sep 16 15:15:49 volumio-piter-room volumio[14398]: verbose: ControllerMpd::sendMpdCommand stop Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: Reading ALSA contributions from plugins. Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: touch_display: No backlight interface detected. Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: snd_dummy loaded Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: MPD Permissions set Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: MPD Permissions set Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: Volumio called home Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: Spotify config file written Sep 16 15:15:49 volumio-piter-room sudo[14711]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Sep 16 15:15:49 volumio-piter-room sudo[14711]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:49 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: No need to fix Spotify hosts Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:49 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Starting Shairport Sync Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Starting Shairport Sync Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Starting Shairport Sync Sep 16 15:15:50 volumio-piter-room sudo[14741]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Sep 16 15:15:50 volumio-piter-room sudo[14741]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:50 volumio-piter-room sudo[14741]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:50 volumio-piter-room sudo[14744]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:50 volumio-piter-room sudo[14744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Asound.conf file unchanged, so no further update is needed Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Output device has changed, restarting MPD Sep 16 15:15:50 volumio-piter-room sudo[14745]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:50 volumio-piter-room sudo[14745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:50 volumio-piter-room sudo[14747]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:50 volumio-piter-room sudo[14747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Output device has changed, restarting Shairport Sync Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:50 volumio-piter-room sudo[14753]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 15:15:50 volumio-piter-room sudo[14753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:50 volumio-piter-room sudo[14753]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:50 volumio-piter-room sudo[14757]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 15:15:50 volumio-piter-room sudo[14757]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Sep 16 15:15:50 volumio-piter-room volumio[14398]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: MPD Permissions set Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: An error occurred while refreshing Spotify Token Error: Bad Request Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: Starting Shairport Sync Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 15:15:50 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 15:15:51 volumio-piter-room volumio[14398]: info: Listing playlists Sep 16 15:15:51 volumio-piter-room sudo[14775]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 15:15:51 volumio-piter-room sudo[14775]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:51 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:51 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:51 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:15:51 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:15:51 volumio-piter-room systemd[1]: Reloading. Sep 16 15:15:51 volumio-piter-room sudo[14706]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:51 volumio-piter-room volumio[14398]: info: touch_display: systemctl daemon-reload succeeded. Sep 16 15:15:51 volumio-piter-room sudo[14788]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Sep 16 15:15:51 volumio-piter-room sudo[14788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:15:52 volumio-piter-room mpd[14689]: 2025-09-16T15:15:52 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 15:15:53 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:53 volumio-piter-room systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Sep 16 15:15:53 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:15:53 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:15:53 volumio-piter-room sudo[14704]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:53 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 15:15:53 volumio-piter-room volumio[14398]: info: touch_display: systemctl disable getty@tty1.service succeeded. Sep 16 15:15:53 volumio-piter-room sudo[14646]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:53 volumio-piter-room sudo[14656]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:53 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 349. Sep 16 15:15:53 volumio-piter-room volumio[14398]: error: MPD error: The expression evaluated to a falsy value: Sep 16 15:15:53 volumio-piter-room volumio[14398]: assert.ok(self.idling) Sep 16 15:15:53 volumio-piter-room volumio[14398]: error: The expression evaluated to a falsy value: Sep 16 15:15:53 volumio-piter-room volumio[14398]: assert.ok(self.idling) Sep 16 15:15:53 volumio-piter-room volumio[14398]: error: updateQueue error: null Sep 16 15:15:53 volumio-piter-room volumio[14398]: info: MPD running with PID14689 Sep 16 15:15:53 volumio-piter-room volumio[14398]: ,establishing connection Sep 16 15:15:53 volumio-piter-room volumio[14398]: error: updateQueue error: null Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopping mpd.service - Music Player Daemon... Sep 16 15:15:54 volumio-piter-room systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 16 15:15:54 volumio-piter-room sudo[14788]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: touch_display: Volumio Kiosk started. Sep 16 15:15:54 volumio-piter-room systemd[1]: go-librespot-daemon.service: Deactivated successfully. Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: Completed starting Core Plugins Sep 16 15:15:54 volumio-piter-room systemd[1]: shairport-sync.service: Deactivated successfully. Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:15:54 volumio-piter-room systemd[1]: shairport-sync.service: Consumed 1.737s CPU time. Sep 16 15:15:54 volumio-piter-room systemd[1]: mpd.service: Deactivated successfully. Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopped mpd.service - Music Player Daemon. Sep 16 15:15:54 volumio-piter-room systemd[1]: mpd.service: Consumed 3.969s CPU time. Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: ------------------------------------------- Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: ----- MyVolumio plugins startup ---- Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: ------------------------------------------- Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 16 15:15:54 volumio-piter-room dnsmasq[14692]: exiting on receipt of SIGTERM Sep 16 15:15:54 volumio-piter-room dbus-daemon[557]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.343' (uid=0 pid=14814 comm="timedatectl show --property=NTPSynchronized --valu") Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:54 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:54 volumio-piter-room sudo[14703]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: touch_display: systemctl stop getty@tty1.service succeeded. Sep 16 15:15:54 volumio-piter-room systemd[1]: mpd.socket: Deactivated successfully. Sep 16 15:15:54 volumio-piter-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: touch_display: X display number found: 0 Sep 16 15:15:54 volumio-piter-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 16 15:15:54 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:15:54 volumio-piter-room sudo[14711]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:54 volumio-piter-room go-librespot[14823]: go-librespot daemon starting... Sep 16 15:15:54 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:54 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:54 volumio-piter-room systemd[1]: Starting mpd.service - Music Player Daemon... Sep 16 15:15:54 volumio-piter-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 16 15:15:54 volumio-piter-room hostapd[14825]: rfkill: WLAN soft blocked Sep 16 15:15:54 volumio-piter-room sudo[14747]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:54 volumio-piter-room sudo[14744]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:54 volumio-piter-room hostapd[14825]: Failed to set beacon parameters Sep 16 15:15:54 volumio-piter-room hostapd[14825]: wlan0: Could not connect to kernel driver Sep 16 15:15:54 volumio-piter-room hostapd[14825]: Interface initialization failed Sep 16 15:15:54 volumio-piter-room hostapd[14825]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:54 volumio-piter-room hostapd[14825]: wlan0: AP-DISABLED Sep 16 15:15:54 volumio-piter-room hostapd[14825]: wlan0: Unable to setup interface. Sep 16 15:15:54 volumio-piter-room hostapd[14825]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:54 volumio-piter-room hostapd[14825]: wlan0: AP-DISABLED Sep 16 15:15:54 volumio-piter-room hostapd[14825]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:54 volumio-piter-room hostapd[14825]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:54 volumio-piter-room hostapd[14825]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:54 volumio-piter-room sudo[14745]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:54 volumio-piter-room sudo[14775]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:54 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:54+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:15:54 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:54+02:00" level=debug msg="app state loaded" Sep 16 15:15:54 volumio-piter-room systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 16 15:15:54 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: Shairport-Sync Started Sep 16 15:15:54 volumio-piter-room volumio[14398]: Error adding Membership: Error: addMembership EINVAL Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: Shairport-Sync Started Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: Shairport-Sync Started Sep 16 15:15:54 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: Shairport-Sync Started Sep 16 15:15:54 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:54 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: CoreCommandRouter::volumioGetState Sep 16 15:15:54 volumio-piter-room volumio[14398]: info: CorePlayQueue::getTrack 0 Sep 16 15:15:55 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:55 volumio-piter-room volumio[14398]: info: touch_display: X display number found: 0 Sep 16 15:15:55 volumio-piter-room volumio[14398]: info: touch_display: Setting screensaver timeout to 10 seconds. Sep 16 15:15:55 volumio-piter-room volumio[14398]: info: touch_display: X display number found: 0 Sep 16 15:15:55 volumio-piter-room volumio[14398]: info: touch_display: X display number found: 0 Sep 16 15:15:55 volumio-piter-room sudo[14830]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 15:15:55 volumio-piter-room sudo[14830]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:15:55 volumio-piter-room dnsmasq[14859]: started, version 2.90 cachesize 150 Sep 16 15:15:55 volumio-piter-room dnsmasq[14859]: 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:15:55 volumio-piter-room dnsmasq-dhcp[14859]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:55 volumio-piter-room dnsmasq[14859]: reading /etc/resolv.conf Sep 16 15:15:55 volumio-piter-room dnsmasq[14859]: using nameserver 192.168.2.1#53 Sep 16 15:15:55 volumio-piter-room dnsmasq[14859]: using nameserver 208.67.222.222#53 Sep 16 15:15:55 volumio-piter-room dnsmasq[14859]: using nameserver 208.67.220.220#53 Sep 16 15:15:55 volumio-piter-room sudo[14830]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:55 volumio-piter-room dnsmasq[14859]: read /etc/hosts - 6 names Sep 16 15:15:55 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:55 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:55+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Sep 16 15:15:55 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:55+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Sep 16 15:15:55 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:55+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Sep 16 15:15:55 volumio-piter-room systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 16 15:15:55 volumio-piter-room dbus-daemon[557]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 16 15:15:55 volumio-piter-room setdatetime-helper.sh[14813]: Time is not synchronized. Attempting to sync... Sep 16 15:15:55 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:55+02:00" level=info msg="zeroconf server listening on port 36439" Sep 16 15:15:55 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:55+02:00" level=debug msg="obtained new client token: AACKKp2MmyxH5xyMlTwmDMZdRqU1mYl3BetctRiVVjCXggGUvnyKaM6s5FEBSJ1SU94UcsrXZepCdjLfp+ZtB2zAXw7cUCJWTFzdI9bIQNZbWjtPXbMFVV/nN/6GNbnZpJx8JHtSj8carSAPnPbG8otlePkChyZnZooTX5VIcOZ8/+hoUnmHydgB16XfvDF2ZzV/v2ozQOEJAzUIhJmOoresRw2G1MjslWsB3PMXIW0uA4alixNJBLZ8SQ==" Sep 16 15:15:55 volumio-piter-room sudo[14869]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 16 Sep 2025 13:15:56 GMT#015' Sep 16 15:15:55 volumio-piter-room sudo[14869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 16 15:15:56 volumio-piter-room setdatetime-helper.sh[14870]: Tue Sep 16 15:15:56 CEST 2025 Sep 16 15:15:56 volumio-piter-room sudo[14869]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:56 volumio-piter-room setdatetime-helper.sh[14813]: Time synchronized successfully. Sep 16 15:15:56 volumio-piter-room systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 16 15:15:56 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:56+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 15:15:56 volumio-piter-room systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 16 15:15:56 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:56+02:00" level=debug msg="completed keyexchange" Sep 16 15:15:56 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:56+02:00" level=debug msg="completed challenge" Sep 16 15:15:56 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:15:56+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 15:15:57 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 350. Sep 16 15:15:57 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:57 volumio-piter-room dnsmasq[14859]: exiting on receipt of SIGTERM Sep 16 15:15:57 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:57 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:57 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:57 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:57 volumio-piter-room hostapd[14872]: rfkill: WLAN soft blocked Sep 16 15:15:57 volumio-piter-room hostapd[14872]: Failed to set beacon parameters Sep 16 15:15:57 volumio-piter-room hostapd[14872]: wlan0: Could not connect to kernel driver Sep 16 15:15:57 volumio-piter-room hostapd[14872]: Interface initialization failed Sep 16 15:15:57 volumio-piter-room hostapd[14872]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:57 volumio-piter-room hostapd[14872]: wlan0: AP-DISABLED Sep 16 15:15:57 volumio-piter-room hostapd[14872]: wlan0: Unable to setup interface. Sep 16 15:15:57 volumio-piter-room hostapd[14872]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:57 volumio-piter-room hostapd[14872]: wlan0: AP-DISABLED Sep 16 15:15:57 volumio-piter-room hostapd[14872]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:57 volumio-piter-room hostapd[14872]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:57 volumio-piter-room hostapd[14872]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:15:57 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:15:57 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:15:57 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:57 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:57 volumio-piter-room dnsmasq[14877]: started, version 2.90 cachesize 150 Sep 16 15:15:57 volumio-piter-room dnsmasq[14877]: 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:15:57 volumio-piter-room dnsmasq-dhcp[14877]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:15:57 volumio-piter-room dnsmasq[14877]: reading /etc/resolv.conf Sep 16 15:15:57 volumio-piter-room dnsmasq[14877]: using nameserver 192.168.2.1#53 Sep 16 15:15:57 volumio-piter-room dnsmasq[14877]: using nameserver 208.67.222.222#53 Sep 16 15:15:57 volumio-piter-room dnsmasq[14877]: using nameserver 208.67.220.220#53 Sep 16 15:15:57 volumio-piter-room dnsmasq[14877]: read /etc/hosts - 6 names Sep 16 15:15:57 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:57 volumio-piter-room volumio[14398]: info: go-librespot daemon successfully initialized Sep 16 15:15:59 volumio-piter-room mpd[14862]: 2025-09-16T15:15:59 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 15:15:59 volumio-piter-room systemd[1]: Started mpd.service - Music Player Daemon. Sep 16 15:15:59 volumio-piter-room sudo[14757]: pam_unix(sudo:session): session closed for user root Sep 16 15:15:59 volumio-piter-room volumio[14398]: error: updateQueue error: null Sep 16 15:15:59 volumio-piter-room volumio[14398]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 16 15:15:59 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 351. Sep 16 15:15:59 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:15:59 volumio-piter-room dnsmasq[14877]: exiting on receipt of SIGTERM Sep 16 15:15:59 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:15:59 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:15:59 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:15:59 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:15:59 volumio-piter-room hostapd[14886]: rfkill: WLAN soft blocked Sep 16 15:15:59 volumio-piter-room hostapd[14886]: Failed to set beacon parameters Sep 16 15:15:59 volumio-piter-room hostapd[14886]: wlan0: Could not connect to kernel driver Sep 16 15:15:59 volumio-piter-room hostapd[14886]: Interface initialization failed Sep 16 15:15:59 volumio-piter-room hostapd[14886]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:15:59 volumio-piter-room hostapd[14886]: wlan0: AP-DISABLED Sep 16 15:15:59 volumio-piter-room hostapd[14886]: wlan0: Unable to setup interface. Sep 16 15:15:59 volumio-piter-room hostapd[14886]: wlan0: interface state DISABLED->DISABLED Sep 16 15:15:59 volumio-piter-room hostapd[14886]: wlan0: AP-DISABLED Sep 16 15:15:59 volumio-piter-room hostapd[14886]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:15:59 volumio-piter-room hostapd[14886]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:15:59 volumio-piter-room hostapd[14886]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:16:00 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:16:00 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:16:00 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:16:00 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:16:00 volumio-piter-room dnsmasq[14891]: started, version 2.90 cachesize 150 Sep 16 15:16:00 volumio-piter-room dnsmasq[14891]: 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:16:00 volumio-piter-room dnsmasq-dhcp[14891]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:16:00 volumio-piter-room dnsmasq[14891]: reading /etc/resolv.conf Sep 16 15:16:00 volumio-piter-room dnsmasq[14891]: using nameserver 192.168.2.1#53 Sep 16 15:16:00 volumio-piter-room dnsmasq[14891]: using nameserver 208.67.222.222#53 Sep 16 15:16:00 volumio-piter-room dnsmasq[14891]: using nameserver 208.67.220.220#53 Sep 16 15:16:00 volumio-piter-room dnsmasq[14891]: read /etc/hosts - 6 names Sep 16 15:16:00 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:16:00 volumio-piter-room volumio[14398]: info: Initializing connection to go-librespot Websocket Sep 16 15:16:01 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:16:01+02:00" level=debug msg="new websocket client" Sep 16 15:16:01 volumio-piter-room volumio[14398]: info: Connection to go-librespot Websocket established Sep 16 15:16:02 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 352. Sep 16 15:16:02 volumio-piter-room go-librespot[14824]: time="2025-09-16T15:16:02+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: UNKNOWN_ERROR" Sep 16 15:16:02 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:16:02 volumio-piter-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Sep 16 15:16:02 volumio-piter-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Sep 16 15:16:02 volumio-piter-room volumio[14398]: info: Connection to go-librespot Websocket closed Sep 16 15:16:02 volumio-piter-room dnsmasq[14891]: exiting on receipt of SIGTERM Sep 16 15:16:02 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:16:02 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:16:02 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:16:02 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:16:02 volumio-piter-room hostapd[14911]: rfkill: WLAN soft blocked Sep 16 15:16:02 volumio-piter-room hostapd[14911]: Failed to set beacon parameters Sep 16 15:16:02 volumio-piter-room hostapd[14911]: wlan0: Could not connect to kernel driver Sep 16 15:16:02 volumio-piter-room hostapd[14911]: Interface initialization failed Sep 16 15:16:02 volumio-piter-room hostapd[14911]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:16:02 volumio-piter-room hostapd[14911]: wlan0: AP-DISABLED Sep 16 15:16:02 volumio-piter-room hostapd[14911]: wlan0: Unable to setup interface. Sep 16 15:16:02 volumio-piter-room hostapd[14911]: wlan0: interface state DISABLED->DISABLED Sep 16 15:16:02 volumio-piter-room hostapd[14911]: wlan0: AP-DISABLED Sep 16 15:16:02 volumio-piter-room hostapd[14911]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:16:02 volumio-piter-room hostapd[14911]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:16:02 volumio-piter-room hostapd[14911]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:16:02 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:16:02 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:16:02 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:16:02 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:16:02 volumio-piter-room dnsmasq[14916]: started, version 2.90 cachesize 150 Sep 16 15:16:02 volumio-piter-room dnsmasq[14916]: 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:16:02 volumio-piter-room dnsmasq-dhcp[14916]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:16:02 volumio-piter-room dnsmasq[14916]: reading /etc/resolv.conf Sep 16 15:16:02 volumio-piter-room dnsmasq[14916]: using nameserver 192.168.2.1#53 Sep 16 15:16:02 volumio-piter-room dnsmasq[14916]: using nameserver 208.67.222.222#53 Sep 16 15:16:02 volumio-piter-room dnsmasq[14916]: using nameserver 208.67.220.220#53 Sep 16 15:16:02 volumio-piter-room dnsmasq[14916]: read /etc/hosts - 6 names Sep 16 15:16:02 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: Adding plugin bluetooth to MyMusic Plugins Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: Adding plugin multiroom to MyMusic Plugins Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: Adding plugin metavolumio to MyMusic Plugins Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: Adding plugin cd_controller to MyMusic Plugins Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 16 15:16:03 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: Starting MyVolumio Remote Streaming Endpoints Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: MyVolumio login type: Token Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 16 15:16:04 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 16 15:16:04 volumio-piter-room systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 353. Sep 16 15:16:04 volumio-piter-room systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:16:04 volumio-piter-room dnsmasq[14916]: exiting on receipt of SIGTERM Sep 16 15:16:04 volumio-piter-room systemd[1]: dnsmasq.service: Deactivated successfully. Sep 16 15:16:04 volumio-piter-room systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:16:04 volumio-piter-room systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:16:04 volumio-piter-room systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 16 15:16:04 volumio-piter-room hostapd[14920]: rfkill: WLAN soft blocked Sep 16 15:16:04 volumio-piter-room hostapd[14920]: Failed to set beacon parameters Sep 16 15:16:04 volumio-piter-room hostapd[14920]: wlan0: Could not connect to kernel driver Sep 16 15:16:04 volumio-piter-room hostapd[14920]: Interface initialization failed Sep 16 15:16:04 volumio-piter-room hostapd[14920]: wlan0: interface state UNINITIALIZED->DISABLED Sep 16 15:16:04 volumio-piter-room hostapd[14920]: wlan0: AP-DISABLED Sep 16 15:16:04 volumio-piter-room hostapd[14920]: wlan0: Unable to setup interface. Sep 16 15:16:04 volumio-piter-room hostapd[14920]: wlan0: interface state DISABLED->DISABLED Sep 16 15:16:04 volumio-piter-room hostapd[14920]: wlan0: AP-DISABLED Sep 16 15:16:04 volumio-piter-room hostapd[14920]: wlan0: CTRL-EVENT-TERMINATING Sep 16 15:16:04 volumio-piter-room hostapd[14920]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 16 15:16:04 volumio-piter-room hostapd[14920]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 16 15:16:04 volumio-piter-room systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Sep 16 15:16:04 volumio-piter-room systemd[1]: hostapd.service: Failed with result 'exit-code'. Sep 16 15:16:04 volumio-piter-room systemd[1]: Failed to start hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 16 15:16:04 volumio-piter-room systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 16 15:16:04 volumio-piter-room dnsmasq[14925]: started, version 2.90 cachesize 150 Sep 16 15:16:04 volumio-piter-room dnsmasq[14925]: 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:16:04 volumio-piter-room dnsmasq-dhcp[14925]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 16 15:16:04 volumio-piter-room dnsmasq[14925]: reading /etc/resolv.conf Sep 16 15:16:04 volumio-piter-room dnsmasq[14925]: using nameserver 192.168.2.1#53 Sep 16 15:16:04 volumio-piter-room dnsmasq[14925]: using nameserver 208.67.222.222#53 Sep 16 15:16:04 volumio-piter-room dnsmasq[14925]: using nameserver 208.67.220.220#53 Sep 16 15:16:04 volumio-piter-room dnsmasq[14925]: read /etc/hosts - 6 names Sep 16 15:16:04 volumio-piter-room systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 16 15:16:05 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 16 15:16:05 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 16 15:16:05 volumio-piter-room volumio[14398]: info: Streaming services startup Sep 16 15:16:05 volumio-piter-room volumio[14398]: info: Starting Streaming Daemon Sep 16 15:16:05 volumio-piter-room sudo[14930]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 15:16:05 volumio-piter-room sudo[14930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 16 15:16:05 volumio-piter-room volumio[14398]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 16 15:16:05 volumio-piter-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Sep 16 15:16:05 volumio-piter-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:16:05 volumio-piter-room volumio[14398]: info: Getting Spotify volume Sep 16 15:16:05 volumio-piter-room volumio[14398]: info: Initializing connection to go-librespot Websocket Sep 16 15:16:05 volumio-piter-room volumio[14398]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 15:16:05 volumio-piter-room volumio[14398]: Error: connect ECONNREFUSED 127.0.0.1:9879 Sep 16 15:16:05 volumio-piter-room volumio[14398]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Sep 16 15:16:05 volumio-piter-room volumio[14398]: errno: -111, Sep 16 15:16:05 volumio-piter-room volumio[14398]: code: 'ECONNREFUSED', Sep 16 15:16:05 volumio-piter-room volumio[14398]: syscall: 'connect', Sep 16 15:16:05 volumio-piter-room volumio[14398]: address: '127.0.0.1', Sep 16 15:16:05 volumio-piter-room volumio[14398]: port: 9879, Sep 16 15:16:05 volumio-piter-room volumio[14398]: response: undefined Sep 16 15:16:05 volumio-piter-room volumio[14398]: } Sep 16 15:16:05 volumio-piter-room volumio[14398]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 15:16:05 volumio-piter-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Sep 16 15:16:05 volumio-piter-room go-librespot[14936]: go-librespot daemon starting... Sep 16 15:16:05 volumio-piter-room sudo[14930]: pam_unix(sudo:session): session closed for user root Sep 16 15:16:05 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:05+02:00" level=info msg="running go-librespot 0.2.0" Sep 16 15:16:05 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:05+02:00" level=debug msg="app state loaded" Sep 16 15:16:05 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:05+02:00" level=info msg="api server listening on 127.0.0.1:9879" Sep 16 15:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+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:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+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:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+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:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+02:00" level=info msg="zeroconf server listening on port 46149" Sep 16 15:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+02:00" level=debug msg="obtained new client token: AAB2+3Cqt8zhBek5sKNVS9Dtjlog6RJgchpoCf4eXBgFa/ZK1jJ7Xpmi2sQqFzOGRvNz0xtMunH4Fp9h1fNHIhwylxbKxJfJREZGjRRlWrPv2Ard1bxUz551DMJ0oBCHMMG+aNUpN68sgt6IkOonfepaPEtzlxUSNWE/E4Zc7zFQPaWlCZr2k1f2H1IB8tVj6o5NFx2+MqHy75OXOwHgKz9I1rO90vnoOP8Z39YCs/PNZdJFE+r548Vwbg==" Sep 16 15:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Sep 16 15:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+02:00" level=debug msg="completed keyexchange" Sep 16 15:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+02:00" level=debug msg="completed challenge" Sep 16 15:16:06 volumio-piter-room go-librespot[14939]: time="2025-09-16T15:16:06+02:00" level=info msg="authenticated AP as ddmm0vyjz4epcocr86rainvro" Sep 16 15:16:06 volumio-piter-room sudo[14958]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-16 15:15' Sep 16 15:16:06 volumio-piter-room sudo[14958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 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"