-- Logs begin at Fri 2026-08-28 22:43:00 HKT, end at Fri 2026-08-28 22:55:36 HKT. -- Aug 28 22:54:31 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Aug 28 22:54:31 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:31 volumio volumio[1067]: info: Prefetching next song Aug 28 22:54:31 volumio volumio[1067]: info: DOING PREFETCH IN MPD Aug 28 22:54:31 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand add "NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff" Aug 28 22:54:31 volumio volumio[1067]: info: sendMpdCommand add "NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff" took 1 milliseconds Aug 28 22:54:31 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 28 22:54:31 volumio volumio[1067]: info: Aug 28 22:54:31 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Aug 28 22:54:31 volumio volumio[1067]: info: Ignoring MPD Status Update Aug 28 22:54:31 volumio volumio[1067]: info: Aug 28 22:54:31 volumio volumio[1067]: ---------------------------- MPD announces state update: options Aug 28 22:54:31 volumio volumio[1067]: info: sendMpdCommand consume 1 took 1 milliseconds Aug 28 22:54:31 volumio volumio[1067]: info: ControllerMpd::getState Aug 28 22:54:31 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:54:31 volumio volumio[1067]: info: ------------------------------ 2ms Aug 28 22:54:31 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds Aug 28 22:54:31 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:54:31 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:54:31 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 28 22:54:31 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:54:31 volumio volumio[1067]: info: ControllerMpd::pushState Aug 28 22:54:31 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Aug 28 22:54:31 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Aug 28 22:54:31 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":149547,"duration":154,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"04 - The Jing Ying Soloists - Love Song Of The Grassland.dff","artist":null,"album":null,"uri":"NAS/DSD/丝竹管弦/04 - The Jing Ying Soloists - Love Song Of The Grassland.dff","trackType":"dff"} Aug 28 22:54:31 volumio volumio[1067]: verbose: CURRENT POSITION 0 Aug 28 22:54:31 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play Aug 28 22:54:31 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:54:31 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload Aug 28 22:54:31 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:31 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Aug 28 22:54:31 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:54:31 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:31 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:31 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Aug 28 22:54:31 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:31 volumio volumio[1067]: info: ------------------------------ 19ms Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::startPlaybackTimer Aug 28 22:54:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:35 volumio volumio[1067]: info: Aug 28 22:54:35 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Aug 28 22:54:35 volumio volumio[1067]: info: Ignoring MPD Status Update Aug 28 22:54:35 volumio volumio[1067]: info: Aug 28 22:54:35 volumio volumio[1067]: ---------------------------- MPD announces state update: player Aug 28 22:54:35 volumio volumio[1067]: info: ControllerMpd::getState Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:54:35 volumio volumio[1067]: info: Aug 28 22:54:35 volumio volumio[1067]: ---------------------------- MPD announces state update: player Aug 28 22:54:35 volumio volumio[1067]: info: ------------------------------ 2ms Aug 28 22:54:35 volumio volumio[1067]: info: sendMpdCommand status took 2 milliseconds Aug 28 22:54:35 volumio volumio[1067]: info: ControllerMpd::getState Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:54:35 volumio volumio[1067]: info: sendMpdCommand status took 3 milliseconds Aug 28 22:54:35 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:54:35 volumio volumio[1067]: info: ControllerMpd::pushState Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Aug 28 22:54:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:35 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":336,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","artist":null,"album":null,"uri":"NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","trackType":"dff"} Aug 28 22:54:35 volumio volumio[1067]: verbose: CURRENT POSITION 1 Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:54:35 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:35 volumio volumio[1067]: info: ------------------------------ 18ms Aug 28 22:54:35 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 15 milliseconds Aug 28 22:54:35 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:54:35 volumio volumio[1067]: info: ControllerMpd::pushState Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Aug 28 22:54:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:35 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":336,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","artist":null,"album":null,"uri":"NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","trackType":"dff"} Aug 28 22:54:35 volumio volumio[1067]: verbose: CURRENT POSITION 1 Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:54:35 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:35 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:35 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:35 volumio volumio[1067]: info: ------------------------------ 32ms Aug 28 22:54:36 volumio volumio[1067]: info: Setting Volume to 100 automatically for DSD Aug 28 22:54:36 volumio volumio[1067]: info: VolumeController::SetAlsaVolume100 Aug 28 22:54:36 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:36 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:54:36 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:36 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:36 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:54:36 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:40 volumio volumio[1067]: 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: 8 Aug 28 22:54:40 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Aug 28 22:54:40 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:43 volumio volumio[1067]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.139 UA: Mozilla/5.0 (Linux; Android 11; SM-G9880 Build/RP1A.200720.012; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.91 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Aug 28 22:54:43 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 22:54:43 volumio volumio[1067]: info: Received Get System Info Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 22:54:43 volumio volumio[1067]: info: Discovery: Getting this device information Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Aug 28 22:54:43 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Aug 28 22:54:43 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:43 volumio volumio[1067]: info: Listing playlists Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue Aug 28 22:54:43 volumio volumio[1067]: info: CoreStateMachine::getQueue Aug 28 22:54:43 volumio volumio[1067]: info: CorePlayQueue::getQueue Aug 28 22:54:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:54:51 volumio volumio[1067]: info: Retrieving Cloud Streaming UI Aug 28 22:54:51 volumio volumio[1067]: info: Getting Tidal Cloud Configuration Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:54:51 volumio volumio[1067]: info: Getting Qobuz Cloud Configuration Aug 28 22:54:51 volumio volumio[1067]: info: Asking plugin for UI Config Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:54:51 volumio volumio[1067]: info: Getting Spotify Cloud Configuration Aug 28 22:54:51 volumio volumio[1067]: info: Asking plugin for UI Config Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:54:51 volumio volumio[1067]: info: Saving Spotify Acccount Aug 28 22:54:51 volumio volumio[1067]: info: Got Tidal Cloud Configuration Aug 28 22:54:51 volumio volumio[1067]: info: Got it Aug 28 22:54:51 volumio volumio[1067]: info: Got it Aug 28 22:54:51 volumio volumio[1067]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:54:51 volumio volumio[1067]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources Aug 28 22:54:51 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources Aug 28 22:54:52 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:54:52 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 28 22:54:55 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Aug 28 22:54:55 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand rescan Aug 28 22:54:55 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:54:55 volumio volumio[1067]: info: Aug 28 22:54:55 volumio volumio[1067]: ---------------------------- MPD announces state update: update Aug 28 22:54:55 volumio volumio[1067]: info: sendMpdCommand rescan took 1 milliseconds Aug 28 22:54:55 volumio volumio[1067]: info: ControllerMpd::getState Aug 28 22:54:55 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:54:55 volumio volumio[1067]: info: sendMpdCommand status took 1 milliseconds Aug 28 22:54:55 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:54:55 volumio volumio[1067]: info: Command Router : Notfying DB Updatetrue Aug 28 22:54:55 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent Aug 28 22:54:55 volumio volumio[1067]: info: sendMpdCommand status took 21 milliseconds Aug 28 22:54:55 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:54:55 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:54:55 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 28 22:54:55 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:54:55 volumio volumio[1067]: info: ControllerMpd::pushState Aug 28 22:54:55 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Aug 28 22:54:55 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:55 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19072,"duration":336,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","artist":null,"album":null,"uri":"NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","trackType":"dff"} Aug 28 22:54:55 volumio volumio[1067]: verbose: CURRENT POSITION 1 Aug 28 22:54:55 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play Aug 28 22:54:55 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:54:55 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload Aug 28 22:54:55 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:55 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:55 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:54:55 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:55 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:54:55 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:54:55 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:54:55 volumio volumio[1067]: info: ------------------------------ 39ms Aug 28 22:54:56 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:55:00 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:55:04 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:55:08 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:55:12 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:55:16 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:55:20 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 28 22:55:27 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 28 22:55:28 volumio volumio[1067]: info: MPD Database updated - AlbumList cache refreshed Aug 28 22:55:28 volumio volumio[1067]: info: Aug 28 22:55:28 volumio volumio[1067]: ---------------------------- MPD announces state update: database Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:55:28 volumio volumio[1067]: info: Aug 28 22:55:28 volumio volumio[1067]: ---------------------------- MPD announces state update: update Aug 28 22:55:28 volumio volumio[1067]: info: ControllerMpd::getState Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:55:28 volumio volumio[1067]: info: ControllerMpd::getState Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:55:28 volumio volumio[1067]: info: sendMpdCommand status took 59 milliseconds Aug 28 22:55:28 volumio volumio[1067]: info: sendMpdCommand status took 59 milliseconds Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:55:28 volumio volumio[1067]: info: Command Router : Notfying DB Updatefalse Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:55:28 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 28 22:55:28 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:55:28 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:55:28 volumio volumio[1067]: info: ControllerMpd::pushState Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Aug 28 22:55:28 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:28 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52135,"duration":336,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","artist":null,"album":null,"uri":"NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","trackType":"dff"} Aug 28 22:55:28 volumio volumio[1067]: verbose: CURRENT POSITION 1 Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:55:28 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:55:28 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:55:28 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:55:28 volumio volumio[1067]: info: ControllerMpd::pushState Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Aug 28 22:55:28 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:28 volumio volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52135,"duration":336,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","artist":null,"album":null,"uri":"NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","trackType":"dff"} Aug 28 22:55:28 volumio volumio[1067]: verbose: CURRENT POSITION 1 Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::syncState stateService play Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus play Aug 28 22:55:28 volumio volumio[1067]: info: Received an update from plugin. extracting info from payload Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:55:28 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:55:28 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:55:28 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:28 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:55:28 volumio volumio[1067]: info: ------------------------------ 132ms Aug 28 22:55:28 volumio volumio[1067]: info: ------------------------------ 132ms Aug 28 22:55:35 volumio volumio[1067]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 28 22:55:35 volumio volumio[1067]: info: Preparing to save Alsa Options, stopping services first Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Aug 28 22:55:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::volumioPause Aug 28 22:55:35 volumio volumio[1067]: info: CoreStateMachine::pause Aug 28 22:55:35 volumio volumio[1067]: info: CoreStateMachine::stPlaybackTimer Aug 28 22:55:35 volumio volumio[1067]: info: CoreStateMachine::servicePause Aug 28 22:55:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::servicePause Aug 28 22:55:35 volumio volumio[1067]: info: ControllerMpd::pause Aug 28 22:55:35 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand pause Aug 28 22:55:35 volumio volumio[1067]: info: Saving Audio Output to: {"output_device":{"value":"7","label":"Dummy"}} Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 22:55:35 volumio volumio[1067]: info: Setting default mixerSoftMaster for Softvolume device Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 28 22:55:35 volumio volumio[1067]: info: Updating Volume Controller Parameters: Device: 7 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 28 22:55:35 volumio volumio[1067]: info: Disabling external Volume Control Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 22:55:35 volumio volumio[1067]: info: Enable softmixer device for audio device undefined Aug 28 22:55:35 volumio volumio[1067]: info: Aug 28 22:55:35 volumio volumio[1067]: ---------------------------- MPD announces state update: player Aug 28 22:55:35 volumio volumio[1067]: info: sendMpdCommand pause took 123 milliseconds Aug 28 22:55:35 volumio volumio[1067]: info: ControllerMpd::getState Aug 28 22:55:35 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Aug 28 22:55:35 volumio volumio[1067]: info: sendMpdCommand status took 5 milliseconds Aug 28 22:55:35 volumio volumio[1067]: verbose: ControllerMpd::parseState Aug 28 22:55:35 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 22:55:35 volumio volumio[1067]: info: Software Volume ALSA configuration written Aug 28 22:55:35 volumio volumio[1067]: info: Preparing to generate the ALSA configuration file Aug 28 22:55:35 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 28 22:55:35 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Aug 28 22:55:35 volumio volumio[1067]: info: ControllerMpd::pushState Aug 28 22:55:35 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Aug 28 22:55:35 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:35 volumio volumio[1067]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":59972,"duration":336,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","artist":null,"album":null,"uri":"NAS/DSD/丝竹管弦/14 - The Jing Ying Soloists - Variation On Yang City Tune.dff","trackType":"dff"} Aug 28 22:55:36 volumio volumio[1067]: verbose: CURRENT POSITION 1 Aug 28 22:55:36 volumio volumio[1067]: info: CoreStateMachine::syncState stateService pause Aug 28 22:55:36 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus pause Aug 28 22:55:36 volumio volumio[1067]: info: CoreStateMachine::pushState Aug 28 22:55:36 volumio volumio[1067]: info: CorePlayQueue::getTrack 1 Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Aug 28 22:55:36 volumio volumio[1067]: info: CoreStateMachine::stPlaybackTimer Aug 28 22:55:36 volumio volumio[1067]: info: ------------------------------ 21ms Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 28 22:55:36 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 28 22:55:36 volumio volumio[1067]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Aug 28 22:55:36 volumio volumio[1067]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Aug 28 22:55:36 volumio volumio[1067]: info: Reading ALSA contributions from plugins. Aug 28 22:55:36 volumio volumio[1067]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 22:55:36 volumio volumio[1067]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Aug 28 22:55:36 volumio volumio[1067]: at Object.readdirSync (fs.js:1048:3) Aug 28 22:55:36 volumio volumio[1067]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Aug 28 22:55:36 volumio volumio[1067]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Aug 28 22:55:36 volumio volumio[1067]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Aug 28 22:55:36 volumio volumio[1067]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Aug 28 22:55:36 volumio volumio[1067]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Aug 28 22:55:36 volumio volumio[1067]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Aug 28 22:55:36 volumio volumio[1067]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Aug 28 22:55:36 volumio volumio[1067]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Aug 28 22:55:36 volumio volumio[1067]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Aug 28 22:55:36 volumio volumio[1067]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Aug 28 22:55:36 volumio volumio[1067]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Aug 28 22:55:36 volumio volumio[1067]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Aug 28 22:55:36 volumio volumio[1067]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Aug 28 22:55:36 volumio volumio[1067]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Aug 28 22:55:36 volumio volumio[1067]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Aug 28 22:55:36 volumio volumio[1067]: errno: -20, Aug 28 22:55:36 volumio volumio[1067]: syscall: 'scandir', Aug 28 22:55:36 volumio volumio[1067]: code: 'ENOTDIR', Aug 28 22:55:36 volumio volumio[1067]: path: '/tmp/peppyrunning' Aug 28 22:55:36 volumio volumio[1067]: } Aug 28 22:55:36 volumio volumio[1067]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 22:55:36 volumio sudo[5078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-28 22:54 Aug 28 22:55:36 volumio sudo[5078]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"