-- Logs begin at Tue 2024-10-29 14:01:56 UTC, end at Wed 2024-10-30 21:23:22 UTC. -- Oct 30 21:22:56 volumio kernel: CIFS: __readahead_batch() returned 47/1024 Oct 30 21:23:01 volumio sudo[10399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 21:23:01 volumio sudo[10397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 21:23:01 volumio sudo[10399]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:23:01 volumio sudo[10397]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:23:01 volumio sudo[10397]: pam_unix(sudo:session): session closed for user root Oct 30 21:23:01 volumio sudo[10399]: pam_unix(sudo:session): session closed for user root Oct 30 21:23:02 volumio volumio[1085]: verbose: New Socket.io Connection to 192.168.1.31 from 192.168.1.34 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 15_8_3 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/15.6.6 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 4 Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::volumioGetVisibleSources Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:02 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 30 21:23:02 volumio volumio[1085]: info: Received Get System Info Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:23:02 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:23:02 volumio volumio[1085]: info: Discovery: Getting this device information Oct 30 21:23:03 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:03 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:03 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:23:03 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:03 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:03 volumio volumio[1085]: info: Listing playlists Oct 30 21:23:03 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 30 21:23:03 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 30 21:23:04 volumio sudo[10404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 21:23:04 volumio sudo[10404]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:23:04 volumio sudo[10404]: pam_unix(sudo:session): session closed for user root Oct 30 21:23:04 volumio sudo[10407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 21:23:04 volumio sudo[10407]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:23:04 volumio sudo[10407]: pam_unix(sudo:session): session closed for user root Oct 30 21:23:04 volumio volumio[1085]: verbose: New Socket.io Connection to 192.168.1.31 from 192.168.1.34 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 15_8_3 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/15.6.6 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::volumioGetVisibleSources Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:04 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 30 21:23:04 volumio volumio[1085]: info: Received Get System Info Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:23:04 volumio volumio[1085]: info: Discovery: Getting this device information Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:04 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:04 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:04 volumio volumio[1085]: info: Listing playlists Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 30 21:23:04 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 30 21:23:05 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 30 21:23:06 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 21:23:06 volumio volumio[1085]: info: Received Get System Info Oct 30 21:23:06 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:23:06 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:23:06 volumio volumio[1085]: info: Discovery: Getting this device information Oct 30 21:23:06 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:06 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:06 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:23:06 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 30 21:23:07 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 30 21:23:08 volumio volumio[1085]: info: CoreCommandRouter::volumioGetQueue Oct 30 21:23:08 volumio volumio[1085]: info: CoreStateMachine::getQueue Oct 30 21:23:08 volumio volumio[1085]: info: CorePlayQueue::getQueue Oct 30 21:23:10 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 30 21:23:10 volumio volumio[1085]: info: CURURI: music-library Oct 30 21:23:10 volumio volumio[1085]: info: Preload queue cleared Oct 30 21:23:10 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 21:23:10 volumio volumio[1085]: info: Received Get System Info Oct 30 21:23:10 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:23:10 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:23:10 volumio volumio[1085]: info: Discovery: Getting this device information Oct 30 21:23:10 volumio volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 30 21:23:10 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:10 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:23:13 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 30 21:23:13 volumio volumio[1085]: info: CURURI: music-library/USB Oct 30 21:23:13 volumio volumio[1085]: info: Preload queue cleared Oct 30 21:23:14 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 21:23:16 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 30 21:23:16 volumio volumio[1085]: info: CURURI: music-library/USB/78EE-0421 Oct 30 21:23:16 volumio volumio[1085]: info: Preload queue cleared Oct 30 21:23:22 volumio volumio[1085]: info: Preload queue cleared Oct 30 21:23:22 volumio volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::ClearQueue Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::stop Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::stPlaybackTimer Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::updateTrackBlock Oct 30 21:23:22 volumio volumio[1085]: info: CorePlayQueue::getTrackBlock Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::pushState Oct 30 21:23:22 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:22 volumio volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:23:22 volumio volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::serviceStop Oct 30 21:23:22 volumio volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 30 21:23:22 volumio volumio[1085]: info: CoreCommandRouter::serviceStop Oct 30 21:23:22 volumio volumio[1085]: info: ControllerMpd::stop Oct 30 21:23:22 volumio volumio[1085]: verbose: ControllerMpd::sendMpdCommand stop Oct 30 21:23:22 volumio volumio[1085]: info: CorePlayQueue::clearPlayQueue Oct 30 21:23:22 volumio volumio[1085]: info: CorePlayQueue::saveQueue Oct 30 21:23:22 volumio volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 30 21:23:22 volumio volumio[1085]: info: CoreStateMachine::addQueueItems Oct 30 21:23:22 volumio volumio[1085]: info: CorePlayQueue::addQueueItems Oct 30 21:23:22 volumio volumio[1085]: info: Preload queue cleared Oct 30 21:23:22 volumio volumio[1085]: info: Adding Item to queue: music-library/USB/78EE-0421/All of Me - A Ming Oct 30 21:23:22 volumio volumio[1085]: info: Exploding uri music-library/USB/78EE-0421/All of Me - A Ming in service mpd Oct 30 21:23:22 volumio volumio[1085]: info: Oct 30 21:23:22 volumio volumio[1085]: ---------------------------- MPD announces state update: player Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F01.%20House%20Of%20The%20Rising%20Sun.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/01. House Of The Rising Sun.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F02.%20Outside%20World.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/02. Outside World.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F03.%20To%20Search%20All%20My%20Life.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/03. To Search All My Life.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F04.%20Have%20I%20told%20you%20lately%20that%20I%20love%20you.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/04. Have I told you lately that I love you.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F05.%20Bridge%20Over%20Troubled%20Water.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/05. Bridge Over Troubled Water.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F07.%20Sometimes%20When%20We%20Touch.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/07. Sometimes When We Touch.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F08.%20Don%E2%80%99t%20Leave%20Me%20Drunk%20Alone.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/08. Don’t Leave Me Drunk Alone.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=a-ming/All%20Of%20Me%20%5BHi%20Res%5D/extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2F09.%20Impression.wav&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/09. Impression.wav Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=//extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2Fdrive-download-20241020T032810Z-001.zip&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/drive-download-20241020T032810Z-001.zip Oct 30 21:23:22 volumio volumio[1085]: info: ALBUMART /albumart?cacheid=931&web=//extralarge&path=%2Fmnt%2FUSB%2F78EE-0421%2FAll%20of%20Me%20%20-%20A%20Ming%2Fdrive-download-20241020T032810Z-001.zip&metadata=false Oct 30 21:23:22 volumio volumio[1085]: info: URI /mnt/USB/78EE-0421/All of Me - A Ming/drive-download-20241020T032810Z-001.zip Oct 30 21:23:22 volumio volumio[1085]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 21:23:22 volumio volumio[1085]: Error: Unable to resolve or reject the same promise twice Oct 30 21:23:22 volumio volumio[1085]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 30 21:23:22 volumio volumio[1085]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Oct 30 21:23:22 volumio volumio[1085]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 30 21:23:22 volumio volumio[1085]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 30 21:23:22 volumio volumio[1085]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 30 21:23:22 volumio volumio[1085]: at Socket.emit (events.js:315:20) Oct 30 21:23:22 volumio volumio[1085]: at addChunk (internal/streams/readable.js:309:12) Oct 30 21:23:22 volumio volumio[1085]: at readableAddChunk (internal/streams/readable.js:280:11) Oct 30 21:23:22 volumio volumio[1085]: at Socket.Readable.push (internal/streams/readable.js:223:10) Oct 30 21:23:22 volumio volumio[1085]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Oct 30 21:23:22 volumio volumio[1085]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 21:23:22 volumio sudo[10458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-30 21:22 Oct 30 21:23:22 volumio sudo[10458]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"