-- Logs begin at Sat 2024-03-30 08:32:43 UTC, end at Sat 2024-03-30 10:31:50 UTC. -- Mar 30 10:30:39 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:30:39 volumio volumio[8626]: info: Mar 30 10:30:39 volumio volumio[8626]: ---------------------------- MPD announces state update: update Mar 30 10:30:39 volumio volumio[8626]: info: ControllerMpd::getState Mar 30 10:30:39 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:30:39 volumio volumio[8626]: info: sendMpdCommand status took 11 milliseconds Mar 30 10:30:39 volumio volumio[8626]: info: sendMpdCommand status took 10 milliseconds Mar 30 10:30:39 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:30:39 volumio volumio[8626]: info: Command Router : Notfying DB Updatetrue Mar 30 10:30:39 volumio volumio[8626]: info: CoreCommandRouter::Close All Modals sent Mar 30 10:30:39 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:30:39 volumio volumio[8626]: info: ControllerMpd::pushState Mar 30 10:30:39 volumio volumio[8626]: info: CoreCommandRouter::servicePushState Mar 30 10:30:39 volumio volumio[8626]: info: CoreStateMachine::pushState Mar 30 10:30:39 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:30:39 volumio volumio[8626]: info: CoreCommandRouter::volumioPushState Mar 30 10:30:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 10:30:39 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:30:39 volumio volumio[8626]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Mar 30 10:30:39 volumio volumio[8626]: info: ------------------------------ 136ms Mar 30 10:30:39 volumio volumio[8626]: info: MPD Database updated - AlbumList cache refreshed Mar 30 10:30:39 volumio volumio[8626]: info: Mar 30 10:30:39 volumio volumio[8626]: ---------------------------- MPD announces state update: database Mar 30 10:30:39 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:30:39 volumio volumio[8626]: info: Mar 30 10:30:39 volumio volumio[8626]: ---------------------------- MPD announces state update: update Mar 30 10:30:39 volumio volumio[8626]: info: ControllerMpd::getState Mar 30 10:30:39 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:30:39 volumio volumio[8626]: info: ControllerMpd::getState Mar 30 10:30:39 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:30:40 volumio volumio[8626]: info: sendMpdCommand status took 771 milliseconds Mar 30 10:30:40 volumio volumio[8626]: info: sendMpdCommand status took 771 milliseconds Mar 30 10:30:40 volumio volumio[8626]: info: sendMpdCommand status took 771 milliseconds Mar 30 10:30:40 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:30:40 volumio volumio[8626]: info: Command Router : Notfying DB Updatefalse Mar 30 10:30:40 volumio volumio[8626]: info: CoreCommandRouter::Close All Modals sent Mar 30 10:30:40 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:30:40 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:30:40 volumio volumio[8626]: info: ControllerMpd::pushState Mar 30 10:30:40 volumio volumio[8626]: info: CoreCommandRouter::servicePushState Mar 30 10:30:40 volumio volumio[8626]: info: CoreStateMachine::pushState Mar 30 10:30:40 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:30:40 volumio volumio[8626]: info: CoreCommandRouter::volumioPushState Mar 30 10:30:40 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 10:30:40 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:30:40 volumio volumio[8626]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Mar 30 10:30:40 volumio volumio[8626]: info: ControllerMpd::pushState Mar 30 10:30:40 volumio volumio[8626]: info: CoreCommandRouter::servicePushState Mar 30 10:30:40 volumio volumio[8626]: info: CoreStateMachine::pushState Mar 30 10:30:40 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:30:40 volumio volumio[8626]: info: CoreCommandRouter::volumioPushState Mar 30 10:30:40 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 10:30:40 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:30:40 volumio volumio[8626]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Mar 30 10:30:40 volumio volumio[8626]: info: ------------------------------ 837ms Mar 30 10:30:40 volumio volumio[8626]: info: ------------------------------ 837ms Mar 30 10:31:30 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:31:30 volumio volumio[8626]: info: Mar 30 10:31:30 volumio volumio[8626]: ---------------------------- MPD announces state update: update Mar 30 10:31:30 volumio volumio[8626]: info: ControllerMpd::getState Mar 30 10:31:30 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:31:30 volumio volumio[8626]: info: sendMpdCommand status took 5 milliseconds Mar 30 10:31:30 volumio volumio[8626]: info: sendMpdCommand status took 3 milliseconds Mar 30 10:31:30 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:31:31 volumio volumio[8626]: info: Command Router : Notfying DB Updatetrue Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::Close All Modals sent Mar 30 10:31:31 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:31:31 volumio volumio[8626]: info: ControllerMpd::pushState Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::servicePushState Mar 30 10:31:31 volumio volumio[8626]: info: CoreStateMachine::pushState Mar 30 10:31:31 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::volumioPushState Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 10:31:31 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:31:31 volumio volumio[8626]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Mar 30 10:31:31 volumio volumio[8626]: info: ------------------------------ 218ms Mar 30 10:31:31 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:31:31 volumio volumio[8626]: info: Mar 30 10:31:31 volumio volumio[8626]: ---------------------------- MPD announces state update: update Mar 30 10:31:31 volumio volumio[8626]: info: ControllerMpd::getState Mar 30 10:31:31 volumio volumio[8626]: verbose: ControllerMpd::sendMpdCommand status Mar 30 10:31:31 volumio volumio[8626]: info: sendMpdCommand status took 6 milliseconds Mar 30 10:31:31 volumio volumio[8626]: info: sendMpdCommand status took 6 milliseconds Mar 30 10:31:31 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:31:31 volumio volumio[8626]: info: Command Router : Notfying DB Updatefalse Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::Close All Modals sent Mar 30 10:31:31 volumio volumio[8626]: verbose: ControllerMpd::parseState Mar 30 10:31:31 volumio volumio[8626]: info: ControllerMpd::pushState Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::servicePushState Mar 30 10:31:31 volumio volumio[8626]: info: CoreStateMachine::pushState Mar 30 10:31:31 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::volumioPushState Mar 30 10:31:31 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 10:31:31 volumio volumio[8626]: info: CorePlayQueue::getTrack 0 Mar 30 10:31:31 volumio volumio[8626]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Mar 30 10:31:31 volumio volumio[8626]: info: ------------------------------ 33ms Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 30 10:31:39 volumio volumio[8626]: info: Retrieving Cloud Streaming UI Mar 30 10:31:39 volumio volumio[8626]: info: Getting Tidal Cloud Configuration Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 30 10:31:39 volumio volumio[8626]: info: Getting Qobuz Cloud Configuration Mar 30 10:31:39 volumio volumio[8626]: info: Asking plugin for UI Config Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 30 10:31:39 volumio volumio[8626]: info: Getting Spotify Cloud Configuration Mar 30 10:31:39 volumio volumio[8626]: info: Asking plugin for UI Config Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 30 10:31:39 volumio volumio[8626]: info: Saving Spotify Acccount Mar 30 10:31:39 volumio volumio[8626]: info: Got Tidal Cloud Configuration Mar 30 10:31:39 volumio volumio[8626]: info: Got it Mar 30 10:31:39 volumio volumio[8626]: info: Got it Mar 30 10:31:39 volumio volumio[8626]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 30 10:31:39 volumio volumio[8626]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 10:31:39 volumio volumio[8626]: info: CoreCommandRouter::volumioGetBrowseSources Mar 30 10:31:40 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 10:31:40 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 30 10:31:44 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 10:31:46 volumio volumio[8626]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Mar 30 10:31:46 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Mar 30 10:31:46 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Mar 30 10:31:46 volumio volumio[8626]: info: Rebuild Album cache Mar 30 10:31:48 volumio volumio[8626]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 10:31:50 volumio volumio[8626]: Error in writing albumart JSON file: Error: ENOENT: no such file or directory, open '/data/albumart/web/Nickelback/info.json' Mar 30 10:31:50 volumio volumio[8626]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 10:31:50 volumio volumio[8626]: { Error: ENOENT: no such file or directory, open '/data/albumart/web/Nickelback/e23c2fc6-5870-4eb4-b8a3-d4e9c6cc9022.jpg' Mar 30 10:31:50 volumio volumio[8626]: errno: -2, Mar 30 10:31:50 volumio volumio[8626]: code: 'ENOENT', Mar 30 10:31:50 volumio volumio[8626]: syscall: 'open', Mar 30 10:31:50 volumio volumio[8626]: path: '/data/albumart/web/Nickelback/e23c2fc6-5870-4eb4-b8a3-d4e9c6cc9022.jpg' } Mar 30 10:31:50 volumio volumio[8626]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 10:31:50 volumio sudo[18647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 10:30 Mar 30 10:31:50 volumio sudo[18647]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"