-- Logs begin at Wed 2025-05-21 18:30:28 -03, end at Wed 2025-05-21 19:03:32 -03. -- May 21 19:02:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:02:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:02:07 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:02:07 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:02:07 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:02:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:02:12 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11:3000 from 192.168.3.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 May 21 19:02:12 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11:3000 from 192.168.3.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 May 21 19:02:14 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-DISCONNECTED bssid=40:dc:a5:b7:83:a0 reason=0 locally_generated=1 May 21 19:02:14 volumio-pc dhcpcd[1000]: wlan0: carrier lost May 21 19:02:14 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD May 21 19:02:14 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=BR May 21 19:02:14 volumio-pc avahi-daemon[867]: Withdrawing address record for 192.168.3.11 on wlan0. May 21 19:02:14 volumio-pc avahi-daemon[867]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.11. May 21 19:02:14 volumio-pc avahi-daemon[867]: Interface wlan0.IPv4 no longer relevant for mDNS. May 21 19:02:14 volumio-pc volumio[1189]: info: Discovery: A device disappeared from network May 21 19:02:14 volumio-pc volumio[1189]: info: Discovery: Device volumio-pc disappeared from network May 21 19:02:14 volumio-pc dhcpcd[1000]: wlan0: deleting route to 192.168.3.0/24 May 21 19:02:14 volumio-pc dhcpcd[1000]: wlan0: deleting default route via 192.168.3.1 May 21 19:02:14 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:02:14 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:02:16 volumio-pc wpa_supplicant[1103]: wlan0: Trying to associate with 40:dc:a5:b7:83:a0 (SSID='Guilherme' freq=2412 MHz) May 21 19:02:16 volumio-pc wpa_supplicant[1103]: wlan0: Associated with 40:dc:a5:b7:83:a0 May 21 19:02:16 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 21 19:02:16 volumio-pc wpa_supplicant[1103]: wlan0: WPA: Key negotiation completed with 40:dc:a5:b7:83:a0 [PTK=CCMP GTK=CCMP] May 21 19:02:16 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-CONNECTED - Connection to 40:dc:a5:b7:83:a0 completed [id=0 id_str=] May 21 19:02:16 volumio-pc dhcpcd[1000]: wlan0: carrier acquired May 21 19:02:16 volumio-pc dhcpcd[1000]: wlan0: IAID f1:4a:c7:98 May 21 19:02:16 volumio-pc dhcpcd[1000]: wlan0: soliciting an IPv6 router May 21 19:02:17 volumio-pc dhcpcd[1000]: wlan0: rebinding lease of 192.168.3.11 May 21 19:02:17 volumio-pc dhcpcd[1000]: wlan0: probing address 192.168.3.11/24 May 21 19:02:17 volumio-pc ntpd[23000]: Deleting interface #3 wlan0, 192.168.3.11#123, interface stats: received=90, sent=92, dropped=0, active_time=56 secs May 21 19:02:17 volumio-pc ntpd[23000]: 200.189.40.8 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 200.160.7.197 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 146.164.48.5 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 200.192.232.8 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 200.160.7.196 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 168.181.126.28 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 216.238.102.201 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 168.181.126.108 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 143.107.229.211 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 216.238.106.159 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 200.160.7.186 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 143.107.229.210 local addr 192.168.3.11 -> May 21 19:02:17 volumio-pc ntpd[23000]: 162.159.200.1 local addr 192.168.3.11 -> May 21 19:02:18 volumio-pc volumio[1189]: info: Volumio Network Manager: Network status updated: 0 May 21 19:02:21 volumio-pc go-librespot[20396]: time="2025-05-21T19:02:21-03:00" level=error msg="did not receive last pong from dealer, 60s passed" May 21 19:02:22 volumio-pc dhcpcd[1000]: wlan0: leased 192.168.3.11 for 86400 seconds May 21 19:02:22 volumio-pc dhcpcd[1000]: wlan0: adding route to 192.168.3.0/24 May 21 19:02:22 volumio-pc dhcpcd[1000]: wlan0: adding default route via 192.168.3.1 May 21 19:02:22 volumio-pc avahi-daemon[867]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.11. May 21 19:02:22 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:02:22 volumio-pc avahi-daemon[867]: New relevant interface wlan0.IPv4 for mDNS. May 21 19:02:22 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:02:22 volumio-pc avahi-daemon[867]: Registering new address record for 192.168.3.11 on wlan0.IPv4. May 21 19:02:22 volumio-pc ntpd[23000]: ntpd exiting on signal 15 (Terminated) May 21 19:02:22 volumio-pc systemd[1]: Stopping Network Time Service... May 21 19:02:22 volumio-pc systemd[1]: ntp.service: Succeeded. May 21 19:02:22 volumio-pc systemd[1]: Stopped Network Time Service. May 21 19:02:22 volumio-pc systemd[1]: Starting Network Time Service... May 21 19:02:22 volumio-pc ntpd[28469]: ntpd 4.2.8p12@1.3728-o (1): Starting May 21 19:02:22 volumio-pc ntpd[28469]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 21 19:02:22 volumio-pc systemd[1]: Started Network Time Service. May 21 19:02:22 volumio-pc ntpd[28476]: proto: precision = 0.250 usec (-22) May 21 19:02:22 volumio-pc ntpd[28476]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 21 19:02:22 volumio-pc ntpd[28476]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 21 19:02:22 volumio-pc ntpd[28476]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 876 days ago May 21 19:02:22 volumio-pc ntpd[28476]: Listen and drop on 0 v6wildcard [::]:123 May 21 19:02:22 volumio-pc ntpd[28476]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 21 19:02:22 volumio-pc ntpd[28476]: Listen normally on 2 lo 127.0.0.1:123 May 21 19:02:22 volumio-pc ntpd[28476]: Listen normally on 3 wlan0 192.168.3.11:123 May 21 19:02:22 volumio-pc ntpd[28476]: Listening on routing socket on fd #20 for interface updates May 21 19:02:22 volumio-pc ntpd[28476]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 21 19:02:22 volumio-pc ntpd[28476]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 21 19:02:23 volumio-pc volumio[1189]: info: Discovery: adding 0642b46d-774f-4542-a638-8e86d520f62f May 21 19:02:23 volumio-pc volumio[1189]: info: Discovery: Found device Volumio-pc May 21 19:02:23 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:02:23 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:02:23 volumio-pc ntpd[28476]: Soliciting pool server 216.238.102.201 May 21 19:02:24 volumio-pc ntpd[28476]: Soliciting pool server 146.164.48.66 May 21 19:02:24 volumio-pc ntpd[28476]: Soliciting pool server 200.160.7.186 May 21 19:02:25 volumio-pc ntpd[28476]: Soliciting pool server 143.107.229.211 May 21 19:02:25 volumio-pc ntpd[28476]: Soliciting pool server 143.107.229.210 May 21 19:02:25 volumio-pc ntpd[28476]: Soliciting pool server 168.181.126.108 May 21 19:02:26 volumio-pc ntpd[28476]: Soliciting pool server 200.192.232.8 May 21 19:02:26 volumio-pc ntpd[28476]: Soliciting pool server 200.160.7.196 May 21 19:02:27 volumio-pc ntpd[28476]: Soliciting pool server 146.164.48.5 May 21 19:02:27 volumio-pc ntpd[28476]: Soliciting pool server 200.160.7.197 May 21 19:02:28 volumio-pc ntpd[28476]: Soliciting pool server 200.189.40.8 May 21 19:02:28 volumio-pc ntpd[28476]: Soliciting pool server 168.181.126.28 May 21 19:02:28 volumio-pc volumio[1189]: info: Volumio Network Manager: Network status updated: 2 May 21 19:02:29 volumio-pc ntpd[28476]: Soliciting pool server 192.36.143.130 May 21 19:02:29 volumio-pc ntpd[28476]: Soliciting pool server 2001:12ff:0:7::197 May 21 19:02:31 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11 from 192.168.3.15 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetVisibleSources May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:02:31 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 21 19:02:31 volumio-pc volumio[1189]: info: Received Get System Info May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:02:31 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:02:31 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:02:31 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:02:31 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:02:32 volumio-pc volumio[1189]: info: Listing playlists May 21 19:02:32 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 21 19:02:32 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:02:32 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:02:32 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:02:32 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:02:32 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:02:32 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:02:32 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:02:32 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:02:32 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:02:33 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:02:33 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:02:33 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:02:33 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:02:33 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:02:33 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:02:44 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:02:44 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:02:44 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:02:44 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:02:44 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:02:44 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11:3000 from 192.168.3.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 May 21 19:02:45 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11:3000 from 192.168.3.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 May 21 19:02:50 volumio-pc go-librespot[20396]: time="2025-05-21T19:02:50-03:00" level=trace msg="received accesspoint ping" May 21 19:02:50 volumio-pc go-librespot[20396]: time="2025-05-21T19:02:50-03:00" level=trace msg="received accesspoint pong ack" May 21 19:02:51 volumio-pc go-librespot[20396]: time="2025-05-21T19:02:51-03:00" level=error msg="did not receive last pong from dealer, 90s passed" May 21 19:03:07 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11 from 192.168.3.15 UA: Mozilla/5.0 (Linux; Android 14; SM-A356E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetVisibleSources May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:03:07 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 21 19:03:07 volumio-pc volumio[1189]: info: Received Get System Info May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:03:07 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:03:07 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:03:07 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:03:07 volumio-pc volumio[1189]: info: Listing playlists May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:03:07 volumio-pc volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin May 21 19:03:07 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - teste1 May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:03:08 volumio-pc volumio[1189]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,teste1.json May 21 19:03:10 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:03:10 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:03:10 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:03:10 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:03:10 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:03:10 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:03:15 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:03:15 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:03:15 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:03:15 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:03:15 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:03:15 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:03:16 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-DISCONNECTED bssid=40:dc:a5:b7:83:a0 reason=0 locally_generated=1 May 21 19:03:16 volumio-pc dhcpcd[1000]: wlan0: carrier lost May 21 19:03:16 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD May 21 19:03:16 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=BR May 21 19:03:16 volumio-pc avahi-daemon[867]: Withdrawing address record for 192.168.3.11 on wlan0. May 21 19:03:16 volumio-pc avahi-daemon[867]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.11. May 21 19:03:16 volumio-pc avahi-daemon[867]: Interface wlan0.IPv4 no longer relevant for mDNS. May 21 19:03:16 volumio-pc volumio[1189]: info: Discovery: A device disappeared from network May 21 19:03:16 volumio-pc volumio[1189]: info: Discovery: Device volumio-pc disappeared from network May 21 19:03:16 volumio-pc dhcpcd[1000]: wlan0: deleting route to 192.168.3.0/24 May 21 19:03:16 volumio-pc dhcpcd[1000]: wlan0: deleting default route via 192.168.3.1 May 21 19:03:16 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:03:16 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:03:17 volumio-pc wpa_supplicant[1103]: wlan0: Trying to associate with 40:dc:a5:b7:83:a0 (SSID='Guilherme' freq=2412 MHz) May 21 19:03:18 volumio-pc wpa_supplicant[1103]: wlan0: Associated with 40:dc:a5:b7:83:a0 May 21 19:03:18 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 21 19:03:18 volumio-pc wpa_supplicant[1103]: wlan0: WPA: Key negotiation completed with 40:dc:a5:b7:83:a0 [PTK=CCMP GTK=CCMP] May 21 19:03:18 volumio-pc wpa_supplicant[1103]: wlan0: CTRL-EVENT-CONNECTED - Connection to 40:dc:a5:b7:83:a0 completed [id=0 id_str=] May 21 19:03:18 volumio-pc dhcpcd[1000]: wlan0: carrier acquired May 21 19:03:18 volumio-pc dhcpcd[1000]: wlan0: IAID f1:4a:c7:98 May 21 19:03:18 volumio-pc dhcpcd[1000]: wlan0: rebinding lease of 192.168.3.11 May 21 19:03:18 volumio-pc dhcpcd[1000]: wlan0: probing address 192.168.3.11/24 May 21 19:03:18 volumio-pc dhcpcd[1000]: wlan0: soliciting an IPv6 router May 21 19:03:19 volumio-pc volumio[1189]: info: Volumio Network Manager: Network status updated: 0 May 21 19:03:19 volumio-pc ntpd[28476]: Deleting interface #3 wlan0, 192.168.3.11#123, interface stats: received=91, sent=91, dropped=0, active_time=57 secs May 21 19:03:19 volumio-pc ntpd[28476]: 192.36.143.130 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 200.189.40.8 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 168.181.126.28 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 146.164.48.5 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 200.160.7.197 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 200.192.232.8 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 200.160.7.196 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 168.181.126.108 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 143.107.229.211 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 143.107.229.210 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 146.164.48.66 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 200.160.7.186 local addr 192.168.3.11 -> May 21 19:03:19 volumio-pc ntpd[28476]: 216.238.102.201 local addr 192.168.3.11 -> May 21 19:03:21 volumio-pc go-librespot[20396]: time="2025-05-21T19:03:21-03:00" level=error msg="did not receive last pong from dealer, 120s passed" May 21 19:03:22 volumio-pc dhcpcd[1000]: wlan0: leased 192.168.3.11 for 86400 seconds May 21 19:03:22 volumio-pc dhcpcd[1000]: wlan0: adding route to 192.168.3.0/24 May 21 19:03:22 volumio-pc dhcpcd[1000]: wlan0: adding default route via 192.168.3.1 May 21 19:03:22 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:03:22 volumio-pc dhcpcd[1000]: wlan0: dhcp_envoption 213: Operation not supported May 21 19:03:22 volumio-pc avahi-daemon[867]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.11. May 21 19:03:22 volumio-pc avahi-daemon[867]: New relevant interface wlan0.IPv4 for mDNS. May 21 19:03:22 volumio-pc avahi-daemon[867]: Registering new address record for 192.168.3.11 on wlan0.IPv4. May 21 19:03:22 volumio-pc ntpd[28476]: ntpd exiting on signal 15 (Terminated) May 21 19:03:22 volumio-pc systemd[1]: Stopping Network Time Service... May 21 19:03:22 volumio-pc systemd[1]: ntp.service: Succeeded. May 21 19:03:22 volumio-pc systemd[1]: Stopped Network Time Service. May 21 19:03:22 volumio-pc systemd[1]: Starting Network Time Service... May 21 19:03:22 volumio-pc ntpd[1825]: ntpd 4.2.8p12@1.3728-o (1): Starting May 21 19:03:22 volumio-pc ntpd[1825]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 21 19:03:22 volumio-pc systemd[1]: Started Network Time Service. May 21 19:03:22 volumio-pc ntpd[1838]: proto: precision = 0.237 usec (-22) May 21 19:03:22 volumio-pc ntpd[1838]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 21 19:03:22 volumio-pc ntpd[1838]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 21 19:03:22 volumio-pc ntpd[1838]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 876 days ago May 21 19:03:22 volumio-pc ntpd[1838]: Listen and drop on 0 v6wildcard [::]:123 May 21 19:03:22 volumio-pc ntpd[1838]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 21 19:03:22 volumio-pc ntpd[1838]: Listen normally on 2 lo 127.0.0.1:123 May 21 19:03:22 volumio-pc ntpd[1838]: Listen normally on 3 wlan0 192.168.3.11:123 May 21 19:03:22 volumio-pc ntpd[1838]: Listening on routing socket on fd #20 for interface updates May 21 19:03:22 volumio-pc ntpd[1838]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 21 19:03:22 volumio-pc ntpd[1838]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 21 19:03:23 volumio-pc volumio[1189]: info: Discovery: adding 0642b46d-774f-4542-a638-8e86d520f62f May 21 19:03:23 volumio-pc volumio[1189]: info: Discovery: Found device Volumio-pc May 21 19:03:23 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:03:23 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:03:23 volumio-pc ntpd[1838]: Soliciting pool server 216.238.102.201 May 21 19:03:24 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11:3000 from 192.168.3.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 May 21 19:03:24 volumio-pc volumio[1189]: verbose: New Socket.io Connection to 192.168.3.11:3000 from 192.168.3.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 May 21 19:03:24 volumio-pc ntpd[1838]: Soliciting pool server 146.164.48.66 May 21 19:03:24 volumio-pc ntpd[1838]: Soliciting pool server 200.160.7.186 May 21 19:03:25 volumio-pc ntpd[1838]: Soliciting pool server 143.107.229.211 May 21 19:03:25 volumio-pc ntpd[1838]: Soliciting pool server 143.107.229.210 May 21 19:03:25 volumio-pc ntpd[1838]: Soliciting pool server 168.181.126.108 May 21 19:03:26 volumio-pc ntpd[1838]: Soliciting pool server 200.192.232.8 May 21 19:03:26 volumio-pc ntpd[1838]: Soliciting pool server 119.8.229.131 May 21 19:03:27 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 21 19:03:27 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 21 19:03:27 volumio-pc volumio[1189]: info: Discovery: Getting this device information May 21 19:03:27 volumio-pc volumio[1189]: info: CoreCommandRouter::volumioGetState May 21 19:03:27 volumio-pc volumio[1189]: info: CorePlayQueue::getTrack 0 May 21 19:03:27 volumio-pc volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 21 19:03:27 volumio-pc ntpd[1838]: Soliciting pool server 146.164.48.5 May 21 19:03:27 volumio-pc ntpd[1838]: Soliciting pool server 200.160.7.197 May 21 19:03:28 volumio-pc ntpd[1838]: Soliciting pool server 216.238.112.29 May 21 19:03:28 volumio-pc ntpd[1838]: Soliciting pool server 168.181.126.28 May 21 19:03:29 volumio-pc volumio[1189]: info: Volumio Network Manager: Network status updated: 2 May 21 19:03:29 volumio-pc ntpd[1838]: Soliciting pool server 2001:12ff:0:7::197 May 21 19:03:31 volumio-pc volumio[1189]: [SpotifyConnect] Killing vollibrespot daemon May 21 19:03:31 volumio-pc volumio[1189]: [SpotifyConnect] Closing metadata listener May 21 19:03:31 volumio-pc volumio[1189]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 21 19:03:31 volumio-pc volumio[1189]: TypeError: Cannot read property 'close' of undefined May 21 19:03:31 volumio-pc volumio[1189]: at ControllerVolspotconnect.onStop (/data/plugins/music_service/volspotconnect2/index.js:342:17) May 21 19:03:31 volumio-pc volumio[1189]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) May 21 19:03:31 volumio-pc volumio[1189]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) May 21 19:03:31 volumio-pc volumio[1189]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) May 21 19:03:31 volumio-pc volumio[1189]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) May 21 19:03:31 volumio-pc volumio[1189]: at Socket.emit (events.js:400:28) May 21 19:03:31 volumio-pc volumio[1189]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 21 19:03:31 volumio-pc volumio[1189]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 21 19:03:31 volumio-pc volumio[1189]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 21 19:03:31 volumio-pc sudo[2686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect2.service May 21 19:03:31 volumio-pc sudo[2686]: pam_unix(sudo:session): session opened for user root by (uid=0) May 21 19:03:31 volumio-pc sudo[2686]: pam_unix(sudo:session): session closed for user root May 21 19:03:32 volumio-pc sudo[2698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-21 19:02 May 21 19:03:32 volumio-pc sudo[2698]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"