Dec 30 11:55:14 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 30 11:55:16 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 30 11:55:16 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 30 11:55:16 volumio systemd[1]: setdatetime-helper.service: Consumed 1.677s CPU time. Dec 30 11:55:46 volumio ntpd[831]: PROTO: 82.65.248.56 unlink local addr 192.168.1.171 -> Dec 30 11:55:57 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.1.171:3000 from 192.168.1.185 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:55:57 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:55:57 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:55:57 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:55:57 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:55:57 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.1.171:3000 from 192.168.1.185 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 30 11:55:57 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.1.171:3000 from 192.168.1.185 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:55:57 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:55:57 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:55:57 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:55:57 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 30 11:55:57 volumio sudo[2487]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 30 11:55:57 volumio sudo[2487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:55:57 volumio sudo[2492]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 30 11:55:57 volumio sudo[2492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:55:57 volumio sudo[2498]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 30 11:55:57 volumio sudo[2498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:55:57 volumio sudo[2487]: pam_unix(sudo:session): session closed for user root Dec 30 11:55:57 volumio sudo[2502]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 30 11:55:57 volumio sudo[2502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:55:57 volumio sudo[2492]: pam_unix(sudo:session): session closed for user root Dec 30 11:55:57 volumio sudo[2509]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 11:55:57 volumio sudo[2509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:55:57 volumio sudo[2514]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 11:55:57 volumio sudo[2514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:55:57 volumio sudo[2498]: pam_unix(sudo:session): session closed for user root Dec 30 11:55:57 volumio sudo[2509]: pam_unix(sudo:session): session closed for user root Dec 30 11:55:57 volumio sudo[2502]: pam_unix(sudo:session): session closed for user root Dec 30 11:55:57 volumio sudo[2514]: pam_unix(sudo:session): session closed for user root Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 11:55:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:55:58 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:55:58 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:55:58 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:55:58 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:55:58 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:55:58 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.1.171:3000 from 192.168.1.185 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 11:55:58 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 11:55:59 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 11:55:59 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 11:56:01 volumio sudo[2540]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 11:56:01 volumio sudo[2540]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:56:01 volumio sudo[2542]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 11:56:01 volumio sudo[2542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:56:01 volumio sudo[2540]: pam_unix(sudo:session): session closed for user root Dec 30 11:56:01 volumio sudo[2542]: pam_unix(sudo:session): session closed for user root Dec 30 11:56:01 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.185 UA: Mozilla/5.0 (Linux; Android 16; SM-S928B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.146 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 30 11:56:01 volumio sudo[2549]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 11:56:01 volumio sudo[2549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:56:01 volumio sudo[2551]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 11:56:01 volumio sudo[2549]: pam_unix(sudo:session): session closed for user root Dec 30 11:56:01 volumio sudo[2551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 11:56:01 volumio sudo[2551]: pam_unix(sudo:session): session closed for user root Dec 30 11:56:01 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.185 UA: Mozilla/5.0 (Linux; Android 16; SM-S928B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.146 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:56:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 30 11:56:01 volumio volumio[1019]: info: Received Get System Info Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:56:01 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:56:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:56:01 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:56:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:02 volumio volumio[1019]: info: Listing playlists Dec 30 11:56:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 30 11:56:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 11:56:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 30 11:56:03 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 11:56:03 volumio volumio[1019]: info: Received Get System Info Dec 30 11:56:03 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:56:03 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:56:03 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:56:03 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:56:03 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:03 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:56:03 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 30 11:56:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 11:56:04 volumio volumio[1019]: info: Received Get System Info Dec 30 11:56:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:56:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:56:04 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:56:04 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:56:04 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:56:11 volumio volumio[1019]: info: CoreCommandRouter::volumioGetQueue Dec 30 11:56:11 volumio volumio[1019]: info: CoreStateMachine::getQueue Dec 30 11:56:11 volumio volumio[1019]: info: CorePlayQueue::getQueue Dec 30 11:56:11 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 30 11:56:15 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 11:56:15 volumio volumio[1019]: info: CURURI: albums:// Dec 30 11:56:15 volumio volumio[1019]: info: listAlbums - loading Albums from cache Dec 30 11:56:15 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 11:56:17 volumio volumio[1019]: info: CURURI: albums://Mario%20Winans/Bad%20Boy%2020th%20Anniversary%20Box%20Set%20Edition Dec 30 11:56:18 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:18 volumio volumio[1019]: info: Preloading song: music-library/USB/1234-5678/00's R&B/Mario Winans - I Don't Wanna Know (feat. Enya & P. Diddy) (2016 Remaster)_pn.mp3 Dec 30 11:56:18 volumio volumio[1019]: info: Exploding uri music-library/USB/1234-5678/00's R&B/Mario Winans - I Don't Wanna Know (feat. Enya & P. Diddy) (2016 Remaster)_pn.mp3 in service mpd Dec 30 11:56:18 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=23&web=Mario%20Winans/Bad%20Boy%2020th%20Anniversary%20Box%20Set%20Edition/extralarge&path=%2Fmnt%2FUSB%2F1234-5678%2F00's%20R%26B%2FMario%20Winans%20-%20I%20Don't%20Wanna%20Know%20(feat.%20Enya%20%26%20P.%20Diddy)%20(2016%20Remaster)_pn.mp3&metadata=false Dec 30 11:56:18 volumio volumio[1019]: info: URI /mnt/USB/1234-5678/00's R&B/Mario Winans - I Don't Wanna Know (feat. Enya & P. Diddy) (2016 Remaster)_pn.mp3 Dec 30 11:56:18 volumio volumio[1019]: info: No valid Plugin REST Endpoint Dec 30 11:56:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 11:56:20 volumio volumio[1019]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 30 11:56:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 30 11:56:20 volumio volumio[1019]: info: Received Get System Version Dec 30 11:56:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 11:56:20 volumio volumio[1019]: info: Received Get System Info Dec 30 11:56:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 11:56:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 11:56:20 volumio volumio[1019]: info: Discovery: Getting this device information Dec 30 11:56:20 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Dec 30 11:56:20 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 11:56:21 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 11:56:21 volumio volumio[1019]: info: CURURI: artists:// Dec 30 11:56:21 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:25 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:32 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 11:56:32 volumio volumio[1019]: info: CURURI: playlists Dec 30 11:56:32 volumio volumio[1019]: info: Listing playlists Dec 30 11:56:32 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay Dec 30 11:56:32 volumio volumio[1019]: info: CoreStateMachine::play index undefined Dec 30 11:56:32 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 11:56:32 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:32 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer Dec 30 11:56:32 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:32 volumio volumio[1019]: verbose: ControllerMpd::clearAddPlayTracks USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav Dec 30 11:56:32 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 11:56:32 volumio volumio[1019]: info: sendMpdCommand stop took 32 milliseconds Dec 30 11:56:32 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 11:56:32 volumio volumio[1019]: info: Dec 30 11:56:32 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Dec 30 11:56:32 volumio volumio[1019]: info: Ignoring MPD Status Update Dec 30 11:56:32 volumio volumio[1019]: info: sendMpdCommand clear took 14 milliseconds Dec 30 11:56:32 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand add "USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav" Dec 30 11:56:32 volumio volumio[1019]: info: Dec 30 11:56:32 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Dec 30 11:56:32 volumio volumio[1019]: info: Ignoring MPD Status Update Dec 30 11:56:32 volumio volumio[1019]: info: Dec 30 11:56:32 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Dec 30 11:56:32 volumio volumio[1019]: info: Ignoring MPD Status Update Dec 30 11:56:32 volumio volumio[1019]: error: updateQueue error: null Dec 30 11:56:32 volumio volumio[1019]: info: Dec 30 11:56:32 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Dec 30 11:56:32 volumio volumio[1019]: info: Ignoring MPD Status Update Dec 30 11:56:32 volumio volumio[1019]: info: ------------------------------ 32ms Dec 30 11:56:32 volumio volumio[1019]: info: sendMpdCommand add "USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav" took 28 milliseconds Dec 30 11:56:32 volumio volumio[1019]: info: ------------------------------ 28ms Dec 30 11:56:32 volumio volumio[1019]: info: ------------------------------ 26ms Dec 30 11:56:32 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play Dec 30 11:56:32 volumio volumio[1019]: info: Dec 30 11:56:32 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Dec 30 11:56:32 volumio volumio[1019]: info: Ignoring MPD Status Update Dec 30 11:56:32 volumio volumio[1019]: info: Dec 30 11:56:32 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Dec 30 11:56:32 volumio volumio[1019]: info: Ignoring MPD Status Update Dec 30 11:56:32 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:32 volumio volumio[1019]: info: ------------------------------ 28ms Dec 30 11:56:32 volumio volumio[1019]: info: sendMpdCommand play took 17 milliseconds Dec 30 11:56:32 volumio volumio[1019]: info: ------------------------------ 15ms Dec 30 11:56:32 volumio volumio[1019]: info: ------------------------------ 12ms Dec 30 11:56:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 11:56:34 volumio volumio[1019]: info: CURURI: genres:// Dec 30 11:56:34 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:35 volumio volumio[1019]: info: Dec 30 11:56:35 volumio volumio[1019]: ---------------------------- MPD announces state update: player Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::getState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Dec 30 11:56:35 volumio volumio[1019]: info: Dec 30 11:56:35 volumio volumio[1019]: ---------------------------- MPD announces state update: player Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::getState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Dec 30 11:56:35 volumio volumio[1019]: info: Dec 30 11:56:35 volumio volumio[1019]: ---------------------------- MPD announces state update: player Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::getState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand status took 21 milliseconds Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 11:56:35 volumio volumio[1019]: info: Dec 30 11:56:35 volumio volumio[1019]: ---------------------------- MPD announces state update: player Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::getState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Dec 30 11:56:35 volumio volumio[1019]: info: Dec 30 11:56:35 volumio volumio[1019]: ---------------------------- MPD announces state update: player Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::getState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand status took 34 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand status took 32 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand status took 13 milliseconds Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","artist":null,"album":null,"uri":"USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","trackType":"wav"} Dec 30 11:56:35 volumio volumio[1019]: verbose: CURRENT POSITION 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop Dec 30 11:56:35 volumio volumio[1019]: info: ------------------------------ 83ms Dec 30 11:56:35 volumio volumio[1019]: info: Dec 30 11:56:35 volumio volumio[1019]: ---------------------------- MPD announces state update: player Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::getState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand status took 47 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 37 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 37 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand status took 8 milliseconds Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseState Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","artist":null,"album":null,"uri":"USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","trackType":"wav"} Dec 30 11:56:35 volumio volumio[1019]: verbose: CURRENT POSITION 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Dec 30 11:56:35 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","artist":null,"album":null,"uri":"USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","trackType":"wav"} Dec 30 11:56:35 volumio volumio[1019]: verbose: CURRENT POSITION 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Dec 30 11:56:35 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","artist":null,"album":null,"uri":"USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","trackType":"wav"} Dec 30 11:56:35 volumio volumio[1019]: verbose: CURRENT POSITION 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Dec 30 11:56:35 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: ------------------------------ 264ms Dec 30 11:56:35 volumio volumio[1019]: info: ------------------------------ 260ms Dec 30 11:56:35 volumio volumio[1019]: info: ------------------------------ 242ms Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 184 milliseconds Dec 30 11:56:35 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 178 milliseconds Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Dec 30 11:56:35 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":269,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2116 Kbps","isStreaming":false,"title":"2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","artist":null,"album":null,"uri":"USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","trackType":"wav"} Dec 30 11:56:35 volumio volumio[1019]: verbose: CURRENT POSITION 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Dec 30 11:56:35 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: ControllerMpd::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":269,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2116 Kbps","isStreaming":false,"title":"2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","artist":null,"album":null,"uri":"USB/1234-5678/SIKNOW/2 Elvissa - Oh La La La (Dimitri Serrano & Max Remix).wav","trackType":"wav"} Dec 30 11:56:35 volumio volumio[1019]: verbose: CURRENT POSITION 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Dec 30 11:56:35 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: CoreStateMachine::pushState Dec 30 11:56:35 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Dec 30 11:56:35 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Dec 30 11:56:35 volumio volumio[1019]: info: ------------------------------ 330ms Dec 30 11:56:35 volumio volumio[1019]: info: ------------------------------ 287ms Dec 30 11:56:35 volumio volumio[1019]: 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' Dec 30 11:56:36 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 11:56:36 volumio volumio[1019]: info: CURURI: genres://Afro%20Club Dec 30 11:56:36 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:36 volumio volumio[1019]: info: Preload queue cleared Dec 30 11:56:42 volumio volumio[1019]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 11:56:42 volumio volumio[1019]: TypeError: Cannot read properties of null (reading 'slice') Dec 30 11:56:42 volumio volumio[1019]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 30 11:56:42 volumio volumio[1019]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 30 11:56:42 volumio volumio[1019]: at Object.onceWrapper (node:events:629:26) Dec 30 11:56:42 volumio volumio[1019]: at ClientRequest.emit (node:events:514:28) Dec 30 11:56:42 volumio volumio[1019]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Dec 30 11:56:42 volumio volumio[1019]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Dec 30 11:56:42 volumio volumio[1019]: at TLSSocket.socketOnData (node:_http_client:535:22) Dec 30 11:56:42 volumio volumio[1019]: at TLSSocket.emit (node:events:514:28) Dec 30 11:56:42 volumio volumio[1019]: at addChunk (node:internal/streams/readable:343:12) Dec 30 11:56:42 volumio volumio[1019]: at readableAddChunk (node:internal/streams/readable:316:9) Dec 30 11:56:42 volumio volumio[1019]: at Readable.push (node:internal/streams/readable:253:10) Dec 30 11:56:42 volumio volumio[1019]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Dec 30 11:56:42 volumio volumio[1019]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 11:56:43 volumio sudo[2687]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-30 11:55' Dec 30 11:56:43 volumio sudo[2687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"