Dec 10 20:20:16 volumio volumio[1460]: info: CoreCommandRouter::volumioGetState Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:20:21 volumio volumio[1460]: info: Retrieving Cloud Streaming UI Dec 10 20:20:21 volumio volumio[1460]: info: Getting Tidal Cloud Configuration Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:20:21 volumio volumio[1460]: info: Getting Qobuz Cloud Configuration Dec 10 20:20:21 volumio volumio[1460]: info: Asking plugin for UI Config Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:20:21 volumio volumio[1460]: info: Getting Spotify Cloud Configuration Dec 10 20:20:21 volumio volumio[1460]: info: Asking plugin for UI Config Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:20:21 volumio volumio[1460]: info: Saving Spotify Acccount Dec 10 20:20:21 volumio volumio[1460]: info: Got Tidal Cloud Configuration Dec 10 20:20:21 volumio volumio[1460]: info: Got it Dec 10 20:20:21 volumio volumio[1460]: info: Got it Dec 10 20:20:21 volumio volumio[1460]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 20:20:21 volumio volumio[1460]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::volumioGetBrowseSources Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::volumioGetBrowseSources Dec 10 20:20:21 volumio volumio[1460]: info: CoreCommandRouter::volumioGetBrowseSources Dec 10 20:20:22 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 20:20:22 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand rescan Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:20:23 volumio volumio[1460]: info: Dec 10 20:20:23 volumio volumio[1460]: ---------------------------- MPD announces state update: update Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand rescan took 1 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: ControllerMpd::getState Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:20:23 volumio volumio[1460]: info: Dec 10 20:20:23 volumio volumio[1460]: ---------------------------- MPD announces state update: update Dec 10 20:20:23 volumio volumio[1460]: info: ControllerMpd::getState Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:20:23 volumio volumio[1460]: info: Dec 10 20:20:23 volumio volumio[1460]: ---------------------------- MPD announces state update: update Dec 10 20:20:23 volumio volumio[1460]: info: ControllerMpd::getState Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand status took 3 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand status took 2 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand status took 2 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand status took 1 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand status took 1 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand status took 0 milliseconds Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:20:23 volumio volumio[1460]: info: Command Router : Notfying DB Updatetrue Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:20:23 volumio volumio[1460]: info: Command Router : Notfying DB Updatetrue Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::Close All Modals sent Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:20:23 volumio volumio[1460]: info: Command Router : Notfying DB Updatetrue Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::Close All Modals sent Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 10 20:20:23 volumio volumio[1460]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:20:23 volumio volumio[1460]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:20:23 volumio volumio[1460]: info: ControllerMpd::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::servicePushState Dec 10 20:20:23 volumio volumio[1460]: info: CorePlayQueue::getTrack 1 Dec 10 20:20:23 volumio volumio[1460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":213763,"duration":291,"samplerate":44.1,"bitdepth":"32 bit","channels":7,"random":false,"updatedb":true,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"27.wav","artist":null,"album":null,"uri":"http://10.0.0.80:8200/MediaItems/27.wav","trackType":"wav"} Dec 10 20:20:23 volumio volumio[1460]: verbose: CURRENT POSITION 1 Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::syncState stateService play Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:20:23 volumio volumio[1460]: info: Received an update from plugin. extracting info from payload Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:20:23 volumio volumio[1460]: info: ControllerMpd::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::servicePushState Dec 10 20:20:23 volumio volumio[1460]: info: CorePlayQueue::getTrack 1 Dec 10 20:20:23 volumio volumio[1460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":213763,"duration":291,"samplerate":44.1,"bitdepth":"32 bit","channels":7,"random":false,"updatedb":true,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"27.wav","artist":null,"album":null,"uri":"http://10.0.0.80:8200/MediaItems/27.wav","trackType":"wav"} Dec 10 20:20:23 volumio volumio[1460]: verbose: CURRENT POSITION 1 Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::syncState stateService play Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:20:23 volumio volumio[1460]: info: Received an update from plugin. extracting info from payload Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:20:23 volumio volumio[1460]: info: ControllerMpd::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::servicePushState Dec 10 20:20:23 volumio volumio[1460]: info: CorePlayQueue::getTrack 1 Dec 10 20:20:23 volumio volumio[1460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":213763,"duration":291,"samplerate":44.1,"bitdepth":"32 bit","channels":7,"random":false,"updatedb":true,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"27.wav","artist":null,"album":null,"uri":"http://10.0.0.80:8200/MediaItems/27.wav","trackType":"wav"} Dec 10 20:20:23 volumio volumio[1460]: verbose: CURRENT POSITION 1 Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::syncState stateService play Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:20:23 volumio volumio[1460]: info: Received an update from plugin. extracting info from payload Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:20:23 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:20:23 volumio volumio[1460]: info: ------------------------------ 81ms Dec 10 20:20:23 volumio volumio[1460]: info: ------------------------------ 80ms Dec 10 20:20:23 volumio volumio[1460]: info: ------------------------------ 79ms Dec 10 20:20:26 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 20:20:30 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 10 20:20:33 volumio volumio[1460]: info: CoreCommandRouter::volumioGetState Dec 10 20:20:41 volumio volumio[1460]: info: CoreCommandRouter::volumioGetState Dec 10 20:20:52 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 10 20:20:52 volumio volumio[1460]: info: Preload queue cleared Dec 10 20:21:28 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 10 20:21:28 volumio volumio[1460]: info: CURURI: music-library Dec 10 20:21:28 volumio volumio[1460]: info: Preload queue cleared Dec 10 20:21:32 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 10 20:21:32 volumio volumio[1460]: info: CURURI: music-library/NAS Dec 10 20:21:32 volumio volumio[1460]: info: Preload queue cleared Dec 10 20:21:33 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 10 20:21:33 volumio volumio[1460]: info: CURURI: music-library/NAS/NAS Dec 10 20:21:33 volumio volumio[1460]: error: Failed LSINFO: null Dec 10 20:21:34 volumio volumio[1460]: info: Preload queue cleared Dec 10 20:21:37 volumio volumio[1460]: info: CorePlayQueue::getTrack 1 Dec 10 20:21:37 volumio volumio[1460]: info: CorePlayQueue::getTrack 2 Dec 10 20:21:37 volumio volumio[1460]: info: Prefetching next song Dec 10 20:21:37 volumio volumio[1460]: info: Doing Prefetch in UPNP Dec 10 20:21:37 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand add "http://10.0.0.80:8200/MediaItems/28.wav" Dec 10 20:21:37 volumio volumio[1460]: info: Dec 10 20:21:37 volumio volumio[1460]: ---------------------------- MPD announces system playlist update Dec 10 20:21:37 volumio volumio[1460]: info: Ignoring MPD Status Update Dec 10 20:21:37 volumio volumio[1460]: info: sendMpdCommand add "http://10.0.0.80:8200/MediaItems/28.wav" took 1 milliseconds Dec 10 20:21:37 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 10 20:21:37 volumio volumio[1460]: info: Dec 10 20:21:37 volumio volumio[1460]: ---------------------------- MPD announces system playlist update Dec 10 20:21:37 volumio volumio[1460]: info: Ignoring MPD Status Update Dec 10 20:21:37 volumio volumio[1460]: info: Dec 10 20:21:37 volumio volumio[1460]: ---------------------------- MPD announces system playlist update Dec 10 20:21:37 volumio volumio[1460]: info: Ignoring MPD Status Update Dec 10 20:21:37 volumio volumio[1460]: info: ------------------------------ 1ms Dec 10 20:21:37 volumio volumio[1460]: info: sendMpdCommand consume 1 took 1 milliseconds Dec 10 20:21:37 volumio volumio[1460]: info: ------------------------------ 1ms Dec 10 20:21:37 volumio volumio[1460]: info: ------------------------------ 1ms Dec 10 20:21:39 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 10 20:21:39 volumio volumio[1460]: info: CURURI: music-library/INTERNAL Dec 10 20:21:39 volumio volumio[1460]: info: Preload queue cleared Dec 10 20:21:39 volumio volumio[1460]: info: Preloading song: music-library/INTERNAL/雷婷-监听终极版(黄金黑胶)CD1.ape Dec 10 20:21:39 volumio volumio[1460]: info: Preloading song: music-library/INTERNAL/01. 加州旅馆.wav Dec 10 20:21:39 volumio volumio[1460]: info: Exploding uri music-library/INTERNAL/雷婷-监听终极版(黄金黑胶)CD1.ape in service mpd Dec 10 20:21:39 volumio volumio[1460]: info: ALBUMART /albumart?cacheid=42&web=//extralarge&path=%2Fmnt%2FINTERNAL%2F%E9%9B%B7%E5%A9%B7-%E7%9B%91%E5%90%AC%E7%BB%88%E6%9E%81%E7%89%88(%E9%BB%84%E9%87%91%E9%BB%91%E8%83%B6)CD1.ape&metadata=false Dec 10 20:21:39 volumio volumio[1460]: info: URI /mnt/INTERNAL/雷婷-监听终极版(黄金黑胶)CD1.ape Dec 10 20:21:39 volumio volumio[1460]: info: Exploding uri music-library/INTERNAL/01. 加州旅馆.wav in service mpd Dec 10 20:21:39 volumio volumio[1460]: info: ALBUMART /albumart?cacheid=42&web=//extralarge&path=%2Fmnt%2FINTERNAL%2F01.%20%E5%8A%A0%E5%B7%9E%E6%97%85%E9%A6%86.wav&metadata=false Dec 10 20:21:39 volumio volumio[1460]: info: URI /mnt/INTERNAL/01. 加州旅馆.wav Dec 10 20:21:41 volumio volumio[1460]: info: Dec 10 20:21:41 volumio volumio[1460]: ---------------------------- MPD announces system playlist update Dec 10 20:21:41 volumio volumio[1460]: info: Ignoring MPD Status Update Dec 10 20:21:41 volumio volumio[1460]: info: Dec 10 20:21:41 volumio volumio[1460]: ---------------------------- MPD announces state update: player Dec 10 20:21:41 volumio volumio[1460]: info: ControllerMpd::getState Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:21:41 volumio volumio[1460]: info: Dec 10 20:21:41 volumio volumio[1460]: ---------------------------- MPD announces system playlist update Dec 10 20:21:41 volumio volumio[1460]: info: Ignoring MPD Status Update Dec 10 20:21:41 volumio volumio[1460]: info: Dec 10 20:21:41 volumio volumio[1460]: ---------------------------- MPD announces state update: player Dec 10 20:21:41 volumio volumio[1460]: info: ControllerMpd::getState Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:21:41 volumio volumio[1460]: info: Dec 10 20:21:41 volumio volumio[1460]: ---------------------------- MPD announces system playlist update Dec 10 20:21:41 volumio volumio[1460]: info: Ignoring MPD Status Update Dec 10 20:21:41 volumio volumio[1460]: info: Dec 10 20:21:41 volumio volumio[1460]: ---------------------------- MPD announces state update: player Dec 10 20:21:41 volumio volumio[1460]: info: ControllerMpd::getState Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand status Dec 10 20:21:41 volumio volumio[1460]: info: ------------------------------ 2ms Dec 10 20:21:41 volumio volumio[1460]: info: sendMpdCommand status took 1 milliseconds Dec 10 20:21:41 volumio volumio[1460]: info: ------------------------------ 1ms Dec 10 20:21:41 volumio volumio[1460]: info: sendMpdCommand status took 1 milliseconds Dec 10 20:21:41 volumio volumio[1460]: info: ------------------------------ 1ms Dec 10 20:21:41 volumio volumio[1460]: info: sendMpdCommand status took 0 milliseconds Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::parseState Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 20:21:41 volumio volumio[1460]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 10 20:21:41 volumio volumio[1460]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 10 20:21:41 volumio volumio[1460]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:21:41 volumio volumio[1460]: verbose: ControllerMpd::parseTrackInfo Dec 10 20:21:41 volumio volumio[1460]: info: ControllerMpd::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::servicePushState Dec 10 20:21:41 volumio volumio[1460]: info: CorePlayQueue::getTrack 1 Dec 10 20:21:41 volumio volumio[1460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":59,"duration":295,"samplerate":44.1,"bitdepth":"32 bit","channels":7,"random":false,"updatedb":true,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"28.wav","artist":null,"album":null,"uri":"http://10.0.0.80:8200/MediaItems/28.wav","trackType":"wav"} Dec 10 20:21:41 volumio volumio[1460]: verbose: CURRENT POSITION 1 Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::syncState stateService play Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:21:41 volumio volumio[1460]: info: Received an update from plugin. extracting info from payload Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:41 volumio volumio[1460]: info: ControllerMpd::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::servicePushState Dec 10 20:21:41 volumio volumio[1460]: info: CorePlayQueue::getTrack 1 Dec 10 20:21:41 volumio volumio[1460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94,"duration":295,"samplerate":44.1,"bitdepth":"32 bit","channels":7,"random":false,"updatedb":true,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"28.wav","artist":null,"album":null,"uri":"http://10.0.0.80:8200/MediaItems/28.wav","trackType":"wav"} Dec 10 20:21:41 volumio volumio[1460]: verbose: CURRENT POSITION 1 Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::syncState stateService play Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:21:41 volumio volumio[1460]: info: Received an update from plugin. extracting info from payload Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:41 volumio volumio[1460]: info: ControllerMpd::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::servicePushState Dec 10 20:21:41 volumio volumio[1460]: info: CorePlayQueue::getTrack 1 Dec 10 20:21:41 volumio volumio[1460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94,"duration":295,"samplerate":44.1,"bitdepth":"32 bit","channels":7,"random":false,"updatedb":true,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"28.wav","artist":null,"album":null,"uri":"http://10.0.0.80:8200/MediaItems/28.wav","trackType":"wav"} Dec 10 20:21:41 volumio volumio[1460]: verbose: CURRENT POSITION 1 Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::syncState stateService play Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::syncState currentStatus play Dec 10 20:21:41 volumio volumio[1460]: info: Received an update from plugin. extracting info from payload Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:41 volumio volumio[1460]: info: ------------------------------ 21ms Dec 10 20:21:41 volumio volumio[1460]: info: ------------------------------ 20ms Dec 10 20:21:41 volumio volumio[1460]: info: ------------------------------ 20ms Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::startPlaybackTimer Dec 10 20:21:41 volumio volumio[1460]: info: CorePlayQueue::getTrack 2 Dec 10 20:21:41 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:41 volumio volumio[1460]: info: CorePlayQueue::getTrack 2 Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:21:41 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:45 volumio volumio[1460]: info: Preload queue cleared Dec 10 20:21:45 volumio volumio[1460]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::ClearQueue Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::stop Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::stPlaybackTimer Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::updateTrackBlock Dec 10 20:21:45 volumio volumio[1460]: info: CorePlayQueue::getTrackBlock Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::pushState Dec 10 20:21:45 volumio volumio[1460]: info: CorePlayQueue::getTrack 2 Dec 10 20:21:45 volumio volumio[1460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 20:21:45 volumio volumio[1460]: info: CoreCommandRouter::volumioPushState Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::serviceStop Dec 10 20:21:45 volumio volumio[1460]: info: CorePlayQueue::getTrack 2 Dec 10 20:21:45 volumio volumio[1460]: info: CoreCommandRouter::serviceStop Dec 10 20:21:45 volumio volumio[1460]: info: [1765426905866] ControllerUPNPBrowser::stop Dec 10 20:21:45 volumio volumio[1460]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 20:21:45 volumio volumio[1460]: info: CorePlayQueue::clearPlayQueue Dec 10 20:21:45 volumio volumio[1460]: info: CorePlayQueue::saveQueue Dec 10 20:21:45 volumio volumio[1460]: info: CoreCommandRouter::volumioPushQueue Dec 10 20:21:45 volumio volumio[1460]: info: CoreStateMachine::addQueueItems Dec 10 20:21:45 volumio volumio[1460]: info: CorePlayQueue::addQueueItems Dec 10 20:21:45 volumio volumio[1460]: info: Preload queue cleared Dec 10 20:21:45 volumio volumio[1460]: info: Adding Item to queue: music-library/INTERNAL/绝对发烧 Dec 10 20:21:45 volumio volumio[1460]: info: Exploding uri music-library/INTERNAL/绝对发烧 in service mpd Dec 10 20:21:45 volumio volumio[1460]: info: Dec 10 20:21:45 volumio volumio[1460]: ---------------------------- MPD announces state update: player Dec 10 20:21:45 volumio volumio[1460]: info: ALBUMART /albumart?cacheid=42&web=/%3F%3F%3F%3F%3Fo%3FN/extralarge&path=%2Fmnt%2FINTERNAL%2F%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F.-.%5B%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A7%5D.%E4%B8%93%E8%BE%91.(ape).ape&metadata=false Dec 10 20:21:45 volumio volumio[1460]: info: URI /mnt/INTERNAL/绝对发烧/群星.-.[绝对发烧].专辑.(ape).ape Dec 10 20:21:45 volumio volumio[1460]: info: ALBUMART /albumart?cacheid=42&web=%3F%3F%3F%3F%3F%3F%D6%AA%3F%3F/%3F%5E%3F%3F%3Fl%3F%3F/extralarge&path=%2Fmnt%2FINTERNAL%2F%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F.-.%5B%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A7%5D.%E4%B8%93%E8%BE%91.(cue).cue&metadata=false Dec 10 20:21:45 volumio volumio[1460]: info: URI /mnt/INTERNAL/绝对发烧/群星.-.[绝对发烧].专辑.(cue).cue Dec 10 20:21:45 volumio volumio[1460]: info: ALBUMART /albumart?cacheid=42&web=%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F/%3F%5E%3F%3F%3Fl%3F%3F/extralarge&path=%2Fmnt%2FINTERNAL%2F%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F.-.%5B%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A7%5D.%E4%B8%93%E8%BE%91.(cue).cue&metadata=false Dec 10 20:21:45 volumio volumio[1460]: info: URI /mnt/INTERNAL/绝对发烧/群星.-.[绝对发烧].专辑.(cue).cue Dec 10 20:21:45 volumio volumio[1460]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 20:21:45 volumio volumio[1460]: Error: Unable to resolve or reject the same promise twice Dec 10 20:21:45 volumio volumio[1460]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Dec 10 20:21:45 volumio volumio[1460]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Dec 10 20:21:45 volumio volumio[1460]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Dec 10 20:21:45 volumio volumio[1460]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Dec 10 20:21:45 volumio volumio[1460]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Dec 10 20:21:45 volumio volumio[1460]: at Socket.emit (node:events:514:28) Dec 10 20:21:45 volumio volumio[1460]: at addChunk (node:internal/streams/readable:343:12) Dec 10 20:21:45 volumio volumio[1460]: at readableAddChunk (node:internal/streams/readable:312:11) Dec 10 20:21:45 volumio volumio[1460]: at Readable.push (node:internal/streams/readable:253:10) Dec 10 20:21:45 volumio volumio[1460]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Dec 10 20:21:45 volumio volumio[1460]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 20:21:46 volumio sudo[5988]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-10 20:20' Dec 10 20:21:46 volumio sudo[5988]: 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"