-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2024-04-21 17:48:36 CST. --
Apr 21 17:47:03 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 21 17:47:03 volumio volumio[5546]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Apr 21 17:47:03 volumio volumio[5546]: info: CoreCommandRouter::volumioGetState
Apr 21 17:47:03 volumio volumio[5546]: info: CorePlayQueue::getTrack 0
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 21 17:47:08 volumio volumio[5546]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Apr 21 17:47:08 volumio volumio[5546]: info: Completed starting MyVolumio Plugin
Apr 21 17:47:08 volumio volumio[5546]: info: BOOT COMPLETED
Apr 21 17:47:08 volumio volumio[5546]: [Metrics] CommandRouter: 64s 57.25ms
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::Close All Modals sent
Apr 21 17:47:08 volumio volumio[5546]: info: CoreCommandRouter::Close All Modals sent
Apr 21 17:47:09 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 21 17:47:09 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 21 17:47:10 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 21 17:47:14 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=24:f5:a2:92:78:00 reason=3 locally_generated=1
Apr 21 17:47:14 volumio dhcpcd[782]: wlan0: carrier lost
Apr 21 17:47:14 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Apr 21 17:47:14 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=CN
Apr 21 17:47:14 volumio avahi-daemon[535]: Withdrawing address record for 192.168.10.125 on wlan0.
Apr 21 17:47:14 volumio avahi-daemon[535]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.10.125.
Apr 21 17:47:14 volumio dhcpcd[782]: wlan0: deleting route to 192.168.10.0/24
Apr 21 17:47:14 volumio avahi-daemon[535]: Interface wlan0.IPv4 no longer relevant for mDNS.
Apr 21 17:47:14 volumio dhcpcd[782]: wlan0: deleting default route via 192.168.10.1
Apr 21 17:47:14 volumio volumio[5546]: info: Discovery: A device disappeared from network
Apr 21 17:47:14 volumio volumio[5546]: info: Discovery: Device volumio disappeared from network
Apr 21 17:47:14 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1
Apr 21 17:47:14 volumio kernel: xhci_hcd 0000:01:00.0: @000000042a1123d0 00000000 00000000 0e000000 02028000
Apr 21 17:47:15 volumio wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Linksys_RF_5GHz'
Apr 21 17:47:15 volumio ntpd[675]: Soliciting pool server 119.28.206.193
Apr 21 17:47:16 volumio wpa_supplicant[770]: wlan0: Associated with 24:f5:a2:92:78:00
Apr 21 17:47:16 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 24:f5:a2:92:78:00 completed [id=0 id_str=]
Apr 21 17:47:16 volumio dhcpcd[782]: wlan0: carrier acquired
Apr 21 17:47:16 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 21 17:47:16 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=SG
Apr 21 17:47:16 volumio dhcpcd[782]: wlan0: IAID dd:ab:28:1b
Apr 21 17:47:16 volumio dhcpcd[782]: wlan0: soliciting an IPv6 router
Apr 21 17:47:16 volumio dhcpcd[782]: wlan0: rebinding lease of 192.168.10.125
Apr 21 17:47:16 volumio dhcpcd[782]: wlan0: probing address 192.168.10.125/24
Apr 21 17:47:17 volumio ntpd[675]: Deleting interface #37 wlan0, 192.168.10.125#123, interface stats: received=23, sent=26, dropped=0, active_time=60 secs
Apr 21 17:47:17 volumio ntpd[675]: 108.59.2.24 local addr 192.168.10.125 ->
Apr 21 17:47:17 volumio ntpd[675]: 84.16.67.12 local addr 192.168.10.125 ->
Apr 21 17:47:17 volumio ntpd[675]: 116.203.151.74 local addr 192.168.10.125 ->
Apr 21 17:47:17 volumio ntpd[675]: 193.182.111.14 local addr 192.168.10.125 ->
Apr 21 17:47:17 volumio ntpd[675]: 202.112.31.197 local addr 192.168.10.125 ->
Apr 21 17:47:17 volumio ntpd[675]: 193.182.111.141 local addr 192.168.10.125 ->
Apr 21 17:47:17 volumio ntpd[675]: 162.159.200.123 local addr 192.168.10.125 ->
Apr 21 17:47:17 volumio ntpd[675]: 193.182.111.12 local addr 192.168.10.125 ->
Apr 21 17:47:21 volumio dhcpcd[782]: wlan0: leased 192.168.10.125 for 86400 seconds
Apr 21 17:47:21 volumio avahi-daemon[535]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.10.125.
Apr 21 17:47:21 volumio avahi-daemon[535]: New relevant interface wlan0.IPv4 for mDNS.
Apr 21 17:47:21 volumio dhcpcd[782]: wlan0: adding route to 192.168.10.0/24
Apr 21 17:47:21 volumio avahi-daemon[535]: Registering new address record for 192.168.10.125 on wlan0.IPv4.
Apr 21 17:47:21 volumio dhcpcd[782]: wlan0: adding default route via 192.168.10.1
Apr 21 17:47:21 volumio volumio[5546]: info: Discovery: adding e0a2f6c6-b93c-44e8-b890-ef975e6d055a
Apr 21 17:47:21 volumio volumio[5546]: info: Discovery: Found device Volumio
Apr 21 17:47:21 volumio volumio[5546]: info: CoreCommandRouter::volumioGetState
Apr 21 17:47:21 volumio volumio[5546]: info: CorePlayQueue::getTrack 0
Apr 21 17:47:22 volumio ntpd[675]: Listen normally on 38 wlan0 192.168.10.125:123
Apr 21 17:47:22 volumio ntpd[675]: new interface(s) found: waking up resolver
Apr 21 17:47:27 volumio ntpd[675]: Soliciting pool server 119.28.183.184
Apr 21 17:47:29 volumio ntpd[675]: Soliciting pool server 78.46.102.180
Apr 21 17:47:34 volumio ntpd[675]: Soliciting pool server 2606:4700:f1::123
Apr 21 17:47:53 volumio volumio-remote-updater[559]: No test mode
Apr 21 17:47:53 volumio volumio-remote-updater[559]: No alpha test mode
Apr 21 17:47:53 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 21 17:47:55 volumio volumio[5546]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Apr 21 17:47:55 volumio volumio[5546]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 21 17:47:58 volumio ntpd[675]: Soliciting pool server 119.28.206.193
Apr 21 17:48:20 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=24:f5:a2:92:78:00 reason=3 locally_generated=1
Apr 21 17:48:20 volumio dhcpcd[782]: wlan0: carrier lost
Apr 21 17:48:20 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Apr 21 17:48:20 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=CN
Apr 21 17:48:20 volumio avahi-daemon[535]: Withdrawing address record for 192.168.10.125 on wlan0.
Apr 21 17:48:20 volumio avahi-daemon[535]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.10.125.
Apr 21 17:48:20 volumio avahi-daemon[535]: Interface wlan0.IPv4 no longer relevant for mDNS.
Apr 21 17:48:20 volumio volumio[5546]: info: Discovery: A device disappeared from network
Apr 21 17:48:20 volumio volumio[5546]: info: Discovery: Device volumio disappeared from network
Apr 21 17:48:20 volumio dhcpcd[782]: wlan0: deleting route to 192.168.10.0/24
Apr 21 17:48:20 volumio dhcpcd[782]: wlan0: deleting default route via 192.168.10.1
Apr 21 17:48:21 volumio wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Linksys_RF_5GHz'
Apr 21 17:48:22 volumio wpa_supplicant[770]: wlan0: Associated with 24:f5:a2:92:78:00
Apr 21 17:48:22 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 24:f5:a2:92:78:00 completed [id=0 id_str=]
Apr 21 17:48:22 volumio dhcpcd[782]: wlan0: carrier acquired
Apr 21 17:48:22 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 21 17:48:22 volumio wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=SG
Apr 21 17:48:22 volumio dhcpcd[782]: wlan0: IAID dd:ab:28:1b
Apr 21 17:48:22 volumio ntpd[675]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 21 17:48:23 volumio dhcpcd[782]: wlan0: rebinding lease of 192.168.10.125
Apr 21 17:48:23 volumio dhcpcd[782]: wlan0: probing address 192.168.10.125/24
Apr 21 17:48:23 volumio dhcpcd[782]: wlan0: soliciting an IPv6 router
Apr 21 17:48:23 volumio ntpd[675]: Deleting interface #38 wlan0, 192.168.10.125#123, interface stats: received=27, sent=32, dropped=0, active_time=61 secs
Apr 21 17:48:23 volumio ntpd[675]: 119.28.206.193 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 78.46.102.180 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 119.28.183.184 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 116.203.151.74 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 193.182.111.14 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 202.112.31.197 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 193.182.111.141 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 162.159.200.123 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 193.182.111.12 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 84.16.67.12 local addr 192.168.10.125 ->
Apr 21 17:48:23 volumio ntpd[675]: 108.59.2.24 local addr 192.168.10.125 ->
Apr 21 17:48:28 volumio dhcpcd[782]: wlan0: leased 192.168.10.125 for 86400 seconds
Apr 21 17:48:28 volumio avahi-daemon[535]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.10.125.
Apr 21 17:48:28 volumio avahi-daemon[535]: New relevant interface wlan0.IPv4 for mDNS.
Apr 21 17:48:28 volumio dhcpcd[782]: wlan0: adding route to 192.168.10.0/24
Apr 21 17:48:28 volumio avahi-daemon[535]: Registering new address record for 192.168.10.125 on wlan0.IPv4.
Apr 21 17:48:28 volumio dhcpcd[782]: wlan0: adding default route via 192.168.10.1
Apr 21 17:48:29 volumio volumio[5546]: info: Discovery: adding e0a2f6c6-b93c-44e8-b890-ef975e6d055a
Apr 21 17:48:29 volumio volumio[5546]: info: Discovery: Found device Volumio
Apr 21 17:48:29 volumio volumio[5546]: info: CoreCommandRouter::volumioGetState
Apr 21 17:48:29 volumio volumio[5546]: info: CorePlayQueue::getTrack 0
Apr 21 17:48:29 volumio ntpd[675]: Listen normally on 39 wlan0 192.168.10.125:123
Apr 21 17:48:29 volumio ntpd[675]: new interface(s) found: waking up resolver
Apr 21 17:48:35 volumio volumio[5546]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 17:48:35 volumio volumio[5546]: Error: connect ETIMEDOUT 74.86.228.110:80
Apr 21 17:48:35 volumio volumio[5546]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Apr 21 17:48:35 volumio volumio[5546]: errno: -110,
Apr 21 17:48:35 volumio volumio[5546]: code: 'ETIMEDOUT',
Apr 21 17:48:35 volumio volumio[5546]: syscall: 'connect',
Apr 21 17:48:35 volumio volumio[5546]: address: '74.86.228.110',
Apr 21 17:48:35 volumio volumio[5546]: port: 80
Apr 21 17:48:35 volumio volumio[5546]: }
Apr 21 17:48:35 volumio volumio[5546]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 17:48:36 volumio sudo[6040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 17:47
Apr 21 17:48:36 volumio sudo[6040]: 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"