-- Logs begin at Fri 2024-11-08 18:57:21 CET, end at Thu 2024-11-28 23:58:04 CET. -- Nov 28 23:57:00 volumio volumio[1271]: ........................................................................................................................++++ Nov 28 23:57:00 volumio volumio[1271]: e is 65537 (0x010001) Nov 28 23:57:00 volumio volumio[1271]: writing RSA key Nov 28 23:57:00 volumio volumio[995]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 28 23:57:01 volumio volumio[995]: info: BOOT COMPLETED Nov 28 23:57:05 volumio dhcpcd[898]: wlan0: carrier lost Nov 28 23:57:05 volumio kernel: rtlwifi: AP off, try to reconnect now Nov 28 23:57:05 volumio kernel: wlan0: Connection to AP 36:60:f9:af:35:ee lost Nov 28 23:57:05 volumio avahi-daemon[533]: Withdrawing address record for 169.254.231.212 on wlan0. Nov 28 23:57:05 volumio avahi-daemon[533]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.231.212. Nov 28 23:57:05 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-DISCONNECTED bssid=36:60:f9:af:35:ee reason=4 locally_generated=1 Nov 28 23:57:05 volumio avahi-daemon[533]: Interface wlan0.IPv4 no longer relevant for mDNS. Nov 28 23:57:05 volumio dhcpcd[898]: wlan0: deleting route to 169.254.0.0/16 Nov 28 23:57:05 volumio volumio[995]: info: Discovery: A device disappeared from network Nov 28 23:57:05 volumio volumio[995]: info: Discovery: Device volumio disappeared from network Nov 28 23:57:05 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:05 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 28 23:57:05 volumio wpa_supplicant[870]: FT: Invalid key management type (2) Nov 28 23:57:05 volumio wpa_supplicant[870]: wlan0: SME: Trying to authenticate with 36:60:f9:af:36:36 (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:05 volumio kernel: wlan0: authenticate with 36:60:f9:af:36:36 Nov 28 23:57:05 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Nov 28 23:57:05 volumio kernel: wlan0: send auth to 36:60:f9:af:36:36 (try 1/3) Nov 28 23:57:05 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Nov 28 23:57:05 volumio kernel: wlan0: send auth to 36:60:f9:af:36:36 (try 2/3) Nov 28 23:57:05 volumio sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Nov 28 23:57:05 volumio sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:05 volumio sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 23:57:05 volumio sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:05 volumio kernel: wlan0: send auth to 36:60:f9:af:36:36 (try 3/3) Nov 28 23:57:05 volumio sudo[1680]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:05 volumio sudo[1685]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:05 volumio sudo[1693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 23:57:05 volumio sudo[1693]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:05 volumio sudo[1693]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:05 volumio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 23:57:05 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:05 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:05 volumio kernel: wlan0: authentication with 36:60:f9:af:36:36 timed out Nov 28 23:57:05 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 28 23:57:05 volumio sudo[1706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 23:57:05 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 28 23:57:05 volumio sudo[1706]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:05 volumio sudo[1706]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:05 volumio sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 23:57:05 volumio sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:06 volumio sudo[1708]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:06 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 28 23:57:06 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:06 volumio ntpd[767]: Deleting interface #3 wlan0, 169.254.231.212#123, interface stats: received=0, sent=0, dropped=0, active_time=83 secs Nov 28 23:57:08 volumio wpa_supplicant[870]: FT: Invalid key management type (2) Nov 28 23:57:08 volumio wpa_supplicant[870]: wlan0: SME: Trying to authenticate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:08 volumio kernel: wlan0: authenticate with 36:60:f9:af:35:ee Nov 28 23:57:08 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Nov 28 23:57:08 volumio kernel: wlan0: send auth to 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:08 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:08 volumio wpa_supplicant[870]: wlan0: Trying to associate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:08 volumio kernel: wlan0: authenticated Nov 28 23:57:08 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:08 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 2/3) Nov 28 23:57:08 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:08 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 3/3) Nov 28 23:57:08 volumio kernel: wlan0: association with 36:60:f9:af:35:ee timed out Nov 28 23:57:11 volumio wpa_supplicant[870]: FT: Invalid key management type (2) Nov 28 23:57:11 volumio wpa_supplicant[870]: wlan0: SME: Trying to authenticate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:11 volumio kernel: wlan0: authenticate with 36:60:f9:af:35:ee Nov 28 23:57:11 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Nov 28 23:57:11 volumio kernel: wlan0: send auth to 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:11 volumio kernel: wlan0: send auth to 36:60:f9:af:35:ee (try 2/3) Nov 28 23:57:11 volumio wpa_supplicant[870]: wlan0: Trying to associate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:11 volumio kernel: wlan0: authenticated Nov 28 23:57:11 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:11 volumio kernel: wlan0: RX AssocResp from 36:60:f9:af:35:ee (capab=0x1c11 status=0 aid=29) Nov 28 23:57:11 volumio wpa_supplicant[870]: wlan0: Associated with 36:60:f9:af:35:ee Nov 28 23:57:11 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 28 23:57:11 volumio kernel: wlan0: associated Nov 28 23:57:11 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:11 volumio kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by 36:60:f9:af:35:ee Nov 28 23:57:12 volumio wpa_supplicant[870]: wlan0: WPA: Key negotiation completed with 36:60:f9:af:35:ee [PTK=CCMP GTK=CCMP] Nov 28 23:57:12 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-CONNECTED - Connection to 36:60:f9:af:35:ee completed [id=0 id_str=] Nov 28 23:57:12 volumio dhcpcd[898]: wlan0: carrier acquired Nov 28 23:57:12 volumio dhcpcd[898]: wlan0: IAID 02:2b:d1:49 Nov 28 23:57:13 volumio dhcpcd[898]: wlan0: soliciting an IPv6 router Nov 28 23:57:13 volumio dhcpcd[898]: wlan0: soliciting a DHCP lease Nov 28 23:57:18 volumio dhcpcd[898]: wlan0: probing for an IPv4LL address Nov 28 23:57:19 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 23:57:19 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 23:57:19 volumio volumio[995]: info: Discovery: Getting this device information Nov 28 23:57:19 volumio volumio[995]: info: CoreCommandRouter::volumioGetState Nov 28 23:57:19 volumio volumio[995]: info: CorePlayQueue::getTrack 0 Nov 28 23:57:19 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 23:57:23 volumio dhcpcd[898]: wlan0: using IPv4LL address 169.254.231.212 Nov 28 23:57:23 volumio dhcpcd[898]: wlan0: adding route to 169.254.0.0/16 Nov 28 23:57:23 volumio avahi-daemon[533]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.231.212. Nov 28 23:57:23 volumio avahi-daemon[533]: New relevant interface wlan0.IPv4 for mDNS. Nov 28 23:57:23 volumio avahi-daemon[533]: Registering new address record for 169.254.231.212 on wlan0.IPv4. Nov 28 23:57:23 volumio dhcpcd[898]: wlan0: carrier lost Nov 28 23:57:23 volumio kernel: rtlwifi: AP off, try to reconnect now Nov 28 23:57:23 volumio kernel: wlan0: Connection to AP 36:60:f9:af:35:ee lost Nov 28 23:57:24 volumio avahi-daemon[533]: Withdrawing address record for 169.254.231.212 on wlan0. Nov 28 23:57:24 volumio avahi-daemon[533]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.231.212. Nov 28 23:57:24 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-DISCONNECTED bssid=36:60:f9:af:35:ee reason=4 locally_generated=1 Nov 28 23:57:24 volumio dhcpcd[898]: wlan0: deleting route to 169.254.0.0/16 Nov 28 23:57:24 volumio avahi-daemon[533]: Interface wlan0.IPv4 no longer relevant for mDNS. Nov 28 23:57:24 volumio volumio[995]: info: Discovery: A device disappeared from network Nov 28 23:57:24 volumio volumio[995]: info: Discovery: adding fe922743-c521-494c-850e-1ec471714db6 Nov 28 23:57:24 volumio volumio[995]: info: Discovery: Found device Volumio Nov 28 23:57:24 volumio volumio[995]: info: CoreCommandRouter::volumioGetState Nov 28 23:57:24 volumio volumio[995]: info: CorePlayQueue::getTrack 0 Nov 28 23:57:25 volumio wpa_supplicant[870]: FT: Invalid key management type (2) Nov 28 23:57:25 volumio wpa_supplicant[870]: wlan0: SME: Trying to authenticate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:25 volumio kernel: wlan0: authenticate with 36:60:f9:af:35:ee Nov 28 23:57:25 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Nov 28 23:57:25 volumio wpa_supplicant[870]: wlan0: Trying to associate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:25 volumio kernel: wlan0: send auth to 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:25 volumio kernel: wlan0: authenticated Nov 28 23:57:25 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:25 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:25 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 2/3) Nov 28 23:57:25 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 3/3) Nov 28 23:57:25 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:25 volumio kernel: wlan0: association with 36:60:f9:af:35:ee timed out Nov 28 23:57:27 volumio wpa_supplicant[870]: FT: Invalid key management type (2) Nov 28 23:57:27 volumio wpa_supplicant[870]: wlan0: SME: Trying to authenticate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:27 volumio kernel: wlan0: authenticate with 36:60:f9:af:35:ee Nov 28 23:57:27 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Nov 28 23:57:27 volumio kernel: wlan0: send auth to 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:27 volumio wpa_supplicant[870]: wlan0: Trying to associate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:27 volumio kernel: wlan0: authenticated Nov 28 23:57:27 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:27 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 2/3) Nov 28 23:57:27 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:27 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 3/3) Nov 28 23:57:28 volumio kernel: wlan0: RX AssocResp from 36:60:f9:af:35:ee (capab=0x1c11 status=0 aid=29) Nov 28 23:57:28 volumio wpa_supplicant[870]: wlan0: Associated with 36:60:f9:af:35:ee Nov 28 23:57:28 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 28 23:57:28 volumio kernel: wlan0: associated Nov 28 23:57:28 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:28 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:33 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:33 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 28 23:57:33 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 28 23:57:33 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 28 23:57:33 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 28 23:57:34 volumio kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by 36:60:f9:af:35:ee Nov 28 23:57:34 volumio ntpd[767]: Soliciting pool server 83.98.155.30 Nov 28 23:57:34 volumio volumio[995]: info: Received Get System Version Nov 28 23:57:34 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 28 23:57:35 volumio ntpd[767]: Soliciting pool server 37.252.127.156 Nov 28 23:57:35 volumio ntpd[767]: Soliciting pool server 87.238.174.133 Nov 28 23:57:36 volumio ntpd[767]: Soliciting pool server 94.198.159.16 Nov 28 23:57:38 volumio wpa_supplicant[870]: wlan0: Authentication with 36:60:f9:af:35:ee timed out. Nov 28 23:57:38 volumio kernel: wlan0: deauthenticating from 36:60:f9:af:35:ee by local choice (Reason: 3=DEAUTH_LEAVING) Nov 28 23:57:38 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-DISCONNECTED bssid=36:60:f9:af:35:ee reason=3 locally_generated=1 Nov 28 23:57:38 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Ziggo5377966" auth_failures=1 duration=10 reason=CONN_FAILED Nov 28 23:57:39 volumio ntpd[767]: Soliciting pool server 213.109.127.82 Nov 28 23:57:39 volumio ntpd[767]: Soliciting pool server 185.51.192.62 Nov 28 23:57:40 volumio ntpd[767]: Soliciting pool server 5.79.108.34 Nov 28 23:57:41 volumio ntpd[767]: Soliciting pool server 94.198.159.15 Nov 28 23:57:41 volumio ntpd[767]: Soliciting pool server 5.255.124.190 Nov 28 23:57:41 volumio ntpd[767]: Soliciting pool server 162.159.200.123 Nov 28 23:57:42 volumio ntpd[767]: Soliciting pool server 45.138.55.61 Nov 28 23:57:42 volumio ntpd[767]: Soliciting pool server 195.123.221.21 Nov 28 23:57:43 volumio ntpd[767]: Soliciting pool server 178.239.19.62 Nov 28 23:57:45 volumio ntpd[767]: Soliciting pool server 209.250.249.159 Nov 28 23:57:48 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Nov 28 23:57:48 volumio volumio[995]: info: CoreCommandRouter::Reload Ui Nov 28 23:57:48 volumio ntpd[767]: receive: Unexpected origin timestamp 0xeaf373ea.ed67cd6a does not match aorg 0xeaf373ec.ed68cec7 from server@195.123.221.21 xmt 0xeaf373ec.eb72cd02 Nov 28 23:57:48 volumio ntpd[767]: receive: Unexpected origin timestamp 0xeaf373ea.ed74e29a does not match aorg 0xeaf373ec.ed71e1df from server@87.238.174.133 xmt 0xeaf373ec.ebf29202 Nov 28 23:57:49 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Ziggo5377966" Nov 28 23:57:49 volumio wpa_supplicant[870]: FT: Invalid key management type (2) Nov 28 23:57:49 volumio wpa_supplicant[870]: wlan0: SME: Trying to authenticate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:49 volumio kernel: wlan0: authenticate with 36:60:f9:af:35:ee Nov 28 23:57:49 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Nov 28 23:57:49 volumio kernel: wlan0: send auth to 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:49 volumio wpa_supplicant[870]: wlan0: Trying to associate with 36:60:f9:af:35:ee (SSID='Ziggo5377966' freq=2457 MHz) Nov 28 23:57:49 volumio kernel: wlan0: authenticated Nov 28 23:57:49 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 1/3) Nov 28 23:57:49 volumio sudo[1907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 23:57:49 volumio sudo[1907]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:49 volumio sudo[1907]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:49 volumio sudo[1909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 23:57:49 volumio sudo[1909]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:49 volumio sudo[1909]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:49 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 2/3) Nov 28 23:57:49 volumio volumio[995]: verbose: New Socket.io Connection to 192.168.178.129:3000 from 192.168.178.70 UA: Mozilla/5.0 (Linux; Android 15; Pixel 8 Build/AP3A.241105.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.39 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 28 23:57:50 volumio wpa_supplicant[870]: RRM: Ignoring radio measurement request: Not associated Nov 28 23:57:50 volumio kernel: wlan0: associate with 36:60:f9:af:35:ee (try 3/3) Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::volumioGetVisibleSources Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Nov 28 23:57:50 volumio wpa_supplicant[870]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Ziggo5377966" auth_failures=2 duration=23 reason=CONN_FAILED Nov 28 23:57:50 volumio kernel: wlan0: association with 36:60:f9:af:35:ee timed out Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Nov 28 23:57:50 volumio volumio[995]: info: Received Get System Info Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 23:57:50 volumio volumio[995]: info: Discovery: Getting this device information Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::volumioGetState Nov 28 23:57:50 volumio volumio[995]: info: CorePlayQueue::getTrack 0 Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 23:57:50 volumio volumio-remote-updater[553]: No test mode Nov 28 23:57:50 volumio volumio-remote-updater[553]: No alpha test mode Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 28 23:57:50 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 23:57:51 volumio volumio[995]: info: Discovery: Getting this device information Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::volumioGetState Nov 28 23:57:51 volumio volumio[995]: info: CorePlayQueue::getTrack 0 Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:51 volumio volumio[995]: info: Retrieving Cloud Streaming UI Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 23:57:51 volumio volumio[995]: info: Getting Tidal Cloud Configuration Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:51 volumio volumio[995]: info: Getting Qobuz Cloud Configuration Nov 28 23:57:51 volumio volumio[995]: info: Asking plugin for UI Config Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:51 volumio volumio[995]: info: Getting Spotify Cloud Configuration Nov 28 23:57:51 volumio volumio[995]: info: Asking plugin for UI Config Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:51 volumio volumio[995]: info: Saving Spotify Acccount Nov 28 23:57:51 volumio volumio[995]: info: Got Tidal Cloud Configuration Nov 28 23:57:51 volumio volumio[995]: info: Got it Nov 28 23:57:51 volumio volumio[995]: info: Got it Nov 28 23:57:51 volumio volumio[995]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:51 volumio volumio[995]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 28 23:57:51 volumio volumio[995]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 28 23:57:51 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 28 23:57:52 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 23:57:52 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 28 23:57:52 volumio volumio[995]: info: Loading i18n strings for locale nl Nov 28 23:57:52 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 28 23:57:52 volumio volumio[995]: info: Setting timezone to Europe/Amsterdam Nov 28 23:57:52 volumio sudo[1917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 28 23:57:52 volumio sudo[1917]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:52 volumio sudo[1917]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:52 volumio sudo[1920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Amsterdam /etc/localtime Nov 28 23:57:52 volumio sudo[1920]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:52 volumio sudo[1920]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:52 volumio sudo[1923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 28 23:57:52 volumio sudo[1923]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:52 volumio sudo[1923]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:52 volumio sudo[1926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Amsterdam Nov 28 23:57:52 volumio sudo[1926]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:52 volumio dbus-daemon[564]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.18' (uid=0 pid=1927 comm="/usr/bin/timedatectl set-timezone Europe/Amsterdam") Nov 28 23:57:53 volumio systemd[1]: Starting Time & Date Service... Nov 28 23:57:53 volumio dbus-daemon[564]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 28 23:57:53 volumio systemd[1]: Started Time & Date Service. Nov 28 23:57:53 volumio sudo[1926]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:53 volumio volumio[995]: info: Fetching Streaming Services browse cache Nov 28 23:57:53 volumio volumio[995]: Updating browse sources language Nov 28 23:57:53 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 23:57:56 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 28 23:57:56 volumio volumio[995]: info: Loading i18n strings for locale nl Nov 28 23:57:56 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 28 23:57:56 volumio volumio[995]: info: Setting timezone to Europe/Amsterdam Nov 28 23:57:56 volumio sudo[1947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 28 23:57:56 volumio sudo[1947]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:56 volumio sudo[1947]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:56 volumio sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Amsterdam /etc/localtime Nov 28 23:57:56 volumio sudo[1950]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:56 volumio sudo[1950]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:56 volumio sudo[1953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 28 23:57:56 volumio sudo[1953]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:56 volumio sudo[1953]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:56 volumio sudo[1956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Amsterdam Nov 28 23:57:56 volumio sudo[1956]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:56 volumio sudo[1956]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:56 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 28 23:57:56 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 28 23:57:56 volumio sudo[1959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 28 23:57:56 volumio sudo[1959]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:56 volumio sudo[1962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 23:57:56 volumio sudo[1962]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:56 volumio sudo[1962]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:56 volumio sudo[1964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 23:57:56 volumio volumio[995]: Updating browse sources language Nov 28 23:57:56 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 23:57:56 volumio sudo[1964]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:57:56 volumio volumio[995]: info: Fetching Streaming Services browse cache Nov 28 23:57:57 volumio sudo[1964]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:57 volumio volumio[995]: verbose: New Socket.io Connection to volumio.local from 192.168.178.10 UA: Mozilla/5.0 (iPad; CPU OS 9_3_5 like Mac OS X) AppleWebKit/601.1.46 (KHTML, like Gecko) Version/9.0 Mobile/13G36 Safari/601.1 Engine version: 3 Transport: polling Total Clients: 6 Nov 28 23:57:58 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Nov 28 23:57:58 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Nov 28 23:57:58 volumio sudo[1959]: pam_unix(sudo:session): session closed for user root Nov 28 23:57:58 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 28 23:57:58 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 23:57:58 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::volumioGetVisibleSources Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Nov 28 23:57:59 volumio volumio[995]: info: Received Get System Info Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 23:57:59 volumio volumio[995]: info: Discovery: Getting this device information Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::volumioGetState Nov 28 23:57:59 volumio volumio[995]: info: CorePlayQueue::getTrack 0 Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 23:57:59 volumio volumio-remote-updater[553]: No test mode Nov 28 23:57:59 volumio volumio-remote-updater[553]: No alpha test mode Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:59 volumio volumio[995]: info: Retrieving Cloud Streaming UI Nov 28 23:57:59 volumio volumio[995]: info: Getting Tidal Cloud Configuration Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:59 volumio volumio[995]: info: Getting Qobuz Cloud Configuration Nov 28 23:57:59 volumio volumio[995]: info: Asking plugin for UI Config Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:59 volumio volumio[995]: info: Getting Spotify Cloud Configuration Nov 28 23:57:59 volumio volumio[995]: info: Asking plugin for UI Config Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:59 volumio volumio[995]: info: Saving Spotify Acccount Nov 28 23:57:59 volumio volumio[995]: info: Got Tidal Cloud Configuration Nov 28 23:57:59 volumio volumio[995]: info: Got it Nov 28 23:57:59 volumio volumio[995]: info: Got it Nov 28 23:57:59 volumio volumio[995]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 23:57:59 volumio volumio[995]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 28 23:57:59 volumio volumio[995]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 28 23:57:59 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 28 23:58:00 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 28 23:58:00 volumio volumio[995]: info: Loading i18n strings for locale nl Nov 28 23:58:01 volumio volumio[995]: Updating browse sources language Nov 28 23:58:01 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 23:58:01 volumio volumio[995]: info: Fetching Streaming Services browse cache Nov 28 23:58:01 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 28 23:58:01 volumio volumio[995]: info: Setting timezone to null Nov 28 23:58:01 volumio sudo[1974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 28 23:58:01 volumio sudo[1974]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:58:01 volumio sudo[1974]: pam_unix(sudo:session): session closed for user root Nov 28 23:58:01 volumio sudo[1977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/null /etc/localtime Nov 28 23:58:01 volumio sudo[1977]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:58:01 volumio sudo[1977]: pam_unix(sudo:session): session closed for user root Nov 28 23:58:01 volumio sudo[1980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 28 23:58:01 volumio sudo[1980]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:58:01 volumio sudo[1980]: pam_unix(sudo:session): session closed for user root Nov 28 23:58:01 volumio volumio[995]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime' Nov 28 23:58:01 volumio volumio[995]: error: Could not set timezone: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/localtime Nov 28 23:58:01 volumio volumio[995]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime' Nov 28 23:58:01 volumio sudo[1983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone null Nov 28 23:58:01 volumio sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:58:02 volumio sudo[1983]: pam_unix(sudo:session): session closed for user root Nov 28 23:58:02 volumio volumio[995]: Failed to set time zone: Invalid time zone 'null' Nov 28 23:58:02 volumio volumio[995]: info: Could not set timezone, retrying Nov 28 23:58:02 volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 23:58:02 volumio nmbd[740]: [2024/11/28 22:58:02.887026, 0] ../source3/libsmb/nmblib.c:917(send_udp) Nov 28 23:58:02 volumio nmbd[740]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Nov 28 23:58:03 volumio sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone null Nov 28 23:58:03 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 23:58:03 volumio sudo[1987]: pam_unix(sudo:session): session closed for user root Nov 28 23:58:03 volumio volumio[995]: Failed to set time zone: Invalid time zone 'null' Nov 28 23:58:03 volumio volumio[995]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 23:58:03 volumio volumio[995]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'null' Nov 28 23:58:03 volumio volumio[995]: Failed to set time zone: Invalid time zone 'null' Nov 28 23:58:03 volumio volumio[995]: at checkExecSyncError (child_process.js:616:11) Nov 28 23:58:03 volumio volumio[995]: at execSync (child_process.js:652:15) Nov 28 23:58:03 volumio volumio[995]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) Nov 28 23:58:03 volumio volumio[995]: at listOnTimeout (internal/timers.js:554:17) Nov 28 23:58:03 volumio volumio[995]: at processTimers (internal/timers.js:497:7) { Nov 28 23:58:03 volumio volumio[995]: status: 1, Nov 28 23:58:03 volumio volumio[995]: signal: null, Nov 28 23:58:03 volumio volumio[995]: output: [ null, '', "Failed to set time zone: Invalid time zone 'null'\n" ], Nov 28 23:58:03 volumio volumio[995]: pid: 1986, Nov 28 23:58:03 volumio volumio[995]: stdout: '', Nov 28 23:58:03 volumio volumio[995]: stderr: "Failed to set time zone: Invalid time zone 'null'\n" Nov 28 23:58:03 volumio volumio[995]: } Nov 28 23:58:03 volumio volumio[995]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 23:58:04 volumio sudo[2001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 23:57 Nov 28 23:58:04 volumio sudo[2001]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"