-- Logs begin at Fri 2024-08-23 15:51:23 -03, end at Mon 2024-08-26 06:16:24 -03. -- Aug 26 06:15:03 volumio systemd[1]: Starting Daily apt download activities... Aug 26 06:15:03 volumio systemd[1]: Starting Daily man-db regeneration... Aug 26 06:15:03 volumio volumio[826]: info: Discovery: A device disappeared from network Aug 26 06:15:03 volumio volumio[826]: info: Discovery: Device volumio disappeared from network Aug 26 06:15:03 volumio volumio[826]: info: Discovery: adding ac591694-00dc-4315-8f63-01dfba4de54b Aug 26 06:15:03 volumio volumio[826]: info: Discovery: Found device Volumio Aug 26 06:15:03 volumio volumio[826]: info: CoreCommandRouter::volumioGetState Aug 26 06:15:03 volumio volumio[826]: info: CorePlayQueue::getTrack 0 Aug 26 06:15:03 volumio systemd[1]: man-db.service: Succeeded. Aug 26 06:15:03 volumio systemd[1]: Started Daily man-db regeneration. Aug 26 06:15:04 volumio volumio[826]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 26 06:15:04 volumio volumio[826]: info: Completed starting MyVolumio Plugin Aug 26 06:15:04 volumio volumio[826]: info: BOOT COMPLETED Aug 26 06:15:04 volumio volumio[826]: [Metrics] CommandRouter: 71s 18.15ms Aug 26 06:15:04 volumio volumio[826]: info: CoreCommandRouter::volumiosetStartupVolume Aug 26 06:15:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 06:15:04 volumio volumio[826]: info: VolumeController:: Setting startup Volume 50 Aug 26 06:15:04 volumio volumio[826]: info: VolumeController::SetAlsaVolume50 Aug 26 06:15:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 06:15:04 volumio volumio[826]: info: CoreCommandRouter::Close All Modals sent Aug 26 06:15:04 volumio volumio[826]: info: CoreCommandRouter::Close All Modals sent Aug 26 06:15:04 volumio volumio[826]: info: CoreStateMachine::pushState Aug 26 06:15:04 volumio volumio[826]: info: CorePlayQueue::getTrack 0 Aug 26 06:15:04 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 06:15:04 volumio volumio[826]: info: CoreCommandRouter::volumioPushState Aug 26 06:15:05 volumio volumio[826]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 06:15:05 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 26 06:15:05 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 06:15:05 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 26 06:15:05 volumio nmbd[735]: [2024/08/26 06:15:05.993818, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Aug 26 06:15:05 volumio nmbd[735]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.19 for name WORKGROUP<1d>. Aug 26 06:15:05 volumio nmbd[735]: This response was from IP 192.168.2.86, reporting an IP address of 192.168.2.86. Aug 26 06:15:06 volumio volumio[826]: info: CoreCommandRouter::volumioGetState Aug 26 06:15:06 volumio volumio[826]: info: CorePlayQueue::getTrack 0 Aug 26 06:15:07 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 06:15:07 volumio volumio[826]: info: Listing playlists Aug 26 06:15:07 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 06:15:07 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 06:15:07 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 06:15:07 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 06:15:07 volumio volumio[826]: info: CoreCommandRouter::volumioGetState Aug 26 06:15:07 volumio volumio[826]: info: CorePlayQueue::getTrack 0 Aug 26 06:15:07 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 06:15:07 volumio volumio[826]: info: Listing playlists Aug 26 06:15:10 volumio systemd[1]: apt-daily.service: Succeeded. Aug 26 06:15:10 volumio systemd[1]: Started Daily apt download activities. Aug 26 06:15:10 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Aug 26 06:15:13 volumio volumio[826]: info: Setting Geolocation for MyVolumio to us1 Aug 26 06:15:13 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 06:15:14 volumio volumio[826]: info: Updating MyVolumio device info Aug 26 06:15:14 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 06:15:16 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Aug 26 06:15:16 volumio systemd[1]: Started Daily apt upgrade and clean activities. Aug 26 06:15:18 volumio volumio[826]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 26 06:15:21 volumio volumio[826]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 26 06:15:25 volumio volumio[826]: info: MYVOLUMIO: Adding device Aug 26 06:15:25 volumio volumio[826]: info: MYVOLUMIO: Evaluating Server Aug 26 06:15:27 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 06:15:27 volumio volumio[826]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 26 06:15:27 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 26 06:15:27 volumio volumio[826]: info: Received Get System Version Aug 26 06:15:27 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 06:15:27 volumio volumio[826]: info: Received Get System Info Aug 26 06:15:27 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 06:15:27 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 06:15:27 volumio volumio[826]: info: Discovery: Getting this device information Aug 26 06:15:27 volumio volumio[826]: info: CoreCommandRouter::volumioGetState Aug 26 06:15:27 volumio volumio[826]: info: CorePlayQueue::getTrack 0 Aug 26 06:15:27 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 06:15:32 volumio volumio[826]: info: Setting Geolocation for MyVolumio to eu6 Aug 26 06:15:32 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 06:15:33 volumio volumio[826]: info: Updating MyVolumio device info Aug 26 06:15:33 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 06:15:34 volumio volumio[826]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 26 06:15:35 volumio volumio[826]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 26 06:15:39 volumio volumio[1209]: ................................................................................................................................................................................................................................................................................................................................++++ Aug 26 06:15:47 volumio volumio[1209]: ....................................................++++ Aug 26 06:15:47 volumio volumio[1209]: e is 65537 (0x010001) Aug 26 06:15:47 volumio volumio[1209]: writing RSA key Aug 26 06:15:59 volumio ntpd[784]: Soliciting pool server 143.107.229.210 Aug 26 06:16:01 volumio ntpd[784]: Soliciting pool server 143.107.229.210 Aug 26 06:16:03 volumio ntpd[784]: Soliciting pool server 143.107.229.210 Aug 26 06:16:06 volumio ntpd[784]: Soliciting pool server 162.159.200.1 Aug 26 06:16:23 volumio volumio[826]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 06:16:23 volumio volumio[826]: Error: connect ETIMEDOUT 130.211.19.189:80 Aug 26 06:16:23 volumio volumio[826]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Aug 26 06:16:23 volumio volumio[826]: errno: -110, Aug 26 06:16:23 volumio volumio[826]: code: 'ETIMEDOUT', Aug 26 06:16:23 volumio volumio[826]: syscall: 'connect', Aug 26 06:16:23 volumio volumio[826]: address: '130.211.19.189', Aug 26 06:16:23 volumio volumio[826]: port: 80 Aug 26 06:16:23 volumio volumio[826]: } Aug 26 06:16:23 volumio volumio[826]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 06:16:24 volumio sudo[1972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 06:15 Aug 26 06:16:24 volumio sudo[1972]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"