Mar 28 10:30:01 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2013. Mar 28 10:30:01 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:01 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:01 volumio upmpdcli[17690]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:30:01 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:30:01 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:30:16 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2014. Mar 28 10:30:16 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:16 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:16 volumio upmpdcli[17706]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:30:16 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:30:16 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:30:22 volumio sudo[17725]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 28 10:30:22 volumio sudo[17725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 28 10:30:22 volumio sudo[17727]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 10:30:22 volumio sudo[17727]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 28 10:30:22 volumio sudo[17725]: pam_unix(sudo:session): session closed for user root Mar 28 10:30:22 volumio sudo[17727]: pam_unix(sudo:session): session closed for user root Mar 28 10:30:22 volumio volumio[1253]: verbose: New Socket.io Connection to 192.168.1.88 from 192.168.1.145 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.4 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 Mar 28 10:30:23 volumio sudo[17732]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 28 10:30:23 volumio sudo[17732]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 28 10:30:23 volumio sudo[17732]: pam_unix(sudo:session): session closed for user root Mar 28 10:30:23 volumio sudo[17734]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 10:30:23 volumio sudo[17734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 28 10:30:23 volumio sudo[17734]: pam_unix(sudo:session): session closed for user root Mar 28 10:30:23 volumio volumio[1253]: verbose: New Socket.io Connection to 192.168.1.88 from 192.168.1.145 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.4 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 6 Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::volumioGetVisibleSources Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::volumioGetState Mar 28 10:30:23 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 28 10:30:23 volumio volumio[1253]: info: Received Get System Info Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:30:23 volumio volumio[1253]: info: Discovery: Getting this device information Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::volumioGetState Mar 28 10:30:23 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::volumioGetState Mar 28 10:30:23 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:30:23 volumio volumio[1253]: info: Listing playlists Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 10:30:23 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 28 10:30:25 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 10:30:25 volumio volumio[1253]: info: Received Get System Info Mar 28 10:30:25 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:30:25 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:30:25 volumio volumio[1253]: info: Discovery: Getting this device information Mar 28 10:30:25 volumio volumio[1253]: info: CoreCommandRouter::volumioGetState Mar 28 10:30:25 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:30:25 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:30:25 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 28 10:30:29 volumio volumio[1253]: info: CoreCommandRouter::volumioGetQueue Mar 28 10:30:29 volumio volumio[1253]: info: CoreStateMachine::getQueue Mar 28 10:30:29 volumio volumio[1253]: info: CorePlayQueue::getQueue Mar 28 10:30:31 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2015. Mar 28 10:30:31 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:31 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:31 volumio upmpdcli[17753]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:30:31 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:30:31 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:30:33 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 28 10:30:35 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 28 10:30:35 volumio volumio[1253]: info: CURURI: music-library/USB/E45CDAF35CDABF8A/【摇滚乐】 Mar 28 10:30:35 volumio volumio[1253]: info: Preload queue cleared Mar 28 10:30:38 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 28 10:30:38 volumio volumio[1253]: info: CURURI: music-library/USB/E45CDAF35CDABF8A/【摇滚乐】/【古典声乐】丽塔·史塔里希《民谣和摇篮曲》 1999 [FLAC+CUE整轨] Mar 28 10:30:38 volumio volumio[1253]: info: Preload queue cleared Mar 28 10:30:47 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2016. Mar 28 10:30:47 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:47 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:30:47 volumio upmpdcli[17769]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:30:47 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:30:47 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:30:58 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 28 10:30:58 volumio volumio[1253]: info: CURURI: music-library/USB/E45CDAF35CDABF8A/【摇滚乐】/【古典声乐】丽塔·史塔里希《民谣和摇篮曲》 1999 [FLAC+CUE整轨] Mar 28 10:30:58 volumio volumio[1253]: info: Preload queue cleared Mar 28 10:31:02 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2017. Mar 28 10:31:02 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:02 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:02 volumio upmpdcli[17800]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:31:02 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:31:02 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:31:17 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2018. Mar 28 10:31:17 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:17 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:17 volumio upmpdcli[17817]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:31:17 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:31:17 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:31:30 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:30 volumio volumio[1253]: info: CorePlayQueue::getTrack 4 Mar 28 10:31:30 volumio volumio[1253]: info: Prefetching next song Mar 28 10:31:30 volumio volumio[1253]: info: DOING PREFETCH IN MPD Mar 28 10:31:30 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand add "USB/E45CDAF35CDABF8A/Volume 21 - Historic Concerto Performances/Record 41/05 - Mozart - HC - 02.flac" Mar 28 10:31:30 volumio volumio[1253]: info: sendMpdCommand add "USB/E45CDAF35CDABF8A/Volume 21 - Historic Concerto Performances/Record 41/05 - Mozart - HC - 02.flac" took 1 milliseconds Mar 28 10:31:30 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 28 10:31:30 volumio volumio[1253]: info: Mar 28 10:31:30 volumio volumio[1253]: ---------------------------- MPD announces system playlist update Mar 28 10:31:30 volumio volumio[1253]: info: Ignoring MPD Status Update Mar 28 10:31:30 volumio volumio[1253]: info: Mar 28 10:31:30 volumio volumio[1253]: ---------------------------- MPD announces system playlist update Mar 28 10:31:30 volumio volumio[1253]: info: Ignoring MPD Status Update Mar 28 10:31:30 volumio volumio[1253]: info: Mar 28 10:31:30 volumio volumio[1253]: ---------------------------- MPD announces system playlist update Mar 28 10:31:30 volumio volumio[1253]: info: Ignoring MPD Status Update Mar 28 10:31:30 volumio volumio[1253]: info: sendMpdCommand consume 1 took 3 milliseconds Mar 28 10:31:30 volumio volumio[1253]: info: ------------------------------ 2ms Mar 28 10:31:30 volumio volumio[1253]: info: ------------------------------ 1ms Mar 28 10:31:30 volumio volumio[1253]: info: ------------------------------ 2ms Mar 28 10:31:32 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2019. Mar 28 10:31:32 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:33 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:33 volumio upmpdcli[17848]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:31:33 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:31:33 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::volumioPause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::pause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::stPlaybackTimer Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::servicePause Mar 28 10:31:34 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::servicePause Mar 28 10:31:34 volumio volumio[1253]: info: ControllerMpd::pause Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand pause Mar 28 10:31:34 volumio volumio[1253]: info: Mar 28 10:31:34 volumio volumio[1253]: ---------------------------- MPD announces state update: player Mar 28 10:31:34 volumio volumio[1253]: info: sendMpdCommand pause took 1 milliseconds Mar 28 10:31:34 volumio volumio[1253]: info: ControllerMpd::getState Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Mar 28 10:31:34 volumio volumio[1253]: info: Mar 28 10:31:34 volumio volumio[1253]: ---------------------------- MPD announces state update: player Mar 28 10:31:34 volumio volumio[1253]: info: ControllerMpd::getState Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Mar 28 10:31:34 volumio volumio[1253]: info: Mar 28 10:31:34 volumio volumio[1253]: ---------------------------- MPD announces state update: player Mar 28 10:31:34 volumio volumio[1253]: info: ControllerMpd::getState Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Mar 28 10:31:34 volumio volumio[1253]: info: sendMpdCommand status took 2 milliseconds Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::parseState Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 10:31:34 volumio volumio[1253]: info: sendMpdCommand status took 2 milliseconds Mar 28 10:31:34 volumio volumio[1253]: info: sendMpdCommand status took 2 milliseconds Mar 28 10:31:34 volumio volumio[1253]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::parseState Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::parseState Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::parseTrackInfo Mar 28 10:31:34 volumio volumio[1253]: info: ControllerMpd::pushState Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::servicePushState Mar 28 10:31:34 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:34 volumio volumio[1253]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":410954,"duration":412,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1113 Kbps","isStreaming":false,"title":"04 - Mozart - HC - 01","artist":null,"album":null,"uri":"USB/E45CDAF35CDABF8A/Volume 21 - Historic Concerto Performances/Record 41/04 - Mozart - HC - 01.flac","trackType":"flac"} Mar 28 10:31:34 volumio volumio[1253]: verbose: CURRENT POSITION 3 Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::syncState stateService pause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::syncState currentStatus pause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::pushState Mar 28 10:31:34 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::volumioPushState Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::stPlaybackTimer Mar 28 10:31:34 volumio volumio[1253]: info: ------------------------------ 9ms Mar 28 10:31:34 volumio volumio[1253]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 28 10:31:34 volumio volumio[1253]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::parseTrackInfo Mar 28 10:31:34 volumio volumio[1253]: verbose: ControllerMpd::parseTrackInfo Mar 28 10:31:34 volumio volumio[1253]: info: ControllerMpd::pushState Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::servicePushState Mar 28 10:31:34 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:34 volumio volumio[1253]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":410954,"duration":412,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1113 Kbps","isStreaming":false,"title":"04 - Mozart - HC - 01","artist":null,"album":null,"uri":"USB/E45CDAF35CDABF8A/Volume 21 - Historic Concerto Performances/Record 41/04 - Mozart - HC - 01.flac","trackType":"flac"} Mar 28 10:31:34 volumio volumio[1253]: verbose: CURRENT POSITION 3 Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::syncState stateService pause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::syncState currentStatus pause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::pushState Mar 28 10:31:34 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::volumioPushState Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::stPlaybackTimer Mar 28 10:31:34 volumio volumio[1253]: info: ControllerMpd::pushState Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::servicePushState Mar 28 10:31:34 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:34 volumio volumio[1253]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":410954,"duration":412,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1113 Kbps","isStreaming":false,"title":"04 - Mozart - HC - 01","artist":null,"album":null,"uri":"USB/E45CDAF35CDABF8A/Volume 21 - Historic Concerto Performances/Record 41/04 - Mozart - HC - 01.flac","trackType":"flac"} Mar 28 10:31:34 volumio volumio[1253]: verbose: CURRENT POSITION 3 Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::syncState stateService pause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::syncState currentStatus pause Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::pushState Mar 28 10:31:34 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:34 volumio volumio[1253]: info: CoreCommandRouter::volumioPushState Mar 28 10:31:34 volumio volumio[1253]: info: CoreStateMachine::stPlaybackTimer Mar 28 10:31:34 volumio volumio[1253]: info: ------------------------------ 18ms Mar 28 10:31:34 volumio volumio[1253]: info: ------------------------------ 18ms Mar 28 10:31:48 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2020. Mar 28 10:31:48 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:48 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 28 10:31:48 volumio upmpdcli[17866]: Could not open config: /tmp/upmpdcli.conf Mar 28 10:31:48 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 28 10:31:48 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 28 10:31:50 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 28 10:31:50 volumio volumio[1253]: info: CURURI: music-library/USB/E45CDAF35CDABF8A/【摇滚乐】/【古典声乐】丽塔·史塔里希《民谣和摇篮曲》 1999 [FLAC+CUE整轨] Mar 28 10:31:50 volumio volumio[1253]: info: Preload queue cleared Mar 28 10:31:52 volumio volumio[1253]: info: Preload queue cleared Mar 28 10:31:52 volumio volumio[1253]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::ClearQueue Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::stop Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::updateTrackBlock Mar 28 10:31:52 volumio volumio[1253]: info: CorePlayQueue::getTrackBlock Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::stPlaybackTimer Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::pushState Mar 28 10:31:52 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:52 volumio volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 10:31:52 volumio volumio[1253]: info: CoreCommandRouter::volumioPushState Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::serviceStop Mar 28 10:31:52 volumio volumio[1253]: info: CorePlayQueue::getTrack 3 Mar 28 10:31:52 volumio volumio[1253]: info: CoreCommandRouter::serviceStop Mar 28 10:31:52 volumio volumio[1253]: info: ControllerMpd::stop Mar 28 10:31:52 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 10:31:52 volumio volumio[1253]: info: CorePlayQueue::clearPlayQueue Mar 28 10:31:52 volumio volumio[1253]: info: CorePlayQueue::saveQueue Mar 28 10:31:52 volumio volumio[1253]: info: CoreCommandRouter::volumioPushQueue Mar 28 10:31:52 volumio volumio[1253]: info: CoreStateMachine::addQueueItems Mar 28 10:31:52 volumio volumio[1253]: info: CorePlayQueue::addQueueItems Mar 28 10:31:52 volumio volumio[1253]: info: Preload queue cleared Mar 28 10:31:52 volumio volumio[1253]: info: Adding Item to queue: music-library/USB/E45CDAF35CDABF8A/【摇滚乐】/【古典声乐】丽塔·史塔里希《民谣和摇篮曲》 1999 [FLAC+CUE整轨]/Rita.Stretch.-.Folksongs.&.Lullabies Mar 28 10:31:52 volumio volumio[1253]: info: Exploding uri music-library/USB/E45CDAF35CDABF8A/【摇滚乐】/【古典声乐】丽塔·史塔里希《民谣和摇篮曲》 1999 [FLAC+CUE整轨]/Rita.Stretch.-.Folksongs.&.Lullabies in service mpd Mar 28 10:31:52 volumio volumio[1253]: info: Mar 28 10:31:52 volumio volumio[1253]: ---------------------------- MPD announces state update: player Mar 28 10:31:52 volumio volumio[1253]: info: sendMpdCommand stop took 45 milliseconds Mar 28 10:31:52 volumio volumio[1253]: info: ControllerMpd::getState Mar 28 10:31:52 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Mar 28 10:31:52 volumio volumio[1253]: info: Mar 28 10:31:52 volumio volumio[1253]: ---------------------------- MPD announces state update: player Mar 28 10:31:52 volumio volumio[1253]: info: ControllerMpd::getState Mar 28 10:31:52 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Mar 28 10:31:52 volumio volumio[1253]: info: Mar 28 10:31:52 volumio volumio[1253]: ---------------------------- MPD announces state update: player Mar 28 10:31:52 volumio volumio[1253]: info: ControllerMpd::getState Mar 28 10:31:52 volumio volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Mar 28 10:31:52 volumio volumio[1253]: info: ALBUMART /albumart?cacheid=131&path=%2Fmnt%2FUSB%2FE45CDAF35CDABF8A%2F%E3%80%90%E6%91%87%E6%BB%9A%E4%B9%90%E3%80%91%2F%E3%80%90%E5%8F%A4%E5%85%B8%E5%A3%B0%E4%B9%90%E3%80%91%E4%B8%BD%E5%A1%94%C2%B7%E5%8F%B2%E5%A1%94%E9%87%8C%E5%B8%8C%E3%80%8A%E6%B0%91%E8%B0%A3%E5%92%8C%E6%91%87%E7%AF%AE%E6%9B%B2%E3%80%8B%201999%20%5BFLAC%2BCUE%E6%95%B4%E8%BD%A8%5D%2FRita.Stretch.-.Folksongs.%26.Lullabies%2FCDImage.cue&metadata=false Mar 28 10:31:52 volumio volumio[1253]: info: URI /mnt/USB/E45CDAF35CDABF8A/【摇滚乐】/【古典声乐】丽塔·史塔里希《民谣和摇篮曲》 1999 [FLAC+CUE整轨]/Rita.Stretch.-.Folksongs.&.Lullabies/CDImage.cue Mar 28 10:31:52 volumio volumio[1253]: info: ALBUMART /albumart?cacheid=131&path=%2Fmnt%2FUSB%2FE45CDAF35CDABF8A%2F%E3%80%90%E6%91%87%E6%BB%9A%E4%B9%90%E3%80%91%2F%E3%80%90%E5%8F%A4%E5%85%B8%E5%A3%B0%E4%B9%90%E3%80%91%E4%B8%BD%E5%A1%94%C2%B7%E5%8F%B2%E5%A1%94%E9%87%8C%E5%B8%8C%E3%80%8A%E6%B0%91%E8%B0%A3%E5%92%8C%E6%91%87%E7%AF%AE%E6%9B%B2%E3%80%8B%201999%20%5BFLAC%2BCUE%E6%95%B4%E8%BD%A8%5D%2FRita.Stretch.-.Folksongs.%26.Lullabies%2FCDImage.cue&metadata=false Mar 28 10:31:52 volumio volumio[1253]: info: URI /mnt/USB/E45CDAF35CDABF8A/【摇滚乐】/【古典声乐】丽塔·史塔里希《民谣和摇篮曲》 1999 [FLAC+CUE整轨]/Rita.Stretch.-.Folksongs.&.Lullabies/CDImage.cue Mar 28 10:31:52 volumio volumio[1253]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 10:31:52 volumio volumio[1253]: Error: Unable to resolve or reject the same promise twice Mar 28 10:31:52 volumio volumio[1253]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 28 10:31:52 volumio volumio[1253]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Mar 28 10:31:52 volumio volumio[1253]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 28 10:31:52 volumio volumio[1253]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 28 10:31:52 volumio volumio[1253]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 28 10:31:52 volumio volumio[1253]: at Socket.emit (node:events:514:28) Mar 28 10:31:52 volumio volumio[1253]: at addChunk (node:internal/streams/readable:343:12) Mar 28 10:31:52 volumio volumio[1253]: at readableAddChunk (node:internal/streams/readable:312:11) Mar 28 10:31:52 volumio volumio[1253]: at Readable.push (node:internal/streams/readable:253:10) Mar 28 10:31:52 volumio volumio[1253]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Mar 28 10:31:52 volumio volumio[1253]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 10:31:52 volumio sudo[17895]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-28 10:30' Mar 28 10:31:52 volumio sudo[17895]: 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"