-- Logs begin at Sat 2024-04-13 11:40:05 UTC, end at Fri 2024-04-19 13:47:14 UTC. -- Apr 19 13:46:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 19 13:46:04 volumio volumio[947]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 19 13:46:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 19 13:46:04 volumio volumio[947]: info: Received Get System Version Apr 19 13:46:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 13:46:04 volumio volumio[947]: info: Received Get System Info Apr 19 13:46:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 19 13:46:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 19 13:46:04 volumio volumio[947]: info: Discovery: Getting this device information Apr 19 13:46:04 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Apr 19 13:46:04 volumio volumio[947]: info: CorePlayQueue::getTrack 2 Apr 19 13:46:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 19 13:46:18 volumio volumio[947]: info: CoreCommandRouter::volumioGetQueue Apr 19 13:46:18 volumio volumio[947]: info: CoreStateMachine::getQueue Apr 19 13:46:18 volumio volumio[947]: info: CorePlayQueue::getQueue Apr 19 13:46:20 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Apr 19 13:46:20 volumio volumio[947]: info: CorePlayQueue::getTrack 2 Apr 19 13:46:21 volumio volumio[947]: error: error Apr 19 13:46:21 volumio volumio[947]: error: error Apr 19 13:46:21 volumio volumio[947]: error: error Apr 19 13:46:23 volumio volumio[947]: info: Executing endpoint metavolumio Apr 19 13:46:23 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 19 13:46:23 volumio volumio[947]: info: Executing endpoint metavolumio Apr 19 13:46:23 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 19 13:46:23 volumio volumio[947]: info: Executing endpoint metavolumio Apr 19 13:46:23 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 19 13:46:27 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Apr 19 13:46:27 volumio volumio[947]: info: CorePlayQueue::getTrack 2 Apr 19 13:46:29 volumio volumio[947]: info: Executing endpoint metavolumio Apr 19 13:46:29 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 19 13:46:29 volumio volumio[947]: info: Executing endpoint metavolumio Apr 19 13:46:29 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 19 13:46:29 volumio volumio[947]: info: Executing endpoint metavolumio Apr 19 13:46:29 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 19 13:46:30 volumio volumio[947]: error: Failed request for metavolumio API Apr 19 13:46:52 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 19 13:46:52 volumio volumio[947]: info: CURURI: music-library Apr 19 13:46:52 volumio volumio[947]: info: Preload queue cleared Apr 19 13:46:54 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 19 13:46:54 volumio volumio[947]: info: CURURI: music-library/NAS Apr 19 13:46:54 volumio volumio[947]: info: Preload queue cleared Apr 19 13:46:54 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 19 13:46:54 volumio volumio[947]: info: CURURI: music-library/NAS/HD_Music Apr 19 13:46:54 volumio volumio[947]: info: Preload queue cleared Apr 19 13:46:54 volumio volumio[947]: info: Preloading song: music-library/NAS/HD_Music/PlayList_1325275389235.m3u Apr 19 13:46:55 volumio volumio[947]: info: Exploding uri music-library/NAS/HD_Music/PlayList_1325275389235.m3u in service mpd Apr 19 13:47:10 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 19 13:47:10 volumio volumio[947]: info: CURURI: music-library/NAS/HD_Music/Norah_Jones Apr 19 13:47:10 volumio volumio[947]: info: Preload queue cleared Apr 19 13:47:11 volumio volumio[947]: error: error Apr 19 13:47:11 volumio volumio[947]: error: error Apr 19 13:47:11 volumio volumio[947]: error: error Apr 19 13:47:14 volumio volumio[947]: info: Preload queue cleared Apr 19 13:47:14 volumio volumio[947]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::ClearQueue Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::stop Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::updateTrackBlock Apr 19 13:47:14 volumio volumio[947]: info: CorePlayQueue::getTrackBlock Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::stPlaybackTimer Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::pushState Apr 19 13:47:14 volumio volumio[947]: info: CorePlayQueue::getTrack 2 Apr 19 13:47:14 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 13:47:14 volumio volumio[947]: info: CoreCommandRouter::volumioPushState Apr 19 13:47:14 volumio volumio[947]: info: MRS: Pushing multiroomSync output update for this device Apr 19 13:47:14 volumio volumio[947]: info: MRS: Pushing multiroomSync output Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::serviceStop Apr 19 13:47:14 volumio volumio[947]: info: CorePlayQueue::getTrack 2 Apr 19 13:47:14 volumio volumio[947]: info: CoreCommandRouter::serviceStop Apr 19 13:47:14 volumio volumio[947]: info: ControllerMpd::stop Apr 19 13:47:14 volumio volumio[947]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 13:47:14 volumio volumio[947]: info: CorePlayQueue::clearPlayQueue Apr 19 13:47:14 volumio volumio[947]: info: CorePlayQueue::saveQueue Apr 19 13:47:14 volumio volumio[947]: info: CoreCommandRouter::volumioPushQueue Apr 19 13:47:14 volumio volumio[947]: info: CoreStateMachine::addQueueItems Apr 19 13:47:14 volumio volumio[947]: info: CorePlayQueue::addQueueItems Apr 19 13:47:14 volumio volumio[947]: info: Preload queue cleared Apr 19 13:47:14 volumio volumio[947]: info: Adding Item to queue: music-library/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late Apr 19 13:47:14 volumio volumio[947]: info: Exploding uri music-library/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late in service mpd Apr 19 13:47:14 volumio volumio[947]: info: Apr 19 13:47:14 volumio volumio[947]: ---------------------------- MPD announces state update: player Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F01%20-%20Wish%20I%20could.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/01 - Wish I could.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F02%20-%20Sinkin'%20soon.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/02 - Sinkin' soon.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F03%20-%20The%20sun%20doesn't%20like%20you.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/03 - The sun doesn't like you.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F04%20-%20Until%20the%20end.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/04 - Until the end.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F05%20-%20Not%20my%20friend.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/05 - Not my friend.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F06%20-%20Thinking%20about%20you.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/06 - Thinking about you.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F07%20-%20Broken.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/07 - Broken.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F08%20-%20My%20dear%20country.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/08 - My dear country.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F09%20-%20Wake%20me%20up.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/09 - Wake me up.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F10%20-%20Be%20my%20somebody.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/10 - Be my somebody.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F11%20-%20Little%20room.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/11 - Little room.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F12%20-%20Rosie's%20lullaby.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/12 - Rosie's lullaby.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2F13%20-%20Not%20too%20late.flac&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/13 - Not too late.flac Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2FNorah%20Jones%20-%20Not%20too%20late%20(flac).cue&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/Norah Jones - Not too late (flac).cue Apr 19 13:47:14 volumio volumio[947]: info: ALBUMART /albumart?cacheid=417&web=Norah%20Jones/Not%20too%20late/extralarge&path=%2Fmnt%2FNAS%2FHD_Music%2FNorah_Jones%2FNorah%20Jones%20(2006)%20Not%20too%20late%2FNorah%20Jones%20-%20Not%20too%20late%20(flac).cue&metadata=false Apr 19 13:47:14 volumio volumio[947]: info: URI /mnt/NAS/HD_Music/Norah_Jones/Norah Jones (2006) Not too late/Norah Jones - Not too late (flac).cue Apr 19 13:47:14 volumio volumio[947]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 13:47:14 volumio volumio[947]: Error: Unable to resolve or reject the same promise twice Apr 19 13:47:14 volumio volumio[947]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 19 13:47:14 volumio volumio[947]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 19 13:47:14 volumio volumio[947]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 19 13:47:14 volumio volumio[947]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 19 13:47:14 volumio volumio[947]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 19 13:47:14 volumio volumio[947]: at Socket.emit (events.js:315:20) Apr 19 13:47:14 volumio volumio[947]: at addChunk (internal/streams/readable.js:309:12) Apr 19 13:47:14 volumio volumio[947]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 19 13:47:14 volumio volumio[947]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 19 13:47:14 volumio volumio[947]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 19 13:47:14 volumio volumio[947]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 13:47:14 volumio sudo[16136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-19 13:46 Apr 19 13:47:14 volumio sudo[16136]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"