-- Logs begin at Wed 2025-03-05 13:20:27 CET, end at Wed 2025-03-05 13:22:19 CET. -- Mar 05 13:21:00 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Mar 05 13:21:04 volumio volumio[1162]: Forking 3 albumart workers Mar 05 13:21:04 volumio dnsmasq[1213]: reading /etc/resolv.conf Mar 05 13:21:04 volumio dnsmasq[1213]: using nameserver 192.168.110.9#53 Mar 05 13:21:04 volumio dnsmasq[1213]: using nameserver 192.168.110.10#53 Mar 05 13:21:04 volumio dnsmasq[1213]: using nameserver 208.67.222.222#53 Mar 05 13:21:04 volumio dnsmasq[1213]: using nameserver 208.67.220.220#53 Mar 05 13:21:04 volumio dhcpcd[945]: eth0: leased 192.168.110.124 for 604800 seconds Mar 05 13:21:04 volumio volumio[1162]: Starting albumart workers Mar 05 13:21:04 volumio volumio[1162]: Starting albumart workers Mar 05 13:21:04 volumio volumio[1162]: Starting albumart workers Mar 05 13:21:05 volumio volumio-time-update[863]: volumio-time-update-util: Date not found in response Mar 05 13:21:05 volumio volumio-time-update[863]: volumio-time-update-util: Retrying in 5 seconds... Mar 05 13:21:10 volumio volumio-time-update[863]: volumio-time-update-util: Fetching time from Volumio... Mar 05 13:21:10 volumio volumio-time-update[863]: volumio-time-update-util: Setting system time to: 2025-03-05 12:21:10 Mar 05 13:21:12 volumio volumio-remote-updater[850]: [2025-03-05 12:21:12] [connect] Successful connection Mar 05 13:21:21 volumio sudo[1828]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-05 12:21:10 Mar 05 13:21:21 volumio sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:21:21 volumio dbus-daemon[866]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.11' (uid=0 pid=1856 comm="timedatectl set-time 2025-03-05 12:21:10 ") Mar 05 13:21:27 volumio dhcpcd[945]: eth0: adding route to 192.168.110.0/24 Mar 05 13:21:27 volumio dhcpcd[945]: eth0: changing default route via 192.168.110.254 Mar 05 13:21:27 volumio volumio-remote-updater[850]: [2025-03-05 12:21:27] [connect] Successful connection Mar 05 13:21:35 volumio ntpd[1047]: Soliciting pool server 149.210.142.45 Mar 05 13:21:36 volumio ntpd[1047]: Soliciting pool server 193.123.38.172 Mar 05 13:21:36 volumio ntpd[1047]: Soliciting pool server 64.142.54.12 Mar 05 13:21:37 volumio ntpd[1047]: Soliciting pool server 192.133.103.10 Mar 05 13:21:37 volumio ntpd[1047]: Soliciting pool server 185.51.192.63 Mar 05 13:21:38 volumio ntpd[1047]: Soliciting pool server 66.85.78.80 Mar 05 13:21:38 volumio ntpd[1047]: Soliciting pool server 94.198.159.15 Mar 05 13:21:38 volumio ntpd[1047]: Soliciting pool server 84.82.15.107 Mar 05 13:21:38 volumio systemd[1]: Starting Time & Date Service... Mar 05 13:21:38 volumio ntpd[1047]: ntpd exiting on signal 15 (Terminated) Mar 05 13:21:38 volumio ntpd[1047]: 149.210.142.45 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio ntpd[1047]: 193.123.38.172 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio ntpd[1047]: 64.142.54.12 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio ntpd[1047]: 185.51.192.63 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio ntpd[1047]: 192.133.103.10 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio ntpd[1047]: 94.198.159.15 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio ntpd[1047]: 66.85.78.80 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio ntpd[1047]: 84.82.15.107 local addr 192.168.110.124 -> Mar 05 13:21:38 volumio systemd[1]: Stopping Network Time Service... Mar 05 13:21:38 volumio systemd[1]: ntp.service: Succeeded. Mar 05 13:21:38 volumio systemd[1]: Stopped Network Time Service. Mar 05 13:21:38 volumio dbus-daemon[866]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 05 13:21:38 volumio systemd[1]: Starting Network Time Service... Mar 05 13:21:38 volumio systemd[1]: Started Time & Date Service. Mar 05 13:21:42 volumio volumio-remote-updater[850]: [2025-03-05 12:21:42] [connect] Successful connection Mar 05 13:21:44 volumio ntpd[1982]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 05 13:21:44 volumio ntpd[1982]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 05 13:21:44 volumio systemd[1]: Started Network Time Service. Mar 05 13:21:44 volumio ntpd[2005]: proto: precision = 0.082 usec (-23) Mar 05 13:21:44 volumio ntpd[2005]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 05 13:21:44 volumio ntpd[2005]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 05 13:21:44 volumio ntpd[2005]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 799 days ago Mar 05 13:21:44 volumio ntpd[2005]: Listen and drop on 0 v6wildcard [::]:123 Mar 05 13:21:44 volumio ntpd[2005]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 05 13:21:44 volumio ntpd[2005]: Listen normally on 2 lo 127.0.0.1:123 Mar 05 13:21:44 volumio ntpd[2005]: Listen normally on 3 eth0 169.254.9.225:123 Mar 05 13:21:44 volumio ntpd[2005]: Listen normally on 4 eth0 192.168.110.124:123 Mar 05 13:21:44 volumio ntpd[2005]: Listen normally on 5 wlan0 192.168.211.1:123 Mar 05 13:21:44 volumio ntpd[2005]: Listen normally on 6 wlan0 169.254.13.173:123 Mar 05 13:21:44 volumio ntpd[2005]: Listening on routing socket on fd #23 for interface updates Mar 05 13:21:44 volumio ntpd[2005]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 05 13:21:44 volumio ntpd[2005]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 05 13:21:10 volumio systemd-timedated[1970]: Changed local time to Wed Mar 5 12:21:10 2025 Mar 05 13:21:10 volumio sudo[1828]: pam_unix(sudo:session): session closed for user root Mar 05 13:21:10 volumio avahi-daemon[860]: Withdrawing address record for 169.254.9.225 on eth0. Mar 05 13:21:10 volumio volumio-time-update[863]: volumio-time-update-util: System time updated successfully. Mar 05 13:21:10 volumio dhcpcd[1674]: eth0: deleting route to 169.254.0.0/16 Mar 05 13:21:10 volumio avahi-daemon[860]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.9.225. Mar 05 13:21:10 volumio avahi-daemon[860]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.110.124. Mar 05 13:21:10 volumio systemd[1]: Started Volumio Time Update Utility. Mar 05 13:21:10 volumio ntpd[2005]: ntpd exiting on signal 15 (Terminated) Mar 05 13:21:10 volumio systemd[1]: Stopping Network Time Service... Mar 05 13:21:10 volumio systemd[1]: ntp.service: Succeeded. Mar 05 13:21:10 volumio systemd[1]: Stopped Network Time Service. Mar 05 13:21:10 volumio dhcpcd[1674]: eth0: deleted default route via 192.168.110.254 Mar 05 13:21:21 volumio systemd[1]: Starting Network Time Service... Mar 05 13:21:21 volumio ntpd[2043]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 05 13:21:21 volumio ntpd[2043]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 05 13:21:21 volumio systemd[1]: Started Network Time Service. Mar 05 13:21:21 volumio dhcpcd[945]: eth0: deleting route to 169.254.0.0/16 Mar 05 13:21:21 volumio ntpd[2049]: proto: precision = 0.110 usec (-23) Mar 05 13:21:21 volumio systemd[1]: Reached target Multi-User System. Mar 05 13:21:21 volumio systemd[1]: Reached target Graphical Interface. Mar 05 13:21:21 volumio ntpd[2049]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 05 13:21:21 volumio ntpd[2049]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 05 13:21:21 volumio ntpd[2049]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 799 days ago Mar 05 13:21:21 volumio ntpd[2049]: Listen and drop on 0 v6wildcard [::]:123 Mar 05 13:21:21 volumio ntpd[2049]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 05 13:21:21 volumio ntpd[2049]: Listen normally on 2 lo 127.0.0.1:123 Mar 05 13:21:21 volumio ntpd[2049]: Listen normally on 3 eth0 192.168.110.124:123 Mar 05 13:21:21 volumio ntpd[2049]: Listen normally on 4 wlan0 192.168.211.1:123 Mar 05 13:21:21 volumio ntpd[2049]: Listen normally on 5 wlan0 169.254.13.173:123 Mar 05 13:21:21 volumio ntpd[2049]: Listening on routing socket on fd #22 for interface updates Mar 05 13:21:21 volumio ntpd[2049]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 05 13:21:21 volumio ntpd[2049]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 05 13:21:21 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 05 13:21:21 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 05 13:21:21 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 05 13:21:21 volumio systemd[1]: Startup finished in 23min 17.987s (kernel) + 1min 39.909s (userspace) = 24min 57.897s. Mar 05 13:21:22 volumio ntpd[2049]: Soliciting pool server 193.123.38.172 Mar 05 13:21:23 volumio volumio-remote-updater[850]: [2025-03-05 12:21:23] [connect] Successful connection Mar 05 13:21:23 volumio ntpd[2049]: Soliciting pool server 185.51.192.63 Mar 05 13:21:23 volumio ntpd[2049]: Soliciting pool server 192.133.103.10 Mar 05 13:21:24 volumio ntpd[2049]: Soliciting pool server 66.85.78.80 Mar 05 13:21:24 volumio ntpd[2049]: Soliciting pool server 94.198.159.15 Mar 05 13:21:24 volumio ntpd[2049]: Soliciting pool server 185.51.192.62 Mar 05 13:21:25 volumio ntpd[2049]: Soliciting pool server 185.80.247.36 Mar 05 13:21:25 volumio ntpd[2049]: Soliciting pool server 143.42.229.154 Mar 05 13:21:25 volumio ntpd[2049]: Soliciting pool server 149.210.142.45 Mar 05 13:21:25 volumio ntpd[2049]: Soliciting pool server 45.137.101.154 Mar 05 13:21:26 volumio ntpd[2049]: Soliciting pool server 191.96.11.154 Mar 05 13:21:26 volumio ntpd[2049]: Soliciting pool server 141.138.201.22 Mar 05 13:21:26 volumio ntpd[2049]: Soliciting pool server 64.142.54.12 Mar 05 13:21:27 volumio systemd[1]: firststart.service: Succeeded. Mar 05 13:21:27 volumio dhcpcd[945]: eth0: deleted default route via 192.168.110.254 Mar 05 13:21:27 volumio dhcpcd[945]: eth0: adding default route via 192.168.110.254 Mar 05 13:21:27 volumio volumio[1162]: info: Plugin mpdemulation is not enabled Mar 05 13:21:27 volumio volumio[1162]: info: Loading plugin "rest_api"... Mar 05 13:21:27 volumio volumio[1162]: info: Loading plugin "websocket"... Mar 05 13:21:27 volumio volumio[1162]: info: Starting Socket.io Server version 2.3.0 Mar 05 13:21:27 volumio volumio[1162]: info: Loading i18n strings for locale en Mar 05 13:21:27 volumio volumio[1162]: Updating browse sources language Mar 05 13:21:27 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:21:27 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 13:21:27 volumio volumio[1162]: info: CoreCommandRouter::initPlayerControls Mar 05 13:21:27 volumio ntpd[2049]: Soliciting pool server 185.45.112.121 Mar 05 13:21:27 volumio ntpd[2049]: Soliciting pool server 5.200.6.34 Mar 05 13:21:28 volumio ntpd[2049]: Soliciting pool server 84.82.15.107 Mar 05 13:21:28 volumio ntpd[2049]: Soliciting pool server 2a03:4000:45:55:4491:94ff:fe64:6910 Mar 05 13:22:06 volumio ntpd[2049]: receive: Unexpected origin timestamp 0xeb72c04b.781a2ca2 does not match aorg 0000000000.00000000 from server@94.198.159.15 xmt 0xeb72c06e.2001b010 Mar 05 13:22:06 volumio ntpd[2049]: receive: Unexpected origin timestamp 0xeb72c04b.78163ba4 does not match aorg 0000000000.00000000 from server@84.82.15.107 xmt 0xeb72c06e.1ed37916 Mar 05 13:22:06 volumio ntpd[2049]: receive: Unexpected origin timestamp 0xeb72c04b.78190498 does not match aorg 0000000000.00000000 from server@143.42.229.154 xmt 0xeb72c06e.2823a3ca Mar 05 13:22:06 volumio ntpd[2049]: receive: Unexpected origin timestamp 0xeb72c04b.78196679 does not match aorg 0000000000.00000000 from server@66.85.78.80 xmt 0xeb72c06e.2ae6ae6d Mar 05 13:22:06 volumio ntpd[2049]: receive: Unexpected origin timestamp 0xeb72c04b.78182729 does not match aorg 0000000000.00000000 from server@64.142.54.12 xmt 0xeb72c06e.3491b622 Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: Express server listening on port 3000 Mar 05 13:22:07 volumio volumio[1162]: [Metrics] WebUI: 86s 881.44ms Mar 05 13:22:07 volumio volumio[1162]: info: Setting Device type: x86 Mar 05 13:22:07 volumio volumio[1162]: info: CoreStateMachine::resetVolumioState Mar 05 13:22:07 volumio volumio[1162]: info: CoreStateMachine::getcurrentVolume Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioRetrievevolume Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 05 13:22:07 volumio volumio[1162]: info: CoreStateMachine::getcurrentVolume Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioRetrievevolume Mar 05 13:22:07 volumio volumio[1162]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 05 13:22:07 volumio volumio[1162]: info: Completed loading Core Plugins Mar 05 13:22:07 volumio volumio[1162]: info: Preparing to generate the ALSA configuration file Mar 05 13:22:07 volumio sudo[2090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 05 13:22:07 volumio sudo[2088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 05 13:22:07 volumio sudo[2090]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:07 volumio sudo[2088]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:07 volumio sudo[2090]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:07 volumio sudo[2088]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:07 volumio volumio[1162]: info: Cannot read play queue from file Mar 05 13:22:07 volumio volumio[1162]: info: Volumio Network Manager: Network status updated: 0 Mar 05 13:22:07 volumio volumio[1162]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 05 13:22:07 volumio volumio[1162]: wlan0 Interface doesn't support scanning : Operation not supported Mar 05 13:22:07 volumio volumio[1162]: info: Cannot use regular scanning, forcing with ap-force Mar 05 13:22:07 volumio sudo[2096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 05 13:22:07 volumio sudo[2096]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:07 volumio sudo[2096]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:07 volumio volumio[1162]: command failed: Operation not supported (-95) Mar 05 13:22:07 volumio volumio[1162]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 05 13:22:07 volumio volumio[1162]: command failed: Operation not supported (-95) Mar 05 13:22:07 volumio volumio[1162]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Mar 05 13:22:07 volumio volumio[1162]: info: VolumeController:: Volume=41 Mute =false Mar 05 13:22:07 volumio volumio[1162]: info: CoreStateMachine::pushState Mar 05 13:22:07 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioPushState Mar 05 13:22:07 volumio volumio[1162]: info: CoreStateMachine::updateTrackBlock Mar 05 13:22:07 volumio volumio[1162]: info: CorePlayQueue::getTrackBlock Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioRetrievevolume Mar 05 13:22:07 volumio volumio[1162]: info: VolumeController:: Volume=41 Mute =false Mar 05 13:22:07 volumio volumio[1162]: info: CoreStateMachine::pushState Mar 05 13:22:07 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioPushState Mar 05 13:22:07 volumio volumio[1162]: info: CoreStateMachine::updateTrackBlock Mar 05 13:22:07 volumio volumio[1162]: info: CorePlayQueue::getTrackBlock Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioRetrievevolume Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 13:22:07 volumio volumio[1162]: info: Discovery: Getting this device information Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:07 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:07 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 13:22:07 volumio volumio[1162]: info: Asound.conf file written Mar 05 13:22:07 volumio sudo[2108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 05 13:22:07 volumio sudo[2108]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:07 volumio sudo[2108]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:07 volumio volumio[1162]: No state is present for card PCH Mar 05 13:22:07 volumio volumio[1162]: Found hardware: "HDA-Intel" "Realtek ALC233" "HDA:10ec0233,17aa30d2,00100003 HDA:80862809,80860101,00100000" "0x17aa" "0x30d2" Mar 05 13:22:07 volumio volumio[1162]: Hardware is initialized using a generic method Mar 05 13:22:07 volumio volumio[1162]: No state is present for card PCH Mar 05 13:22:07 volumio volumio[1162]: info: Output device has changed, restarting MPD Mar 05 13:22:08 volumio volumio[1162]: info: Output device has changed, restarting Shairport Sync Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:08 volumio sudo[2113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 13:22:08 volumio sudo[2113]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio sudo[2115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 13:22:08 volumio sudo[2115]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio systemd[1]: Stopping Music Player Daemon... Mar 05 13:22:08 volumio volumio[1162]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 05 13:22:08 volumio volumio[1162]: info: ___________ START PLUGINS ___________ Mar 05 13:22:08 volumio volumio[1162]: info: Setting Hotspot Unique name on first start: Volumio-35279 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::Reload Ui Mar 05 13:22:08 volumio volumio[1162]: info: ControllerMpd::onStart: Initializing MPD Mar 05 13:22:08 volumio volumio[1162]: info: Creating MPD Configuration file Mar 05 13:22:08 volumio sudo[2113]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 05 13:22:08 volumio volumio[1162]: info: [1741177328043] CoreMusicLibrary::Adding element Media Servers Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:08 volumio sudo[2122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 13:22:08 volumio sudo[2122]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio sudo[2122]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:08 volumio sudo[2124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 13:22:08 volumio sudo[2124]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio volumio[1162]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 05 13:22:08 volumio volumio[1162]: info: [1741177328088] CoreMusicLibrary::Adding element Last_100 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 05 13:22:08 volumio volumio[1162]: info: [1741177328089] CoreMusicLibrary::Adding element Webradio Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 05 13:22:08 volumio volumio[1162]: info: Initializing BBC Radios Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: Volumio Calling Home Mar 05 13:22:08 volumio systemd[1]: mpd.service: Succeeded. Mar 05 13:22:08 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 13:22:08 volumio systemd[1]: Starting Music Player Daemon... Mar 05 13:22:08 volumio sudo[2145]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 13:22:08 volumio sudo[2145]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio sudo[2145]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio volumio[1162]: info: MPD Permissions set Mar 05 13:22:08 volumio volumio[1162]: info: MPD Permissions set Mar 05 13:22:08 volumio volumio[1162]: info: VolumeController:: Volume=41 Mute =false Mar 05 13:22:08 volumio volumio[1162]: info: CoreStateMachine::pushState Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioPushState Mar 05 13:22:08 volumio volumio[1162]: info: VolumeController:: Volume=41 Mute =false Mar 05 13:22:08 volumio volumio[1162]: info: CoreStateMachine::pushState Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioPushState Mar 05 13:22:08 volumio volumio[1162]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Mar 05 13:22:08 volumio volumio[1162]: info: Volumio called home Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio sudo[2151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 05 13:22:08 volumio sudo[2151]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 05 13:22:08 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 05 13:22:08 volumio sudo[2151]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 13:22:08 volumio volumio[1162]: info: Discovery: adding a62131a9-d3a1-483c-943a-f9bfd6bd67ae Mar 05 13:22:08 volumio volumio[1162]: info: Discovery: Found device Volumio Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: Discovery: this is already registered, a62131a9-d3a1-483c-943a-f9bfd6bd67ae Mar 05 13:22:08 volumio volumio[1162]: info: Discovery: Found device Volumio Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: Upmpdcli Daemon Started Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: Starting Shairport Sync Mar 05 13:22:08 volumio volumio[1162]: info: Starting Shairport Sync Mar 05 13:22:08 volumio volumio[1162]: info: Starting Shairport Sync Mar 05 13:22:08 volumio sudo[2171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 05 13:22:08 volumio sudo[2171]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio sudo[2167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 05 13:22:08 volumio sudo[2169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 05 13:22:08 volumio sudo[2169]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio sudo[2167]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 05 13:22:08 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 05 13:22:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 05 13:22:08 volumio mpd[2149]: Mar 05 12:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 13:22:08 volumio volumio[1162]: info: Discovery: Getting this device information Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 13:22:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 05 13:22:08 volumio systemd[1]: Started Music Player Daemon. Mar 05 13:22:08 volumio sudo[2167]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio sudo[2124]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio sudo[2115]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio sudo[2169]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio sudo[2171]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:08 volumio volumio[1162]: verbose: New Socket.io Connection to 192.168.110.124:3000 from 192.168.110.81 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Mar 05 13:22:08 volumio volumio[1162]: info: Shairport-Sync Started Mar 05 13:22:08 volumio volumio[1162]: Error adding Membership: Error: addMembership EINVAL Mar 05 13:22:08 volumio volumio[1162]: info: Shairport-Sync Started Mar 05 13:22:08 volumio volumio[1162]: info: Shairport-Sync Started Mar 05 13:22:08 volumio volumio[1162]: info: Completed starting Core Plugins Mar 05 13:22:08 volumio volumio[1162]: info: ------------------------------------------- Mar 05 13:22:08 volumio volumio[1162]: info: ----- MyVolumio plugins startup ---- Mar 05 13:22:08 volumio volumio[1162]: info: ------------------------------------------- Mar 05 13:22:08 volumio volumio[1162]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 05 13:22:08 volumio volumio[2155]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:08 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 05 13:22:08 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 05 13:22:08 volumio volumio[1162]: info: MPD running with PID2149 Mar 05 13:22:08 volumio volumio[1162]: ,establishing connection Mar 05 13:22:08 volumio volumio[1162]: error: MPD error: The expression evaluated to a falsy value: Mar 05 13:22:08 volumio volumio[1162]: assert.ok(self.idling) Mar 05 13:22:08 volumio volumio[1162]: error: The expression evaluated to a falsy value: Mar 05 13:22:08 volumio volumio[1162]: assert.ok(self.idling) Mar 05 13:22:08 volumio volumio[1162]: error: MPD error: The expression evaluated to a falsy value: Mar 05 13:22:08 volumio volumio[1162]: assert.ok(self.idling) Mar 05 13:22:08 volumio volumio[1162]: error: The expression evaluated to a falsy value: Mar 05 13:22:08 volumio volumio[1162]: assert.ok(self.idling) Mar 05 13:22:08 volumio volumio[1162]: error: updateQueue error: null Mar 05 13:22:08 volumio volumio[2155]: ...............++++ Mar 05 13:22:09 volumio sudo[2202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Mar 05 13:22:09 volumio sudo[2202]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:09 volumio sudo[2202]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:09 volumio volumio[1162]: info: Permissions for /etc/hostapd/hostapd.conf Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Mar 05 13:22:09 volumio volumio[1162]: info: Discovery: Restarting Advertising due to device name change Mar 05 13:22:09 volumio sudo[2205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Mar 05 13:22:09 volumio sudo[2205]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:09 volumio systemd[1]: Starting Wireless Services... Mar 05 13:22:09 volumio wireless.js[2207]: Cleaning previous... Mar 05 13:22:09 volumio systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... Mar 05 13:22:09 volumio dnsmasq[1213]: exiting on receipt of SIGTERM Mar 05 13:22:09 volumio systemd[1]: dnsmasq.service: Succeeded. Mar 05 13:22:09 volumio systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. Mar 05 13:22:09 volumio systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Mar 05 13:22:09 volumio dhcpcd[945]: wlan0: carrier lost Mar 05 13:22:09 volumio dhcpcd[945]: wlan0: deleting route to 169.254.0.0/16 Mar 05 13:22:09 volumio avahi-daemon[860]: Withdrawing address record for 169.254.13.173 on wlan0. Mar 05 13:22:09 volumio avahi-daemon[860]: Interface wlan0.IPv4 no longer relevant for mDNS. Mar 05 13:22:09 volumio avahi-daemon[860]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 05 13:22:09 volumio avahi-daemon[860]: Withdrawing address record for 192.168.211.1 on wlan0. Mar 05 13:22:09 volumio avahi-daemon[860]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 05 13:22:09 volumio avahi-daemon[860]: New relevant interface wlan0.IPv4 for mDNS. Mar 05 13:22:09 volumio avahi-daemon[860]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Mar 05 13:22:09 volumio systemd[1]: hostapd.service: Succeeded. Mar 05 13:22:09 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Mar 05 13:22:09 volumio volumio[1162]: info: Discovery: A device disappeared from network Mar 05 13:22:09 volumio volumio[1162]: info: Discovery: Device volumio disappeared from network Mar 05 13:22:09 volumio sudo[2281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 05 13:22:09 volumio sudo[2281]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:09 volumio sudo[2279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 05 13:22:09 volumio sudo[2279]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:09 volumio sudo[2281]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:09 volumio sudo[2279]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:09 volumio sudo[2285]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 05 13:22:09 volumio sudo[2285]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:09 volumio volumio[1162]: verbose: New Socket.io Connection to 192.168.110.124 from 192.168.110.81 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3 Mar 05 13:22:09 volumio sudo[2285]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:09 volumio avahi-daemon[860]: Withdrawing address record for 192.168.211.1 on wlan0. Mar 05 13:22:09 volumio avahi-daemon[860]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 05 13:22:09 volumio avahi-daemon[860]: Interface wlan0.IPv4 no longer relevant for mDNS. Mar 05 13:22:09 volumio sudo[2287]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 05 13:22:09 volumio sudo[2287]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::volumioGetVisibleSources Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 05 13:22:09 volumio sudo[2287]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 05 13:22:09 volumio volumio[1162]: info: Received Get System Info Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 13:22:09 volumio volumio[1162]: info: Discovery: Getting this device information Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:09 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 05 13:22:09 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:09 volumio wireless.js[2207]: Stopped aP Mar 05 13:22:09 volumio sudo[2294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 05 13:22:09 volumio sudo[2294]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:09 volumio volumio[2155]: ...........................................................................................................................................................................................................................................................................++++ Mar 05 13:22:09 volumio volumio[2155]: e is 65537 (0x010001) Mar 05 13:22:09 volumio volumio[2155]: writing RSA key Mar 05 13:22:10 volumio sudo[2294]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:10 volumio sudo[2311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 05 13:22:10 volumio sudo[2311]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:10 volumio sudo[2311]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:10 volumio sudo[2323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 05 13:22:10 volumio sudo[2323]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:10 volumio sudo[2323]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:10 volumio sudo[2326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 05 13:22:10 volumio sudo[2326]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:10 volumio volumio[1162]: info: Discovery: A device disappeared from network Mar 05 13:22:10 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 05 13:22:10 volumio volumio[1162]: info: Loading i18n strings for locale de Mar 05 13:22:10 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 05 13:22:10 volumio volumio[1162]: info: Setting timezone to Europe/Berlin Mar 05 13:22:10 volumio sudo[2401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 05 13:22:10 volumio sudo[2401]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:10 volumio sudo[2401]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:10 volumio sudo[2404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Berlin /etc/localtime Mar 05 13:22:10 volumio sudo[2404]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:10 volumio sudo[2404]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:10 volumio sudo[2407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 05 13:22:10 volumio sudo[2407]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:10 volumio sudo[2407]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:10 volumio sudo[2410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin Mar 05 13:22:10 volumio sudo[2410]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:10 volumio systemd-timedated[1970]: Failed to set time zone: Permission denied Mar 05 13:22:10 volumio sudo[2410]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:10 volumio volumio[1162]: Failed to set time zone: Access denied Mar 05 13:22:10 volumio volumio[1162]: info: Could not set timezone, retrying Mar 05 13:22:10 volumio volumio[1162]: Updating browse sources language Mar 05 13:22:10 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:11 volumio ntpd[2049]: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=15 secs Mar 05 13:22:11 volumio ntpd[2049]: Deleting interface #5 wlan0, 169.254.13.173#123, interface stats: received=0, sent=0, dropped=0, active_time=15 secs Mar 05 13:22:11 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 05 13:22:12 volumio volumio-remote-updater[850]: [2025-03-05 12:22:12] [connect] Successful connection Mar 05 13:22:13 volumio sudo[2326]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:13 volumio wireless.js[2207]: SETTING APPROPRIATE REG DOMAIN: DE Mar 05 13:22:16 volumio volumio[1162]: info: Volumio Network Manager: Network status updated: 1 Mar 05 13:22:16 volumio sudo[2445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 05 13:22:16 volumio sudo[2445]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:16 volumio sudo[2445]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:16 volumio sudo[2447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Mar 05 13:22:16 volumio sudo[2447]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:16 volumio sudo[2447]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:16 volumio wireless.js[2207]: SUCCESSFULLY SET NEW REGDOMAIN: DE Mar 05 13:22:16 volumio sudo[2452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin Mar 05 13:22:16 volumio sudo[2452]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:16 volumio sudo[2452]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:16 volumio volumio[1162]: info: Discovery: Started advertising with name: Volumio Mar 05 13:22:16 volumio sudo[2458]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 05 13:22:16 volumio sudo[2458]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:16 volumio volumio[1162]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 05 13:22:16 volumio volumio-remote-updater[850]: [2025-03-05 12:22:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741177332 101 Mar 05 13:22:16 volumio sudo[2458]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:16 volumio volumio[1162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Mar 05 13:22:16 volumio sudo[2460]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 05 13:22:16 volumio sudo[2460]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:16 volumio sudo[2460]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:16 volumio volumio[1162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::volumioGetVisibleSources Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 05 13:22:17 volumio volumio[1162]: info: Received Get System Info Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 13:22:17 volumio volumio[1162]: info: Discovery: Getting this device information Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:17 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 13:22:17 volumio volumio-remote-updater[850]: No test mode Mar 05 13:22:17 volumio volumio-remote-updater[850]: No alpha test mode Mar 05 13:22:17 volumio avahi-daemon[860]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 05 13:22:17 volumio avahi-daemon[860]: New relevant interface wlan0.IPv4 for mDNS. Mar 05 13:22:17 volumio avahi-daemon[860]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Mar 05 13:22:17 volumio sudo[2467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 05 13:22:17 volumio sudo[2467]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:17 volumio sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 05 13:22:17 volumio sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:17 volumio volumio[1162]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 05 13:22:17 volumio sudo[2467]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:17 volumio sudo[2469]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:17 volumio volumio[1162]: verbose: New Socket.io Connection to 192.168.110.124 from 192.168.110.81 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Mar 05 13:22:17 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Mar 05 13:22:17 volumio hostapd[2477]: Configuration file: /etc/hostapd/hostapd.conf Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::volumioGetVisibleSources Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 05 13:22:17 volumio volumio[1162]: info: Received Get System Info Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 13:22:17 volumio volumio[1162]: info: Discovery: Getting this device information Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Mar 05 13:22:17 volumio volumio[1162]: info: CorePlayQueue::getTrack 0 Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 13:22:17 volumio volumio-remote-updater[850]: No test mode Mar 05 13:22:17 volumio volumio-remote-updater[850]: No alpha test mode Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 05 13:22:17 volumio volumio[1162]: info: Adding plugin bluetooth to MyMusic Plugins Mar 05 13:22:17 volumio volumio[1162]: info: Adding plugin multiroom to MyMusic Plugins Mar 05 13:22:17 volumio volumio[1162]: info: Adding plugin metavolumio to MyMusic Plugins Mar 05 13:22:17 volumio avahi-daemon[860]: Interface wlan0.IPv4 no longer relevant for mDNS. Mar 05 13:22:17 volumio volumio[1162]: info: Adding plugin cd_controller to MyMusic Plugins Mar 05 13:22:17 volumio avahi-daemon[860]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 05 13:22:17 volumio volumio[1162]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 05 13:22:17 volumio volumio[1162]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 05 13:22:17 volumio avahi-daemon[860]: Withdrawing address record for 192.168.211.1 on wlan0. Mar 05 13:22:17 volumio avahi-daemon[860]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 05 13:22:17 volumio avahi-daemon[860]: New relevant interface wlan0.IPv4 for mDNS. Mar 05 13:22:17 volumio avahi-daemon[860]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Mar 05 13:22:17 volumio hostapd[2477]: Using interface wlan0 with hwaddr f0:d5:bf:97:40:41 and ssid "Volumio-35279" Mar 05 13:22:17 volumio dhcpcd[945]: wlan0: carrier acquired Mar 05 13:22:17 volumio hostapd[2477]: wlan0: interface state UNINITIALIZED->ENABLED Mar 05 13:22:17 volumio hostapd[2477]: wlan0: AP-ENABLED Mar 05 13:22:17 volumio systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Mar 05 13:22:17 volumio dhcpcd[945]: wlan0: IAID bf:97:40:41 Mar 05 13:22:17 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Mar 05 13:22:17 volumio dnsmasq[2481]: dnsmasq: syntax check OK. Mar 05 13:22:17 volumio iwconfig[2483]: Error for wireless request "Set Power Management" (8B2C) : Mar 05 13:22:17 volumio iwconfig[2483]: SET failed on device wlan0 ; Invalid argument. Mar 05 13:22:17 volumio systemd[1]: wireless.service: Succeeded. Mar 05 13:22:17 volumio systemd[1]: Started Wireless Services. Mar 05 13:22:17 volumio sudo[2205]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:17 volumio dnsmasq[2489]: started, version 2.80 cachesize 150 Mar 05 13:22:17 volumio dnsmasq[2489]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Mar 05 13:22:17 volumio dnsmasq-dhcp[2489]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Mar 05 13:22:17 volumio dnsmasq[2489]: reading /etc/resolv.conf Mar 05 13:22:17 volumio dnsmasq[2489]: using nameserver 192.168.110.9#53 Mar 05 13:22:17 volumio dnsmasq[2489]: using nameserver 192.168.110.10#53 Mar 05 13:22:17 volumio dnsmasq[2489]: using nameserver 208.67.222.222#53 Mar 05 13:22:17 volumio dnsmasq[2489]: using nameserver 208.67.220.220#53 Mar 05 13:22:17 volumio dnsmasq[2489]: read /etc/hosts - 5 addresses Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 13:22:17 volumio volumio[1162]: info: Starting MyVolumio Remote Streaming Endpoints Mar 05 13:22:17 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Mar 05 13:22:17 volumio volumio[1162]: info: MyVolumio not started Mar 05 13:22:17 volumio volumio[1162]: info: Initializing device activation check Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 05 13:22:17 volumio dhcpcd[945]: wlan0: soliciting an IPv6 router Mar 05 13:22:17 volumio volumio[1162]: info: Starting Streaming Service Transparent Proxy Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 05 13:22:17 volumio volumio[1162]: info: Streaming services startup Mar 05 13:22:17 volumio volumio[1162]: info: Starting Streaming Daemon Mar 05 13:22:17 volumio sudo[2502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 05 13:22:17 volumio sudo[2502]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:17 volumio volumio[1162]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 05 13:22:17 volumio sudo[2502]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Retrieving Cloud Streaming UI Mar 05 13:22:17 volumio volumio[1162]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 05 13:22:17 volumio volumio[1162]: error: Cannot start Volumio Streaming Daemon Mar 05 13:22:17 volumio volumio[1162]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 05 13:22:17 volumio volumio[1162]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Retrieving Cloud Streaming UI Mar 05 13:22:17 volumio volumio[1162]: info: Getting Tidal Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Getting Qobuz Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: Asking plugin for UI Config Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Getting Spotify Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: Asking plugin for UI Config Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Saving Spotify Acccount Mar 05 13:22:17 volumio volumio[1162]: info: Got Tidal Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: Got it Mar 05 13:22:17 volumio volumio[1162]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 05 13:22:17 volumio volumio[1162]: info: Getting Tidal Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Getting Qobuz Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: Asking plugin for UI Config Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Getting Spotify Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: Asking plugin for UI Config Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: info: Saving Spotify Acccount Mar 05 13:22:17 volumio volumio[1162]: info: Got Tidal Cloud Configuration Mar 05 13:22:17 volumio volumio[1162]: info: Got it Mar 05 13:22:17 volumio volumio[1162]: info: Got it Mar 05 13:22:17 volumio volumio[1162]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 05 13:22:17 volumio volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 13:22:17 volumio volumio[1162]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 05 13:22:18 volumio volumio[1162]: STREAMING PROXY: Starting server on port 3245 Mar 05 13:22:18 volumio volumio[1162]: Node JS runtime: 14 Mar 05 13:22:18 volumio dhcpcd[945]: wlan0: soliciting a DHCP lease Mar 05 13:22:18 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 05 13:22:18 volumio volumio[1162]: info: Loading i18n strings for locale en Mar 05 13:22:18 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 05 13:22:18 volumio volumio[1162]: info: Setting timezone to UTC Mar 05 13:22:18 volumio sudo[2511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 05 13:22:18 volumio sudo[2511]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:18 volumio sudo[2511]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:18 volumio sudo[2514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime Mar 05 13:22:18 volumio sudo[2514]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:18 volumio sudo[2514]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:18 volumio sudo[2517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 05 13:22:18 volumio sudo[2517]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:18 volumio sudo[2517]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:18 volumio sudo[2520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Mar 05 13:22:18 volumio sudo[2520]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:18 volumio systemd-timedated[1970]: Failed to set time zone: Permission denied Mar 05 13:22:18 volumio sudo[2520]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:18 volumio volumio[1162]: Failed to set time zone: Access denied Mar 05 13:22:18 volumio volumio[1162]: info: Could not set timezone, retrying Mar 05 13:22:18 volumio volumio[1162]: Updating browse sources language Mar 05 13:22:18 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:18 volumio volumio[1162]: info: Fetching Streaming Services browse cache Mar 05 13:22:18 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 05 13:22:19 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 05 13:22:19 volumio volumio[1162]: info: Loading i18n strings for locale de Mar 05 13:22:19 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 05 13:22:19 volumio volumio[1162]: info: Setting timezone to Europe/Berlin Mar 05 13:22:19 volumio sudo[2534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 05 13:22:19 volumio sudo[2534]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:19 volumio sudo[2534]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:19 volumio sudo[2537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Berlin /etc/localtime Mar 05 13:22:19 volumio sudo[2537]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:19 volumio sudo[2537]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:19 volumio sudo[2540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 05 13:22:19 volumio sudo[2540]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:19 volumio sudo[2540]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:19 volumio sudo[2543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin Mar 05 13:22:19 volumio sudo[2543]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:19 volumio systemd-timedated[1970]: Failed to set time zone: Permission denied Mar 05 13:22:19 volumio sudo[2543]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:19 volumio volumio[1162]: Failed to set time zone: Access denied Mar 05 13:22:19 volumio volumio[1162]: info: Could not set timezone, retrying Mar 05 13:22:19 volumio volumio[1162]: Updating browse sources language Mar 05 13:22:19 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 13:22:19 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 05 13:22:19 volumio ntpd[2049]: Listen normally on 6 wlan0 192.168.211.1:123 Mar 05 13:22:19 volumio ntpd[2049]: new interface(s) found: waking up resolver Mar 05 13:22:19 volumio sudo[2546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Mar 05 13:22:19 volumio sudo[2546]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 13:22:19 volumio systemd-timedated[1970]: Failed to set time zone: Permission denied Mar 05 13:22:19 volumio sudo[2546]: pam_unix(sudo:session): session closed for user root Mar 05 13:22:19 volumio volumio[1162]: Failed to set time zone: Access denied Mar 05 13:22:19 volumio volumio[1162]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 13:22:19 volumio volumio[1162]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'UTC' Mar 05 13:22:19 volumio volumio[1162]: Failed to set time zone: Access denied Mar 05 13:22:19 volumio volumio[1162]: at checkExecSyncError (child_process.js:790:11) Mar 05 13:22:19 volumio volumio[1162]: at execSync (child_process.js:863:15) Mar 05 13:22:19 volumio volumio[1162]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) Mar 05 13:22:19 volumio volumio[1162]: at listOnTimeout (internal/timers.js:557:17) Mar 05 13:22:19 volumio volumio[1162]: at processTimers (internal/timers.js:500:7) { Mar 05 13:22:19 volumio volumio[1162]: status: 1, Mar 05 13:22:19 volumio volumio[1162]: signal: null, Mar 05 13:22:19 volumio volumio[1162]: output: [ null, '', 'Failed to set time zone: Access denied\n' ], Mar 05 13:22:19 volumio volumio[1162]: pid: 2545, Mar 05 13:22:19 volumio volumio[1162]: stdout: '', Mar 05 13:22:19 volumio volumio[1162]: stderr: 'Failed to set time zone: Access denied\n' Mar 05 13:22:19 volumio volumio[1162]: } Mar 05 13:22:19 volumio volumio[1162]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 13:22:19 volumio sudo[2557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-05 13:21 Mar 05 13:22:19 volumio sudo[2557]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"