-- Logs begin at Wed 2024-10-23 23:02:11 JST, end at Mon 2024-10-28 01:24:19 JST. -- Oct 28 01:23:00 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 28 01:23:00 volumio volumio[976]: info: Received Get System Info Oct 28 01:23:00 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 28 01:23:00 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 28 01:23:00 volumio volumio[976]: info: Discovery: Getting this device information Oct 28 01:23:00 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Oct 28 01:23:00 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 28 01:23:19 volumio dhcpcd[923]: wlan0: carrier lost Oct 28 01:23:19 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-DISCONNECTED bssid=28:87:ba:ea:c3:8a reason=0 locally_generated=1 Oct 28 01:23:19 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 28 01:23:19 volumio dhcpcd[923]: wlan0: deleting route to 192.168.0.0/24 Oct 28 01:23:19 volumio dhcpcd[923]: wlan0: deleting default route via 192.168.0.1 Oct 28 01:23:19 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=JP Oct 28 01:23:19 volumio avahi-daemon[684]: Withdrawing address record for 192.168.0.40 on wlan0. Oct 28 01:23:19 volumio avahi-daemon[684]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.40. Oct 28 01:23:19 volumio avahi-daemon[684]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 28 01:23:19 volumio volumio[976]: info: Discovery: A device disappeared from network Oct 28 01:23:19 volumio volumio[976]: info: Discovery: Device volumio disappeared from network Oct 28 01:23:20 volumio wpa_supplicant[913]: wlan0: Trying to associate with SSID 'IODATA-e0e2b4-2G_EXT' Oct 28 01:23:21 volumio wpa_supplicant[913]: wlan0: Associated with 28:87:ba:ea:c3:8a Oct 28 01:23:21 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-CONNECTED - Connection to 28:87:ba:ea:c3:8a completed [id=0 id_str=] Oct 28 01:23:21 volumio dhcpcd[923]: wlan0: carrier acquired Oct 28 01:23:21 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 28 01:23:21 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Oct 28 01:23:21 volumio dhcpcd[923]: wlan0: IAID eb:98:8f:08 Oct 28 01:23:22 volumio dhcpcd[923]: wlan0: soliciting an IPv6 router Oct 28 01:23:22 volumio dhcpcd[923]: wlan0: rebinding lease of 192.168.0.40 Oct 28 01:23:23 volumio ntpd[820]: Deleting interface #3 wlan0, 192.168.0.40#123, interface stats: received=2763, sent=2777, dropped=0, active_time=193535 secs Oct 28 01:23:23 volumio ntpd[820]: 167.179.119.205 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 45.77.20.103 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 133.243.238.243 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 160.16.113.133 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 133.130.121.141 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 172.105.204.105 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 202.182.111.234 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 133.243.238.163 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 163.44.97.196 local addr 192.168.0.40 -> Oct 28 01:23:23 volumio ntpd[820]: 172.105.240.243 local addr 192.168.0.40 -> Oct 28 01:23:26 volumio dhcpcd[923]: wlan0: probing address 192.168.0.40/24 Oct 28 01:23:30 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-DISCONNECTED bssid=28:87:ba:ea:c3:8a reason=0 locally_generated=1 Oct 28 01:23:30 volumio dhcpcd[923]: wlan0: carrier lost Oct 28 01:23:30 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 28 01:23:30 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=JP Oct 28 01:23:31 volumio wpa_supplicant[913]: wlan0: Trying to associate with SSID 'IODATA-e0e2b4-2G_EXT' Oct 28 01:23:32 volumio wpa_supplicant[913]: wlan0: Associated with 28:87:ba:ea:c3:8a Oct 28 01:23:32 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-CONNECTED - Connection to 28:87:ba:ea:c3:8a completed [id=0 id_str=] Oct 28 01:23:32 volumio dhcpcd[923]: wlan0: carrier acquired Oct 28 01:23:32 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 28 01:23:32 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Oct 28 01:23:32 volumio dhcpcd[923]: wlan0: IAID eb:98:8f:08 Oct 28 01:23:32 volumio dhcpcd[923]: wlan0: rebinding lease of 192.168.0.40 Oct 28 01:23:32 volumio dhcpcd[923]: wlan0: probing address 192.168.0.40/24 Oct 28 01:23:32 volumio dhcpcd[923]: wlan0: soliciting an IPv6 router Oct 28 01:23:37 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-DISCONNECTED bssid=28:87:ba:ea:c3:8a reason=0 locally_generated=1 Oct 28 01:23:37 volumio dhcpcd[923]: wlan0: carrier lost Oct 28 01:23:37 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 28 01:23:37 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=JP Oct 28 01:23:37 volumio wpa_supplicant[913]: wlan0: Trying to associate with SSID 'IODATA-e0e2b4-2G_EXT' Oct 28 01:23:38 volumio wpa_supplicant[913]: wlan0: Associated with 28:87:ba:ea:c3:8a Oct 28 01:23:38 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-CONNECTED - Connection to 28:87:ba:ea:c3:8a completed [id=0 id_str=] Oct 28 01:23:38 volumio dhcpcd[923]: wlan0: carrier acquired Oct 28 01:23:38 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 28 01:23:38 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Oct 28 01:23:38 volumio dhcpcd[923]: wlan0: IAID eb:98:8f:08 Oct 28 01:23:39 volumio dhcpcd[923]: wlan0: soliciting an IPv6 router Oct 28 01:23:39 volumio dhcpcd[923]: wlan0: rebinding lease of 192.168.0.40 Oct 28 01:23:39 volumio dhcpcd[923]: wlan0: probing address 192.168.0.40/24 Oct 28 01:23:45 volumio dhcpcd[923]: wlan0: leased 192.168.0.40 for 86400 seconds Oct 28 01:23:45 volumio avahi-daemon[684]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.40. Oct 28 01:23:45 volumio avahi-daemon[684]: New relevant interface wlan0.IPv4 for mDNS. Oct 28 01:23:45 volumio avahi-daemon[684]: Registering new address record for 192.168.0.40 on wlan0.IPv4. Oct 28 01:23:45 volumio dhcpcd[923]: wlan0: adding route to 192.168.0.0/24 Oct 28 01:23:45 volumio dhcpcd[923]: wlan0: adding default route via 192.168.0.1 Oct 28 01:23:45 volumio volumio[976]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.0.40); type is 'disconnect' Oct 28 01:23:45 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Oct 28 01:23:45 volumio volumio[976]: verbose: UNSET VOLATILE: Service: squeezelite_mc Oct 28 01:23:45 volumio volumio[976]: info: [squeezelite_mc] Pushing empty state... Oct 28 01:23:45 volumio volumio[976]: info: CoreCommandRouter::servicePushState Oct 28 01:23:45 volumio volumio[976]: info: CoreStateMachine::pushState Oct 28 01:23:45 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 28 01:23:45 volumio volumio[976]: info: CoreCommandRouter::servicePushState Oct 28 01:23:45 volumio volumio[976]: info: CoreStateMachine::pushState Oct 28 01:23:45 volumio volumio[976]: info: CoreCommandRouter::volumioPushState Oct 28 01:23:46 volumio volumio[976]: info: Discovery: adding f4989869-44f6-4ec0-aad9-38686d78dfaf Oct 28 01:23:46 volumio volumio[976]: info: Discovery: Found device Volumio Oct 28 01:23:46 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Oct 28 01:23:46 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 28 01:23:47 volumio ntpd[820]: Listen normally on 4 wlan0 192.168.0.40:123 Oct 28 01:23:47 volumio ntpd[820]: new interface(s) found: waking up resolver Oct 28 01:23:51 volumio volumio[976]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.0.40); type is 'connect' Oct 28 01:23:51 volumio volumio[976]: info: [squeezelite_mc] Getting players connected to volumio (192.168.0.40) Oct 28 01:23:52 volumio volumio[976]: info: [squeezelite_mc] Players connected to volumio (192.168.0.40): [{"id":"b8:27:eb:98:8f:08","uuid":null,"ip":"192.168.0.40","name":"volumio","server":{"ip":"192.168.0.40","name":"volumio","ver":"8.5.3","uuid":"01edf835-1ea0-47ce-9480-0dcdefa601e9","jsonPort":"9000","cliPort":"9090"}}] Oct 28 01:23:52 volumio volumio[976]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:98:8f:08","uuid":null,"ip":"192.168.0.40","name":"volumio","server":{"ip":"192.168.0.40","name":"volumio","ver":"8.5.3","uuid":"01edf835-1ea0-47ce-9480-0dcdefa601e9","jsonPort":"9000","cliPort":"9090"}} Oct 28 01:23:53 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Oct 28 01:23:53 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Oct 28 01:23:58 volumio ntpd[820]: Soliciting pool server 2401:c080:1000:48b4:5400:4ff:fe9d:d455 Oct 28 01:23:58 volumio ntpd[820]: Soliciting pool server 45.159.48.231 Oct 28 01:23:59 volumio ntpd[820]: Soliciting pool server 45.76.211.39 Oct 28 01:24:12 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-DISCONNECTED bssid=28:87:ba:ea:c3:8a reason=0 locally_generated=1 Oct 28 01:24:12 volumio dhcpcd[923]: wlan0: carrier lost Oct 28 01:24:12 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 28 01:24:12 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=JP Oct 28 01:24:12 volumio avahi-daemon[684]: Withdrawing address record for 192.168.0.40 on wlan0. Oct 28 01:24:12 volumio avahi-daemon[684]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.40. Oct 28 01:24:12 volumio avahi-daemon[684]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 28 01:24:12 volumio dhcpcd[923]: wlan0: deleting route to 192.168.0.0/24 Oct 28 01:24:12 volumio dhcpcd[923]: wlan0: deleting default route via 192.168.0.1 Oct 28 01:24:12 volumio volumio[976]: info: Discovery: A device disappeared from network Oct 28 01:24:12 volumio volumio[976]: info: Discovery: Device volumio disappeared from network Oct 28 01:24:13 volumio wpa_supplicant[913]: wlan0: Trying to associate with SSID 'IODATA-e0e2b4-2G_EXT' Oct 28 01:24:14 volumio ntpd[820]: Deleting interface #4 wlan0, 192.168.0.40#123, interface stats: received=66, sent=68, dropped=0, active_time=27 secs Oct 28 01:24:14 volumio ntpd[820]: 45.159.48.231 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 172.105.240.243 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 163.44.97.196 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 133.243.238.163 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 202.182.111.234 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 172.105.204.105 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 133.130.121.141 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 160.16.113.133 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 133.243.238.243 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 45.77.20.103 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio ntpd[820]: 167.179.119.205 local addr 192.168.0.40 -> Oct 28 01:24:14 volumio wpa_supplicant[913]: wlan0: Associated with 28:87:ba:ea:c3:8a Oct 28 01:24:14 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-CONNECTED - Connection to 28:87:ba:ea:c3:8a completed [id=0 id_str=] Oct 28 01:24:14 volumio dhcpcd[923]: wlan0: carrier acquired Oct 28 01:24:14 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 28 01:24:14 volumio wpa_supplicant[913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Oct 28 01:24:14 volumio dhcpcd[923]: wlan0: IAID eb:98:8f:08 Oct 28 01:24:14 volumio dhcpcd[923]: wlan0: rebinding lease of 192.168.0.40 Oct 28 01:24:14 volumio dhcpcd[923]: wlan0: probing address 192.168.0.40/24 Oct 28 01:24:15 volumio dhcpcd[923]: wlan0: soliciting an IPv6 router Oct 28 01:24:16 volumio volumio[976]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 01:24:16 volumio volumio[976]: Error: send ENETUNREACH 255.255.255.255:3483 Oct 28 01:24:16 volumio volumio[976]: at doSend (dgram.js:692:16) Oct 28 01:24:16 volumio volumio[976]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Oct 28 01:24:16 volumio volumio[976]: at afterDns (dgram.js:638:5) Oct 28 01:24:16 volumio volumio[976]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Oct 28 01:24:16 volumio volumio[976]: errno: -101, Oct 28 01:24:16 volumio volumio[976]: code: 'ENETUNREACH', Oct 28 01:24:16 volumio volumio[976]: syscall: 'send', Oct 28 01:24:16 volumio volumio[976]: address: '255.255.255.255', Oct 28 01:24:16 volumio volumio[976]: port: 3483 Oct 28 01:24:16 volumio volumio[976]: } Oct 28 01:24:16 volumio volumio[976]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 01:24:19 volumio sudo[21850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-28 01:23 Oct 28 01:24:19 volumio sudo[21850]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"