-- Logs begin at Wed 2024-04-10 04:48:12 UTC, end at Wed 2024-04-10 04:53:34 UTC. -- Apr 10 04:52:39 volumio-pi volumiologrotate[551]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Apr 10 04:52:39 volumio-pi volumiologrotate[551]: ls: cannot access 'PI': No such file or directory Apr 10 04:52:46 volumio-pi sudo[1792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 10 04:52:46 volumio-pi sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 04:52:46 volumio-pi sudo[1792]: pam_unix(sudo:session): session closed for user root Apr 10 04:52:46 volumio-pi sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 10 04:52:46 volumio-pi sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 04:52:46 volumio-pi sudo[1795]: pam_unix(sudo:session): session closed for user root Apr 10 04:52:46 volumio-pi volumio[1211]: verbose: New Socket.io Connection to 192.168.10.131 from 192.168.10.119 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 5 Apr 10 04:52:47 volumio-pi sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 10 04:52:47 volumio-pi sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 04:52:47 volumio-pi sudo[1800]: pam_unix(sudo:session): session closed for user root Apr 10 04:52:47 volumio-pi sudo[1802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 10 04:52:47 volumio-pi sudo[1802]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 10 04:52:47 volumio-pi sudo[1802]: pam_unix(sudo:session): session closed for user root Apr 10 04:52:47 volumio-pi volumio[1211]: verbose: New Socket.io Connection to 192.168.10.131 from 192.168.10.119 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 6 Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetState Apr 10 04:52:47 volumio-pi volumio[1211]: info: CorePlayQueue::getTrack 0 Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetVisibleSources Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 10 04:52:47 volumio-pi volumio[1211]: info: Listing playlists Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 10 04:52:47 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 10 04:52:48 volumio-pi volumio[1211]: info: VolumeController::SetAlsaVolume0 Apr 10 04:52:48 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetState Apr 10 04:52:48 volumio-pi volumio[1211]: info: CorePlayQueue::getTrack 0 Apr 10 04:52:48 volumio-pi volumio[1211]: info: CoreStateMachine::pushState Apr 10 04:52:48 volumio-pi volumio[1211]: info: CorePlayQueue::getTrack 0 Apr 10 04:52:48 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 04:52:48 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioPushState Apr 10 04:52:48 volumio-pi volumio[1211]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 10 04:52:49 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 10 04:52:49 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 04:52:54 volumio-pi volumio[1211]: info: Retrieving Cloud Streaming UI Apr 10 04:52:54 volumio-pi volumio[1211]: info: Getting Tidal Cloud Configuration Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 04:52:54 volumio-pi volumio[1211]: info: Getting Qobuz Cloud Configuration Apr 10 04:52:54 volumio-pi volumio[1211]: info: Asking plugin for UI Config Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 04:52:54 volumio-pi volumio[1211]: info: Getting Spotify Cloud Configuration Apr 10 04:52:54 volumio-pi volumio[1211]: info: Asking plugin for UI Config Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 04:52:54 volumio-pi volumio[1211]: info: Saving Spotify Acccount Apr 10 04:52:54 volumio-pi volumio[1211]: info: Got Tidal Cloud Configuration Apr 10 04:52:54 volumio-pi volumio[1211]: info: Got it Apr 10 04:52:54 volumio-pi volumio[1211]: info: Got it Apr 10 04:52:54 volumio-pi volumio[1211]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 10 04:52:54 volumio-pi volumio[1211]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetBrowseSources Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 10 04:52:54 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 10 04:52:58 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 04:53:02 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 04:53:04 volumio-pi ntpd[682]: Soliciting pool server 2606:4700:f1::123 Apr 10 04:53:05 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 10 04:53:05 volumio-pi volumio[1211]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 10 04:53:05 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 10 04:53:06 volumio-pi volumio[1211]: info: Received Get System Version Apr 10 04:53:06 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 04:53:06 volumio-pi volumio[1211]: info: Received Get System Info Apr 10 04:53:06 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 10 04:53:06 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 10 04:53:06 volumio-pi volumio[1211]: info: Discovery: Getting this device information Apr 10 04:53:06 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetState Apr 10 04:53:06 volumio-pi volumio[1211]: info: CorePlayQueue::getTrack 0 Apr 10 04:53:06 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 10 04:53:06 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 10 04:53:08 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 04:53:08 volumio-pi volumio[1211]: info: CURURI: music-library Apr 10 04:53:08 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:09 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioGetQueue Apr 10 04:53:09 volumio-pi volumio[1211]: info: CoreStateMachine::getQueue Apr 10 04:53:09 volumio-pi volumio[1211]: info: CorePlayQueue::getQueue Apr 10 04:53:10 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 04:53:10 volumio-pi volumio[1211]: info: CURURI: music-library/INTERNAL Apr 10 04:53:11 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:16 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 04:53:16 volumio-pi volumio[1211]: info: CURURI: music-library/INTERNAL/FusionDsp Apr 10 04:53:16 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:17 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 04:53:17 volumio-pi volumio[1211]: info: CURURI: music-library/INTERNAL/FusionDsp/hrtf-filters Apr 10 04:53:17 volumio-pi volumio[1211]: error: Failed LSINFO: null Apr 10 04:53:18 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:24 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 04:53:24 volumio-pi volumio[1211]: info: CURURI: music-library/NAS Apr 10 04:53:24 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:26 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 04:53:26 volumio-pi volumio[1211]: info: CURURI: music-library/NAS/PI5-4TB_NVMe Apr 10 04:53:26 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:30 volumio-pi volumio[1211]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 04:53:30 volumio-pi volumio[1211]: info: CURURI: music-library/NAS/PI5-4TB_NVMe/CD SONGS 5 Apr 10 04:53:30 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:33 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:33 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 04:53:33 volumio-pi volumio[1211]: info: CoreStateMachine::ClearQueue Apr 10 04:53:33 volumio-pi volumio[1211]: info: CoreStateMachine::stop Apr 10 04:53:33 volumio-pi volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 04:53:33 volumio-pi volumio[1211]: info: CorePlayQueue::clearPlayQueue Apr 10 04:53:33 volumio-pi volumio[1211]: info: CorePlayQueue::saveQueue Apr 10 04:53:33 volumio-pi volumio[1211]: info: CoreCommandRouter::volumioPushQueue Apr 10 04:53:33 volumio-pi volumio[1211]: info: CoreStateMachine::addQueueItems Apr 10 04:53:33 volumio-pi volumio[1211]: info: CorePlayQueue::addQueueItems Apr 10 04:53:33 volumio-pi volumio[1211]: info: Preload queue cleared Apr 10 04:53:33 volumio-pi volumio[1211]: info: Adding Item to queue: music-library/NAS/PI5-4TB_NVMe/CD SONGS 5/One Man Many Roles - Kishore Kumar [Qobuz] [16-Bit CD Quality 44.1 kHz - Stereo] - ENIGMA.zip Apr 10 04:53:33 volumio-pi volumio[1211]: info: Exploding uri music-library/NAS/PI5-4TB_NVMe/CD SONGS 5/One Man Many Roles - Kishore Kumar [Qobuz] [16-Bit CD Quality 44.1 kHz - Stereo] - ENIGMA.zip in service mpd Apr 10 04:53:33 volumio-pi volumio[1211]: info: ALBUMART /albumart?cacheid=886&web=Kishore%20Kumar/One%20Man%20Many%20Roles%20-%20Kishore%20Kumar/mega&path=%2Fmnt%2FNAS%2FPI5-4TB_NVMe%2FCD%20SONGS%205%2FOne%20Man%20Many%20Roles%20-%20Kishore%20Kumar%20%5BQobuz%5D%20%5B16-Bit%20CD%20Quality%2044.1%20kHz%20-%20Stereo%5D%20-%20ENIGMA.zip&metadata=false Apr 10 04:53:33 volumio-pi volumio[1211]: info: URI /mnt/NAS/PI5-4TB_NVMe/CD SONGS 5/One Man Many Roles - Kishore Kumar [Qobuz] [16-Bit CD Quality 44.1 kHz - Stereo] - ENIGMA.zip Apr 10 04:53:33 volumio-pi volumio[1211]: info: ALBUMART /albumart?cacheid=886&web=Kishore%20Kumar/One%20Man%20Many%20Roles%20-%20Kishore%20Kumar/mega&path=%2Fmnt%2FNAS%2FPI5-4TB_NVMe%2FCD%20SONGS%205%2FOne%20Man%20Many%20Roles%20-%20Kishore%20Kumar%20%5BQobuz%5D%20%5B16-Bit%20CD%20Quality%2044.1%20kHz%20-%20Stereo%5D%20-%20ENIGMA.zip&metadata=false Apr 10 04:53:33 volumio-pi volumio[1211]: info: URI /mnt/NAS/PI5-4TB_NVMe/CD SONGS 5/One Man Many Roles - Kishore Kumar [Qobuz] [16-Bit CD Quality 44.1 kHz - Stereo] - ENIGMA.zip Apr 10 04:53:33 volumio-pi volumio[1211]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 04:53:33 volumio-pi volumio[1211]: Error: Unable to resolve or reject the same promise twice Apr 10 04:53:33 volumio-pi volumio[1211]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 10 04:53:33 volumio-pi volumio[1211]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 10 04:53:33 volumio-pi volumio[1211]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 10 04:53:33 volumio-pi volumio[1211]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 10 04:53:33 volumio-pi volumio[1211]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 10 04:53:33 volumio-pi volumio[1211]: at Socket.emit (events.js:315:20) Apr 10 04:53:33 volumio-pi volumio[1211]: at addChunk (internal/streams/readable.js:309:12) Apr 10 04:53:33 volumio-pi volumio[1211]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 10 04:53:33 volumio-pi volumio[1211]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 10 04:53:33 volumio-pi volumio[1211]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 10 04:53:33 volumio-pi volumio[1211]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 04:53:34 volumio-pi sudo[1860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-10 04:52 Apr 10 04:53:34 volumio-pi sudo[1860]: 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"