-- Logs begin at Tue 2025-04-29 23:26:32 CST, end at Tue 2025-04-29 23:32:39 CST. --
Apr 29 23:31:03 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 23:31:03 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 23:31:03 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 29 23:31:03 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 29 23:31:03 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 29 23:31:03 localhost volumio[2566]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 29 23:31:03 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 29 23:31:04 localhost volumio[2566]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Apr 29 23:31:04 localhost volumio[2566]: info: Completed starting MyVolumio Plugin
Apr 29 23:31:04 localhost volumio[2566]: [Metrics] CommandRouter: 47s 871.42ms
Apr 29 23:31:04 localhost volumio[2566]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 29 23:31:04 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 29 23:31:04 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 23:31:04 localhost volumio[2566]: info: CoreCommandRouter::Close All Modals sent
Apr 29 23:31:04 localhost volumio[2566]: info: CoreCommandRouter::Close All Modals sent
Apr 29 23:31:05 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 29 23:31:05 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 29 23:31:05 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 29 23:31:11 localhost volumio[2566]: info: BOOT COMPLETED
Apr 29 23:31:23 localhost volumio[2566]: info: UPDATER: Scheduling automatic update
Apr 29 23:31:23 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Apr 29 23:31:23 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Apr 29 23:31:23 localhost volumio[2566]: info: UPDATER: Auto update will take place at: Wed Apr 30 2025 04:32:53 GMT+0800 (China Standard Time)
Apr 29 23:32:00 localhost sudo[3039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 29 23:32:00 localhost sudo[3039]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 23:32:00 localhost sudo[3039]: pam_unix(sudo:session): session closed for user root
Apr 29 23:32:00 localhost sudo[3041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 29 23:32:00 localhost sudo[3041]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 23:32:00 localhost sudo[3041]: pam_unix(sudo:session): session closed for user root
Apr 29 23:32:00 localhost volumio[2566]: verbose: New Socket.io Connection to 192.168.50.84 from 192.168.50.13 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 29 23:32:00 localhost sudo[3045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 29 23:32:00 localhost sudo[3045]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 23:32:00 localhost sudo[3045]: pam_unix(sudo:session): session closed for user root
Apr 29 23:32:00 localhost sudo[3047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 29 23:32:00 localhost sudo[3047]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 23:32:00 localhost sudo[3047]: pam_unix(sudo:session): session closed for user root
Apr 29 23:32:00 localhost volumio[2566]: verbose: New Socket.io Connection to 192.168.50.84 from 192.168.50.13 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::volumioGetState
Apr 29 23:32:00 localhost volumio[2566]: info: CorePlayQueue::getTrack 0
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 29 23:32:00 localhost volumio[2566]: info: Received Get System Info
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 29 23:32:00 localhost volumio[2566]: info: Discovery: Getting this device information
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::volumioGetState
Apr 29 23:32:00 localhost volumio[2566]: info: CorePlayQueue::getTrack 0
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::volumioGetState
Apr 29 23:32:00 localhost volumio[2566]: info: CorePlayQueue::getTrack 0
Apr 29 23:32:00 localhost volumio[2566]: info: Listing playlists
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 29 23:32:00 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 29 23:32:01 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 29 23:32:01 localhost volumio[2566]: info: CoreCommandRouter::volumioGetState
Apr 29 23:32:01 localhost volumio[2566]: info: CorePlayQueue::getTrack 0
Apr 29 23:32:02 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Apr 29 23:32:02 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 29 23:32:02 localhost volumio[2566]: info: Received Get System Info
Apr 29 23:32:02 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 29 23:32:02 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 29 23:32:02 localhost volumio[2566]: info: Discovery: Getting this device information
Apr 29 23:32:02 localhost volumio[2566]: info: CoreCommandRouter::volumioGetState
Apr 29 23:32:02 localhost volumio[2566]: info: CorePlayQueue::getTrack 0
Apr 29 23:32:02 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 29 23:32:06 localhost volumio[2566]: info: CoreCommandRouter::volumioGetQueue
Apr 29 23:32:06 localhost volumio[2566]: info: CoreStateMachine::getQueue
Apr 29 23:32:06 localhost volumio[2566]: info: CorePlayQueue::getQueue
Apr 29 23:32:07 localhost nmbd[795]: [2025/04/29 23:32:07.378762, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 29 23:32:07 localhost nmbd[795]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.50.84 for name WORKGROUP<1d>.
Apr 29 23:32:07 localhost nmbd[795]: This response was from IP 192.168.50.162, reporting an IP address of 192.168.50.162.
Apr 29 23:32:10 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 23:32:10 localhost volumio[2566]: info: CURURI: music-library
Apr 29 23:32:10 localhost volumio[2566]: error: Failed LSINFO: null
Apr 29 23:32:10 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:10 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 29 23:32:13 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 23:32:13 localhost volumio[2566]: info: CURURI: music-library
Apr 29 23:32:13 localhost volumio[2566]: error: Failed LSINFO: null
Apr 29 23:32:13 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:16 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 23:32:16 localhost volumio[2566]: info: CURURI: music-library
Apr 29 23:32:16 localhost volumio[2566]: error: Failed LSINFO: null
Apr 29 23:32:16 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:18 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:18 localhost volumio[2566]: info: Preloading song: mnt/NAS/select/Pearl White Story.mp3
Apr 29 23:32:18 localhost volumio[2566]: info: Exploding uri mnt/NAS/select/Pearl White Story.mp3 in service mpd
Apr 29 23:32:18 localhost volumio[2566]: error: scanFolder - failure to stat '/mnt/NAS/select/Pearl White Story.mp3'
Apr 29 23:32:19 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 23:32:19 localhost volumio[2566]: info: CURURI: music-library
Apr 29 23:32:19 localhost volumio[2566]: error: Failed LSINFO: null
Apr 29 23:32:19 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:23 localhost volumio[2566]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Apr 29 23:32:23 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 23:32:23 localhost volumio[2566]: info: CURURI: playlists
Apr 29 23:32:23 localhost volumio[2566]: info: Listing playlists
Apr 29 23:32:23 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:27 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 23:32:27 localhost volumio[2566]: info: CURURI: albums://
Apr 29 23:32:27 localhost volumio[2566]: info: listAlbums - loading Albums from cache
Apr 29 23:32:27 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:28 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 29 23:32:28 localhost volumio[2566]: info: CURURI: genres://
Apr 29 23:32:29 localhost volumio[2566]: info: Preload queue cleared
Apr 29 23:32:31 localhost volumio[2566]: info: CoreCommandRouter::volumioGetState
Apr 29 23:32:31 localhost volumio[2566]: info: CorePlayQueue::getTrack 0
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 29 23:32:33 localhost volumio[2566]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 29 23:32:36 localhost volumio[2566]: info: CoreCommandRouter::volumioGetState
Apr 29 23:32:36 localhost volumio[2566]: info: CorePlayQueue::getTrack 0
Apr 29 23:32:38 localhost volumio[2566]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 23:32:38 localhost volumio[2566]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 29 23:32:38 localhost volumio[2566]: info: Retrieving Cloud Streaming UI
Apr 29 23:32:38 localhost volumio[2566]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 29 23:32:38 localhost volumio[2566]: Error: connect ETIMEDOUT 115.126.100.160:443
Apr 29 23:32:38 localhost volumio[2566]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Apr 29 23:32:38 localhost volumio[2566]: errno: -110,
Apr 29 23:32:38 localhost volumio[2566]: code: 'ETIMEDOUT',
Apr 29 23:32:38 localhost volumio[2566]: syscall: 'connect',
Apr 29 23:32:38 localhost volumio[2566]: address: '115.126.100.160',
Apr 29 23:32:38 localhost volumio[2566]: port: 443
Apr 29 23:32:38 localhost volumio[2566]: }
Apr 29 23:32:38 localhost volumio[2566]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 29 23:32:39 localhost sudo[3121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 23:31
Apr 29 23:32:39 localhost sudo[3121]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"