Mar 25 09:42:04 volumio volumio[1372]: error: [now-playing] Error fetching lyrics from LRCLIB (URL: https://lrclib.net/api/get?track_name=01+2002%E5%B9%B4%E7%9A%84%E7%AC%AC%E4%B8%80%E5%9C%BA%E9%9B%AA&artist_name=%E5%88%80%E9%83%8E&album_name=%E8%AF%95%E9%9F%B3%E5%88%80%E9%83%8E&duration=258): TypeError: fetch failed Mar 25 09:42:04 volumio volumio[1372]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Mar 25 09:42:04 volumio volumio[1372]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 25 09:42:04 volumio volumio[1372]: at async apiGet (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:16:26) Mar 25 09:42:04 volumio volumio[1372]: at async LRCLibAPI.getLyrics (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:33:24) Mar 25 09:42:04 volumio volumio[1372]: at async DefaultMetadataProvider.getSongInfo (/data/plugins/user_interface/now_playing/dist/lib/api/DefaultMetadataProvider.js:72:37) Mar 25 09:42:04 volumio volumio[1372]: at async /data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:135:40 Mar 25 09:42:04 volumio volumio[1372]: error: [now-playing] Caught error in callback of MetdataAPI.#getFetchPromise(): Token missing - Please provide a Genius Access Token in the Now Playing plugin settings. Mar 25 09:42:04 volumio volumio[1372]: error: [now-playing] API endpoint metadata/fetchInfo returned error: Error: Could not fetch info: Token missing - Please provide a Genius Access Token in the Now Playing plugin settings. Mar 25 09:42:04 volumio volumio[1372]: at MetadataAPI._MetadataAPI_doFetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:180:15) Mar 25 09:42:04 volumio volumio[1372]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 25 09:42:04 volumio volumio[1372]: at async MetadataAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:52:36) Mar 25 09:42:04 volumio volumio[1372]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:126:28) Mar 25 09:42:19 volumio volumio[1372]: info: [now-playing] Weather not configured: Weather is not set up: add Geographic Coordinates in Localization and an OpenWeatherMap API key in Weather Service. Mar 25 09:42:19 volumio volumio[1372]: verbose: New Socket.io Connection to 192.168.5.224:3000 from 192.168.5.198 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Mar 25 09:42:19 volumio volumio[1372]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Mar 25 09:42:19 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Mar 25 09:42:19 volumio volumio[1372]: info: Listing playlists Mar 25 09:42:19 volumio volumio[1372]: info: CoreCommandRouter::volumioGetQueue Mar 25 09:42:19 volumio volumio[1372]: info: CoreStateMachine::getQueue Mar 25 09:42:19 volumio volumio[1372]: info: CorePlayQueue::getQueue Mar 25 09:42:19 volumio volumio[1372]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 09:42:19 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 09:42:19 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:19 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:20 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 09:42:20 volumio volumio[1372]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"01 2002年的第一场雪","artist":"刀郎","album":"试音刀郎","duration":"258","uri":"mnt/NAS/MusicHD/《试音刀郎》/01 2002年的第一场雪.wav","service":""} Mar 25 09:42:20 volumio volumio[1372]: info: [now-playing] LRCLIB getLyrics(): song: "01 2002年的第一场雪" album: "试音刀郎" artist: "刀郎" duration: "258" Mar 25 09:42:20 volumio volumio[1372]: info: [now-playing] LRCLIB getLyrics() API URL: https://lrclib.net/api/get?track_name=01+2002%E5%B9%B4%E7%9A%84%E7%AC%AC%E4%B8%80%E5%9C%BA%E9%9B%AA&artist_name=%E5%88%80%E9%83%8E&album_name=%E8%AF%95%E9%9F%B3%E5%88%80%E9%83%8E&duration=258 Mar 25 09:42:20 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:20 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:21 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 09:42:21 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 25 09:42:25 volumio volumio[1372]: error: [now-playing] Error fetching lyrics from LRCLIB (URL: https://lrclib.net/api/get?track_name=01+2002%E5%B9%B4%E7%9A%84%E7%AC%AC%E4%B8%80%E5%9C%BA%E9%9B%AA&artist_name=%E5%88%80%E9%83%8E&album_name=%E8%AF%95%E9%9F%B3%E5%88%80%E9%83%8E&duration=258): TypeError: fetch failed Mar 25 09:42:25 volumio volumio[1372]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Mar 25 09:42:25 volumio volumio[1372]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 25 09:42:25 volumio volumio[1372]: at async apiGet (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:16:26) Mar 25 09:42:25 volumio volumio[1372]: at async LRCLibAPI.getLyrics (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:33:24) Mar 25 09:42:25 volumio volumio[1372]: at async DefaultMetadataProvider.getSongInfo (/data/plugins/user_interface/now_playing/dist/lib/api/DefaultMetadataProvider.js:72:37) Mar 25 09:42:25 volumio volumio[1372]: at async /data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:135:40 Mar 25 09:42:25 volumio volumio[1372]: error: [now-playing] Caught error in callback of MetdataAPI.#getFetchPromise(): Token missing - Please provide a Genius Access Token in the Now Playing plugin settings. Mar 25 09:42:25 volumio volumio[1372]: error: [now-playing] API endpoint metadata/fetchInfo returned error: Error: Could not fetch info: Token missing - Please provide a Genius Access Token in the Now Playing plugin settings. Mar 25 09:42:25 volumio volumio[1372]: at MetadataAPI._MetadataAPI_doFetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:180:15) Mar 25 09:42:25 volumio volumio[1372]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 25 09:42:25 volumio volumio[1372]: at async MetadataAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:52:36) Mar 25 09:42:25 volumio volumio[1372]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:126:28) Mar 25 09:42:25 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:25 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio sudo[11619]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 09:42:26 volumio sudo[11619]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:26 volumio sudo[11619]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:26 volumio sudo[11621]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 09:42:26 volumio sudo[11621]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:26 volumio sudo[11621]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:26 volumio volumio[1372]: verbose: New Socket.io Connection to 192.168.5.224 from 192.168.5.198 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 10 Mar 25 09:42:26 volumio sudo[11625]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 09:42:26 volumio sudo[11625]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:26 volumio sudo[11625]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:26 volumio sudo[11627]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 09:42:26 volumio sudo[11627]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:26 volumio sudo[11627]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: verbose: New Socket.io Connection to 192.168.5.224 from 192.168.5.198 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 10 Mar 25 09:42:26 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:26 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 09:42:26 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:26 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: Listing playlists Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetQueue Mar 25 09:42:26 volumio volumio[1372]: info: CoreStateMachine::getQueue Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getQueue Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:26 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 09:42:26 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:26 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:26 volumio volumio[1372]: info: Listing playlists Mar 25 09:42:26 volumio volumio[1372]: info: CoreCommandRouter::volumioGetQueue Mar 25 09:42:26 volumio volumio[1372]: info: CoreStateMachine::getQueue Mar 25 09:42:26 volumio volumio[1372]: info: CorePlayQueue::getQueue Mar 25 09:42:28 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 25 09:42:29 volumio sudo[11662]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 09:42:29 volumio sudo[11662]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:29 volumio sudo[11662]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:29 volumio sudo[11664]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 09:42:29 volumio sudo[11664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:29 volumio sudo[11664]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:29 volumio volumio[1372]: verbose: New Socket.io Connection to 192.168.5.224 from 192.168.5.198 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Mar 25 09:42:29 volumio sudo[11668]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 09:42:29 volumio sudo[11668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:29 volumio sudo[11668]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:29 volumio sudo[11670]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 09:42:29 volumio sudo[11670]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio sudo[11670]: pam_unix(sudo:session): session closed for user root Mar 25 09:42:29 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:29 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 09:42:29 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:29 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: Listing playlists Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetQueue Mar 25 09:42:29 volumio volumio[1372]: info: CoreStateMachine::getQueue Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getQueue Mar 25 09:42:29 volumio volumio[1372]: verbose: New Socket.io Connection to 192.168.5.224 from 192.168.5.198 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 25 09:42:29 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 25 09:42:29 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:29 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 09:42:29 volumio volumio[1372]: info: Received Get System Info Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 09:42:29 volumio volumio[1372]: info: Discovery: Getting this device information Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:29 volumio volumio[1372]: info: Listing playlists Mar 25 09:42:29 volumio volumio[1372]: info: CoreCommandRouter::volumioGetQueue Mar 25 09:42:29 volumio volumio[1372]: info: CoreStateMachine::getQueue Mar 25 09:42:29 volumio volumio[1372]: info: CorePlayQueue::getQueue Mar 25 09:42:37 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 25 09:42:37 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 25 09:42:40 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 25 09:42:40 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 25 09:42:52 volumio volumio[1372]: info: [now-playing] Weather not configured: Weather is not set up: add Geographic Coordinates in Localization and an OpenWeatherMap API key in Weather Service. Mar 25 09:42:52 volumio volumio[1372]: verbose: New Socket.io Connection to 192.168.5.224:3000 from 192.168.5.198 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Mar 25 09:42:52 volumio volumio[1372]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Mar 25 09:42:52 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Mar 25 09:42:52 volumio volumio[1372]: info: Listing playlists Mar 25 09:42:52 volumio volumio[1372]: info: CoreCommandRouter::volumioGetQueue Mar 25 09:42:52 volumio volumio[1372]: info: CoreStateMachine::getQueue Mar 25 09:42:52 volumio volumio[1372]: info: CorePlayQueue::getQueue Mar 25 09:42:52 volumio volumio[1372]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 09:42:52 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 09:42:52 volumio volumio[1372]: info: CoreCommandRouter::volumioGetState Mar 25 09:42:52 volumio volumio[1372]: info: CorePlayQueue::getTrack 0 Mar 25 09:42:52 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 09:42:52 volumio volumio[1372]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"01 2002年的第一场雪","artist":"刀郎","album":"试音刀郎","duration":"258","uri":"mnt/NAS/MusicHD/《试音刀郎》/01 2002年的第一场雪.wav","service":""} Mar 25 09:42:52 volumio volumio[1372]: info: [now-playing] LRCLIB getLyrics(): song: "01 2002年的第一场雪" album: "试音刀郎" artist: "刀郎" duration: "258" Mar 25 09:42:52 volumio volumio[1372]: info: [now-playing] LRCLIB getLyrics() API URL: https://lrclib.net/api/get?track_name=01+2002%E5%B9%B4%E7%9A%84%E7%AC%AC%E4%B8%80%E5%9C%BA%E9%9B%AA&artist_name=%E5%88%80%E9%83%8E&album_name=%E8%AF%95%E9%9F%B3%E5%88%80%E9%83%8E&duration=258 Mar 25 09:42:54 volumio volumio[1372]: error: [now-playing] Error fetching lyrics from LRCLIB (URL: https://lrclib.net/api/get?track_name=01+2002%E5%B9%B4%E7%9A%84%E7%AC%AC%E4%B8%80%E5%9C%BA%E9%9B%AA&artist_name=%E5%88%80%E9%83%8E&album_name=%E8%AF%95%E9%9F%B3%E5%88%80%E9%83%8E&duration=258): Error: Response error: 404 - Not Found Mar 25 09:42:54 volumio volumio[1372]: at apiGet (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:20:15) Mar 25 09:42:54 volumio volumio[1372]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 25 09:42:54 volumio volumio[1372]: at async LRCLibAPI.getLyrics (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:33:24) Mar 25 09:42:54 volumio volumio[1372]: at async DefaultMetadataProvider.getSongInfo (/data/plugins/user_interface/now_playing/dist/lib/api/DefaultMetadataProvider.js:72:37) Mar 25 09:42:54 volumio volumio[1372]: at async /data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:135:40 Mar 25 09:42:54 volumio volumio[1372]: error: [now-playing] Caught error in callback of MetdataAPI.#getFetchPromise(): Token missing - Please provide a Genius Access Token in the Now Playing plugin settings. Mar 25 09:42:54 volumio volumio[1372]: error: [now-playing] API endpoint metadata/fetchInfo returned error: Error: Could not fetch info: Token missing - Please provide a Genius Access Token in the Now Playing plugin settings. Mar 25 09:42:54 volumio volumio[1372]: at MetadataAPI._MetadataAPI_doFetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:180:15) Mar 25 09:42:54 volumio volumio[1372]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 25 09:42:54 volumio volumio[1372]: at async MetadataAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:52:36) Mar 25 09:42:54 volumio volumio[1372]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:126:28) Mar 25 09:43:00 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 09:43:00 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 25 09:43:04 volumio volumio[1372]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 09:43:11 volumio volumio[1372]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object] Mar 25 09:43:11 volumio volumio[1372]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:11-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Mar 25 09:43:46 volumio volumio[1372]: Resolving github.com (github.com)... 198.18.5.184 Mar 25 09:43:46 volumio volumio[1372]: Connecting to github.com (github.com)|198.18.5.184|:443... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... 404 Not Found Mar 25 09:43:46 volumio volumio[1372]: 2026-03-25 09:43:18 ERROR 404: Not Found. Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:18-- http://a/ Mar 25 09:43:46 volumio volumio[1372]: Resolving a (a)... failed: Device or resource busy. Mar 25 09:43:46 volumio volumio[1372]: wget: unable to resolve host address ‘a’ Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:18-- http://packet.zip/ Mar 25 09:43:46 volumio volumio[1372]: Resolving packet.zip (packet.zip)... 198.18.6.69 Mar 25 09:43:46 volumio volumio[1372]: Connecting to packet.zip (packet.zip)|198.18.6.69|:80... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... 302 Found Mar 25 09:43:46 volumio volumio[1372]: Location: http://www.packet.zip/ [following] Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:18-- http://www.packet.zip/ Mar 25 09:43:46 volumio volumio[1372]: Resolving www.packet.zip (www.packet.zip)... 198.18.6.70 Mar 25 09:43:46 volumio volumio[1372]: Connecting to www.packet.zip (www.packet.zip)|198.18.6.70|:80... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... No data received. Mar 25 09:43:46 volumio volumio[1372]: Retrying. Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:24-- (try: 2) http://www.packet.zip/ Mar 25 09:43:46 volumio volumio[1372]: Connecting to www.packet.zip (www.packet.zip)|198.18.6.70|:80... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... No data received. Mar 25 09:43:46 volumio volumio[1372]: Retrying. Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:31-- (try: 3) http://www.packet.zip/ Mar 25 09:43:46 volumio volumio[1372]: Connecting to www.packet.zip (www.packet.zip)|198.18.6.70|:80... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... No data received. Mar 25 09:43:46 volumio volumio[1372]: Retrying. Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:35-- (try: 4) http://www.packet.zip/ Mar 25 09:43:46 volumio volumio[1372]: Connecting to www.packet.zip (www.packet.zip)|198.18.6.70|:80... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... No data received. Mar 25 09:43:46 volumio volumio[1372]: Retrying. Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:40-- (try: 5) http://www.packet.zip/ Mar 25 09:43:46 volumio volumio[1372]: Connecting to www.packet.zip (www.packet.zip)|198.18.6.70|:80... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... No data received. Mar 25 09:43:46 volumio volumio[1372]: Retrying. Mar 25 09:43:46 volumio volumio[1372]: --2026-03-25 09:43:45-- (try: 6) http://www.packet.zip/ Mar 25 09:43:46 volumio volumio[1372]: Connecting to www.packet.zip (www.packet.zip)|198.18.6.70|:80... connected. Mar 25 09:43:46 volumio volumio[1372]: HTTP request sent, awaiting response... 403 Forbidden Mar 25 09:43:46 volumio volumio[1372]: 2026-03-25 09:43:46 ERROR 403: Forbidden. Mar 25 09:43:46 volumio volumio[1372]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Mar 25 09:43:46 volumio volumio[1372]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Mar 25 09:43:46 volumio volumio[1372]: /bin/rm: cannot remove 'a': No such file or directory Mar 25 09:43:46 volumio volumio[1372]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Mar 25 09:43:46 volumio volumio[1372]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 09:43:46 volumio volumio[1372]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Mar 25 09:43:46 volumio volumio[1372]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Mar 25 09:43:46 volumio volumio[1372]: /bin/rm: cannot remove 'a': No such file or directory Mar 25 09:43:46 volumio volumio[1372]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Mar 25 09:43:46 volumio volumio[1372]: at checkExecSyncError (node:child_process:887:11) Mar 25 09:43:46 volumio volumio[1372]: at execSync (node:child_process:959:15) Mar 25 09:43:46 volumio volumio[1372]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19 Mar 25 09:43:46 volumio volumio[1372]: at new Promise () Mar 25 09:43:46 volumio volumio[1372]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12) Mar 25 09:43:46 volumio volumio[1372]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Mar 25 09:43:46 volumio volumio[1372]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Mar 25 09:43:46 volumio volumio[1372]: at Socket.emit (node:events:514:28) Mar 25 09:43:46 volumio volumio[1372]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 25 09:43:46 volumio volumio[1372]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Mar 25 09:43:46 volumio volumio[1372]: status: 1, Mar 25 09:43:46 volumio volumio[1372]: signal: null, Mar 25 09:43:46 volumio volumio[1372]: output: [ Mar 25 09:43:46 volumio volumio[1372]: null, Mar 25 09:43:46 volumio volumio[1372]: , Mar 25 09:43:46 volumio volumio[1372]: Mar 25 09:43:46 volumio volumio[1372]: ], Mar 25 09:43:46 volumio volumio[1372]: pid: 11993, Mar 25 09:43:46 volumio volumio[1372]: stdout: , Mar 25 09:43:46 volumio volumio[1372]: stderr: Mar 25 09:43:46 volumio volumio[1372]: } Mar 25 09:43:46 volumio volumio[1372]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 09:43:46 volumio sudo[12009]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-25 09:42' Mar 25 09:43:46 volumio sudo[12009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 17:11:42 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="21a5161aef4cb85a1f93b140ccadc4f1"