-- Logs begin at Thu 2025-05-29 20:00:01 CEST, end at Thu 2025-05-29 20:11:02 CEST. -- May 29 20:10:01 rpi4-argon CRON[4609]: pam_unix(cron:session): session opened for user root by (uid=0) May 29 20:10:01 rpi4-argon CRON[4610]: (root) CMD (/usr/bin/sudo bash /home/volumio/scripts/date_time.sh) May 29 20:10:01 rpi4-argon sudo[4611]: root : TTY=unknown ; PWD=/root ; USER=root ; COMMAND=/bin/bash /home/volumio/scripts/date_time.sh May 29 20:10:01 rpi4-argon sudo[4611]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:01 rpi4-argon sudo[4618]: root : TTY=unknown ; PWD=/root ; USER=root ; COMMAND=/bin/date -s Thu, 29 May 2025 18:10:02 GMT#015 May 29 20:10:01 rpi4-argon sudo[4618]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:02 rpi4-argon sudo[4618]: pam_unix(sudo:session): session closed for user root May 29 20:10:02 rpi4-argon sudo[4611]: pam_unix(sudo:session): session closed for user root May 29 20:10:02 rpi4-argon cron[686]: 2025-05-29 20:10:02 1uKhha-0001CW-2x Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 May 29 20:10:02 rpi4-argon cron[686]: 2025-05-29 20:10:02 1uKhha-0001CW-2x <= root@localhost U=root P=local S=618 May 29 20:10:02 rpi4-argon cron[686]: 2025-05-29 20:10:02 1uKhha-0001CW-2x Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 May 29 20:10:02 rpi4-argon cron[686]: exim: could not open panic log - aborting: see message(s) above May 29 20:10:02 rpi4-argon exim[4620]: 2025-05-29 20:10:02 1uKhha-0001CW-2x <= root@localhost U=root P=local S=618 May 29 20:10:02 rpi4-argon exim[4620]: 2025-05-29 20:10:02 1uKhha-0001CW-2x Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 May 29 20:10:02 rpi4-argon exim[4620]: exim: could not open panic log - aborting: see message(s) above May 29 20:10:02 rpi4-argon CRON[4609]: (root) MAIL (mailed 30 bytes of output but got status 0x0001 from MTA ) May 29 20:10:02 rpi4-argon CRON[4609]: pam_unix(cron:session): session closed for user root May 29 20:10:08 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 29 20:10:08 rpi4-argon volumio[1398]: info: CURURI: music-library/NAS/M1S/01-test/DSD May 29 20:10:08 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:08 rpi4-argon volumio[1398]: info: Preloading song: music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf May 29 20:10:08 rpi4-argon volumio[1398]: info: Preloading song: music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf May 29 20:10:08 rpi4-argon volumio[1398]: info: Preloading song: music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf May 29 20:10:08 rpi4-argon volumio[1398]: info: Preloading song: music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf May 29 20:10:08 rpi4-argon volumio[1398]: info: Exploding uri music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf in service mpd May 29 20:10:08 rpi4-argon volumio[1398]: error: scanFolder - failure to stat '/mnt/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf' May 29 20:10:08 rpi4-argon volumio[1398]: info: Exploding uri music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf in service mpd May 29 20:10:08 rpi4-argon volumio[1398]: error: scanFolder - failure to stat '/mnt/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf' May 29 20:10:08 rpi4-argon volumio[1398]: info: Exploding uri music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf in service mpd May 29 20:10:08 rpi4-argon volumio[1398]: error: scanFolder - failure to stat '/mnt/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf' May 29 20:10:08 rpi4-argon volumio[1398]: info: Exploding uri music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf in service mpd May 29 20:10:08 rpi4-argon volumio[1398]: error: scanFolder - failure to stat '/mnt/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf' May 29 20:10:16 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 29 20:10:16 rpi4-argon volumio[1398]: info: CURURI: music-library/NAS/M1S/01-test/DSD May 29 20:10:16 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:19 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioReplaceandPlayItems May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::ClearQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::stop May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::clearPlayQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::addQueueItems May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::addQueueItems May 29 20:10:19 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:19 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::updateTrackBlock May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrackBlock May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPlay May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::play index 0 May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::addQueueItems May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::addQueueItems May 29 20:10:19 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:19 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::stop May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::play index undefined May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:19 rpi4-argon volumio[1398]: info: CoreStateMachine::updateTrackBlock May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrackBlock May 29 20:10:19 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:25 rpi4-argon sudo[4668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 20:10:25 rpi4-argon sudo[4668]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:25 rpi4-argon sudo[4668]: pam_unix(sudo:session): session closed for user root May 29 20:10:25 rpi4-argon sudo[4671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 20:10:25 rpi4-argon sudo[4671]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:25 rpi4-argon sudo[4671]: pam_unix(sudo:session): session closed for user root May 29 20:10:26 rpi4-argon volumio[1398]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.181 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 29 20:10:26 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetVisibleSources May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:27 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetQueue May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreStateMachine::getQueue May 29 20:10:27 rpi4-argon volumio[1398]: info: CorePlayQueue::getQueue May 29 20:10:27 rpi4-argon volumio[1398]: info: Listing playlists May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 29 20:10:27 rpi4-argon volumio[1398]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 29 20:10:27 rpi4-argon volumio[1398]: info: Received Get System Info May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 20:10:27 rpi4-argon volumio[1398]: info: Discovery: Getting this device information May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:27 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:27 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 29 20:10:27 rpi4-argon volumio[1398]: info: Received Get System Info May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 20:10:27 rpi4-argon volumio[1398]: info: Discovery: Getting this device information May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:27 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:27 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 20:10:28 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 29 20:10:29 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 29 20:10:29 rpi4-argon volumio[1398]: info: Received Get System Info May 29 20:10:29 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 20:10:29 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 20:10:29 rpi4-argon volumio[1398]: info: Discovery: Getting this device information May 29 20:10:29 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:29 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:29 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 20:10:31 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:31 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:32 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 29 20:10:32 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 29 20:10:32 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 29 20:10:34 rpi4-argon volumio[1398]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 29 20:10:34 rpi4-argon volumio[1398]: info: Preparing to save Alsa Options, stopping services first May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:34 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPause May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreStateMachine::pause May 29 20:10:34 rpi4-argon volumio[1398]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Pre Box S2 Digital"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: info: Setting mixer Pre Box S2 Digital for card Pre Box S2 Digital May 29 20:10:34 rpi4-argon volumio[1398]: info: QobuzConnect: setDeactiveState invoked May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:34 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:34 rpi4-argon vtcs[2039]: [2025-05-29 20:10:34.459] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 29 20:10:34 rpi4-argon vtcs[2039]: [2025-05-29 20:10:34.460] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 29 20:10:34 rpi4-argon vtcs[2039]: [2025-05-29 20:10:34.460] [tisoc] [error] [SpkconServer.cpp:473] socket write error. fd=3 errorno=32 error=Broken pipe May 29 20:10:34 rpi4-argon sudo[4698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 29 20:10:34 rpi4-argon sudo[4698]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:34 rpi4-argon systemd[1]: Stopping Volumio Tidal Connect Service... May 29 20:10:34 rpi4-argon systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 29 20:10:34 rpi4-argon systemd[1]: vtcs.service: Succeeded. May 29 20:10:34 rpi4-argon systemd[1]: Stopped Volumio Tidal Connect Service. May 29 20:10:34 rpi4-argon sudo[4698]: pam_unix(sudo:session): session closed for user root May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 29 20:10:34 rpi4-argon volumio[1398]: info: Updating Volume Controller Parameters: Device: 5 Name: Pre Box S2 Digital Mixer: Pre Box S2 Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 29 20:10:34 rpi4-argon volumio[1398]: info: Disabling external Volume Control May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:34 rpi4-argon volumio[1398]: info: Preparing to generate the ALSA configuration file May 29 20:10:34 rpi4-argon sudo[4705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 29 20:10:34 rpi4-argon sudo[4705]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:34 rpi4-argon sudo[4705]: pam_unix(sudo:session): session closed for user root May 29 20:10:34 rpi4-argon sudo[4712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 29 20:10:34 rpi4-argon sudo[4712]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:34 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: running May 29 20:10:34 rpi4-argon volumio[1398]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 29 20:10:34 rpi4-argon sudo[4712]: pam_unix(sudo:session): session closed for user root May 29 20:10:34 rpi4-argon volumio[1398]: info: Reading ALSA contributions from plugins. May 29 20:10:34 rpi4-argon sudo[4714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 29 20:10:34 rpi4-argon sudo[4714]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:34 rpi4-argon systemd[1]: Stopping Volumio Qobuz Connect Service... May 29 20:10:34 rpi4-argon qobuz-connect[2012]: 20250529 20:10:34.681 [2012.2012] INFO SampleApp: Stopping Local configuration server May 29 20:10:34 rpi4-argon qobuz-connect[2012]: 20250529 20:10:34.691 [2012.2012] INFO SampleApp: shat down connection on UNIX socket May 29 20:10:34 rpi4-argon systemd[1]: qobuz-connect.service: Succeeded. May 29 20:10:34 rpi4-argon systemd[1]: Stopped Volumio Qobuz Connect Service. May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 29 20:10:34 rpi4-argon systemd[1]: Started Volumio Qobuz Connect Service. May 29 20:10:34 rpi4-argon sudo[4714]: pam_unix(sudo:session): session closed for user root May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 29 20:10:34 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: running May 29 20:10:34 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 29 20:10:34 rpi4-argon volumio[1398]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 29 20:10:34 rpi4-argon volumio[1398]: info: QobuzConnect: setDeactiveState invoked May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:34 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:34 rpi4-argon volumio[1398]: info: VolumeController:: Volume=22 Mute =false May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:34 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:34 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:34 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:34 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:34 rpi4-argon volumio[1398]: info: Executing endpoint qc_getconfig May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.844 [4718.4718] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.848 [4718.4718] INFO VolumeManager: [0x1ff3a38]: Setting new playback volume: 75 May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.848 [4718.4718] INFO VolumeManager: [0x1ff3a38]: Setting new mute state: 0 May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.848 [4718.4718] INFO QobuzConnect: [0x1ff4408]: Client initialized! May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.848 [4718.4718] INFO SampleApp: Starting Avahi advertising, name: rPi4-Argon, service name: _qobuz-connect._tcp May 29 20:10:34 rpi4-argon volumio[1398]: info: Asound.conf file unchanged, so no further update is needed May 29 20:10:34 rpi4-argon volumio[1398]: info: Output device has changed, restarting MPD May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.855 [4718.4718] INFO LocalConfigManager: [0x1ff3318]: Starting Local Configuration server May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.855 [4718.4718] INFO SampleApp: Starting Local configuration server May 29 20:10:34 rpi4-argon qobuz-connect[4718]: 20250529 20:10:34.856 [4718.4718] INFO SampleApp: Connected to UNIX socket client 0x1fe8f60 May 29 20:10:34 rpi4-argon sudo[4725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 29 20:10:34 rpi4-argon volumio[1398]: info: Output device has changed, restarting Shairport Sync May 29 20:10:34 rpi4-argon sudo[4725]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 29 20:10:34 rpi4-argon sudo[4725]: pam_unix(sudo:session): session closed for user root May 29 20:10:34 rpi4-argon sudo[4727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 29 20:10:34 rpi4-argon sudo[4727]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:34 rpi4-argon systemd[1]: Stopping Music Player Daemon... May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 29 20:10:34 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:34 rpi4-argon volumio[1398]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:34 rpi4-argon volumio[1398]: info: QobuzConnect: setDeactiveState invoked May 29 20:10:34 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:34 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:34 rpi4-argon sudo[4736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 29 20:10:34 rpi4-argon sudo[4736]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:35 rpi4-argon qobuz-connect[4718]: 20250529 20:10:35.003 [4718.4718] INFO SampleApp: Playback volume changed: 75 May 29 20:10:35 rpi4-argon sudo[4739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 29 20:10:35 rpi4-argon sudo[4739]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:35 rpi4-argon sudo[4736]: pam_unix(sudo:session): session closed for user root May 29 20:10:35 rpi4-argon sudo[4739]: pam_unix(sudo:session): session closed for user root May 29 20:10:35 rpi4-argon volumio[1398]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 29 20:10:35 rpi4-argon volumio[1398]: info: QobuzConnect: QOBUZ Connect daemon connected May 29 20:10:35 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: running May 29 20:10:35 rpi4-argon sudo[4746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 29 20:10:35 rpi4-argon sudo[4746]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:35 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:35 rpi4-argon sudo[4746]: pam_unix(sudo:session): session closed for user root May 29 20:10:35 rpi4-argon volumio[1398]: info: MPD Permissions set May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon sudo[4749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 29 20:10:35 rpi4-argon sudo[4749]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 29 20:10:35 rpi4-argon volumio[1398]: info: Starting Shairport Sync May 29 20:10:35 rpi4-argon systemd[1]: mpd.service: Succeeded. May 29 20:10:35 rpi4-argon systemd[1]: Stopped Music Player Daemon. May 29 20:10:35 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 29 20:10:35 rpi4-argon sudo[4757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 29 20:10:35 rpi4-argon sudo[4757]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:35 rpi4-argon systemd[1]: Starting Music Player Daemon... May 29 20:10:35 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: running May 29 20:10:35 rpi4-argon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 29 20:10:35 rpi4-argon systemd[1]: Stopping Volumio Qobuz Connect Service... May 29 20:10:35 rpi4-argon systemd[1]: shairport-sync.service: Succeeded. May 29 20:10:35 rpi4-argon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 29 20:10:35 rpi4-argon qobuz-connect[4718]: 20250529 20:10:35.234 [4718.4718] INFO SampleApp: Stopping Local configuration server May 29 20:10:35 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: running May 29 20:10:35 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: running May 29 20:10:35 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 29 20:10:35 rpi4-argon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 29 20:10:35 rpi4-argon qobuz-connect[4718]: 20250529 20:10:35.244 [4718.4718] INFO SampleApp: shat down connection on UNIX socket May 29 20:10:35 rpi4-argon systemd[1]: qobuz-connect.service: Succeeded. May 29 20:10:35 rpi4-argon sudo[4757]: pam_unix(sudo:session): session closed for user root May 29 20:10:35 rpi4-argon systemd[1]: Stopped Volumio Qobuz Connect Service. May 29 20:10:35 rpi4-argon volumio[1398]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 29 20:10:35 rpi4-argon volumio[1398]: info: QobuzConnect: setDeactiveState invoked May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:35 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:35 rpi4-argon systemd[1]: Started Volumio Qobuz Connect Service. May 29 20:10:35 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 29 20:10:35 rpi4-argon volumio[1398]: info: Shairport-Sync Started May 29 20:10:35 rpi4-argon sudo[4749]: pam_unix(sudo:session): session closed for user root May 29 20:10:35 rpi4-argon volumio[1398]: info: Executing endpoint qc_getconfig May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.298 [4761.4761] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 29 20:10:35 rpi4-argon volumio[1398]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 29 20:10:35 rpi4-argon volumio[1398]: info: QobuzConnect: QOBUZ Connect daemon connected May 29 20:10:35 rpi4-argon sudo[4755]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.302 [4761.4761] INFO VolumeManager: [0x1a79a38]: Setting new playback volume: 75 May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.303 [4761.4761] INFO VolumeManager: [0x1a79a38]: Setting new mute state: 0 May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.303 [4761.4761] INFO QobuzConnect: [0x1a7a408]: Client initialized! May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.303 [4761.4761] INFO SampleApp: Starting Avahi advertising, name: rPi4-Argon, service name: _qobuz-connect._tcp May 29 20:10:35 rpi4-argon sudo[4755]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:35 rpi4-argon sudo[4755]: pam_unix(sudo:session): session closed for user root May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.311 [4761.4761] INFO LocalConfigManager: [0x1a79318]: Starting Local Configuration server May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.311 [4761.4761] INFO SampleApp: Starting Local configuration server May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.311 [4761.4761] INFO SampleApp: Connected to UNIX socket client 0x1a6ef60 May 29 20:10:35 rpi4-argon qobuz-connect[4761]: 20250529 20:10:35.449 [4761.4761] INFO SampleApp: Playback volume changed: 75 May 29 20:10:35 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:35 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:35 rpi4-argon mpd[4767]: May 29 20:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 29 20:10:36 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 29 20:10:36 rpi4-argon volumio[1398]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] May 29 20:10:36 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions May 29 20:10:36 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:36 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:36 rpi4-argon volumio[1398]: info: Restoring Previous Volume level: 22 false false May 29 20:10:36 rpi4-argon volumio[1398]: info: Volume configurations have been set May 29 20:10:36 rpi4-argon volumio[1398]: info: QobuzConnect: setDeactiveState invoked May 29 20:10:36 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:36 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:36 rpi4-argon sudo[4769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 29 20:10:36 rpi4-argon sudo[4769]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:37 rpi4-argon sudo[4769]: pam_unix(sudo:session): session closed for user root May 29 20:10:37 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 29 20:10:37 rpi4-argon volumio[1398]: info: Updating Volume Controller Parameters: Device: 5 Name: Pre Box S2 Digital Mixer: Pre Box S2 Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 29 20:10:37 rpi4-argon volumio[1398]: info: Disabling external Volume Control May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:37 rpi4-argon systemd[1]: Started Music Player Daemon. May 29 20:10:37 rpi4-argon sudo[4727]: pam_unix(sudo:session): session closed for user root May 29 20:10:37 rpi4-argon sudo[4776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 29 20:10:37 rpi4-argon sudo[4776]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:37 rpi4-argon sudo[4776]: pam_unix(sudo:session): session closed for user root May 29 20:10:37 rpi4-argon sudo[4784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 29 20:10:37 rpi4-argon sudo[4784]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:37 rpi4-argon sudo[4784]: pam_unix(sudo:session): session closed for user root May 29 20:10:37 rpi4-argon sudo[4788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 29 20:10:37 rpi4-argon sudo[4788]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:37 rpi4-argon systemd[1]: Stopping Volumio Qobuz Connect Service... May 29 20:10:37 rpi4-argon qobuz-connect[4761]: 20250529 20:10:37.191 [4761.4761] INFO SampleApp: Stopping Local configuration server May 29 20:10:37 rpi4-argon qobuz-connect[4761]: 20250529 20:10:37.202 [4761.4761] INFO SampleApp: shat down connection on UNIX socket May 29 20:10:37 rpi4-argon systemd[1]: qobuz-connect.service: Succeeded. May 29 20:10:37 rpi4-argon systemd[1]: Stopped Volumio Qobuz Connect Service. May 29 20:10:37 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 29 20:10:37 rpi4-argon systemd[1]: Started Volumio Qobuz Connect Service. May 29 20:10:37 rpi4-argon sudo[4788]: pam_unix(sudo:session): session closed for user root May 29 20:10:37 rpi4-argon volumio[1398]: xcb_connection_has_error() returned true May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 29 20:10:37 rpi4-argon volumio[1398]: error: updateQueue error: null May 29 20:10:37 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: running May 29 20:10:37 rpi4-argon volumio[1398]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 29 20:10:37 rpi4-argon volumio[1398]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 29 20:10:37 rpi4-argon volumio[1398]: info: QobuzConnect: setDeactiveState invoked May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: VolumeController:: Volume=22 Mute =false May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: Executing endpoint qc_getconfig May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.338 [4794.4794] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 29 20:10:37 rpi4-argon volumio[1398]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 29 20:10:37 rpi4-argon volumio[1398]: info: QobuzConnect: QOBUZ Connect daemon connected May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.342 [4794.4794] INFO VolumeManager: [0x894a38]: Setting new playback volume: 75 May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.342 [4794.4794] INFO VolumeManager: [0x894a38]: Setting new mute state: 0 May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.342 [4794.4794] INFO QobuzConnect: [0x895408]: Client initialized! May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.342 [4794.4794] INFO SampleApp: Starting Avahi advertising, name: rPi4-Argon, service name: _qobuz-connect._tcp May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.347 [4794.4794] INFO LocalConfigManager: [0x894318]: Starting Local Configuration server May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.348 [4794.4794] INFO SampleApp: Starting Local configuration server May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.348 [4794.4794] INFO SampleApp: Connected to UNIX socket client 0x889f60 May 29 20:10:37 rpi4-argon qobuz-connect[4794]: 20250529 20:10:37.488 [4794.4794] INFO SampleApp: Playback volume changed: 75 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: TidalConnect service stoped! May 29 20:10:37 rpi4-argon volumio[1398]: info: TidalConnect service stoped! May 29 20:10:37 rpi4-argon volumio[1398]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 29 20:10:37 rpi4-argon volumio[1398]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 29 20:10:37 rpi4-argon sudo[4809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 29 20:10:37 rpi4-argon sudo[4809]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:37 rpi4-argon systemd[1]: Started Volumio Tidal Connect Service. May 29 20:10:37 rpi4-argon sudo[4809]: pam_unix(sudo:session): session closed for user root May 29 20:10:37 rpi4-argon volumio[1398]: info: Executing endpoint tc_getconfig May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 29 20:10:37 rpi4-argon vtcs[4811]: STARTING TidalConnect services, version: 1.4.0.34 May 29 20:10:37 rpi4-argon vtcs[4811]: STARTED TidalConnect services. May 29 20:10:37 rpi4-argon volumio[1398]: info: Executing endpoint tc_connect May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 29 20:10:37 rpi4-argon volumio[1398]: info: Connecting to TidalConnect May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::servicePushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 29 20:10:37 rpi4-argon volumio[1398]: verbose: CURRENT POSITION 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::syncState stateService stop May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::syncState currentStatus stop May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: No code May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::servicePushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 29 20:10:37 rpi4-argon volumio[1398]: verbose: CURRENT POSITION 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::syncState stateService stop May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::syncState currentStatus stop May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: No code May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:37 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:37 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:37 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:38 rpi4-argon volumio[1398]: info: TidalConnect service stoped! May 29 20:10:38 rpi4-argon volumio[1398]: info: TidalConnect service stoped! May 29 20:10:38 rpi4-argon volumio[1398]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 29 20:10:38 rpi4-argon volumio[1398]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 29 20:10:38 rpi4-argon sudo[4839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 29 20:10:38 rpi4-argon sudo[4839]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:38 rpi4-argon sudo[4839]: pam_unix(sudo:session): session closed for user root May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreStateMachine::getcurrentVolume May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioRetrievevolume May 29 20:10:38 rpi4-argon volumio[1398]: info: VolumeController:: Volume=22 Mute =false May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:38 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:38 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:38 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:38 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreStateMachine::updateTrackBlock May 29 20:10:38 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrackBlock May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioRetrievevolume May 29 20:10:38 rpi4-argon volumio[1398]: info: VolumeController:: Volume=22 Mute =false May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:38 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:38 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:38 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:38 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:38 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:40 rpi4-argon volumio[1398]: info: TidalConnect service stoped! May 29 20:10:40 rpi4-argon volumio[1398]: info: TidalConnect service stoped! May 29 20:10:40 rpi4-argon volumio[1398]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 29 20:10:40 rpi4-argon volumio[1398]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 29 20:10:40 rpi4-argon sudo[4856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 29 20:10:40 rpi4-argon sudo[4856]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:10:40 rpi4-argon sudo[4856]: pam_unix(sudo:session): session closed for user root May 29 20:10:40 rpi4-argon volumio[1398]: info: TidalConnect service started! May 29 20:10:41 rpi4-argon volumio[1398]: info: TidalConnect service started! May 29 20:10:41 rpi4-argon volumio[1398]: info: VolumeController::SetAlsaVolume22 May 29 20:10:41 rpi4-argon volumio[1398]: info: CoreStateMachine::pushState May 29 20:10:41 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:41 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushState May 29 20:10:41 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output update for this device May 29 20:10:41 rpi4-argon volumio[1398]: info: MRS: Pushing multiroomSync output May 29 20:10:41 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:41 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:41 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:41 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:43 rpi4-argon volumio[1398]: info: TidalConnect service started! May 29 20:10:43 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 29 20:10:43 rpi4-argon volumio[1398]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 29 20:10:43 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 29 20:10:43 rpi4-argon volumio[1398]: info: Received Get System Version May 29 20:10:43 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 29 20:10:43 rpi4-argon volumio[1398]: info: Received Get System Info May 29 20:10:43 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 20:10:43 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 20:10:43 rpi4-argon volumio[1398]: info: Discovery: Getting this device information May 29 20:10:43 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:43 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:43 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 20:10:44 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 29 20:10:44 rpi4-argon volumio[1398]: info: CURURI: music-library May 29 20:10:44 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:45 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 29 20:10:45 rpi4-argon volumio[1398]: info: CURURI: music-library/NAS May 29 20:10:45 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:45 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 29 20:10:45 rpi4-argon volumio[1398]: info: CURURI: music-library/NAS/M1S May 29 20:10:45 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:47 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 29 20:10:47 rpi4-argon volumio[1398]: info: CURURI: music-library/NAS/M1S/01-test May 29 20:10:47 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:48 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 29 20:10:48 rpi4-argon volumio[1398]: info: CURURI: music-library/NAS/M1S/01-test/DSD May 29 20:10:48 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:50 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioReplaceandPlayItems May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::ClearQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::stop May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::clearPlayQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::addQueueItems May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::addQueueItems May 29 20:10:50 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:50 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::updateTrackBlock May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrackBlock May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPlay May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::play index 0 May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::addQueueItems May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::addQueueItems May 29 20:10:50 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:50 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::stop May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::play index undefined May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:50 rpi4-argon volumio[1398]: info: CoreStateMachine::updateTrackBlock May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrackBlock May 29 20:10:50 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:52 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioReplaceandPlayItems May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::ClearQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::stop May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::clearPlayQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::addQueueItems May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::addQueueItems May 29 20:10:52 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:52 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0101 - Morgan Wade - Total Control DSD64.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0106 - Morgan Wade - 2AM in London DSD128.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::updateTrackBlock May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrackBlock May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPlay May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::play index 1 May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::addQueueItems May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::addQueueItems May 29 20:10:52 rpi4-argon volumio[1398]: info: Preload queue cleared May 29 20:10:52 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0107 - Morgan Wade - Hansel and Gretel DSD256.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: Adding Item to queue: music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: Using cached record of: music-library/NAS/M1S/01-test/DSD/0110 - Morgan Wade - Walked on Water DSD512.dsf May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::stop May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioPushQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::saveQueue May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::play index undefined May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 20:10:52 rpi4-argon volumio[1398]: info: CoreStateMachine::updateTrackBlock May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrackBlock May 29 20:10:52 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 1 May 29 20:10:55 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetState May 29 20:10:55 rpi4-argon volumio[1398]: info: CorePlayQueue::getTrack 0 May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:58 rpi4-argon volumio[1398]: info: Retrieving Cloud Streaming UI May 29 20:10:58 rpi4-argon volumio[1398]: info: Getting Tidal Cloud Configuration May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:58 rpi4-argon volumio[1398]: info: Getting Qobuz Cloud Configuration May 29 20:10:58 rpi4-argon volumio[1398]: info: Asking plugin for UI Config May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:58 rpi4-argon volumio[1398]: info: Getting Spotify Cloud Configuration May 29 20:10:58 rpi4-argon volumio[1398]: info: Asking plugin for UI Config May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:58 rpi4-argon volumio[1398]: info: Saving Spotify Acccount May 29 20:10:58 rpi4-argon volumio[1398]: info: Got it May 29 20:10:58 rpi4-argon volumio[1398]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 29 20:10:58 rpi4-argon volumio[1398]: info: Got Tidal Cloud Configuration May 29 20:10:58 rpi4-argon volumio[1398]: info: Got it May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetBrowseSources May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetBrowseSources May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::volumioGetBrowseSources May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 20:10:58 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 29 20:11:01 rpi4-argon CRON[4935]: pam_unix(cron:session): session opened for user root by (uid=0) May 29 20:11:01 rpi4-argon CRON[4936]: (root) CMD (/usr/bin/sudo bash /home/volumio/scripts/date_time.sh) May 29 20:11:01 rpi4-argon sudo[4937]: root : TTY=unknown ; PWD=/root ; USER=root ; COMMAND=/bin/bash /home/volumio/scripts/date_time.sh May 29 20:11:01 rpi4-argon sudo[4937]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:11:01 rpi4-argon sudo[4944]: root : TTY=unknown ; PWD=/root ; USER=root ; COMMAND=/bin/date -s Thu, 29 May 2025 18:11:01 GMT#015 May 29 20:11:01 rpi4-argon sudo[4944]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:11:01 rpi4-argon sudo[4944]: pam_unix(sudo:session): session closed for user root May 29 20:11:01 rpi4-argon sudo[4937]: pam_unix(sudo:session): session closed for user root May 29 20:11:01 rpi4-argon cron[686]: 2025-05-29 20:11:01 1uKhiX-0001Hn-2M Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 May 29 20:11:01 rpi4-argon cron[686]: 2025-05-29 20:11:01 1uKhiX-0001Hn-2M <= root@localhost U=root P=local S=618 May 29 20:11:01 rpi4-argon cron[686]: 2025-05-29 20:11:01 1uKhiX-0001Hn-2M Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 May 29 20:11:01 rpi4-argon cron[686]: exim: could not open panic log - aborting: see message(s) above May 29 20:11:01 rpi4-argon exim[4947]: 2025-05-29 20:11:01 1uKhiX-0001Hn-2M <= root@localhost U=root P=local S=618 May 29 20:11:01 rpi4-argon exim[4947]: 2025-05-29 20:11:01 1uKhiX-0001Hn-2M Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 May 29 20:11:01 rpi4-argon exim[4947]: exim: could not open panic log - aborting: see message(s) above May 29 20:11:01 rpi4-argon CRON[4935]: (root) MAIL (mailed 30 bytes of output but got status 0x0001 from MTA ) May 29 20:11:01 rpi4-argon CRON[4935]: pam_unix(cron:session): session closed for user root May 29 20:11:02 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 29 20:11:02 rpi4-argon volumio[1398]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 29 20:11:02 rpi4-argon sudo[4963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/M1S May 29 20:11:02 rpi4-argon sudo[4963]: pam_unix(sudo:session): session opened for user root by (uid=0) May 29 20:11:02 rpi4-argon sudo[4963]: pam_unix(sudo:session): session closed for user root May 29 20:11:02 rpi4-argon volumio[1398]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 20:11:02 rpi4-argon volumio[1398]: Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/M1S' May 29 20:11:02 rpi4-argon volumio[1398]: at Object.rmdirSync (fs.js:890:10) May 29 20:11:02 rpi4-argon volumio[1398]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 May 29 20:11:02 rpi4-argon volumio[1398]: at ChildProcess.exithandler (child_process.js:299:7) May 29 20:11:02 rpi4-argon volumio[1398]: at ChildProcess.emit (events.js:315:20) May 29 20:11:02 rpi4-argon volumio[1398]: at maybeClose (internal/child_process.js:1048:16) May 29 20:11:02 rpi4-argon volumio[1398]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) { May 29 20:11:02 rpi4-argon volumio[1398]: errno: -16, May 29 20:11:02 rpi4-argon volumio[1398]: syscall: 'rmdir', May 29 20:11:02 rpi4-argon volumio[1398]: code: 'EBUSY', May 29 20:11:02 rpi4-argon volumio[1398]: path: '/mnt/NAS/M1S' May 29 20:11:02 rpi4-argon volumio[1398]: } May 29 20:11:02 rpi4-argon volumio[1398]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 20:11:02 rpi4-argon sudo[4975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-29 20:10 May 29 20:11:02 rpi4-argon sudo[4975]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"