-- Logs begin at Thu 2025-06-12 11:13:01 CST, end at Thu 2025-06-12 11:27:47 CST. -- Jun 12 11:26:06 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:06 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:11 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:11 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:13 volumiosurfacep4i5 volumio[874]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 12 11:26:13 volumiosurfacep4i5 volumio[874]: info: Retrying Login Due to Network Error Jun 12 11:26:18 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:18 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:23 volumiosurfacep4i5 volumio[874]: info: MyVolumio login type: Token Jun 12 11:26:26 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:26 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:30 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:30 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:41 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:41 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:42 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:42 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:53 volumiosurfacep4i5 volumio[874]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 12 11:26:53 volumiosurfacep4i5 volumio[874]: info: Retrying Login Due to Network Error Jun 12 11:26:54 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:54 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: Discovery: Getting this device information Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: verbose: New Socket.io Connection to 192.168.2.150:3000 from 192.168.2.26 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:56 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:26:58 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:26:58 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:01 volumiosurfacep4i5 sudo[5697]: volumio : unable to resolve host volumiosurfacep4i5 Jun 12 11:27:01 volumiosurfacep4i5 sudo[5697]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 12 11:27:01 volumiosurfacep4i5 sudo[5697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 11:27:01 volumiosurfacep4i5 sudo[5697]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 11:27:01 volumiosurfacep4i5 sudo[5699]: volumio : unable to resolve host volumiosurfacep4i5 Jun 12 11:27:01 volumiosurfacep4i5 sudo[5699]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 12 11:27:01 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 11:27:01 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 11:27:01 volumiosurfacep4i5 volumio[874]: info: Discovery: Getting this device information Jun 12 11:27:01 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:01 volumiosurfacep4i5 sudo[5699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 11:27:01 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:01 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 11:27:01 volumiosurfacep4i5 sudo[5699]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 11:27:01 volumiosurfacep4i5 sudo[5697]: pam_unix(sudo:session): session closed for user root Jun 12 11:27:01 volumiosurfacep4i5 sudo[5699]: pam_unix(sudo:session): session closed for user root Jun 12 11:27:01 volumiosurfacep4i5 volumio[874]: verbose: New Socket.io Connection to 192.168.2.150 from 192.168.2.26 UA: Mozilla/5.0 (Linux; Android 13; 21091116C Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 12 11:27:02 volumiosurfacep4i5 sudo[5705]: volumio : unable to resolve host volumiosurfacep4i5 Jun 12 11:27:02 volumiosurfacep4i5 sudo[5705]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 12 11:27:02 volumiosurfacep4i5 sudo[5707]: volumio : unable to resolve host volumiosurfacep4i5 Jun 12 11:27:02 volumiosurfacep4i5 sudo[5707]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 12 11:27:02 volumiosurfacep4i5 sudo[5705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 11:27:02 volumiosurfacep4i5 sudo[5707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 11:27:02 volumiosurfacep4i5 sudo[5707]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 11:27:02 volumiosurfacep4i5 sudo[5705]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 11:27:02 volumiosurfacep4i5 sudo[5707]: pam_unix(sudo:session): session closed for user root Jun 12 11:27:02 volumiosurfacep4i5 sudo[5705]: pam_unix(sudo:session): session closed for user root Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: verbose: New Socket.io Connection to 192.168.2.150 from 192.168.2.26 UA: Mozilla/5.0 (Linux; Android 13; 21091116C Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetVisibleSources Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: Received Get System Info Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: Discovery: Getting this device information Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: Listing playlists Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 12 11:27:02 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: MyVolumio login type: Token Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: Received Get System Info Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: Discovery: Getting this device information Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 11:27:03 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 12 11:27:06 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:06 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Retrieving Cloud Streaming UI Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Getting Tidal Cloud Configuration Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Getting Qobuz Cloud Configuration Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Asking plugin for UI Config Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Getting Spotify Cloud Configuration Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Asking plugin for UI Config Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Saving Spotify Acccount Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Got Tidal Cloud Configuration Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Got it Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: Got it Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetBrowseSources Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetBrowseSources Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetBrowseSources Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 12 11:27:10 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 12 11:27:11 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:11 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:12 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 12 11:27:14 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetQueue Jun 12 11:27:14 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::getQueue Jun 12 11:27:14 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getQueue Jun 12 11:27:16 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 12 11:27:16 volumiosurfacep4i5 volumio[874]: info: CURURI: music-library Jun 12 11:27:16 volumiosurfacep4i5 volumio[874]: info: Preload queue cleared Jun 12 11:27:18 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:18 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:20 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 12 11:27:20 volumiosurfacep4i5 volumio[874]: info: CURURI: music-library/INTERNAL Jun 12 11:27:20 volumiosurfacep4i5 volumio[874]: info: Preload queue cleared Jun 12 11:27:20 volumiosurfacep4i5 volumio[874]: info: Preloading song: music-library/INTERNAL/王菲 世界赠予我的.mp3 Jun 12 11:27:20 volumiosurfacep4i5 volumio[874]: info: Exploding uri music-library/INTERNAL/王菲 世界赠予我的.mp3 in service mpd Jun 12 11:27:20 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=%E7%8E%8B%E8%8F%B2//extralarge&path=%2Fmnt%2FINTERNAL%2F%E7%8E%8B%E8%8F%B2%20%E4%B8%96%E7%95%8C%E8%B5%A0%E4%BA%88%E6%88%91%E7%9A%84.mp3&metadata=false Jun 12 11:27:20 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/王菲 世界赠予我的.mp3 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Preload queue cleared Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::ClearQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::stop Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::clearPlayQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::saveQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPushQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::addQueueItems Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::addQueueItems Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Preload queue cleared Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Adding Item to queue: music-library/INTERNAL/王菲 世界赠予我的.mp3 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Using cached record of: music-library/INTERNAL/王菲 世界赠予我的.mp3 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPushQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::saveQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::updateTrackBlock Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrackBlock Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPlay Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::play index 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::addQueueItems Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::addQueueItems Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Preload queue cleared Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Adding Item to queue: music-library/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦) Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Exploding uri music-library/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦) in service mpd Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::stop Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::play index undefined Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::startPlaybackTimer Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/王菲 世界赠予我的.mp3 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F01.Going%20Home.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/01.Going Home.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F02.Scarborough%20Fair.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/02.Scarborough Fair.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F03.Amazing%20Grace.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/03.Amazing Grace.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F04.Es%20Waren%20Zwei%20Koningskinder.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/04.Es Waren Zwei Koningskinder.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F05.Paintings.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/05.Paintings.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F06.Abide%20With%20Me.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/06.Abide With Me.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F07.Yosaku.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/07.Yosaku.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F08.Careless%20Love.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/08.Careless Love.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F09.When%20Irish%20Eyes%20Are%20Smiling.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/09.When Irish Eyes Are Smiling.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F10.The%20Rose%20Of%20Tralee.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/10.The Rose Of Tralee.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F11.The%20Londonderry%20Air.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/11.The Londonderry Air.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F12.Country%20Train.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/12.Country Train.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ALBUMART /albumart?cacheid=172&web=James%20Last/Romantic%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FJames%20Last%20-%E3%80%8ARomantic%20Dreams%E3%80%8B(%E6%B5%AA%E6%BC%AB%E4%B9%8B%E6%A2%A6)%2F13.Cockles%20And%20Mussels.ape&metadata=false Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: URI /mnt/INTERNAL/James Last -《Romantic Dreams》(浪漫之梦)/13.Cockles And Mussels.ape Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand stop took 4 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPushQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::saveQueue Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::updateTrackBlock Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrackBlock Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: ---------------------------- MPD announces system playlist update Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Ignoring MPD Status Update Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand clear took 6 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/王菲 世界赠予我的.mp3" Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: Upnp client error: Error: This socket has been ended by the other party Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: error: updateQueue error: null Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: ---------------------------- MPD announces system playlist update Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Ignoring MPD Status Update Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ------------------------------ 2ms Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand add "INTERNAL/王菲 世界赠予我的.mp3" took 2 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand play Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: error: Upnp client error: Error: This socket has been ended by the other party Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ------------------------------ 1ms Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand play took 1 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: ---------------------------- MPD announces state update: player Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ControllerMpd::getState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand status Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: ---------------------------- MPD announces state update: player Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand status took 23 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ControllerMpd::getState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand status Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::parseState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand status took 1 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::parseState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::parseTrackInfo Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ControllerMpd::pushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::servicePushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"世界贈予我的【高音質】","artist":"王菲","album":null,"uri":"INTERNAL/王菲 世界赠予我的.mp3","trackType":"mp3"} Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: CURRENT POSITION 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::syncState stateService play Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::syncState currentStatus stop Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ------------------------------ 26ms Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::parseTrackInfo Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ControllerMpd::pushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::servicePushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":241,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"世界贈予我的【高音質】","artist":"王菲","album":null,"uri":"INTERNAL/王菲 世界赠予我的.mp3","trackType":"mp3"} Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: verbose: CURRENT POSITION 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::syncState stateService play Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::syncState currentStatus play Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: Received an update from plugin. extracting info from payload Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::pushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::pushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPushState Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: info: ------------------------------ 12ms Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/a5eb3fee-50d1-4101-b63d-7bd68f6f8cd0.jpg' Jun 12 11:27:23 volumiosurfacep4i5 volumio[874]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/a5eb3fee-50d1-4101-b63d-7bd68f6f8cd0.jpg' Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: Discovery: Getting this device information Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:26 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:30 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:30 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:30 volumiosurfacep4i5 volumio[874]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jun 12 11:27:30 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:30 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:33 volumiosurfacep4i5 volumio[874]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 12 11:27:33 volumiosurfacep4i5 volumio[874]: info: Retrying Login Due to Network Error Jun 12 11:27:34 volumiosurfacep4i5 volumio[874]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jun 12 11:27:34 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:34 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:34 volumiosurfacep4i5 volumio[874]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/a5eb3fee-50d1-4101-b63d-7bd68f6f8cd0.jpg' Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: Invalid card number. Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 12 11:27:38 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 12 11:27:41 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:41 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:43 volumiosurfacep4i5 volumio[874]: info: MyVolumio login type: Token Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Preparing to save Alsa Options, stopping services first Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioGetState Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::pause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::stPlaybackTimer Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::servicePause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::servicePause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: ControllerMpd::pause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand pause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Saving Audio Output to: {"output_device":{"value":"0,0","label":"Analog Out"}} Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Found match in Cards Database: setting mixer for card Analog Out Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Setting mixer Master for card Analog Out Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Updating Volume Controller Parameters: Device: 0,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Disabling external Volume Control Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Preparing to generate the ALSA configuration file Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Reading ALSA contributions from plugins. Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: ---------------------------- MPD announces state update: player Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand pause took 75 milliseconds Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: ControllerMpd::getState Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand status Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand status took 9 milliseconds Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::parseState Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: verbose: ControllerMpd::parseTrackInfo Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: ControllerMpd::pushState Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::servicePushState Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":24405,"duration":241,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"世界贈予我的【高音質】","artist":"王菲","album":null,"uri":"INTERNAL/王菲 世界赠予我的.mp3","trackType":"mp3"} Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: verbose: CURRENT POSITION 0 Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::syncState stateService pause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::syncState currentStatus pause Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::pushState Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CorePlayQueue::getTrack 0 Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::volumioPushState Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreStateMachine::stPlaybackTimer Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: ------------------------------ 20ms Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Object.readdirSync (fs.js:1048:3) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: errno: -20, Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: syscall: 'scandir', Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: code: 'ENOTDIR', Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: path: '/tmp/peppyrunning' Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: } Jun 12 11:27:47 volumiosurfacep4i5 volumio[874]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 11:27:47 volumiosurfacep4i5 sudo[5940]: volumio : unable to resolve host volumiosurfacep4i5 Jun 12 11:27:47 volumiosurfacep4i5 sudo[5940]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 12 11:27:47 volumiosurfacep4i5 sudo[5940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-12 11:26 Jun 12 11:27:47 volumiosurfacep4i5 sudo[5940]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"