Dec 21 13:53:10 volumio ntpd[899]: PROTO: 91.212.242.20 unlink local addr 192.168.0.222 -> Dec 21 13:54:07 volumio sudo[3893]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 21 13:54:07 volumio sudo[3893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:07 volumio sudo[3893]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:07 volumio sudo[3895]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 13:54:07 volumio sudo[3895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:07 volumio sudo[3895]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:08 volumio volumio[979]: verbose: New Socket.io Connection to 192.168.0.222 from 192.168.0.101 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 21 13:54:08 volumio volumio[979]: info: Executing endpoint metavolumio Dec 21 13:54:08 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 21 13:54:08 volumio volumio[979]: info: Executing endpoint metavolumio Dec 21 13:54:08 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 21 13:54:10 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 21 13:54:10 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::volumioGetVisibleSources Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::volumioGetQueue Dec 21 13:54:11 volumio volumio[979]: info: CoreStateMachine::getQueue Dec 21 13:54:11 volumio volumio[979]: info: CorePlayQueue::getQueue Dec 21 13:54:11 volumio volumio[979]: info: Listing playlists Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 21 13:54:11 volumio volumio[979]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 21 13:54:11 volumio volumio[979]: info: Received Get System Info Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:54:11 volumio volumio[979]: info: Discovery: Getting this device information Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 21 13:54:11 volumio volumio[979]: info: Received Get System Info Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:54:11 volumio volumio[979]: info: Discovery: Getting this device information Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 21 13:54:11 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 21 13:54:12 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 21 13:54:13 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 21 13:54:14 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 21 13:54:14 volumio volumio[979]: info: Received Get System Info Dec 21 13:54:14 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:54:14 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:54:14 volumio volumio[979]: info: Discovery: Getting this device information Dec 21 13:54:14 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:14 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:54:15 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 21 13:54:15 volumio volumio[979]: info: Received Get System Info Dec 21 13:54:15 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:54:15 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:54:15 volumio volumio[979]: info: Discovery: Getting this device information Dec 21 13:54:15 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:15 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:54:17 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:18 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 21 13:54:19 volumio volumio[979]: info: Executing endpoint metavolumio Dec 21 13:54:19 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:22 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:24 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:24 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:24 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:24 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:24 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:24 volumio vtcs[1732]: [2025-12-21 13:54:24.672] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 21 13:54:24 volumio vtcs[1732]: [2025-12-21 13:54:24.673] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 21 13:54:24 volumio sudo[3955]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:24 volumio sudo[3955]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:24 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:24 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:24 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:24 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:24 volumio sudo[3963]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:24 volumio sudo[3963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:24 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:24 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:24 volumio volumio[979]: Unable to parse: Dec 21 13:54:24 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:24 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:24 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:24 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:24 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:24 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 21 13:54:24 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 21 13:54:24 volumio systemd[1]: vtcs.service: Killing process 1757 (vtcs) with signal SIGKILL. Dec 21 13:54:24 volumio sudo[3970]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:24 volumio sudo[3970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:24 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 21 13:54:24 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:25 volumio systemd[1]: vtcs.service: Consumed 1.275s CPU time. Dec 21 13:54:25 volumio sudo[3955]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:25 volumio sudo[3970]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:25 volumio sudo[3963]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:25 volumio volumio[979]: Unable to parse: Dec 21 13:54:25 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:25 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:25 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:25 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:25 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:25 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:25 volumio sudo[3992]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:25 volumio sudo[3992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:25 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:25 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:25 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:25 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:25 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:25 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:25 volumio qobuz-connect[1668]: 20251221 13:54:25.361 [1668.1668] INFO SampleApp: Stopping Local configuration server Dec 21 13:54:25 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:25 volumio sudo[3998]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:25 volumio sudo[3998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:25 volumio sudo[3998]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:25 volumio sudo[4000]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:25 volumio sudo[4000]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:25 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:25 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:25 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 21 13:54:25 volumio sudo[4012]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:25 volumio sudo[4010]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:25 volumio qobuz-connect[1668]: 20251221 13:54:25.625 [1668.1668] INFO SampleApp: shat down connection on UNIX socket Dec 21 13:54:25 volumio sudo[4012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:25 volumio sudo[4010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:25 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:25 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:25 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:25 volumio volumio[979]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 21 13:54:25 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio sudo[4019]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:25 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:25 volumio sudo[4019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:25 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:54:25 volumio sudo[3992]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:25 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:54:25 volumio systemd[1]: mpd.service: Consumed 3.185s CPU time. Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:25 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:25 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:25 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:25 volumio sudo[4019]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:25 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:54:25 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:54:25 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:54:25 volumio sudo[4031]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:25 volumio sudo[4031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:26 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:54:26 volumio sudo[4036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:26 volumio sudo[4036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.026 [4022.4022] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 21 13:54:26 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.044 [4022.4022] INFO VolumeManager: [0x1bc2368]: Setting new playback volume: 75 Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.048 [4022.4022] INFO VolumeManager: [0x1bc2368]: Setting new mute state: 0 Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.048 [4022.4022] INFO QobuzConnect: [0x1bc2d38]: Client initialized! Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.048 [4022.4022] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 21 13:54:26 volumio volumio[979]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 21 13:54:26 volumio volumio[979]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 21 13:54:26 volumio volumio[979]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.141 [4022.4022] INFO LocalConfigManager: [0x1bc1c48]: Starting Local Configuration server Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.144 [4022.4022] INFO SampleApp: Starting Local configuration server Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.145 [4022.4022] INFO SampleApp: Connected to UNIX socket client 0x1bac818 Dec 21 13:54:26 volumio sudo[4010]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.177 [4022.4022] INFO SampleApp: Playback volume changed: 75 Dec 21 13:54:26 volumio sudo[4012]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:26 volumio volumio[979]: info: Received Get System Version Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 21 13:54:26 volumio volumio[979]: info: Received Get System Info Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:54:26 volumio volumio[979]: info: Discovery: Getting this device information Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:54:26 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:26 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:26 volumio qobuz-connect[4022]: 20251221 13:54:26.327 [4022.4022] INFO SampleApp: Stopping Local configuration server Dec 21 13:54:26 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 21 13:54:26 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 21 13:54:26 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:26 volumio systemd[1]: shairport-sync.service: Consumed 9.849s CPU time. Dec 21 13:54:26 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:26 volumio sudo[4031]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:26 volumio volumio[979]: info: Shairport-Sync Started Dec 21 13:54:26 volumio sudo[4040]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:54:26 volumio sudo[4040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:54:26 volumio sudo[4040]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:27 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 21 13:54:27 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 21 13:54:27 volumio systemd[1]: setdatetime-helper.service: Consumed 2.081s CPU time. Dec 21 13:54:28 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:28 volumio qobuz-connect[4022]: 20251221 13:54:28.158 [4022.4022] INFO SampleApp: shat down connection on UNIX socket Dec 21 13:54:28 volumio volumio[979]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 21 13:54:28 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:28 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:28 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:28 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:28 volumio sudo[4036]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:28 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:28 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:28 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:28 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:28 volumio sudo[4085]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:28 volumio sudo[4085]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.437 [4074.4074] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 21 13:54:28 volumio volumio[979]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 21 13:54:28 volumio volumio[979]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.454 [4074.4074] INFO VolumeManager: [0xa80368]: Setting new playback volume: 75 Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.455 [4074.4074] INFO VolumeManager: [0xa80368]: Setting new mute state: 0 Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.455 [4074.4074] INFO QobuzConnect: [0xa80d38]: Client initialized! Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.455 [4074.4074] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.508 [4074.4074] INFO LocalConfigManager: [0xa7fc48]: Starting Local Configuration server Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.509 [4074.4074] INFO SampleApp: Starting Local configuration server Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.510 [4074.4074] INFO SampleApp: Connected to UNIX socket client 0xa6a818 Dec 21 13:54:28 volumio qobuz-connect[4074]: 20251221 13:54:28.588 [4074.4074] INFO SampleApp: Playback volume changed: 75 Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:28 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:28 volumio sudo[4085]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 21 13:54:28 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:28 volumio volumio[979]: Unable to parse: Dec 21 13:54:28 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:28 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:28 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:28 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:28 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:28 volumio volumio[979]: Unable to parse: Dec 21 13:54:28 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:28 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:28 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:28 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:28 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:28 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:28 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:28 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:28 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Dec 21 13:54:28 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Dec 21 13:54:28 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:29 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:29 volumio volumio[979]: Unable to parse: Dec 21 13:54:29 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:29 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:29 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:29 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:29 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:29 volumio volumio[979]: Unable to parse: Dec 21 13:54:29 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:29 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:29 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:29 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:29 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:29 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:29 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:29 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:29 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:29 volumio volumio[979]: info: Executing endpoint tc_getconfig Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 21 13:54:29 volumio vtcs[4093]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 21 13:54:29 volumio vtcs[4093]: STARTED TidalConnect services. Dec 21 13:54:29 volumio volumio[979]: info: Executing endpoint tc_connect Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 21 13:54:29 volumio volumio[979]: info: Connecting to TidalConnect Dec 21 13:54:29 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::servicePushState Dec 21 13:54:29 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:29 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:29 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:29 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Dec 21 13:54:29 volumio volumio[979]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::servicePushState Dec 21 13:54:29 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:29 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:29 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:29 volumio volumio[979]: info: CorePlayQueue::getTrack 0 Dec 21 13:54:29 volumio volumio[979]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Dec 21 13:54:29 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:29 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:29 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:29 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:29 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:29 volumio sudo[4124]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:29 volumio sudo[4124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:29 volumio sudo[4124]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:29 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:29 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:29 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:29 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:29 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:29 volumio vtcs[4093]: [2025-12-21 13:54:29.717] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 21 13:54:29 volumio vtcs[4093]: [2025-12-21 13:54:29.717] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 21 13:54:29 volumio sudo[4137]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:29 volumio sudo[4137]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:29 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:29 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:29 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:29 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:29 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 21 13:54:29 volumio systemd[1]: vtcs.service: Killing process 4105 (vtcs) with signal SIGKILL. Dec 21 13:54:29 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 21 13:54:29 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:29 volumio sudo[4137]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:29 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:29 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:29 volumio volumio[979]: Unable to parse: Dec 21 13:54:29 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:29 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:29 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:29 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:30 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:30 volumio sudo[4144]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:30 volumio sudo[4144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio sudo[4151]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:30 volumio sudo[4151]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio sudo[4151]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:30 volumio sudo[4144]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:30 volumio sudo[4158]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:30 volumio sudo[4158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:30 volumio volumio[979]: Unable to parse: Dec 21 13:54:30 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:30 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:30 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:30 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:30 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:30 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:30 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:30 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:30 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:30 volumio qobuz-connect[4074]: 20251221 13:54:30.371 [4074.4074] INFO SampleApp: Stopping Local configuration server Dec 21 13:54:30 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:30 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:30 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:30 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:30 volumio sudo[4165]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:30 volumio sudo[4165]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio sudo[4165]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:30 volumio qobuz-connect[4074]: 20251221 13:54:30.516 [4074.4074] INFO SampleApp: shat down connection on UNIX socket Dec 21 13:54:30 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:30 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:30 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:30 volumio sudo[4167]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:30 volumio sudo[4167]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:30 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:30 volumio sudo[4158]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:30 volumio sudo[4178]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:30 volumio sudo[4178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio sudo[4181]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:30 volumio sudo[4181]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:30 volumio volumio[979]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 21 13:54:30 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:30 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:30 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:54:30 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:54:30 volumio systemd[1]: mpd.service: Consumed 4.475s CPU time. Dec 21 13:54:30 volumio sudo[4188]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:30 volumio sudo[4188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.841 [4174.4174] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 21 13:54:30 volumio volumio[979]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 21 13:54:30 volumio volumio[979]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.861 [4174.4174] INFO VolumeManager: [0x181c368]: Setting new playback volume: 75 Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.862 [4174.4174] INFO VolumeManager: [0x181c368]: Setting new mute state: 0 Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.862 [4174.4174] INFO QobuzConnect: [0x181cd38]: Client initialized! Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.862 [4174.4174] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.900 [4174.4174] INFO LocalConfigManager: [0x181bc48]: Starting Local Configuration server Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.900 [4174.4174] INFO SampleApp: Starting Local configuration server Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.901 [4174.4174] INFO SampleApp: Connected to UNIX socket client 0x1806818 Dec 21 13:54:30 volumio sudo[4188]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:30 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:54:30 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:30 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:30 volumio sudo[4200]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:30 volumio sudo[4200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio sudo[4203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:30 volumio sudo[4203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:30 volumio qobuz-connect[4174]: 20251221 13:54:30.991 [4174.4174] INFO SampleApp: Playback volume changed: 75 Dec 21 13:54:30 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:31 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:54:31 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:54:31 volumio sudo[4178]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:31 volumio sudo[4181]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:31 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:31 volumio qobuz-connect[4174]: 20251221 13:54:31.292 [4174.4174] INFO SampleApp: Stopping Local configuration server Dec 21 13:54:31 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 21 13:54:31 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 21 13:54:31 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:31 volumio systemd[1]: shairport-sync.service: Consumed 1.775s CPU time. Dec 21 13:54:31 volumio sudo[4206]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:54:31 volumio sudo[4206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:54:31 volumio sudo[4206]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:31 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:31 volumio sudo[4203]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:31 volumio volumio[979]: info: Shairport-Sync Started Dec 21 13:54:31 volumio volumio[979]: info: TidalConnect service started! Dec 21 13:54:32 volumio volumio[979]: info: TidalConnect service started! Dec 21 13:54:32 volumio qobuz-connect[4174]: 20251221 13:54:32.908 [4174.4174] INFO SampleApp: shat down connection on UNIX socket Dec 21 13:54:32 volumio volumio[979]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 21 13:54:32 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:32 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:32 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:32 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:32 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:33 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:33 volumio sudo[4200]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:33 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:33 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.149 [4242.4242] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.159 [4242.4242] INFO VolumeManager: [0x9d3368]: Setting new playback volume: 75 Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.160 [4242.4242] INFO VolumeManager: [0x9d3368]: Setting new mute state: 0 Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.160 [4242.4242] INFO QobuzConnect: [0x9d3d38]: Client initialized! Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.160 [4242.4242] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 21 13:54:33 volumio volumio[979]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 21 13:54:33 volumio volumio[979]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.197 [4242.4242] INFO LocalConfigManager: [0x9d2c48]: Starting Local Configuration server Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.197 [4242.4242] INFO SampleApp: Starting Local configuration server Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.199 [4242.4242] INFO SampleApp: Connected to UNIX socket client 0x9bd818 Dec 21 13:54:33 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:33 volumio qobuz-connect[4242]: 20251221 13:54:33.299 [4242.4242] INFO SampleApp: Playback volume changed: 75 Dec 21 13:54:33 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:33 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:33 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:33 volumio sudo[4258]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:33 volumio sudo[4258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:33 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:33 volumio sudo[4258]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:33 volumio volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 21 13:54:33 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Dec 21 13:54:33 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:33 volumio volumio[979]: Unable to parse: Dec 21 13:54:33 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:33 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:33 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:33 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:33 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:33 volumio volumio[979]: Unable to parse: Dec 21 13:54:33 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:33 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:33 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:33 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:33 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:33 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:33 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:33 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:33 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:33 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:33 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Dec 21 13:54:33 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Dec 21 13:54:33 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:34 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:34 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:34 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:34 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:34 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:34 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:34 volumio sudo[4277]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:34 volumio sudo[4277]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:34 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:34 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:34 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:34 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 21 13:54:34 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 21 13:54:34 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:34 volumio sudo[4277]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:34 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:34 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:34 volumio sudo[4284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:34 volumio sudo[4284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:34 volumio volumio[979]: info: Executing endpoint tc_getconfig Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 21 13:54:34 volumio volumio[979]: Unable to parse: Dec 21 13:54:34 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:34 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:34 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:34 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:34 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:34 volumio sudo[4291]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:34 volumio sudo[4291]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:34 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:34 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:34 volumio volumio[979]: Unable to parse: Dec 21 13:54:34 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:34 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:34 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:34 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:34 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:34 volumio volumio[979]: Unable to parse: Dec 21 13:54:34 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:34 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:34 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:34 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:34 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:34 volumio sudo[4291]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:34 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:34 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:34 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:34 volumio sudo[4284]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:34 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:34 volumio sudo[4304]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:34 volumio sudo[4304]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:34 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:34 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:34 volumio volumio[979]: Unable to parse: Dec 21 13:54:34 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:34 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:34 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:34 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:34 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:34 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:34 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:34 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:34 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:34 volumio qobuz-connect[4242]: 20251221 13:54:34.775 [4242.4242] INFO SampleApp: Stopping Local configuration server Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:34 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:34 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:34 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:34 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:34 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:35 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:35 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:35 volumio sudo[4325]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:35 volumio sudo[4325]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:35 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:35 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:35 volumio sudo[4332]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:35 volumio sudo[4332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio qobuz-connect[4242]: 20251221 13:54:35.207 [4242.4242] INFO SampleApp: shat down connection on UNIX socket Dec 21 13:54:35 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:35 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:35 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:35 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:35 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:35 volumio sudo[4339]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:35 volumio sudo[4339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio sudo[4325]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:35 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:35 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:35 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:35 volumio sudo[4355]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:35 volumio sudo[4355]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:35 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:35 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:35 volumio sudo[4304]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:35 volumio sudo[4339]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:35 volumio sudo[4332]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:35 volumio sudo[4360]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:35 volumio sudo[4360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio sudo[4365]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:35 volumio sudo[4365]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio sudo[4355]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:35 volumio volumio[979]: Unable to parse: Dec 21 13:54:35 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:35 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:35 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:35 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:35 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:35 volumio volumio[979]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 21 13:54:35 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:35 volumio sudo[4373]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:35 volumio sudo[4373]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:35 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:35 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:35 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:35 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:35 volumio sudo[4377]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:35 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:35 volumio sudo[4377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:35 volumio sudo[4365]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:35 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:35 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:35 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:36 volumio sudo[4373]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio sudo[4391]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:36 volumio sudo[4392]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:36 volumio sudo[4391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:36 volumio sudo[4392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:36 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:36 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:36 volumio sudo[4360]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:36 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:36 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:36 volumio sudo[4377]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:36 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:36 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:36 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:36 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 21 13:54:36 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:36 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:36 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 21 13:54:36 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:36 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:36 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:36 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:36 volumio sudo[4391]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio sudo[4414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:36 volumio sudo[4414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:36 volumio sudo[4392]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:36 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:36 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:36 volumio sudo[4414]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio sudo[4423]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:36 volumio sudo[4423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:36 volumio sudo[4425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:36 volumio sudo[4425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:36 volumio sudo[4435]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:36 volumio sudo[4435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:36 volumio volumio[979]: Unable to parse: Dec 21 13:54:36 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:36 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:36 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:36 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:36 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:36 volumio sudo[4440]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:36 volumio sudo[4440]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:36 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:36 volumio volumio[979]: Unable to parse: Dec 21 13:54:36 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:36 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:36 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:36 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:36 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:36 volumio sudo[4423]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio volumio[979]: Unable to parse: Dec 21 13:54:36 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:36 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:36 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:36 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:36 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:36 volumio sudo[4425]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio volumio[979]: info: TidalConnect service started! Dec 21 13:54:36 volumio volumio[979]: Unable to parse: Dec 21 13:54:36 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:36 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:36 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:36 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:36 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:36 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:36 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:36 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:36 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:36 volumio sudo[4435]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio sudo[4440]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:36 volumio mpd[4211]: 2025-12-21T13:54:36 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 21 13:54:36 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 21 13:54:36 volumio sudo[4167]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio sudo[4000]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio sudo[4452]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:37 volumio sudo[4451]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:37 volumio sudo[4451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio sudo[4452]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:37 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:37 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:37 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:37 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:37 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:37 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:37 volumio sudo[4452]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio sudo[4451]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio volumio[979]: Unable to parse: Dec 21 13:54:37 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:37 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:37 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:37 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:37 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:37 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:37 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:37 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:37 volumio volumio[979]: Unable to parse: Dec 21 13:54:37 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:37 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:37 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:37 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:37 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:37 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:37 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:37 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:37 volumio volumio[979]: Unable to parse: Dec 21 13:54:37 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:37 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:37 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:37 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:37 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:37 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:37 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:37 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:37 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:37 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:37 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:37 volumio sudo[4469]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:37 volumio sudo[4469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio sudo[4469]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio sudo[4472]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:37 volumio sudo[4472]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:37 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:37 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:37 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 21 13:54:37 volumio sudo[4481]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:37 volumio sudo[4481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio sudo[4484]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:37 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:54:37 volumio sudo[4484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:54:37 volumio systemd[1]: mpd.service: Consumed 5.702s CPU time. Dec 21 13:54:37 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:54:37 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:54:37 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:54:37 volumio sudo[4491]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:37 volumio sudo[4491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:54:37 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:37 volumio sudo[4481]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio sudo[4491]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:37 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:37 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:37 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:37 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:37 volumio sudo[4484]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:37 volumio sudo[4502]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:37 volumio sudo[4502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:37 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:37 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:37 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:37 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:37 volumio sudo[4497]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:54:37 volumio sudo[4497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:54:37 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:37 volumio sudo[4497]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:37 volumio sudo[4502]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:38 volumio volumio[979]: error: MPD error: The expression evaluated to a falsy value: Dec 21 13:54:38 volumio volumio[979]: assert.ok(self.idling) Dec 21 13:54:38 volumio volumio[979]: error: The expression evaluated to a falsy value: Dec 21 13:54:38 volumio volumio[979]: assert.ok(self.idling) Dec 21 13:54:38 volumio volumio[979]: error: MPD error: Error: write EPIPE Dec 21 13:54:38 volumio volumio[979]: error: write EPIPE {"code":"EPIPE","errno":-32,"syscall":"write"} Dec 21 13:54:38 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:38 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:38 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:38 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 21 13:54:38 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:38 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.445 [4511.4511] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.456 [4511.4511] INFO VolumeManager: [0x15f5368]: Setting new playback volume: 75 Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.457 [4511.4511] INFO VolumeManager: [0x15f5368]: Setting new mute state: 0 Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.457 [4511.4511] INFO QobuzConnect: [0x15f5d38]: Client initialized! Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.457 [4511.4511] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 21 13:54:38 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.501 [4511.4511] INFO LocalConfigManager: [0x15f4c48]: Starting Local Configuration server Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.501 [4511.4511] INFO SampleApp: Starting Local configuration server Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.502 [4511.4511] INFO SampleApp: Connected to UNIX socket client 0x15df818 Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 21 13:54:38 volumio qobuz-connect[4511]: 20251221 13:54:38.596 [4511.4511] INFO SampleApp: Playback volume changed: 75 Dec 21 13:54:38 volumio volumio[979]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 21 13:54:38 volumio volumio[979]: Unable to parse: Dec 21 13:54:38 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:38 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:38 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:38 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:38 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:38 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:38 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:38 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:38 volumio volumio[979]: Unable to parse: Dec 21 13:54:38 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:38 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:38 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:38 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:38 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:38 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:38 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:38 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:38 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Dec 21 13:54:38 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:38 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:38 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:38 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:38 volumio sudo[4552]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:38 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:38 volumio sudo[4552]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:38 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:38 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:38 volumio sudo[4561]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:38 volumio sudo[4561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:38 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 21 13:54:38 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 21 13:54:38 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:38 volumio systemd[1]: shairport-sync.service: Consumed 1.817s CPU time. Dec 21 13:54:38 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:38 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:38 volumio sudo[4560]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:38 volumio sudo[4560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:38 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:38 volumio sudo[4560]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:38 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:39 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:39 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:39 volumio sudo[4572]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:39 volumio sudo[4572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio sudo[4552]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:39 volumio sudo[4576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:39 volumio sudo[4576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio volumio[979]: Unable to parse: Dec 21 13:54:39 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:39 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:39 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:39 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:39 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 21 13:54:39 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Dec 21 13:54:39 volumio sudo[4582]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:39 volumio sudo[4582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:39 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:54:39 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:54:39 volumio systemd[1]: mpd.service: Consumed 1.432s CPU time. Dec 21 13:54:39 volumio sudo[4572]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:39 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:39 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:39 volumio sudo[4601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:39 volumio sudo[4601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:39 volumio volumio[979]: info: TidalConnect service started! Dec 21 13:54:39 volumio volumio[979]: info: Shairport-Sync Started Dec 21 13:54:39 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:39 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:39 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:39 volumio volumio[979]: Unable to parse: Dec 21 13:54:39 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:39 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:39 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:39 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:39 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:39 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:39 volumio sudo[4582]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:39 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:39 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:39 volumio sudo[4576]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:39 volumio volumio[979]: Unable to parse: Dec 21 13:54:39 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:39 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:39 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:39 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:39 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:39 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:54:39 volumio sudo[4609]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:39 volumio sudo[4609]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:54:39 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:54:39 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:39 volumio volumio[979]: error: MPD error: Error: read ECONNRESET Dec 21 13:54:39 volumio volumio[979]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Dec 21 13:54:39 volumio volumio[979]: Job for vtcs.service canceled. Dec 21 13:54:39 volumio volumio[979]: {"cmd":"/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3","code":1,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3\nJob for vtcs.service canceled.\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)","stderr":"Job for vtcs.service canceled.\n","stdout":""} Dec 21 13:54:39 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:54:39 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:39 volumio sudo[4601]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:39 volumio sudo[4619]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:39 volumio sudo[4619]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio qobuz-connect[4511]: 20251221 13:54:39.609 [4511.4511] INFO SampleApp: Stopping Local configuration server Dec 21 13:54:39 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 21 13:54:39 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:39 volumio sudo[4619]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:39 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:39 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:39 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:39 volumio volumio[979]: Unable to parse: Dec 21 13:54:39 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:39 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:39 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:39 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:39 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:39 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:39 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:39 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:39 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Dec 21 13:54:39 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:39 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:39 volumio volumio[979]: Unable to parse: Dec 21 13:54:39 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:39 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:39 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:39 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:39 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:39 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:39 volumio volumio[979]: Unable to parse: Dec 21 13:54:39 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:39 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:39 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:39 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:39 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:39 volumio sudo[4617]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:54:39 volumio sudo[4617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:54:39 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:39 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:39 volumio sudo[4617]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:39 volumio sudo[4634]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:39 volumio sudo[4634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio sudo[4642]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:39 volumio sudo[4642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:39 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:39 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:40 volumio sudo[4638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:40 volumio sudo[4638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio sudo[4642]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio sudo[4647]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:40 volumio sudo[4647]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:40 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:40 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:40 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:40 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 21 13:54:40 volumio sudo[4638]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 21 13:54:40 volumio sudo[4656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:40 volumio sudo[4656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:40 volumio systemd[1]: shairport-sync.service: Consumed 1.023s CPU time. Dec 21 13:54:40 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:54:40 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:54:40 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:54:40 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:54:40 volumio sudo[4658]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:40 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:54:40 volumio sudo[4658]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:40 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:40 volumio sudo[4668]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:54:40 volumio sudo[4668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio volumio[979]: Unable to parse: Dec 21 13:54:40 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:40 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:40 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:40 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:40 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:40 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:54:40 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:40 volumio sudo[4634]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:40 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:40 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Dec 21 13:54:40 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 21 13:54:40 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:40 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 21 13:54:40 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 21 13:54:40 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:40 volumio sudo[4668]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio qobuz-connect[4511]: 20251221 13:54:40.510 [4511.4511] INFO SampleApp: shat down connection on UNIX socket Dec 21 13:54:40 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:40 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:40 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:40 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:40 volumio sudo[4658]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio sudo[4695]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:40 volumio sudo[4656]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio sudo[4695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:40 volumio volumio[979]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 21 13:54:40 volumio volumio[979]: info: Preparing to save Alsa Options, stopping services first Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:40 volumio volumio[979]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Hegel USB Audio B"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:40 volumio sudo[4675]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:54:40 volumio sudo[4675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:54:40 volumio sudo[4698]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 21 13:54:40 volumio sudo[4698]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio sudo[4675]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:40 volumio sudo[4609]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:40 volumio volumio[979]: info: Setting mixer PCM for card Hegel USB Audio B Dec 21 13:54:40 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:40 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:40 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:40 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:40 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 21 13:54:40 volumio volumio[979]: info: Updating Volume Controller Parameters: Device: 5 Name: Hegel USB Audio B Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 21 13:54:40 volumio volumio[979]: info: Disabling external Volume Control Dec 21 13:54:40 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:40 volumio sudo[4716]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:40 volumio sudo[4716]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:40 volumio sudo[4695]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:40 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 21 13:54:40 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 21 13:54:40 volumio systemd[1]: mpd_monitor.service: Consumed 1.365s CPU time. Dec 21 13:54:40 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:54:41 volumio sudo[4725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:41 volumio sudo[4725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:41 volumio sudo[4716]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:41 volumio sudo[4725]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:41 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:41 volumio volumio[979]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 21 13:54:41 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:41 volumio volumio[979]: info: Shairport-Sync Started Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:41 volumio sudo[4733]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:41 volumio sudo[4733]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:41 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 21 13:54:41 volumio volumio[979]: info: CoreStateMachine::getcurrentVolume Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:41 volumio sudo[4733]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:41 volumio sudo[4746]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:41 volumio sudo[4746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:41 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:41 volumio volumio[979]: info: Executing endpoint tc_getconfig Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 21 13:54:41 volumio sudo[4748]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 21 13:54:41 volumio sudo[4748]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:41 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:41 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:41 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:41 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:41 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:41 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:41 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:41 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:41 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:41 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:41 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:41 volumio sudo[4746]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:41 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:41 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:41 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:41 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:41 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Dec 21 13:54:41 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:41 volumio volumio[979]: Unable to parse: Dec 21 13:54:41 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:41 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:41 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:41 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:41 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:41 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:41 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:41 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:41 volumio sudo[4776]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:41 volumio sudo[4776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:41 volumio sudo[4778]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:41 volumio sudo[4778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:54:42 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:42 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:42 volumio volumio[979]: info: Executing endpoint qc_getconfig Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 21 13:54:42 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:42 volumio sudo[4776]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.208 [4751.4751] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.216 [4751.4751] INFO VolumeManager: [0xa0b368]: Setting new playback volume: 75 Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.216 [4751.4751] INFO VolumeManager: [0xa0b368]: Setting new mute state: 0 Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.216 [4751.4751] INFO QobuzConnect: [0xa0bd38]: Client initialized! Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.216 [4751.4751] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 21 13:54:42 volumio sudo[4778]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:42 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:42 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:42 volumio volumio[979]: Unable to parse: Dec 21 13:54:42 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:42 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:42 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:42 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:42 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.258 [4751.4751] INFO LocalConfigManager: [0xa0ac48]: Starting Local Configuration server Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.259 [4751.4751] INFO SampleApp: Starting Local configuration server Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.259 [4751.4751] INFO SampleApp: Connected to UNIX socket client 0x9f5818 Dec 21 13:54:42 volumio volumio[979]: Unable to parse: Dec 21 13:54:42 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:42 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:42 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:42 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:42 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:42 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:42 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:42 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:42 volumio volumio[979]: info: CoreStateMachine::updateTrackBlock Dec 21 13:54:42 volumio volumio[979]: info: CorePlayQueue::getTrackBlock Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 13:54:42 volumio qobuz-connect[4751]: 20251221 13:54:42.358 [4751.4751] INFO SampleApp: Playback volume changed: 75 Dec 21 13:54:42 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:42 volumio volumio[979]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 21 13:54:42 volumio volumio[979]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 21 13:54:42 volumio volumio[979]: Unable to parse: Dec 21 13:54:42 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:42 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:42 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:42 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:42 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:42 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:42 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:42 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:42 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:42 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:42 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:42 volumio volumio[979]: Unable to parse: Dec 21 13:54:42 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:42 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:42 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:42 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:42 volumio volumio[979]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 21 13:54:42 volumio sudo[4813]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:42 volumio sudo[4813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:42 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:42 volumio sudo[4817]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:42 volumio sudo[4817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:42 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 21 13:54:42 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 21 13:54:42 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:42 volumio systemd[1]: shairport-sync.service: Consumed 1.436s CPU time. Dec 21 13:54:42 volumio sudo[4820]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:42 volumio sudo[4820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio sudo[4823]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:42 volumio sudo[4823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio sudo[4820]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:42 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:42 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:42 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:42 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:42 volumio sudo[4813]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:42 volumio sudo[4838]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:42 volumio sudo[4834]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:42 volumio sudo[4838]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio sudo[4834]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:54:42 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:54:42 volumio systemd[1]: mpd.service: Consumed 2.126s CPU time. Dec 21 13:54:42 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:54:42 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:54:42 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:54:42 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:42 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:42 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:42 volumio volumio[979]: info: Shairport-Sync Started Dec 21 13:54:42 volumio volumio[979]: info: TidalConnect service started! Dec 21 13:54:42 volumio volumio[979]: info: TidalConnect service started! Dec 21 13:54:42 volumio volumio[979]: Unable to parse: Dec 21 13:54:42 volumio volumio[979]: Simple mixer control 'PCM',0 Dec 21 13:54:42 volumio volumio[979]: Capabilities: pswitch pswitch-joined Dec 21 13:54:42 volumio volumio[979]: Playback channels: Mono Dec 21 13:54:42 volumio volumio[979]: Mono: Playback [on] Dec 21 13:54:42 volumio volumio[979]: info: VolumeController:: Volume=undefined Mute =false Dec 21 13:54:42 volumio volumio[979]: info: CoreStateMachine::pushState Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioPushState Dec 21 13:54:42 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:54:42 volumio sudo[4858]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:42 volumio sudo[4858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:42 volumio volumio[979]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:54:42 volumio volumio[979]: info: MRS: Pushing multiroomSync output Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:42 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:54:42 volumio sudo[4817]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:42 volumio volumio[979]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7jTTEFMMp1T7gO1fxQbEaOdcuXv2.a8a6ae3be1996aebf59fd724964c7125.state.status' Dec 21 13:54:42 volumio volumio[979]: info: Executing endpoint tc_getconfig Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 21 13:54:42 volumio vtcs[4805]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 21 13:54:42 volumio vtcs[4805]: STARTED TidalConnect services. Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:42 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio sudo[4858]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:43 volumio volumio[979]: info: Executing endpoint tc_connect Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 21 13:54:43 volumio volumio[979]: info: Connecting to TidalConnect Dec 21 13:54:43 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 21 13:54:43 volumio systemd[1]: vtcs.service: Killing process 4868 (vtcs) with signal SIGKILL. Dec 21 13:54:43 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:43 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 21 13:54:43 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:43 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:43 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:43 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:43 volumio sudo[4875]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:43 volumio sudo[4875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio sudo[4877]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:43 volumio sudo[4877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio sudo[4880]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:43 volumio sudo[4880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio sudo[4834]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:43 volumio sudo[4880]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:43 volumio sudo[4838]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:43 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:43 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio sudo[4881]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:43 volumio sudo[4881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio sudo[4861]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:54:43 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:43 volumio sudo[4861]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:54:43 volumio sudo[4861]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:43 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Dec 21 13:54:43 volumio sudo[4896]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:43 volumio sudo[4896]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio sudo[4900]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:43 volumio sudo[4900]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio volumio[979]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:54:43 volumio volumio[979]: info: Reading ALSA contributions from plugins. Dec 21 13:54:43 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:43 volumio volumio[979]: info: TidalConnect service started! Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio sudo[4907]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:43 volumio sudo[4907]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Dec 21 13:54:43 volumio volumio[979]: info: Output device has changed, restarting MPD Dec 21 13:54:43 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:43 volumio sudo[4907]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:43 volumio sudo[4916]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:54:43 volumio sudo[4916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:54:43 volumio sudo[4916]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:43 volumio volumio[979]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:54:43 volumio qobuz-connect[4751]: 20251221 13:54:43.687 [4751.4751] INFO SampleApp: Stopping Local configuration server Dec 21 13:54:43 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio sudo[4917]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:54:43 volumio sudo[4917]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 21 13:54:43 volumio volumio[979]: info: QobuzConnect: setDeactiveState invoked Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::volumioGetState Dec 21 13:54:43 volumio sudo[4923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:43 volumio sudo[4923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 21 13:54:43 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:43 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:54:43 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:54:43 volumio sudo[4929]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:43 volumio sudo[4929]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio sudo[4932]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:54:43 volumio sudo[4932]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio volumio[979]: info: MPD Permissions set Dec 21 13:54:43 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:43 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:43 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:43 volumio sudo[4938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 21 13:54:43 volumio sudo[4938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio sudo[4946]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:43 volumio sudo[4946]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:54:43 volumio volumio[979]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:43 volumio volumio[979]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:54:43 volumio volumio[979]: info: Starting Shairport Sync Dec 21 13:54:44 volumio sudo[4900]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio sudo[4958]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:54:44 volumio sudo[4958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:44 volumio sudo[4896]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio sudo[4960]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:54:44 volumio sudo[4960]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:44 volumio volumio[979]: info: TidalConnect service stoped! Dec 21 13:54:44 volumio sudo[4938]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio sudo[4965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 21 13:54:44 volumio sudo[4965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:54:44 volumio sudo[4929]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio sudo[4932]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio qobuz-connect[4751]: 20251221 13:54:44.266 [4751.4751] INFO SampleApp: shat down connection on UNIX socket Dec 21 13:54:44 volumio volumio[979]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 13:54:44 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:44 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:44 volumio volumio[979]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Dec 21 13:54:44 volumio volumio[979]: Job for vtcs.service canceled. Dec 21 13:54:44 volumio volumio[979]: at ChildProcess.exithandler (node:child_process:421:12) Dec 21 13:54:44 volumio volumio[979]: at ChildProcess.emit (node:events:514:28) Dec 21 13:54:44 volumio volumio[979]: at maybeClose (node:internal/child_process:1105:16) Dec 21 13:54:44 volumio volumio[979]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) { Dec 21 13:54:44 volumio volumio[979]: code: 1, Dec 21 13:54:44 volumio volumio[979]: killed: false, Dec 21 13:54:44 volumio volumio[979]: signal: null, Dec 21 13:54:44 volumio volumio[979]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Dec 21 13:54:44 volumio volumio[979]: stdout: '', Dec 21 13:54:44 volumio volumio[979]: stderr: 'Job for vtcs.service canceled.\n' Dec 21 13:54:44 volumio volumio[979]: } Dec 21 13:54:44 volumio volumio[979]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 13:54:44 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:54:44 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:54:44 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:54:44 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:54:44 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:54:44 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:44 volumio sudo[4875]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio sudo[4923]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:54:44 volumio sudo[4877]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio sudo[4958]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio sudo[4946]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 21 13:54:44 volumio sudo[4960]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 21 13:54:44 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 21 13:54:44 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:44 volumio sudo[4979]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:54:44 volumio sudo[4979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:54:44 volumio sudo[4979]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:44 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 21 13:54:44 volumio sudo[4965]: pam_unix(sudo:session): session closed for user root Dec 21 13:54:45 volumio sudo[5006]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-21 13:53' Dec 21 13:54:45 volumio sudo[5006]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="ac7dd5922ede329d1459d48b226ddc71f5209a2c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="3441cddd43405c36fe444484553f10f2f5bc830b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Nov 13 11:04:27 UTC 2025" VOLUMIO_VERSION="4.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="7da8d6d9f8baf8621af4ec2af5a00f00"