Jul 08 22:12:03 vdev volumio[1380]: info: [1752005523969] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Jul 08 22:12:04 vdev volumio[1380]: info: [1752005524224] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Jul 08 22:12:04 vdev volumio[1380]: info: [1752005524424] [RadioParadise] received new metadata: {"time":187,"artist":"Cocteau Twins","title":"Iceblink Luck","album":"Heaven or Las Vegas","year":"1990","cover":"https://img.radioparadise.com/covers/l/B00000DRAX.jpg","cover_med":"https://img.radioparadise.com/covers/m/B00000DRAX.jpg","cover_small":"https://img.radioparadise.com/covers/s/B00000DRAX.jpg"} Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::servicePushState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B00000DRAX.jpg","uri":"https://stream.radioparadise.com/flac","name":"Iceblink Luck","title":"Iceblink Luck","artist":"Cocteau Twins","album":"Heaven or Las Vegas","streaming":true,"disableUiControls":true,"duration":192,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 08 22:12:04 vdev volumio[1380]: verbose: CURRENT POSITION 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::syncState stateService play Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:12:04 vdev volumio[1380]: info: Received an update from plugin. extracting info from payload Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: [1752005524438] [RadioParadise] setting new timer with duration of 192000 seconds. Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 1 Jul 08 22:12:04 vdev volumio[1380]: info: [1752005524687] [RadioParadise] received new metadata: {"time":187,"artist":"Cocteau Twins","title":"Iceblink Luck","album":"Heaven or Las Vegas","year":"1990","cover":"https://img.radioparadise.com/covers/l/B00000DRAX.jpg","cover_med":"https://img.radioparadise.com/covers/m/B00000DRAX.jpg","cover_small":"https://img.radioparadise.com/covers/s/B00000DRAX.jpg"} Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::servicePushState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B00000DRAX.jpg","uri":"https://stream.radioparadise.com/flac","name":"Iceblink Luck","title":"Iceblink Luck","artist":"Cocteau Twins","album":"Heaven or Las Vegas","streaming":true,"disableUiControls":true,"duration":192,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 08 22:12:04 vdev volumio[1380]: verbose: CURRENT POSITION 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::syncState stateService play Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:12:04 vdev volumio[1380]: info: Received an update from plugin. extracting info from payload Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:12:04 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:12:04 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: [1752005524700] [RadioParadise] setting new timer with duration of 192000 seconds. Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:04 vdev volumio[1380]: info: CorePlayQueue::getTrack 1 Jul 08 22:12:07 vdev volumio[1380]: info: Executing endpoint metavolumio Jul 08 22:12:07 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:12:07 vdev volumio[1380]: info: Executing endpoint metavolumio Jul 08 22:12:07 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:12:07 vdev volumio[1380]: info: Executing endpoint metavolumio Jul 08 22:12:07 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:12:47 vdev systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 08 22:12:47 vdev dbus-daemon[911]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.54' (uid=0 pid=2902 comm="timedatectl show --property=NTPSynchronized --valu") Jul 08 22:12:47 vdev systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 08 22:12:48 vdev dbus-daemon[911]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 08 22:12:48 vdev systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 08 22:12:48 vdev setdatetime-helper.sh[2901]: Time is not synchronized. Attempting to sync... Jul 08 22:12:48 vdev sudo[2910]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 08 Jul 2025 20:12:48 GMT#015' Jul 08 22:12:48 vdev sudo[2910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:12:48 vdev setdatetime-helper.sh[2911]: Tue Jul 8 22:12:48 CEST 2025 Jul 08 22:12:48 vdev sudo[2910]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:48 vdev systemd-journald[426]: Time jumped backwards, rotating. Jul 08 22:12:48 vdev setdatetime-helper.sh[2901]: Time synchronized successfully. Jul 08 22:12:48 vdev systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 08 22:12:48 vdev systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:12:56 vdev volumio[1380]: info: Getting Alsa Cards List without I2S DAC Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:12:56 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:12:57 vdev volumio[1380]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 08 22:12:57 vdev volumio[1380]: info: Preparing to save Alsa Options, stopping services first Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioPause Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::pause Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::stPlaybackTimer Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::servicePause Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::servicePause Jul 08 22:12:57 vdev volumio[1380]: verbose: ControllerMpd::sendMpdCommand pause Jul 08 22:12:57 vdev volumio[1380]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"Hifiberry DAC"},"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"Generic I2S DAC"}} Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: Device 0 does not have any Mixer Control Available Jul 08 22:12:57 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev vtcs[1979]: [2025-07-08 22:12:57.750] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jul 08 22:12:57 vdev vtcs[1979]: [2025-07-08 22:12:57.750] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jul 08 22:12:57 vdev sudo[2957]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:12:57 vdev sudo[2957]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 08 22:12:57 vdev volumio[1380]: info: Updating Volume Controller Parameters: Device: 0 Name: Generic I2S DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 08 22:12:57 vdev volumio[1380]: info: Disabling external Volume Control Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:12:57 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:12:57 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jul 08 22:12:57 vdev volumio[1380]: info: Preparing to generate the ALSA configuration file Jul 08 22:12:57 vdev systemd[1]: vtcs.service: Deactivated successfully. Jul 08 22:12:57 vdev systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jul 08 22:12:57 vdev sudo[2957]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:57 vdev sudo[2965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:12:57 vdev sudo[2965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev volumio[1380]: info: sendMpdCommand pause took 80 milliseconds Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::servicePushState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev volumio[1380]: verbose: STATE SERVICE {"status":"pause","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B00000DRAX.jpg","uri":"https://stream.radioparadise.com/flac","name":"Iceblink Luck","title":"Iceblink Luck","artist":"Cocteau Twins","album":"Heaven or Las Vegas","streaming":true,"disableUiControls":true,"duration":192,"seek":53369,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 08 22:12:57 vdev volumio[1380]: verbose: CURRENT POSITION 0 Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::syncState stateService pause Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::syncState currentStatus pause Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:12:57 vdev sudo[2973]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:12:57 vdev sudo[2973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:12:57 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev volumio[1380]: info: CoreStateMachine::stPlaybackTimer Jul 08 22:12:57 vdev sudo[2965]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:57 vdev volumio[1380]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:12:57 vdev sudo[2973]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:57 vdev volumio[1380]: info: Reading ALSA contributions from plugins. Jul 08 22:12:57 vdev sudo[2976]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:12:57 vdev sudo[2976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:12:57 vdev volumio[1380]: info: Getting Alsa Cards List without I2S DAC Jul 08 22:12:57 vdev systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jul 08 22:12:57 vdev qobuz-connect[1964]: 20250708 22:12:57.860 [1964.1964] INFO SampleApp: Stopping Local configuration server Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:12:57 vdev volumio[1380]: info: Asound.conf file unchanged, so no further update is needed Jul 08 22:12:57 vdev volumio[1380]: info: Output device has changed, restarting MPD Jul 08 22:12:57 vdev volumio[1380]: info: Output device has changed, restarting Shairport Sync Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:57 vdev sudo[2993]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:12:57 vdev sudo[2993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev sudo[2993]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:57 vdev volumio[1380]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:12:57 vdev sudo[2997]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:12:57 vdev volumio[1380]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:12:57 vdev sudo[2997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:57 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:57 vdev systemd[1]: Stopping mpd.service - Music Player Daemon... Jul 08 22:12:57 vdev sudo[3007]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:12:57 vdev sudo[3007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev sudo[3005]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:12:57 vdev sudo[3005]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev volumio[1380]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 22:12:57 vdev volumio[1380]: info: MPD Permissions set Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev sudo[3015]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:12:57 vdev sudo[3015]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:12:57 vdev volumio[1380]: info: Starting Shairport Sync Jul 08 22:12:57 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:12:57 vdev sudo[3005]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:57 vdev sudo[3023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:12:57 vdev sudo[3023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:57 vdev sudo[3007]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:58 vdev sudo[3015]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:58 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:12:58 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:12:58 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:12:58 vdev sudo[3027]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:12:58 vdev sudo[3027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:12:58 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:12:58 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:12:58 vdev systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 22:12:58 vdev systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 22:12:58 vdev systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:12:58 vdev systemd[1]: shairport-sync.service: Consumed 1.996s CPU time. Jul 08 22:12:58 vdev systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:12:58 vdev sudo[3023]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:58 vdev volumio[1380]: info: Shairport-Sync Started Jul 08 22:12:58 vdev sudo[3031]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 08 22:12:58 vdev sudo[3031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:12:58 vdev sudo[3031]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:58 vdev mpd[3048]: 2025-07-08T22:12:58 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 08 22:12:58 vdev systemd[1]: Started mpd.service - Music Player Daemon. Jul 08 22:12:58 vdev sudo[2997]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:58 vdev volumio[1380]: error: updateQueue error: null Jul 08 22:12:59 vdev qobuz-connect[1964]: 20250708 22:12:59.639 [1964.1964] INFO SampleApp: shat down connection on UNIX socket Jul 08 22:12:59 vdev volumio[1380]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 08 22:12:59 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:12:59 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:59 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:12:59 vdev systemd[1]: qobuz-connect.service: Deactivated successfully. Jul 08 22:12:59 vdev systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:12:59 vdev systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:12:59 vdev sudo[2976]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:59 vdev sudo[3027]: pam_unix(sudo:session): session closed for user root Jul 08 22:12:59 vdev volumio[1380]: info: Executing endpoint qc_getconfig Jul 08 22:12:59 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.694 [3051.3051] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 08 22:12:59 vdev volumio[1380]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 08 22:12:59 vdev volumio[1380]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.696 [3051.3051] INFO VolumeManager: [0xa63258]: Setting new playback volume: 75 Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.696 [3051.3051] INFO VolumeManager: [0xa63258]: Setting new mute state: 0 Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.696 [3051.3051] INFO QobuzConnect: [0xa63c28]: Client initialized! Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.696 [3051.3051] INFO SampleApp: Starting Avahi advertising, name: VDev, service name: _qobuz-connect._tcp Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.701 [3051.3051] INFO LocalConfigManager: [0xa62b38]: Starting Local Configuration server Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.701 [3051.3051] INFO SampleApp: Starting Local configuration server Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.702 [3051.3051] INFO SampleApp: Connected to UNIX socket client 0xa4d818 Jul 08 22:12:59 vdev qobuz-connect[3051]: 20250708 22:12:59.845 [3051.3051] INFO SampleApp: Playback volume changed: 75 Jul 08 22:12:59 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:12:59 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:00 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:00 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:00 vdev volumio[1380]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:00 vdev volumio[1380]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:00 vdev sudo[3063]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:13:00 vdev sudo[3063]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:00 vdev systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jul 08 22:13:00 vdev sudo[3063]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:00 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:01 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:01 vdev volumio[1380]: info: Executing endpoint tc_getconfig Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 08 22:13:01 vdev vtcs[3066]: OpenSSL version mismatch. Built against 101010ef, you have 30000100 Jul 08 22:13:01 vdev vtcs[3066]: STARTING TidalConnect services, version: 1.5.0.45 Jul 08 22:13:01 vdev volumio[1380]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:01 vdev volumio[1380]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:01 vdev vtcs[3066]: STARTED TidalConnect services. Jul 08 22:13:01 vdev volumio[1380]: info: Executing endpoint tc_connect Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 08 22:13:01 vdev sudo[3077]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:13:01 vdev volumio[1380]: info: Connecting to TidalConnect Jul 08 22:13:01 vdev sudo[3077]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::servicePushState Jul 08 22:13:01 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:13:01 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:13:01 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:01 vdev volumio[1380]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::servicePushState Jul 08 22:13:01 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:13:01 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:13:01 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:01 vdev volumio[1380]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Jul 08 22:13:01 vdev vtcs[3066]: [2025-07-08 22:13:01.045] [tisoc] [error] [WebsocketServerTls.cpp:90] [WebsocketServerTls onTlsInit Error] use_certificate_chain: no start line Jul 08 22:13:01 vdev sudo[3077]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 08 22:13:01 vdev volumio[1380]: info: CoreStateMachine::getcurrentVolume Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioRetrievevolume Jul 08 22:13:01 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:13:01 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:13:01 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:13:01 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:01 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:03 vdev volumio[1380]: info: TidalConnect service started! Jul 08 22:13:04 vdev volumio[1380]: info: TidalConnect service started! Jul 08 22:13:06 vdev volumio[1380]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 08 22:13:06 vdev volumio[1380]: info: Preparing to save Alsa Options, stopping services first Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:06 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioPause Jul 08 22:13:06 vdev volumio[1380]: info: CoreStateMachine::pause Jul 08 22:13:06 vdev volumio[1380]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"Hifiberry DAC"},"i2s":false,"i2sid":{"value":"hifiberry-dac","label":"Generic I2S DAC"}} Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:13:06 vdev volumio[1380]: info: Disabling I2S DAC: Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:13:06 vdev volumio[1380]: info: Found match in Cards Database: setting mixer undefined for card Hifiberry DAC Jul 08 22:13:06 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:06 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:06 vdev vtcs[3066]: [2025-07-08 22:13:06.198] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jul 08 22:13:06 vdev vtcs[3066]: [2025-07-08 22:13:06.198] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jul 08 22:13:06 vdev sudo[3117]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:06 vdev sudo[3117]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev volumio[1380]: info: Device 0 does not have any Mixer Control Available Jul 08 22:13:06 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:06 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:06 vdev sudo[3123]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:06 vdev sudo[3123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 08 22:13:06 vdev volumio[1380]: info: Updating Volume Controller Parameters: Device: 0 Name: Hifiberry DAC Mixer: undefined Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 08 22:13:06 vdev volumio[1380]: info: Disabling external Volume Control Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:13:06 vdev systemd[1]: vtcs.service: Deactivated successfully. Jul 08 22:13:06 vdev systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jul 08 22:13:06 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:13:06 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:13:06 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:13:06 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:06 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:06 vdev volumio[1380]: info: Preparing to generate the ALSA configuration file Jul 08 22:13:06 vdev sudo[3117]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3123]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3130]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:06 vdev sudo[3130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3132]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:06 vdev sudo[3132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3141]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:06 vdev sudo[3141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3150]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:06 vdev sudo[3150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev volumio[1380]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:13:06 vdev volumio[1380]: info: Reading ALSA contributions from plugins. Jul 08 22:13:06 vdev sudo[3141]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3132]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3152]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:06 vdev sudo[3152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3157]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jul 08 22:13:06 vdev sudo[3157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3150]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3157]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev volumio[1380]: info: No Overlays Loaded Jul 08 22:13:06 vdev systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jul 08 22:13:06 vdev qobuz-connect[3051]: 20250708 22:13:06.321 [3051.3051] INFO SampleApp: Stopping Local configuration server Jul 08 22:13:06 vdev sudo[3159]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:06 vdev sudo[3159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3130]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:13:06 vdev volumio[1380]: info: Asound.conf file unchanged, so no further update is needed Jul 08 22:13:06 vdev volumio[1380]: info: Output device has changed, restarting MPD Jul 08 22:13:06 vdev volumio[1380]: info: Output device has changed, restarting Shairport Sync Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:06 vdev sudo[3169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:13:06 vdev sudo[3169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3169]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3171]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:13:06 vdev sudo[3171]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev volumio[1380]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:13:06 vdev volumio[1380]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:06 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:06 vdev systemd[1]: Stopping mpd.service - Music Player Daemon... Jul 08 22:13:06 vdev sudo[3181]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:06 vdev sudo[3183]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:06 vdev sudo[3183]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev sudo[3181]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev volumio[1380]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jul 08 22:13:06 vdev volumio[1380]: info: MPD Permissions set Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:06 vdev volumio[1380]: info: Starting Shairport Sync Jul 08 22:13:06 vdev sudo[3191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:06 vdev sudo[3191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:13:06 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:13:06 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:13:06 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:13:06 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:13:06 vdev sudo[3199]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:13:06 vdev sudo[3199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:13:06 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:13:06 vdev sudo[3183]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3181]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3191]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev sudo[3204]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:06 vdev sudo[3204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:06 vdev systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 22:13:06 vdev systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 22:13:06 vdev systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:13:06 vdev systemd[1]: shairport-sync.service: Consumed 1.536s CPU time. Jul 08 22:13:06 vdev sudo[3202]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 08 22:13:06 vdev sudo[3202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:13:06 vdev sudo[3202]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:13:06 vdev sudo[3199]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:06 vdev volumio[1380]: info: Shairport-Sync Started Jul 08 22:13:07 vdev mpd[3209]: 2025-07-08T22:13:07 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 08 22:13:07 vdev systemd[1]: Started mpd.service - Music Player Daemon. Jul 08 22:13:07 vdev sudo[3171]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:07 vdev volumio[1380]: error: updateQueue error: null Jul 08 22:13:07 vdev qobuz-connect[3051]: 20250708 22:13:07.711 [3051.3051] INFO SampleApp: shat down connection on UNIX socket Jul 08 22:13:07 vdev volumio[1380]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 08 22:13:07 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:07 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:07 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:07 vdev systemd[1]: qobuz-connect.service: Deactivated successfully. Jul 08 22:13:07 vdev systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:13:07 vdev sudo[3159]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:07 vdev systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:13:07 vdev sudo[3204]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:07 vdev sudo[3152]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:07 vdev volumio[1380]: info: Executing endpoint qc_getconfig Jul 08 22:13:07 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 08 22:13:07 vdev volumio[1380]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 08 22:13:07 vdev volumio[1380]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.765 [3226.3226] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.767 [3226.3226] INFO VolumeManager: [0x90c258]: Setting new playback volume: 75 Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.767 [3226.3226] INFO VolumeManager: [0x90c258]: Setting new mute state: 0 Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.768 [3226.3226] INFO QobuzConnect: [0x90cc28]: Client initialized! Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.768 [3226.3226] INFO SampleApp: Starting Avahi advertising, name: VDev, service name: _qobuz-connect._tcp Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.773 [3226.3226] INFO LocalConfigManager: [0x90bb38]: Starting Local Configuration server Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.773 [3226.3226] INFO SampleApp: Starting Local configuration server Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.773 [3226.3226] INFO SampleApp: Connected to UNIX socket client 0x8f6818 Jul 08 22:13:07 vdev qobuz-connect[3226]: 20250708 22:13:07.916 [3226.3226] INFO SampleApp: Playback volume changed: 75 Jul 08 22:13:07 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:07 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev volumio[1380]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 08 22:13:08 vdev volumio[1380]: info: Preparing to save Alsa Options, stopping services first Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:08 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioPause Jul 08 22:13:08 vdev volumio[1380]: info: CoreStateMachine::pause Jul 08 22:13:08 vdev volumio[1380]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"HDMI 0 Out"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:13:08 vdev volumio[1380]: info: Found match in Cards Database: setting mixer for card HDMI 0 Out Jul 08 22:13:08 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:08 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev sudo[3237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev volumio[1380]: info: Device 1 does not have any Mixer Control Available Jul 08 22:13:08 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:08 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev sudo[3243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 08 22:13:08 vdev volumio[1380]: info: Updating Volume Controller Parameters: Device: 1 Name: HDMI 0 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 08 22:13:08 vdev volumio[1380]: info: Disabling external Volume Control Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:13:08 vdev volumio[1380]: info: CoreStateMachine::pushState Jul 08 22:13:08 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioPushState Jul 08 22:13:08 vdev volumio[1380]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:13:08 vdev volumio[1380]: info: MRS: Pushing multiroomSync output Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:08 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev sudo[3237]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev volumio[1380]: info: Preparing to generate the ALSA configuration file Jul 08 22:13:08 vdev sudo[3243]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev sudo[3250]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3261]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:08 vdev sudo[3261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev volumio[1380]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:13:08 vdev volumio[1380]: info: Reading ALSA contributions from plugins. Jul 08 22:13:08 vdev sudo[3268]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:08 vdev sudo[3268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3250]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev sudo[3261]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev sudo[3252]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev sudo[3272]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:08 vdev sudo[3272]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:13:08 vdev sudo[3268]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:13:08 vdev systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jul 08 22:13:08 vdev qobuz-connect[3226]: 20250708 22:13:08.870 [3226.3226] INFO SampleApp: Stopping Local configuration server Jul 08 22:13:08 vdev sudo[3281]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:08 vdev sudo[3281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev volumio[1380]: info: Asound.conf file written Jul 08 22:13:08 vdev sudo[3285]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 08 22:13:08 vdev sudo[3285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3285]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev volumio[1380]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jul 08 22:13:08 vdev volumio[1380]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jul 08 22:13:08 vdev volumio[1380]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jul 08 22:13:08 vdev volumio[1380]: info: Output device has changed, restarting MPD Jul 08 22:13:08 vdev volumio[1380]: info: Output device has changed, restarting Shairport Sync Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:08 vdev sudo[3292]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:13:08 vdev sudo[3292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3292]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev volumio[1380]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:13:08 vdev volumio[1380]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:08 vdev sudo[3293]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:13:08 vdev sudo[3293]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:08 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev volumio[1380]: info: Output device has changed, restarting MPD Jul 08 22:13:08 vdev systemd[1]: Stopping mpd.service - Music Player Daemon... Jul 08 22:13:08 vdev volumio[1380]: info: Output device has changed, restarting Shairport Sync Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:08 vdev sudo[3303]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3303]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3305]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:13:08 vdev sudo[3305]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3307]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:13:08 vdev sudo[3307]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3305]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:08 vdev volumio[1380]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:13:08 vdev volumio[1380]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:08 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:08 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:08 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:08 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:13:08 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:13:08 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:13:08 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:13:08 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:13:08 vdev sudo[3318]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3321]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:08 vdev sudo[3324]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:08 vdev sudo[3324]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3332]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:09 vdev sudo[3332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:13:09 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:13:09 vdev volumio[1380]: info: MPD Permissions set Jul 08 22:13:09 vdev volumio[1380]: info: MPD Permissions set Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev sudo[3340]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:09 vdev sudo[3340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3332]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev sudo[3340]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:13:09 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev sudo[3348]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:09 vdev sudo[3349]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:09 vdev volumio[1380]: info: Starting Shairport Sync Jul 08 22:13:09 vdev sudo[3348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev volumio[1380]: info: Starting Shairport Sync Jul 08 22:13:09 vdev sudo[3357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:13:09 vdev sudo[3357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3321]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: info: Preparing to generate the ALSA configuration file Jul 08 22:13:09 vdev sudo[3318]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:13:09 vdev volumio[1380]: info: Reading ALSA contributions from plugins. Jul 08 22:13:09 vdev sudo[3361]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:13:09 vdev sudo[3324]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev volumio[1380]: info: Asound.conf file written Jul 08 22:13:09 vdev sudo[3303]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 08 22:13:09 vdev sudo[3368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3368]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jul 08 22:13:09 vdev volumio[1380]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jul 08 22:13:09 vdev volumio[1380]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jul 08 22:13:09 vdev volumio[1380]: info: Output device has changed, restarting MPD Jul 08 22:13:09 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:13:09 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:13:09 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:13:09 vdev volumio[1380]: info: Output device has changed, restarting Shairport Sync Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:09 vdev sudo[3374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:13:09 vdev sudo[3374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3374]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:13:09 vdev sudo[3376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev volumio[1380]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:13:09 vdev volumio[1380]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:09 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:09 vdev volumio[1380]: info: Preparing to generate the ALSA configuration file Jul 08 22:13:09 vdev sudo[3387]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:09 vdev sudo[3387]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3390]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:09 vdev sudo[3390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:13:09 vdev volumio[1380]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:13:09 vdev volumio[1380]: info: Reading ALSA contributions from plugins. Jul 08 22:13:09 vdev volumio[1380]: info: MPD Permissions set Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 22:13:09 vdev sudo[3398]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:09 vdev sudo[3398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:09 vdev systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:13:09 vdev systemd[1]: shairport-sync.service: Consumed 1.526s CPU time. Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: Starting Shairport Sync Jul 08 22:13:09 vdev volumio[1380]: info: Asound.conf file unchanged, so no further update is needed Jul 08 22:13:09 vdev volumio[1380]: info: Output device has changed, restarting MPD Jul 08 22:13:09 vdev volumio[1380]: info: Output device has changed, restarting Shairport Sync Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:09 vdev sudo[3408]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:13:09 vdev sudo[3406]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:13:09 vdev sudo[3406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3408]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:13:09 vdev volumio[1380]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev sudo[3411]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:13:09 vdev sudo[3411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev volumio[1380]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::volumioGetState Jul 08 22:13:09 vdev volumio[1380]: info: CorePlayQueue::getTrack 0 Jul 08 22:13:09 vdev sudo[3398]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3422]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:09 vdev sudo[3422]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3421]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:09 vdev sudo[3421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:13:09 vdev sudo[3425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev volumio[1380]: info: MPD Permissions set Jul 08 22:13:09 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:09 vdev systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:13:09 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:09 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:09 vdev sudo[3357]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3361]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: info: Shairport-Sync Started Jul 08 22:13:09 vdev volumio[1380]: info: Shairport-Sync Started Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:13:09 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:13:09 vdev sudo[3434]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:13:09 vdev sudo[3434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:13:09 vdev volumio[1380]: info: TidalConnect service stoped! Jul 08 22:13:09 vdev volumio[1380]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:09 vdev volumio[1380]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:09 vdev volumio[1380]: info: Starting Shairport Sync Jul 08 22:13:09 vdev sudo[3390]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3466]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:13:09 vdev sudo[3466]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3387]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:09 vdev volumio[1380]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:13:09 vdev sudo[3477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:13:09 vdev sudo[3477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3480]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:13:09 vdev sudo[3480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3434]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3482]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:13:09 vdev sudo[3482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:13:09 vdev sudo[3421]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3425]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev volumio[1380]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 22:13:09 vdev volumio[1380]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jul 08 22:13:09 vdev volumio[1380]: Job for vtcs.service canceled. Jul 08 22:13:09 vdev volumio[1380]: at ChildProcess.exithandler (node:child_process:421:12) Jul 08 22:13:09 vdev volumio[1380]: at ChildProcess.emit (node:events:514:28) Jul 08 22:13:09 vdev volumio[1380]: at maybeClose (node:internal/child_process:1105:16) Jul 08 22:13:09 vdev volumio[1380]: at Socket. (node:internal/child_process:457:11) Jul 08 22:13:09 vdev volumio[1380]: at Socket.emit (node:events:514:28) Jul 08 22:13:09 vdev volumio[1380]: at Pipe. (node:net:337:12) { Jul 08 22:13:09 vdev volumio[1380]: code: 1, Jul 08 22:13:09 vdev volumio[1380]: killed: false, Jul 08 22:13:09 vdev volumio[1380]: signal: null, Jul 08 22:13:09 vdev volumio[1380]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Jul 08 22:13:09 vdev volumio[1380]: stdout: '', Jul 08 22:13:09 vdev volumio[1380]: stderr: 'Job for vtcs.service canceled.\n' Jul 08 22:13:09 vdev volumio[1380]: } Jul 08 22:13:09 vdev volumio[1380]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 22:13:09 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:13:09 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:13:09 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:13:09 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:13:09 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:13:09 vdev systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 22:13:09 vdev systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jul 08 22:13:09 vdev sudo[3477]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 22:13:09 vdev systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:13:09 vdev sudo[3480]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:13:09 vdev sudo[3406]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3466]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3496]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 08 22:13:09 vdev sudo[3496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:13:09 vdev sudo[3496]: pam_unix(sudo:session): session closed for user root Jul 08 22:13:09 vdev sudo[3521]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-08 22:12' Jul 08 22:13:09 vdev sudo[3521]: 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="4f980d5cf693b4272997a2fa2da8bb8036ddf1ab" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jul 5 02:50:33 UTC 2025" VOLUMIO_VERSION="4.015" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d42ab79cc13d24482826e04fda2e8350"