-- Logs begin at Thu 2024-04-25 08:56:50 CST, end at Thu 2024-04-25 09:03:24 CST. -- Apr 25 09:02:04 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 25 09:02:04 volumio volumio[29134]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Apr 25 09:02:04 volumio volumio[29134]: info: CoreCommandRouter::volumioGetState Apr 25 09:02:04 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::volumioGetBrowseSources Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 25 09:02:09 volumio volumio[29134]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 25 09:02:09 volumio volumio[29134]: info: Completed starting MyVolumio Plugin Apr 25 09:02:09 volumio volumio[29134]: info: BOOT COMPLETED Apr 25 09:02:09 volumio volumio[29134]: [Metrics] CommandRouter: 62s 706.91ms Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::volumiosetStartupVolume Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::Close All Modals sent Apr 25 09:02:09 volumio volumio[29134]: info: CoreCommandRouter::Close All Modals sent Apr 25 09:02:10 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 25 09:02:10 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 25 09:02:10 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 25 09:02:19 volumio volumio[29134]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 25 09:02:19 volumio volumio[29134]: info: Retrying Login Due to Network Error Apr 25 09:02:20 volumio volumio-remote-updater[522]: No test mode Apr 25 09:02:20 volumio volumio-remote-updater[522]: No alpha test mode Apr 25 09:02:20 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 25 09:02:21 volumio volumio[29134]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 25 09:02:21 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 25 09:02:26 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 25 09:02:26 volumio volumio[29134]: info: CURURI: artists:// Apr 25 09:02:26 volumio volumio[29134]: info: Preload queue cleared Apr 25 09:02:26 volumio volumio[29134]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%3F%3F%3F/33f6a45b-5964-4031-9361-e8b40b57464f.jpg' Apr 25 09:02:27 volumio volumio[29134]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%9C%E8%81%AA/1ec0b5be-3999-4154-9237-aab0d9cab2ac.jpg' Apr 25 09:02:29 volumio volumio[29134]: info: MyVolumio login type: Token Apr 25 09:02:32 volumio volumio[29134]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E4%BC%A6/98d21635-45ad-4008-979e-318a35cbd9e4.jpg' Apr 25 09:02:59 volumio volumio[29134]: verbose: New Socket.io Connection to 192.168.88.77 from 192.168.88.114 UA: unknown Total Clients: 5 Apr 25 09:02:59 volumio volumio[29134]: info: CoreCommandRouter::volumioGetState Apr 25 09:02:59 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:02:59 volumio volumio[29134]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 25 09:02:59 volumio volumio[29134]: info: Retrying Login Due to Network Error Apr 25 09:02:59 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 25 09:02:59 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 25 09:03:00 volumio volumio[29134]: info: Discovery: Getting this device information Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::volumioGetState Apr 25 09:03:00 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 25 09:03:00 volumio volumio[29134]: info: Discovery: Getting this device information Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::volumioGetState Apr 25 09:03:00 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 25 09:03:00 volumio volumio[29134]: verbose: New Socket.io Connection to 192.168.88.76 from 192.168.88.114 UA: unknown Total Clients: 6 Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::volumioGetState Apr 25 09:03:00 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 25 09:03:00 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 25 09:03:03 volumio sudo[29431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 25 09:03:03 volumio sudo[29431]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 25 09:03:03 volumio sudo[29431]: pam_unix(sudo:session): session closed for user root Apr 25 09:03:03 volumio sudo[29434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 25 09:03:03 volumio sudo[29434]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 25 09:03:03 volumio sudo[29434]: pam_unix(sudo:session): session closed for user root Apr 25 09:03:03 volumio volumio[29134]: verbose: New Socket.io Connection to 192.168.88.76 from 192.168.88.114 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Apr 25 09:03:04 volumio volumio[29134]: info: CoreCommandRouter::volumioGetState Apr 25 09:03:04 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:04 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 25 09:03:04 volumio volumio[29134]: info: Listing playlists Apr 25 09:03:04 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 25 09:03:04 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 25 09:03:04 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 25 09:03:04 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 25 09:03:09 volumio volumio[29134]: info: CoreCommandRouter::volumioPlay Apr 25 09:03:09 volumio volumio[29134]: info: CoreStateMachine::play index undefined Apr 25 09:03:09 volumio volumio[29134]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 25 09:03:09 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:09 volumio volumio[29134]: info: MyVolumio login type: Token Apr 25 09:03:13 volumio volumio[29134]: info: CoreCommandRouter::volumioGetQueue Apr 25 09:03:13 volumio volumio[29134]: info: CoreStateMachine::getQueue Apr 25 09:03:13 volumio volumio[29134]: info: CorePlayQueue::getQueue Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::volumioRandom Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::writePlayerControls Apr 25 09:03:17 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:17 volumio volumio[29134]: info: CoreStateMachine::setRepeat true single false Apr 25 09:03:17 volumio volumio[29134]: info: CoreStateMachine::pushState Apr 25 09:03:17 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::volumioPushState Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::volumioRandom Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::writePlayerControls Apr 25 09:03:17 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:17 volumio volumio[29134]: info: CoreStateMachine::setRepeat true single true Apr 25 09:03:17 volumio volumio[29134]: info: CoreStateMachine::pushState Apr 25 09:03:17 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 09:03:17 volumio volumio[29134]: info: CoreCommandRouter::volumioPushState Apr 25 09:03:19 volumio volumio[29134]: info: CoreCommandRouter::volumioRandom Apr 25 09:03:19 volumio volumio[29134]: info: CoreCommandRouter::writePlayerControls Apr 25 09:03:19 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:19 volumio volumio[29134]: info: CoreStateMachine::setRepeat false single false Apr 25 09:03:19 volumio volumio[29134]: info: CoreStateMachine::pushState Apr 25 09:03:19 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:19 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 09:03:19 volumio volumio[29134]: info: CoreCommandRouter::volumioPushState Apr 25 09:03:23 volumio volumio[29134]: verbose: New Socket.io Connection to 192.168.88.76 from 192.168.88.114 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 8 Apr 25 09:03:23 volumio volumio[29134]: info: CoreCommandRouter::volumioGetState Apr 25 09:03:23 volumio volumio[29134]: info: CorePlayQueue::getTrack 0 Apr 25 09:03:23 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 25 09:03:23 volumio volumio[29134]: info: Listing playlists Apr 25 09:03:23 volumio volumio[29134]: info: CoreCommandRouter::volumioGetQueue Apr 25 09:03:23 volumio volumio[29134]: info: CoreStateMachine::getQueue Apr 25 09:03:23 volumio volumio[29134]: info: CorePlayQueue::getQueue Apr 25 09:03:23 volumio volumio[29134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 25 09:03:23 volumio volumio[29134]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 09:03:23 volumio volumio[29134]: Error: connect ETIMEDOUT 174.37.54.20:443 Apr 25 09:03:23 volumio volumio[29134]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 25 09:03:23 volumio volumio[29134]: errno: -110, Apr 25 09:03:23 volumio volumio[29134]: code: 'ETIMEDOUT', Apr 25 09:03:23 volumio volumio[29134]: syscall: 'connect', Apr 25 09:03:23 volumio volumio[29134]: address: '174.37.54.20', Apr 25 09:03:23 volumio volumio[29134]: port: 443 Apr 25 09:03:23 volumio volumio[29134]: } Apr 25 09:03:23 volumio volumio[29134]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 09:03:24 volumio sudo[29449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-25 09:02 Apr 25 09:03:24 volumio sudo[29449]: 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"