-- Logs begin at Sat 2024-04-20 22:26:53 EEST, end at Sat 2024-04-20 22:39:15 EEST. --
Apr 20 22:38:01 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:05 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:08 volumio-n kernel: CIFS: __readahead_batch() returned 832/1024
Apr 20 22:38:08 volumio-n kernel: CIFS: __readahead_batch() returned 896/1024
Apr 20 22:38:08 volumio-n kernel: CIFS: __readahead_batch() returned 480/1024
Apr 20 22:38:09 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:13 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:17 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:21 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:25 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:28 volumio-n volumio[652]: info: MPD Database updated - AlbumList cache refreshed
Apr 20 22:38:28 volumio-n volumio[652]: info:
Apr 20 22:38:28 volumio-n volumio[652]: ---------------------------- MPD announces state update: database
Apr 20 22:38:28 volumio-n volumio[652]: verbose: ControllerMpd::sendMpdCommand status
Apr 20 22:38:28 volumio-n volumio[652]: info:
Apr 20 22:38:28 volumio-n volumio[652]: ---------------------------- MPD announces state update: update
Apr 20 22:38:28 volumio-n volumio[652]: info: ControllerMpd::getState
Apr 20 22:38:28 volumio-n volumio[652]: verbose: ControllerMpd::sendMpdCommand status
Apr 20 22:38:28 volumio-n volumio[652]: info: ControllerMpd::getState
Apr 20 22:38:28 volumio-n volumio[652]: verbose: ControllerMpd::sendMpdCommand status
Apr 20 22:38:30 volumio-n volumio[652]: info: sendMpdCommand status took 1633 milliseconds
Apr 20 22:38:30 volumio-n volumio[652]: info: sendMpdCommand status took 1631 milliseconds
Apr 20 22:38:30 volumio-n volumio[652]: info: sendMpdCommand status took 1628 milliseconds
Apr 20 22:38:30 volumio-n volumio[652]: verbose: ControllerMpd::parseState
Apr 20 22:38:30 volumio-n volumio[652]: info: Command Router : Notfying DB Updatefalse
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreCommandRouter::Close All Modals sent
Apr 20 22:38:30 volumio-n volumio[652]: verbose: ControllerMpd::parseState
Apr 20 22:38:30 volumio-n volumio[652]: verbose: ControllerMpd::parseState
Apr 20 22:38:30 volumio-n volumio[652]: info: ControllerMpd::pushState
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreCommandRouter::servicePushState
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreStateMachine::pushState
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreCommandRouter::volumioPushState
Apr 20 22:38:30 volumio-n volumio[652]: info: MRS: Pushing multiroomSync output update for this device
Apr 20 22:38:30 volumio-n volumio[652]: info: MRS: Pushing multiroomSync output
Apr 20 22:38:30 volumio-n volumio[652]: info: CorePlayQueue::getTrack 0
Apr 20 22:38:30 volumio-n volumio[652]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 20 22:38:30 volumio-n volumio[652]: info: ControllerMpd::pushState
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreCommandRouter::servicePushState
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreStateMachine::pushState
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreCommandRouter::volumioPushState
Apr 20 22:38:30 volumio-n volumio[652]: info: MRS: Pushing multiroomSync output update for this device
Apr 20 22:38:30 volumio-n volumio[652]: info: MRS: Pushing multiroomSync output
Apr 20 22:38:30 volumio-n volumio[652]: info: CorePlayQueue::getTrack 0
Apr 20 22:38:30 volumio-n volumio[652]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 20 22:38:30 volumio-n volumio[652]: info: ------------------------------ 1804ms
Apr 20 22:38:30 volumio-n volumio[652]: info: ------------------------------ 1805ms
Apr 20 22:38:30 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:33 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:37 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:41 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:45 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:49 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:53 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:38:57 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:39:01 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 22:39:03 volumio-n volumio[652]: info: CoreCommandRouter::volumioGetState
Apr 20 22:39:07 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 20 22:39:07 volumio-n volumio[652]: info: CURURI: music-library
Apr 20 22:39:07 volumio-n volumio[652]: info: Preload queue cleared
Apr 20 22:39:08 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 20 22:39:08 volumio-n volumio[652]: info: CURURI: music-library/NAS
Apr 20 22:39:08 volumio-n volumio[652]: info: Preload queue cleared
Apr 20 22:39:09 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 20 22:39:09 volumio-n volumio[652]: info: CURURI: music-library/NAS/Zamba
Apr 20 22:39:09 volumio-n volumio[652]: info: Preload queue cleared
Apr 20 22:39:12 volumio-n volumio[652]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 20 22:39:12 volumio-n volumio[652]: info: CURURI: music-library/NAS/Zamba/NewMuss
Apr 20 22:39:12 volumio-n volumio[652]: info: Preload queue cleared
Apr 20 22:39:12 volumio-n volumio[652]: info: Preloading song: music-library/NAS/Zamba/NewMuss/01 Mendelssohn - Capriccio Brillante For Piano And Orchestra.wav
Apr 20 22:39:12 volumio-n volumio[652]: info: Exploding uri music-library/NAS/Zamba/NewMuss/01 Mendelssohn - Capriccio Brillante For Piano And Orchestra.wav in service mpd
Apr 20 22:39:12 volumio-n volumio[652]: info: ALBUMART /albumart?cacheid=106&web=//extralarge&path=%2Fmnt%2FNAS%2FZamba%2FNewMuss%2F01%20Mendelssohn%20-%20Capriccio%20Brillante%20For%20Piano%20And%20Orchestra.wav&metadata=false
Apr 20 22:39:12 volumio-n volumio[652]: info: URI /mnt/NAS/Zamba/NewMuss/01 Mendelssohn - Capriccio Brillante For Piano And Orchestra.wav
Apr 20 22:39:15 volumio-n volumio[652]: info: Preload queue cleared
Apr 20 22:39:15 volumio-n volumio[652]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 20 22:39:15 volumio-n volumio[652]: info: CoreStateMachine::ClearQueue
Apr 20 22:39:15 volumio-n volumio[652]: info: CoreStateMachine::stop
Apr 20 22:39:15 volumio-n volumio[652]: info: CoreStateMachine::serviceStop
Apr 20 22:39:15 volumio-n volumio[652]: info: Received STOP, but no service to execute it
Apr 20 22:39:15 volumio-n volumio[652]: info: CorePlayQueue::clearPlayQueue
Apr 20 22:39:15 volumio-n volumio[652]: info: CorePlayQueue::saveQueue
Apr 20 22:39:15 volumio-n volumio[652]: info: CoreCommandRouter::volumioPushQueue
Apr 20 22:39:15 volumio-n volumio[652]: info: CoreStateMachine::addQueueItems
Apr 20 22:39:15 volumio-n volumio[652]: info: CorePlayQueue::addQueueItems
Apr 20 22:39:15 volumio-n volumio[652]: info: Preload queue cleared
Apr 20 22:39:15 volumio-n volumio[652]: info: Adding Item to queue: music-library/NAS/Zamba/NewMuss/(2011) VA - AYA - Authentic Audio Check
Apr 20 22:39:15 volumio-n volumio[652]: info: Exploding uri music-library/NAS/Zamba/NewMuss/(2011) VA - AYA - Authentic Audio Check in service mpd
Apr 20 22:39:15 volumio-n volumio[652]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists%20/AYA%20-%20Authentic%20Audio%20Check%20/extralarge&path=%2Fmnt%2FNAS%2FZamba%2FNewMuss%2F(2011)%20VA%20-%20AYA%20-%20Authentic%20Audio%20Check%2FVarious%20Artists%20%20-%20AYA%20-%20Authentic%20Audio%20Check.flac&metadata=false
Apr 20 22:39:15 volumio-n volumio[652]: info: URI /mnt/NAS/Zamba/NewMuss/(2011) VA - AYA - Authentic Audio Check/Various Artists - AYA - Authentic Audio Check.flac
Apr 20 22:39:15 volumio-n volumio[652]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists%20/AYA%20-%20Authentic%20Audio%20Check%20/extralarge&path=%2Fmnt%2FNAS%2FZamba%2FNewMuss%2F(2011)%20VA%20-%20AYA%20-%20Authentic%20Audio%20Check%2FVarious%20Artists%20%20-%20AYA%20-%20Authentic%20Audio%20Check.flac.cue&metadata=false
Apr 20 22:39:15 volumio-n volumio[652]: info: URI /mnt/NAS/Zamba/NewMuss/(2011) VA - AYA - Authentic Audio Check/Various Artists - AYA - Authentic Audio Check.flac.cue
Apr 20 22:39:15 volumio-n volumio[652]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists%20/AYA%20-%20Authentic%20Audio%20Check%20/extralarge&path=%2Fmnt%2FNAS%2FZamba%2FNewMuss%2F(2011)%20VA%20-%20AYA%20-%20Authentic%20Audio%20Check%2FVarious%20Artists%20%20-%20AYA%20-%20Authentic%20Audio%20Check.flac.cue&metadata=false
Apr 20 22:39:15 volumio-n volumio[652]: info: URI /mnt/NAS/Zamba/NewMuss/(2011) VA - AYA - Authentic Audio Check/Various Artists - AYA - Authentic Audio Check.flac.cue
Apr 20 22:39:15 volumio-n volumio[652]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 20 22:39:15 volumio-n volumio[652]: Error: Unable to resolve or reject the same promise twice
Apr 20 22:39:15 volumio-n volumio[652]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Apr 20 22:39:15 volumio-n volumio[652]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Apr 20 22:39:15 volumio-n volumio[652]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Apr 20 22:39:15 volumio-n volumio[652]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Apr 20 22:39:15 volumio-n volumio[652]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Apr 20 22:39:15 volumio-n volumio[652]: at Socket.emit (events.js:315:20)
Apr 20 22:39:15 volumio-n volumio[652]: at addChunk (internal/streams/readable.js:309:12)
Apr 20 22:39:15 volumio-n volumio[652]: at readableAddChunk (internal/streams/readable.js:280:11)
Apr 20 22:39:15 volumio-n volumio[652]: at Socket.Readable.push (internal/streams/readable.js:223:10)
Apr 20 22:39:15 volumio-n volumio[652]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Apr 20 22:39:15 volumio-n volumio[652]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 20 22:39:15 volumio-n sudo[2436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-20 22:38
Apr 20 22:39:15 volumio-n sudo[2436]: 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"