Oct 14 20:47:23 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:47:26 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:47:34 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:47:36 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 14 20:47:36 volumio volumio[1520]: info: CURURI: music-library/NAS/music_sacd Oct 14 20:47:36 volumio volumio[1520]: info: Preload queue cleared Oct 14 20:47:37 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:47:57 volumio volumio[1520]: info: MPD Database updated - AlbumList cache refreshed Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: database Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: update Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: MPD Database updated - AlbumList cache refreshed Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: database Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: update Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: MPD Database updated - AlbumList cache refreshed Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: database Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: update Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: MPD Database updated - AlbumList cache refreshed Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: database Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: Oct 14 20:47:57 volumio volumio[1520]: ---------------------------- MPD announces state update: update Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::getState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 47 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 47 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 46 milliseconds Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: Command Router : Notfying DB Updatefalse Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::Close All Modals sent Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 114ms Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 115ms Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 129 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 129 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 128 milliseconds Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: Command Router : Notfying DB Updatefalse Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::Close All Modals sent Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 169ms Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 170ms Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 182 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 182 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 181 milliseconds Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: Command Router : Notfying DB Updatefalse Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::Close All Modals sent Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 207ms Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 207ms Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 243 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 242 milliseconds Oct 14 20:47:57 volumio volumio[1520]: info: sendMpdCommand status took 242 milliseconds Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: Command Router : Notfying DB Updatefalse Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::Close All Modals sent Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: verbose: ControllerMpd::parseState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ControllerMpd::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::servicePushState Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 14 20:47:57 volumio volumio[1520]: verbose: CURRENT POSITION 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: No code Oct 14 20:47:57 volumio volumio[1520]: info: CoreStateMachine::pushState Oct 14 20:47:57 volumio volumio[1520]: info: CorePlayQueue::getTrack 0 Oct 14 20:47:57 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 267ms Oct 14 20:47:57 volumio volumio[1520]: info: ------------------------------ 267ms Oct 14 20:48:05 volumio volumio[1520]: info: Preload queue cleared Oct 14 20:48:09 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:12 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:15 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 14 20:48:15 volumio volumio[1520]: info: CURURI: music-library Oct 14 20:48:15 volumio volumio[1520]: info: Preload queue cleared Oct 14 20:48:16 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:18 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 14 20:48:18 volumio volumio[1520]: info: CURURI: music-library/NAS Oct 14 20:48:18 volumio volumio[1520]: info: Preload queue cleared Oct 14 20:48:19 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:22 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 14 20:48:22 volumio volumio[1520]: info: CURURI: music-library/NAS/music Oct 14 20:48:22 volumio volumio[1520]: info: Preload queue cleared Oct 14 20:48:23 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:26 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:30 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:33 volumio wpa_supplicant[1484]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 20:48:44 volumio volumio[1520]: info: Preload queue cleared Oct 14 20:48:44 volumio volumio[1520]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 14 20:48:44 volumio volumio[1520]: info: CoreStateMachine::ClearQueue Oct 14 20:48:44 volumio volumio[1520]: info: CoreStateMachine::stop Oct 14 20:48:44 volumio volumio[1520]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 20:48:44 volumio volumio[1520]: info: CorePlayQueue::clearPlayQueue Oct 14 20:48:44 volumio volumio[1520]: info: CorePlayQueue::saveQueue Oct 14 20:48:44 volumio volumio[1520]: info: CoreCommandRouter::volumioPushQueue Oct 14 20:48:44 volumio volumio[1520]: info: CoreStateMachine::addQueueItems Oct 14 20:48:44 volumio volumio[1520]: info: CorePlayQueue::addQueueItems Oct 14 20:48:44 volumio volumio[1520]: info: Preload queue cleared Oct 14 20:48:44 volumio volumio[1520]: info: Adding Item to queue: music-library/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE] Oct 14 20:48:44 volumio volumio[1520]: info: Exploding uri music-library/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE] in service mpd Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=David%20Abel%2FJulie%20Steinberg/Beethoven%3A%20Violin%20Sonata%2C%20Op.%2096%20-%20Enescu%3A%20Violin%20Sonata%2C%20Op.%2025/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2F01%20-%20Beethoven%20-%20Violin%20Sonata%20No.%2010%20in%20G%20Major%2C%20Op.%2096%20-%20I.%20Allegro%20moderato.flac&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/01 - Beethoven - Violin Sonata No. 10 in G Major, Op. 96 - I. Allegro moderato.flac Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=David%20Abel%2FJulie%20Steinberg/Beethoven%3A%20Violin%20Sonata%2C%20Op.%2096%20-%20Enescu%3A%20Violin%20Sonata%2C%20Op.%2025/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2F02%20-%20Beethoven%20-%20Violin%20Sonata%20No.%2010%20in%20G%20Major%2C%20Op.%2096%20-%20II.%20Adagio%20espressivo.flac&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/02 - Beethoven - Violin Sonata No. 10 in G Major, Op. 96 - II. Adagio espressivo.flac Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=David%20Abel%2FJulie%20Steinberg/Beethoven%3A%20Violin%20Sonata%2C%20Op.%2096%20-%20Enescu%3A%20Violin%20Sonata%2C%20Op.%2025/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2F03%20-%20Beethoven%20-%20Violin%20Sonata%20No.%2010%20in%20G%20Major%2C%20Op.%2096%20-%20III.%20Scherzo%20-%20Allegro.flac&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/03 - Beethoven - Violin Sonata No. 10 in G Major, Op. 96 - III. Scherzo - Allegro.flac Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=David%20Abel%2FJulie%20Steinberg/Beethoven%3A%20Violin%20Sonata%2C%20Op.%2096%20-%20Enescu%3A%20Violin%20Sonata%2C%20Op.%2025/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2F04%20-%20Beethoven%20-%20Violin%20Sonata%20No.%2010%20in%20G%20Major%2C%20Op.%2096%20-%20IV.%20Poco%20allegretto.flac&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/04 - Beethoven - Violin Sonata No. 10 in G Major, Op. 96 - IV. Poco allegretto.flac Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=David%20Abel%2FJulie%20Steinberg/Beethoven%3A%20Violin%20Sonata%2C%20Op.%2096%20-%20Enescu%3A%20Violin%20Sonata%2C%20Op.%2025/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2F05%20-%20Enescu%20-%20Violin%20Sonata%20No.%203%20in%20A%20Minor%2C%20Op.%2025%2C%20Dans%20le%20caractere%20populaire%20roumain%20-%20I.flac&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/05 - Enescu - Violin Sonata No. 3 in A Minor, Op. 25, Dans le caractere populaire roumain - I.flac Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=David%20Abel%2FJulie%20Steinberg/Beethoven%3A%20Violin%20Sonata%2C%20Op.%2096%20-%20Enescu%3A%20Violin%20Sonata%2C%20Op.%2025/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2F06%20-%20Enescu%20-%20Violin%20Sonata%20No.%203%20in%20A%20Minor%2C%20Op.%2025%2C%20Dans%20le%20caractere%20populaire%20roumain%20-%20II.flac&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/06 - Enescu - Violin Sonata No. 3 in A Minor, Op. 25, Dans le caractere populaire roumain - II.flac Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=David%20Abel%2FJulie%20Steinberg/Beethoven%3A%20Violin%20Sonata%2C%20Op.%2096%20-%20Enescu%3A%20Violin%20Sonata%2C%20Op.%2025/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2F07%20-%20Enescu%20-%20Violin%20Sonata%20No.%203%20in%20A%20Minor%2C%20Op.%2025%2C%20Dans%20le%20caractere%20populaire%20roumain%20-%20III.flac&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/07 - Enescu - Violin Sonata No. 3 in A Minor, Op. 25, Dans le caractere populaire roumain - III.flac Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=/Beethoven%20(Sonato%20in%20G%20Major)%2C%20Enescu%20(Sonata%20No.%203)/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2FBeethoven%20Sonata%20in%20G%20Op.96%20For%20Piano%20and%20Violin-Enescu%20Sonata%20No.3%20in%20Rumanian%20Polkstyle.cue&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/Beethoven Sonata in G Op.96 For Piano and Violin-Enescu Sonata No.3 in Rumanian Polkstyle.cue Oct 14 20:48:44 volumio volumio[1520]: info: ALBUMART /albumart?cacheid=409&web=/Beethoven%20(Sonato%20in%20G%20Major)%2C%20Enescu%20(Sonata%20No.%203)/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A%E2%80%9C%E9%BB%84%E7%A2%9F%E2%80%9DWilson%20Audiophile%E8%B4%9D%E5%A4%9A%E8%8A%AC%E5%92%8C%E5%9F%83%E5%A5%88%E6%96%AF%E5%BA%93%E7%9A%84%E5%B0%8F%E6%8F%90%E7%90%B4%E5%A5%8F%E9%B8%A3%E6%9B%B2-%E3%80%8B-24-176Hz%20%5BFLAC%2BCUE%5D%2FBeethoven%20Sonata%20in%20G%20Op.96%20For%20Piano%20and%20Violin-Enescu%20Sonata%20No.3%20in%20Rumanian%20Polkstyle.cue&metadata=false Oct 14 20:48:44 volumio volumio[1520]: info: URI /mnt/NAS/music/《“黄碟”Wilson Audiophile贝多芬和埃奈斯库的小提琴奏鸣曲-》-24-176Hz [FLAC+CUE]/Beethoven Sonata in G Op.96 For Piano and Violin-Enescu Sonata No.3 in Rumanian Polkstyle.cue Oct 14 20:48:44 volumio volumio[1520]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 20:48:44 volumio volumio[1520]: Error: Unable to resolve or reject the same promise twice Oct 14 20:48:44 volumio volumio[1520]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 14 20:48:44 volumio volumio[1520]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 14 20:48:44 volumio volumio[1520]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 14 20:48:44 volumio volumio[1520]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 14 20:48:44 volumio volumio[1520]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 14 20:48:44 volumio volumio[1520]: at Socket.emit (node:events:514:28) Oct 14 20:48:44 volumio volumio[1520]: at addChunk (node:internal/streams/readable:343:12) Oct 14 20:48:44 volumio volumio[1520]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 14 20:48:44 volumio volumio[1520]: at Readable.push (node:internal/streams/readable:253:10) Oct 14 20:48:44 volumio volumio[1520]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 14 20:48:44 volumio volumio[1520]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 20:48:44 volumio sudo[2936]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 20:47' Oct 14 20:48:44 volumio sudo[2936]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"