-- Logs begin at Tue 2024-09-17 16:09:38 CEST, end at Tue 2024-09-17 16:11:02 CEST. -- Sep 17 16:10:00 volumio ntpd[668]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Sep 17 16:10:00 volumio volumio-remote-updater[561]: [2024-09-17 16:10:00] [info] asio async_connect error: system:111 (Connection refused) Sep 17 16:10:00 volumio volumio-remote-updater[561]: [2024-09-17 16:10:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 17 16:10:00 volumio volumio-remote-updater[561]: [2024-09-17 16:10:00] [error] handle_connect error: Underlying Transport Error Sep 17 16:10:00 volumio bthelper[571]: Changing power off succeeded Sep 17 16:10:00 volumio bthelper[571]: [CHG] Controller DC:A6:32:99:6D:B6 Class: 0x0000041c Sep 17 16:10:00 volumio bthelper[571]: Changing power on succeeded Sep 17 16:10:00 volumio sudo[733]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:00 volumio wireless.js[540]: SETTING APPROPRIATE REG DOMAIN: SK Sep 17 16:10:00 volumio sudo[751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 17 16:10:00 volumio sudo[751]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:00 volumio sudo[751]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:00 volumio sudo[753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set SK Sep 17 16:10:00 volumio sudo[753]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:00 volumio sudo[753]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:00 volumio wireless.js[540]: SUCCESSFULLY SET NEW REGDOMAIN: SK Sep 17 16:10:00 volumio wireless.js[540]: Start wireless flow Sep 17 16:10:00 volumio wireless.js[540]: Stopped hotspot (if there).. Sep 17 16:10:00 volumio sudo[758]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 17 16:10:00 volumio sudo[758]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:00 volumio sudo[758]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:00 volumio sudo[760]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 17 16:10:00 volumio sudo[760]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:01 volumio sudo[760]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:01 volumio wireless.js[540]: DHCP IP Sep 17 16:10:01 volumio wireless.js[540]: Start ap Sep 17 16:10:01 volumio wpa_supplicant[762]: Successfully initialized wpa_supplicant Sep 17 16:10:01 volumio sudo[763]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Sep 17 16:10:01 volumio sudo[763]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:01 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 17 16:10:01 volumio dhcpcd[764]: dev: loaded udev Sep 17 16:10:01 volumio dhcpcd-run-hooks[773]: wlan0: starting wpa_supplicant Sep 17 16:10:01 volumio dhcpcd-run-hooks[778]: wlan0: failed to start wpa_supplicant Sep 17 16:10:01 volumio dhcpcd-run-hooks[779]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Sep 17 16:10:01 volumio dhcpcd[764]: wlan0: connected to Access Point `' Sep 17 16:10:01 volumio dhcpcd[764]: DUID 00:01:00:01:2d:69:1c:d0:dc:a6:32:99:6d:b4 Sep 17 16:10:01 volumio dhcpcd[764]: eth0: IAID 32:99:6d:b4 Sep 17 16:10:01 volumio dhcpcd[764]: eth0: adding address fe80::dea6:32ff:fe99:6db4 Sep 17 16:10:01 volumio dhcpcd[764]: ipv6_addaddr1: Permission denied Sep 17 16:10:01 volumio dhcpcd[764]: wlan0: waiting for carrier Sep 17 16:10:02 volumio dhcpcd[764]: eth0: soliciting an IPv6 router Sep 17 16:10:02 volumio wireless.js[540]: trying... Sep 17 16:10:02 volumio sudo[790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:02 volumio sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:02 volumio sudo[790]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:02 volumio dhcpcd[764]: eth0: rebinding lease of 192.168.1.182 Sep 17 16:10:03 volumio wireless.js[540]: trying... Sep 17 16:10:03 volumio sudo[793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:03 volumio sudo[793]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:03 volumio sudo[793]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:04 volumio wpa_supplicant[777]: wlan0: Trying to associate with SSID 'T-tQuamA' Sep 17 16:10:04 volumio sh[434]: eth0: probing address 192.168.1.182/24 Sep 17 16:10:04 volumio dhcpcd[478]: eth0: probing address 192.168.1.182/24 Sep 17 16:10:04 volumio wireless.js[540]: trying... Sep 17 16:10:04 volumio sudo[796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:04 volumio sudo[796]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:04 volumio sudo[796]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:05 volumio wireless.js[540]: trying... Sep 17 16:10:05 volumio sudo[799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:05 volumio sudo[799]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:05 volumio sudo[799]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:06 volumio wireless.js[540]: trying... Sep 17 16:10:06 volumio sudo[802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:06 volumio sudo[802]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:06 volumio sudo[802]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:06 volumio dhcpcd[764]: wlan0: carrier acquired Sep 17 16:10:06 volumio dhcpcd[764]: wlan0: connected to Access Point `T-tQuamA' Sep 17 16:10:06 volumio wpa_supplicant[777]: wlan0: Associated with 34:5d:9e:35:b6:2c Sep 17 16:10:06 volumio wpa_supplicant[777]: wlan0: CTRL-EVENT-CONNECTED - Connection to 34:5d:9e:35:b6:2c completed [id=0 id_str=] Sep 17 16:10:06 volumio wpa_supplicant[777]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Sep 17 16:10:06 volumio wpa_supplicant[777]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Sep 17 16:10:06 volumio dhcpcd[764]: wlan0: IAID 32:99:6d:b5 Sep 17 16:10:06 volumio dhcpcd[764]: wlan0: adding address fe80::dea6:32ff:fe99:6db5 Sep 17 16:10:06 volumio dhcpcd[764]: ipv6_addaddr1: Permission denied Sep 17 16:10:06 volumio dhcpcd[764]: wlan0: carrier lost Sep 17 16:10:06 volumio dhcpcd[764]: wlan0: carrier acquired Sep 17 16:10:06 volumio dhcpcd[764]: wlan0: IAID 32:99:6d:b5 Sep 17 16:10:06 volumio dhcpcd[764]: eth0: probing address 192.168.1.182/24 Sep 17 16:10:07 volumio dhcpcd[764]: wlan0: soliciting an IPv6 router Sep 17 16:10:07 volumio wireless.js[540]: trying... Sep 17 16:10:07 volumio sudo[817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:07 volumio sudo[817]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:07 volumio sudo[817]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:07 volumio volumio-remote-updater[561]: [2024-09-17 16:10:07] [info] asio async_connect error: system:111 (Connection refused) Sep 17 16:10:07 volumio volumio-remote-updater[561]: [2024-09-17 16:10:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 17 16:10:07 volumio volumio-remote-updater[561]: [2024-09-17 16:10:07] [error] handle_connect error: Underlying Transport Error Sep 17 16:10:07 volumio dhcpcd[764]: wlan0: soliciting a DHCP lease Sep 17 16:10:08 volumio wireless.js[540]: trying... Sep 17 16:10:08 volumio sudo[820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:08 volumio sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:08 volumio sudo[820]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:09 volumio wireless.js[540]: trying... Sep 17 16:10:09 volumio sudo[823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:09 volumio sudo[823]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:09 volumio sudo[823]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:09 volumio sh[434]: eth0: leased 192.168.1.182 for 86400 seconds Sep 17 16:10:09 volumio dhcpcd[478]: eth0: leased 192.168.1.182 for 86400 seconds Sep 17 16:10:09 volumio sh[434]: eth0: adding route to 192.168.1.0/24 Sep 17 16:10:09 volumio sh[434]: eth0: adding default route via 192.168.1.1 Sep 17 16:10:09 volumio dhcpcd[478]: eth0: adding route to 192.168.1.0/24 Sep 17 16:10:09 volumio avahi-daemon[543]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.182. Sep 17 16:10:09 volumio dhcpcd[478]: eth0: adding default route via 192.168.1.1 Sep 17 16:10:09 volumio avahi-daemon[543]: New relevant interface eth0.IPv4 for mDNS. Sep 17 16:10:09 volumio avahi-daemon[543]: Registering new address record for 192.168.1.182 on eth0.IPv4. Sep 17 16:10:09 volumio sh[434]: forked to background, child pid 846 Sep 17 16:10:09 volumio dhcpcd[478]: forked to background, child pid 846 Sep 17 16:10:09 volumio ifplugd(eth0)[683]: client: ifup: interface eth0 already configured Sep 17 16:10:09 volumio sh[434]: eth0=eth0 Sep 17 16:10:10 volumio ifplugd(eth0)[683]: Program executed successfully. Sep 17 16:10:10 volumio wireless.js[540]: trying... Sep 17 16:10:10 volumio sudo[873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:10 volumio sudo[873]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:10 volumio sudo[873]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:11 volumio ntpd[668]: Listen normally on 3 eth0 192.168.1.182:123 Sep 17 16:10:11 volumio ntpd[668]: new interface(s) found: waking up resolver Sep 17 16:10:11 volumio wireless.js[540]: trying... Sep 17 16:10:11 volumio sudo[876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:11 volumio sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:11 volumio sudo[876]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:12 volumio nmbd[648]: [2024/09/17 16:10:12.156788, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 16:10:12 volumio systemd[1]: Started Samba NMB Daemon. Sep 17 16:10:12 volumio nmbd[648]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 17 16:10:12 volumio systemd[1]: Starting Samba Winbind Daemon... Sep 17 16:10:12 volumio wireless.js[540]: trying... Sep 17 16:10:12 volumio sudo[881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:12 volumio sudo[881]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:12 volumio sudo[881]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:12 volumio dhcpcd[764]: eth0: leased 192.168.1.182 for 86400 seconds Sep 17 16:10:12 volumio dhcpcd[764]: eth0: adding route to 192.168.1.0/24 Sep 17 16:10:12 volumio dhcpcd[764]: eth0: adding default route via 192.168.1.1 Sep 17 16:10:12 volumio dhcpcd[764]: forked to background, child pid 904 Sep 17 16:10:12 volumio sudo[763]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:12 volumio dhcpcd[904]: wlan0: probing for an IPv4LL address Sep 17 16:10:13 volumio winbindd[878]: [2024/09/17 16:10:13.430120, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Sep 17 16:10:13 volumio winbindd[878]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 17 16:10:13 volumio wireless.js[540]: trying... Sep 17 16:10:13 volumio sudo[907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:13 volumio sudo[907]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:13 volumio sudo[907]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:13 volumio winbindd[878]: [2024/09/17 16:10:13.618344, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 16:10:13 volumio systemd[1]: Started Samba Winbind Daemon. Sep 17 16:10:13 volumio winbindd[878]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 17 16:10:13 volumio systemd[1]: Starting Samba SMB Daemon... Sep 17 16:10:13 volumio winbindd[878]: [2024/09/17 16:10:13.999303, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Sep 17 16:10:13 volumio winbindd[878]: res_names->count = 3, expected 4 Sep 17 16:10:14 volumio smbd[911]: [2024/09/17 16:10:14.021543, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 16:10:14 volumio smbd[911]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 17 16:10:14 volumio systemd[1]: Started Samba SMB Daemon. Sep 17 16:10:14 volumio wireless.js[540]: trying... Sep 17 16:10:14 volumio sudo[920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:14 volumio sudo[920]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:14 volumio sudo[920]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:15 volumio wireless.js[540]: trying... Sep 17 16:10:15 volumio sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:15 volumio sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:15 volumio sudo[923]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:16 volumio wireless.js[540]: trying... Sep 17 16:10:16 volumio sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:16 volumio sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:16 volumio sudo[926]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:17 volumio dhcpcd[904]: wlan0: using IPv4LL address 169.254.219.200 Sep 17 16:10:17 volumio avahi-daemon[543]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.219.200. Sep 17 16:10:17 volumio avahi-daemon[543]: New relevant interface wlan0.IPv4 for mDNS. Sep 17 16:10:17 volumio dhcpcd[904]: wlan0: adding route to 169.254.0.0/16 Sep 17 16:10:17 volumio avahi-daemon[543]: Registering new address record for 169.254.219.200 on wlan0.IPv4. Sep 17 16:10:17 volumio wireless.js[540]: trying... Sep 17 16:10:17 volumio sudo[939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 17 16:10:17 volumio sudo[939]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:17 volumio sudo[939]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:17 volumio wireless.js[540]: Connected to: ----T-tQuamA Sep 17 16:10:17 volumio wireless.js[540]: ---- Sep 17 16:10:17 volumio sudo[951]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 16:10:17 volumio sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:17 volumio sudo[951]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:17 volumio wireless.js[540]: ... joined AP, wlan0 IPv4 is 169.254.219.200, ipV6 is undefined Sep 17 16:10:17 volumio wireless.js[540]: It's done! AP Sep 17 16:10:17 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 17 16:10:17 volumio systemd[1]: Started Wireless Services. Sep 17 16:10:17 volumio systemd[1]: Started Volumio Backend Module. Sep 17 16:10:17 volumio systemd[1]: Started Volumio Cpu Tweaker. Sep 17 16:10:17 volumio systemd[1]: Reached target Multi-User System. Sep 17 16:10:17 volumio systemd[1]: Reached target Graphical Interface. Sep 17 16:10:17 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 17 16:10:17 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 17 16:10:17 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 17 16:10:17 volumio volumio-remote-updater[561]: [2024-09-17 16:10:17] [info] asio async_connect error: system:111 (Connection refused) Sep 17 16:10:17 volumio volumio-remote-updater[561]: [2024-09-17 16:10:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 17 16:10:17 volumio volumio-remote-updater[561]: [2024-09-17 16:10:17] [error] handle_connect error: Underlying Transport Error Sep 17 16:10:17 volumio systemd[1]: Startup finished in 11.887s (kernel) + 41.362s (userspace) = 53.250s. Sep 17 16:10:17 volumio volumio-cpu-tweak[957]: Setting RT Priority for mpd Sep 17 16:10:17 volumio volumio-cpu-tweak[957]: pid 35's current scheduling policy: SCHED_OTHER Sep 17 16:10:17 volumio volumio-cpu-tweak[957]: pid 35's current scheduling priority: 0 Sep 17 16:10:17 volumio volumio-cpu-tweak[957]: Setting MPD Affinity Sep 17 16:10:18 volumio volumio-cpu-tweak[957]: pid 3's current affinity mask: f Sep 17 16:10:18 volumio volumio-cpu-tweak[957]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Sep 17 16:10:18 volumio volumio-cpu-tweak[957]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Sep 17 16:10:18 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Sep 17 16:10:19 volumio ntpd[668]: Listen normally on 4 wlan0 169.254.219.200:123 Sep 17 16:10:19 volumio ntpd[668]: new interface(s) found: waking up resolver Sep 17 16:10:19 volumio dhcpcd[904]: wlan0: offered 192.168.1.143 from 192.168.1.1 Sep 17 16:10:19 volumio dhcpcd[904]: wlan0: probing address 192.168.1.143/24 Sep 17 16:10:23 volumio volumio[956]: info: ------------------------------------------- Sep 17 16:10:23 volumio volumio[956]: info: ----- Volumio3 ---- Sep 17 16:10:23 volumio volumio[956]: info: ------------------------------------------- Sep 17 16:10:23 volumio volumio[956]: info: ----- System startup ---- Sep 17 16:10:23 volumio volumio[956]: info: ------------------------------------------- Sep 17 16:10:24 volumio volumio[956]: info: MYVOLUMIO Environment detected Sep 17 16:10:24 volumio systemd[1]: systemd-fsckd.service: Succeeded. Sep 17 16:10:24 volumio dhcpcd[904]: wlan0: leased 192.168.1.143 for 86400 seconds Sep 17 16:10:24 volumio avahi-daemon[543]: Registering new address record for 192.168.1.143 on wlan0.IPv4. Sep 17 16:10:24 volumio dhcpcd[904]: wlan0: adding route to 192.168.1.0/24 Sep 17 16:10:24 volumio dhcpcd[904]: wlan0: adding default route via 192.168.1.1 Sep 17 16:10:25 volumio avahi-daemon[543]: Withdrawing address record for 169.254.219.200 on wlan0. Sep 17 16:10:25 volumio avahi-daemon[543]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.219.200. Sep 17 16:10:25 volumio avahi-daemon[543]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.143. Sep 17 16:10:25 volumio dhcpcd[904]: wlan0: deleting route to 169.254.0.0/16 Sep 17 16:10:25 volumio volumio[956]: info: Plugin folders cleanup Sep 17 16:10:25 volumio volumio[956]: info: Scanning into folder /volumio/app/plugins/ Sep 17 16:10:25 volumio volumio[956]: info: Scanning category audio_interface Sep 17 16:10:25 volumio volumio[956]: info: Scanning category miscellanea Sep 17 16:10:25 volumio volumio[956]: info: Scanning category music_service Sep 17 16:10:25 volumio volumio[956]: info: Scanning category plugins.json Sep 17 16:10:25 volumio volumio[956]: info: Scanning category system_controller Sep 17 16:10:25 volumio volumio[956]: info: Scanning category user_interface Sep 17 16:10:25 volumio volumio[956]: info: Scanning into folder /data/plugins/ Sep 17 16:10:25 volumio volumio[956]: info: Scanning category music_service Sep 17 16:10:25 volumio volumio[956]: info: Scanning category system_controller Sep 17 16:10:25 volumio volumio[956]: info: Scanning category user_interface Sep 17 16:10:25 volumio volumio[956]: info: Plugin folders cleanup completed Sep 17 16:10:25 volumio volumio[956]: info: ------------------------------------------- Sep 17 16:10:25 volumio volumio[956]: info: ----- Core plugins startup ---- Sep 17 16:10:25 volumio volumio[956]: info: ------------------------------------------- Sep 17 16:10:25 volumio volumio[956]: info: Loading plugins from folder /volumio/app/plugins/ Sep 17 16:10:25 volumio volumio[956]: info: Adding plugin upnp to MyMusic Plugins Sep 17 16:10:25 volumio volumio[956]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 17 16:10:25 volumio volumio[956]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 17 16:10:25 volumio volumio[956]: info: Loading plugins from folder /data/plugins/ Sep 17 16:10:25 volumio volumio[956]: info: Loading plugin "system"... Sep 17 16:10:25 volumio volumio[956]: info: Loading plugin "appearance"... Sep 17 16:10:26 volumio ntpd[668]: Listen normally on 5 wlan0 192.168.1.143:123 Sep 17 16:10:26 volumio ntpd[668]: Deleting interface #4 wlan0, 169.254.219.200#123, interface stats: received=0, sent=0, dropped=0, active_time=7 secs Sep 17 16:10:26 volumio ntpd[668]: new interface(s) found: waking up resolver Sep 17 16:10:26 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Sep 17 16:10:27 volumio volumio-remote-updater[561]: [2024-09-17 16:10:27] [connect] Successful connection Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "network"... Sep 17 16:10:28 volumio volumio[956]: info: Refreshing Cached IP Addresses Sep 17 16:10:28 volumio sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 16:10:28 volumio sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "services"... Sep 17 16:10:28 volumio sudo[1029]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:28 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 16:10:28 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "alsa_controller"... Sep 17 16:10:28 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:28 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 17 16:10:28 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:28 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "wizard"... Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "networkfs"... Sep 17 16:10:28 volumio volumio[956]: info: Starting Udev Watcher for removable devices Sep 17 16:10:28 volumio volumio[956]: info: Ignoring mount for partition: boot Sep 17 16:10:28 volumio volumio[956]: info: Ignoring mount for partition: volumio Sep 17 16:10:28 volumio volumio[956]: info: Ignoring mount for partition: volumio_data Sep 17 16:10:28 volumio volumio[956]: info: Mounting Device PATRIOT Sep 17 16:10:28 volumio sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/PATRIOT -o noatime Sep 17 16:10:28 volumio sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:28 volumio mount.exfat[1047]: volume was not unmounted cleanly Sep 17 16:10:28 volumio kernel: fuse: init (API version 7.37) Sep 17 16:10:28 volumio sudo[1045]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:28 volumio volumio[956]: WARN: volume was not unmounted cleanly. Sep 17 16:10:28 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "volumio_command_line_client"... Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "upnp"... Sep 17 16:10:28 volumio volumio[956]: info: [1726582228760] Starting Upmpd Daemon Sep 17 16:10:28 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "my_music"... Sep 17 16:10:28 volumio volumio[956]: info: Loading plugin "mpd"... Sep 17 16:10:28 volumio systemd[1]: Mounting FUSE Control File System... Sep 17 16:10:28 volumio systemd[1]: Mounted FUSE Control File System. Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "upnp_browser"... Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "alarm-clock"... Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "airplay_emulation"... Sep 17 16:10:29 volumio volumio[956]: info: Starting Shairport Sync Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "last_100"... Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "webradio"... Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "i2s_dacs"... Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "volumiodiscovery"... Sep 17 16:10:29 volumio volumio[956]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 17 16:10:29 volumio node[956]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 17 16:10:29 volumio volumio[956]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 16:10:29 volumio node[956]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 16:10:29 volumio volumio[956]: *** WARNING *** For more information see Sep 17 16:10:29 volumio node[956]: *** WARNING *** For more information see Sep 17 16:10:29 volumio volumio[956]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 17 16:10:29 volumio node[956]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 17 16:10:29 volumio volumio[956]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 16:10:29 volumio node[956]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 16:10:29 volumio volumio[956]: *** WARNING *** For more information see Sep 17 16:10:29 volumio node[956]: *** WARNING *** For more information see Sep 17 16:10:29 volumio volumio[956]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 17 16:10:29 volumio volumio[956]: info: Discovery: Started advertising with name: Volumio Sep 17 16:10:29 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 16:10:29 volumio volumio[956]: info: Loading plugin "spop"... Sep 17 16:10:30 volumio volumio[956]: info: Loading plugin "ytmusic"... Sep 17 16:10:31 volumio volumio[956]: info: Loading plugin "now_playing"... Sep 17 16:10:32 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:35 volumio volumio[956]: info: Loading plugin "peppy_screensaver"... Sep 17 16:10:36 volumio volumio[956]: info: Applying required configuration parameters for plugin peppy_screensaver Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "outputs"... Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "albumart"... Sep 17 16:10:36 volumio volumio[956]: info: Plugin example_plugin is not enabled Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "inputs"... Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "updater_comm"... Sep 17 16:10:36 volumio volumio[956]: info: Plugin mpdemulation is not enabled Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "rest_api"... Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "websocket"... Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "backup_restore"... Sep 17 16:10:36 volumio volumio[956]: Forking 3 albumart workers Sep 17 16:10:36 volumio volumio[956]: info: Applying required configuration parameters for plugin backup_restore Sep 17 16:10:36 volumio volumio[956]: info: Loading plugin "Systeminfo"... Sep 17 16:10:37 volumio volumio[956]: Starting albumart workers Sep 17 16:10:37 volumio volumio[956]: info: Loading plugin "touch_display"... Sep 17 16:10:37 volumio volumio[956]: Starting albumart workers Sep 17 16:10:37 volumio volumio[956]: Starting albumart workers Sep 17 16:10:37 volumio volumio[956]: info: Applying required configuration parameters for plugin touch_display Sep 17 16:10:37 volumio volumio[956]: info: Loading i18n strings for locale hu Sep 17 16:10:37 volumio volumio[956]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 17 16:10:37 volumio volumio[956]: Updating browse sources language Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::initPlayerControls Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 16:10:37 volumio volumio[956]: Express server listening on port 3000 Sep 17 16:10:37 volumio volumio[956]: [Metrics] WebUI: 15s 114.33ms Sep 17 16:10:37 volumio volumio[956]: info: CoreStateMachine::resetVolumioState Sep 17 16:10:37 volumio volumio[956]: info: CoreStateMachine::getcurrentVolume Sep 17 16:10:37 volumio volumio[956]: info: CoreCommandRouter::volumioRetrievevolume Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 16:10:38 volumio volumio[956]: info: Discovery: Getting this device information Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 16:10:38 volumio volumio[956]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Sep 17 16:10:38 volumio volumio[956]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 16:10:38 volumio volumio[956]: info: Executing start script for DAC IQaudIO DAC Plus Sep 17 16:10:38 volumio volumio[956]: info: Reloading queue from file Sep 17 16:10:38 volumio volumio[956]: info: VolumeController:: Volume=100 Mute =false Sep 17 16:10:38 volumio volumio[956]: info: CoreStateMachine::pushState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioPushState Sep 17 16:10:38 volumio volumio[956]: info: CoreStateMachine::updateTrackBlock Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrackBlock Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioRetrievevolume Sep 17 16:10:38 volumio volumio[956]: info: CoreStateMachine::setRepeat false single undefined Sep 17 16:10:38 volumio volumio[956]: info: CoreStateMachine::pushState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioPushState Sep 17 16:10:38 volumio volumio[956]: info: CoreStateMachine::setRandom false Sep 17 16:10:38 volumio volumio[956]: info: CoreStateMachine::pushState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioPushState Sep 17 16:10:38 volumio volumio[956]: info: Setting Device type: Raspberry PI Sep 17 16:10:38 volumio volumio[956]: info: DAC script executed Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 16:10:38 volumio volumio[956]: info: Discovery: Getting this device information Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 16:10:38 volumio volumio[956]: info: Discovery: Getting this device information Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 16:10:38 volumio volumio[956]: verbose: New Socket.io Connection to 192.168.1.182:3000 from 192.168.1.11 UA: Dart/3.4 (dart:io) Total Clients: 3 Sep 17 16:10:38 volumio volumio[956]: info: VolumeController:: Volume=100 Mute =false Sep 17 16:10:38 volumio volumio[956]: info: CoreStateMachine::pushState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioPushState Sep 17 16:10:38 volumio volumio[956]: info: Discovery: adding a1f4d132-8375-457f-a467-78188ce26a04 Sep 17 16:10:38 volumio volumio[956]: info: Discovery: Found device Volumio Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: Discovery: this is already registered, a1f4d132-8375-457f-a467-78188ce26a04 Sep 17 16:10:38 volumio volumio[956]: info: Discovery: Found device Volumio Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:38 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 17 16:10:38 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 17 16:10:38 volumio sudo[1126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 16:10:38 volumio sudo[1126]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:38 volumio sudo[1128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 16:10:38 volumio sudo[1126]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:38 volumio sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:38 volumio sudo[1128]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:38 volumio sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 17 16:10:38 volumio sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:38 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 17 16:10:38 volumio sudo[1132]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:38 volumio volumio[956]: info: Upmpdcli Daemon Started Sep 17 16:10:38 volumio volumio[956]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 17 16:10:42 volumio volumio-remote-updater[561]: [2024-09-17 16:10:42] [connect] Successful connection Sep 17 16:10:42 volumio volumio-remote-updater[561]: [2024-09-17 16:10:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1726582242 101 Sep 17 16:10:42 volumio volumio[956]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 4 Sep 17 16:10:42 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 16:10:42 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:42 volumio sudo[1136]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:42 volumio sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 16:10:42 volumio sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:42 volumio sudo[1139]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:42 volumio volumio[956]: verbose: New Socket.io Connection to 192.168.1.182 from 192.168.1.11 UA: Mozilla/5.0 (Linux; Android 13; M2103K19PG Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Total Clients: 5 Sep 17 16:10:42 volumio volumio[956]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 17 16:10:43 volumio sudo[1142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 16:10:43 volumio sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:43 volumio sudo[1142]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:43 volumio sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 16:10:43 volumio sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 16:10:43 volumio sudo[1144]: pam_unix(sudo:session): session closed for user root Sep 17 16:10:43 volumio volumio[956]: verbose: New Socket.io Connection to 192.168.1.182 from 192.168.1.11 UA: Mozilla/5.0 (Linux; Android 13; M2103K19PG Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Total Clients: 6 Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::volumioGetVisibleSources Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:43 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 17 16:10:43 volumio volumio[956]: info: Received Get System Info Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 16:10:43 volumio volumio[956]: info: Discovery: Getting this device information Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:43 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:43 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:43 volumio volumio[956]: info: Listing playlists Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 17 16:10:43 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 17 16:10:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 17 16:10:45 volumio volumio[956]: info: Received Get System Info Sep 17 16:10:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 16:10:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 16:10:45 volumio volumio[956]: info: Discovery: Getting this device information Sep 17 16:10:45 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:45 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 16:10:46 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Sep 17 16:10:46 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 17 16:10:46 volumio volumio[956]: info: Received Get System Info Sep 17 16:10:46 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 16:10:46 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 16:10:46 volumio volumio[956]: info: Discovery: Getting this device information Sep 17 16:10:46 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:46 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:46 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 16:10:47 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Sep 17 16:10:47 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 16:10:47 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 16:10:47 volumio volumio[956]: info: Discovery: Getting this device information Sep 17 16:10:47 volumio volumio[956]: info: CoreCommandRouter::volumioGetState Sep 17 16:10:47 volumio volumio[956]: info: CorePlayQueue::getTrack 0 Sep 17 16:10:47 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 16:10:48 volumio volumio[956]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 17 16:10:53 volumio volumio[956]: info: CoreCommandRouter::volumioGetQueue Sep 17 16:10:53 volumio volumio[956]: info: CoreStateMachine::getQueue Sep 17 16:10:53 volumio volumio[956]: info: CorePlayQueue::getQueue Sep 17 16:10:58 volumio volumio[956]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 17 16:11:01 volumio volumio[956]: info: Preload queue cleared Sep 17 16:11:01 volumio volumio[956]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 17 16:11:01 volumio volumio[956]: info: CoreStateMachine::ClearQueue Sep 17 16:11:01 volumio volumio[956]: info: CoreStateMachine::stop Sep 17 16:11:01 volumio volumio[956]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 16:11:01 volumio volumio[956]: info: CorePlayQueue::clearPlayQueue Sep 17 16:11:01 volumio volumio[956]: info: CorePlayQueue::saveQueue Sep 17 16:11:01 volumio volumio[956]: info: CoreCommandRouter::volumioPushQueue Sep 17 16:11:01 volumio volumio[956]: info: CoreStateMachine::addQueueItems Sep 17 16:11:01 volumio volumio[956]: info: CorePlayQueue::addQueueItems Sep 17 16:11:01 volumio volumio[956]: info: Preload queue cleared Sep 17 16:11:01 volumio volumio[956]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s298107&filter=s:popular Sep 17 16:11:01 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 17 16:11:01 volumio volumio[956]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 16:11:01 volumio volumio[956]: TypeError: Cannot read property 'tune_radio' of undefined Sep 17 16:11:01 volumio volumio[956]: at ControllerWebradio.explodeUri (/volumio/app/plugins/music_service/webradio/index.js:539:33) Sep 17 16:11:01 volumio volumio[956]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Sep 17 16:11:01 volumio volumio[956]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:179:33) Sep 17 16:11:01 volumio volumio[956]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Sep 17 16:11:01 volumio volumio[956]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Sep 17 16:11:01 volumio volumio[956]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Sep 17 16:11:01 volumio volumio[956]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) Sep 17 16:11:01 volumio volumio[956]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) Sep 17 16:11:01 volumio volumio[956]: at Socket.emit (events.js:315:20) Sep 17 16:11:01 volumio volumio[956]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Sep 17 16:11:01 volumio volumio[956]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Sep 17 16:11:01 volumio volumio[956]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 16:11:02 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-17 16:10 Sep 17 16:11:02 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"