Jul 08 22:02:08 vdev volumio[1381]: info: [1752004928610] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Jul 08 22:02:08 vdev volumio[1381]: info: [1752004928734] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Jul 08 22:02:09 vdev volumio[1381]: info: [1752004929092] [RadioParadise] received new metadata: {"time":217,"artist":"Neil Finn","title":"Turn and Run","album":"One Nil","year":"2001","cover":"https://img.radioparadise.com/covers/l/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg","cover_med":"https://img.radioparadise.com/covers/m/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg","cover_small":"https://img.radioparadise.com/covers/s/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg"} Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::servicePushState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg","uri":"https://stream.radioparadise.com/flac","name":"Turn and Run","title":"Turn and Run","artist":"Neil Finn","album":"One Nil","streaming":true,"disableUiControls":true,"duration":222,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 08 22:02:09 vdev volumio[1381]: verbose: CURRENT POSITION 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::syncState stateService play Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:02:09 vdev volumio[1381]: info: Received an update from plugin. extracting info from payload Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: [1752004929106] [RadioParadise] setting new timer with duration of 222000 seconds. Jul 08 22:02:09 vdev volumio[1381]: info: [1752004929231] [RadioParadise] received new metadata: {"time":217,"artist":"Neil Finn","title":"Turn and Run","album":"One Nil","year":"2001","cover":"https://img.radioparadise.com/covers/l/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg","cover_med":"https://img.radioparadise.com/covers/m/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg","cover_small":"https://img.radioparadise.com/covers/s/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg"} Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::servicePushState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg","uri":"https://stream.radioparadise.com/flac","name":"Turn and Run","title":"Turn and Run","artist":"Neil Finn","album":"One Nil","streaming":true,"disableUiControls":true,"duration":222,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 08 22:02:09 vdev volumio[1381]: verbose: CURRENT POSITION 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::syncState stateService play Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:02:09 vdev volumio[1381]: info: Received an update from plugin. extracting info from payload Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:09 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:09 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: [1752004929242] [RadioParadise] setting new timer with duration of 222000 seconds. Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:09 vdev volumio[1381]: info: CorePlayQueue::getTrack 1 Jul 08 22:02:20 vdev systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 08 22:02:20 vdev dbus-daemon[852]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.46' (uid=0 pid=2860 comm="timedatectl show --property=NTPSynchronized --valu") Jul 08 22:02:20 vdev systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 08 22:02:20 vdev dbus-daemon[852]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 08 22:02:20 vdev systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 08 22:02:20 vdev setdatetime-helper.sh[2859]: Time is not synchronized. Attempting to sync... Jul 08 22:02:20 vdev sudo[2868]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 08 Jul 2025 20:02:21 GMT#015' Jul 08 22:02:20 vdev sudo[2868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:02:21 vdev setdatetime-helper.sh[2869]: Tue Jul 8 22:02:21 CEST 2025 Jul 08 22:02:21 vdev sudo[2868]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:21 vdev setdatetime-helper.sh[2859]: Time synchronized successfully. Jul 08 22:02:21 vdev systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 08 22:02:21 vdev systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 08 22:02:34 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:34 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:36 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:36 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:36 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:36 vdev volumio[1381]: info: Getting Alsa Cards List without I2S DAC Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 22:02:36 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:02:37 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:02:40 vdev volumio[1381]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 08 22:02:40 vdev volumio[1381]: info: Preparing to save Alsa Options, stopping services first Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioPause Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::pause Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::stPlaybackTimer Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::servicePause Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::servicePause Jul 08 22:02:40 vdev volumio[1381]: verbose: ControllerMpd::sendMpdCommand pause Jul 08 22:02:40 vdev volumio[1381]: 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:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: Device 0 does not have any Mixer Control Available Jul 08 22:02:40 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev vtcs[1910]: [2025-07-08 22:02:40.618] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jul 08 22:02:40 vdev vtcs[1910]: [2025-07-08 22:02:40.618] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jul 08 22:02:40 vdev sudo[2931]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:40 vdev sudo[2931]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 08 22:02:40 vdev volumio[1381]: info: Updating Volume Controller Parameters: Device: 0 Name: Generic I2S DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 08 22:02:40 vdev volumio[1381]: info: Disabling external Volume Control Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:40 vdev systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jul 08 22:02:40 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:40 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev systemd[1]: vtcs.service: Killing process 1917 (vtcs) with signal SIGKILL. Jul 08 22:02:40 vdev systemd[1]: vtcs.service: Deactivated successfully. Jul 08 22:02:40 vdev systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jul 08 22:02:40 vdev volumio[1381]: info: Preparing to generate the ALSA configuration file Jul 08 22:02:40 vdev sudo[2931]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev sudo[2938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:40 vdev sudo[2938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev volumio[1381]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:02:40 vdev volumio[1381]: info: Reading ALSA contributions from plugins. Jul 08 22:02:40 vdev volumio[1381]: info: Jul 08 22:02:40 vdev volumio[1381]: ---------------------------- MPD announces state update: player Jul 08 22:02:40 vdev volumio[1381]: info: sendMpdCommand pause took 91 milliseconds Jul 08 22:02:40 vdev volumio[1381]: info: ControllerMpd::getState Jul 08 22:02:40 vdev volumio[1381]: verbose: ControllerMpd::sendMpdCommand status Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::servicePushState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: verbose: STATE SERVICE {"status":"pause","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/19824_8aacad29-68e3-4df7-a2c7-bce7e96b58ef.jpg","uri":"https://stream.radioparadise.com/flac","name":"Turn and Run","title":"Turn and Run","artist":"Neil Finn","album":"One Nil","streaming":true,"disableUiControls":true,"duration":222,"seek":31532,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 08 22:02:40 vdev volumio[1381]: verbose: CURRENT POSITION 0 Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::syncState stateService pause Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::syncState currentStatus pause Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:40 vdev sudo[2945]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:40 vdev sudo[2945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:40 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: CoreStateMachine::stPlaybackTimer Jul 08 22:02:40 vdev volumio[1381]: info: sendMpdCommand status took 20 milliseconds Jul 08 22:02:40 vdev volumio[1381]: verbose: ControllerMpd::parseState Jul 08 22:02:40 vdev volumio[1381]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 22:02:40 vdev volumio[1381]: info: sendMpdCommand playlistinfo took 0 milliseconds Jul 08 22:02:40 vdev volumio[1381]: verbose: ControllerMpd::parseTrackInfo Jul 08 22:02:40 vdev volumio[1381]: info: ControllerMpd::pushState Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::servicePushState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jul 08 22:02:40 vdev volumio[1381]: info: ------------------------------ 23ms Jul 08 22:02:40 vdev sudo[2945]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev sudo[2947]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:02:40 vdev sudo[2947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:40 vdev volumio[1381]: info: Getting Alsa Cards List without I2S DAC Jul 08 22:02:40 vdev sudo[2938]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:40 vdev systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jul 08 22:02:40 vdev qobuz-connect[1848]: 20250708 22:02:40.728 [1848.1848] INFO SampleApp: Stopping Local configuration server Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:02:40 vdev volumio[1381]: info: Asound.conf file unchanged, so no further update is needed Jul 08 22:02:40 vdev volumio[1381]: info: Output device has changed, restarting MPD Jul 08 22:02:40 vdev volumio[1381]: info: Output device has changed, restarting Shairport Sync Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:40 vdev sudo[2963]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:02:40 vdev sudo[2963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev sudo[2963]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev sudo[2965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:02:40 vdev sudo[2965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev volumio[1381]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:02:40 vdev volumio[1381]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev sudo[2976]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:40 vdev systemd[1]: Stopping mpd.service - Music Player Daemon... Jul 08 22:02:40 vdev sudo[2976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev volumio[1381]: info: MPD Permissions set Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev sudo[2977]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:40 vdev sudo[2977]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev sudo[2984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:40 vdev sudo[2984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev sudo[2976]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev qobuz-connect[1848]: 20250708 22:02:40.820 [1848.1848] INFO SampleApp: shat down connection on UNIX socket Jul 08 22:02:40 vdev systemd[1]: qobuz-connect.service: Deactivated successfully. Jul 08 22:02:40 vdev systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:40 vdev volumio[1381]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 08 22:02:40 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:40 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:40 vdev volumio[1381]: info: Starting Shairport Sync Jul 08 22:02:40 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:02:40 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:02:40 vdev systemd[1]: mpd.service: Consumed 3.727s CPU time. Jul 08 22:02:40 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:02:40 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:02:40 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:02:40 vdev sudo[2997]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:02:40 vdev sudo[2997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:02:40 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:02:40 vdev systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:02:40 vdev sudo[2947]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev sudo[2984]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 22:02:40 vdev volumio[1381]: info: Executing endpoint qc_getconfig Jul 08 22:02:40 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 08 22:02:40 vdev volumio[1381]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 08 22:02:40 vdev volumio[1381]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 08 22:02:40 vdev systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.894 [3001.3001] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.896 [3001.3001] INFO VolumeManager: [0x176f258]: Setting new playback volume: 75 Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.896 [3001.3001] INFO VolumeManager: [0x176f258]: Setting new mute state: 0 Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.896 [3001.3001] INFO QobuzConnect: [0x176fc28]: Client initialized! Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.896 [3001.3001] INFO SampleApp: Starting Avahi advertising, name: VDev, service name: _qobuz-connect._tcp Jul 08 22:02:40 vdev systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:02:40 vdev systemd[1]: shairport-sync.service: Consumed 1.967s CPU time. Jul 08 22:02:40 vdev systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:02:40 vdev sudo[2997]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev sudo[3002]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:02:40 vdev sudo[3002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:40 vdev sudo[2977]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:40 vdev volumio[1381]: info: Shairport-Sync Started Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.916 [3001.3001] INFO LocalConfigManager: [0x176eb38]: Starting Local Configuration server Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.916 [3001.3001] INFO SampleApp: Starting Local configuration server Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.916 [3001.3001] INFO SampleApp: Connected to UNIX socket client 0x1759818 Jul 08 22:02:40 vdev systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jul 08 22:02:40 vdev qobuz-connect[3001]: 20250708 22:02:40.931 [3001.3001] INFO SampleApp: Stopping Local configuration server Jul 08 22:02:40 vdev sudo[3000]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 08 22:02:40 vdev sudo[3000]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:02:40 vdev sudo[3000]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:41 vdev mpd[3023]: 2025-07-08T22:02:41 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 08 22:02:41 vdev systemd[1]: Started mpd.service - Music Player Daemon. Jul 08 22:02:41 vdev sudo[2965]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:41 vdev volumio[1381]: error: updateQueue error: null Jul 08 22:02:42 vdev qobuz-connect[3001]: 20250708 22:02:42.924 [3001.3001] INFO SampleApp: shat down connection on UNIX socket Jul 08 22:02:42 vdev volumio[1381]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 08 22:02:42 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:42 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:42 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:42 vdev systemd[1]: qobuz-connect.service: Deactivated successfully. Jul 08 22:02:42 vdev systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:02:42 vdev systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:02:42 vdev sudo[3002]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:42 vdev volumio[1381]: info: Executing endpoint qc_getconfig Jul 08 22:02:42 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 08 22:02:42 vdev volumio[1381]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 08 22:02:42 vdev volumio[1381]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.981 [3040.3040] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.983 [3040.3040] INFO VolumeManager: [0x812258]: Setting new playback volume: 75 Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.983 [3040.3040] INFO VolumeManager: [0x812258]: Setting new mute state: 0 Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.983 [3040.3040] INFO QobuzConnect: [0x812c28]: Client initialized! Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.983 [3040.3040] INFO SampleApp: Starting Avahi advertising, name: VDev, service name: _qobuz-connect._tcp Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.989 [3040.3040] INFO LocalConfigManager: [0x811b38]: Starting Local Configuration server Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.989 [3040.3040] INFO SampleApp: Starting Local configuration server Jul 08 22:02:42 vdev qobuz-connect[3040]: 20250708 22:02:42.989 [3040.3040] INFO SampleApp: Connected to UNIX socket client 0x7fc818 Jul 08 22:02:43 vdev qobuz-connect[3040]: 20250708 22:02:43.131 [3040.3040] INFO SampleApp: Playback volume changed: 75 Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:43 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:43 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:43 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:43 vdev volumio[1381]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:43 vdev volumio[1381]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:43 vdev sudo[3052]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:02:43 vdev sudo[3052]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:43 vdev systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jul 08 22:02:43 vdev sudo[3052]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:43 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:43 vdev volumio[1381]: info: Executing endpoint tc_getconfig Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 08 22:02:43 vdev vtcs[3055]: OpenSSL version mismatch. Built against 101010ef, you have 30000100 Jul 08 22:02:43 vdev vtcs[3055]: STARTING TidalConnect services, version: 1.5.0.45 Jul 08 22:02:43 vdev vtcs[3055]: STARTED TidalConnect services. Jul 08 22:02:43 vdev volumio[1381]: info: Executing endpoint tc_connect Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 08 22:02:43 vdev volumio[1381]: info: Connecting to TidalConnect Jul 08 22:02:43 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::servicePushState Jul 08 22:02:43 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:43 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:43 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:43 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:43 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:43 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:43 vdev volumio[1381]: 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:02:43 vdev volumio[1381]: info: CoreCommandRouter::servicePushState Jul 08 22:02:43 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:43 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:43 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:43 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:43 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:43 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:43 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:43 vdev volumio[1381]: 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:02:43 vdev vtcs[3055]: [2025-07-08 22:02:43.932] [tisoc] [error] [WebsocketServerTls.cpp:90] [WebsocketServerTls onTlsInit Error] use_certificate_chain: no start line Jul 08 22:02:43 vdev volumio[1381]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:43 vdev volumio[1381]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:43 vdev sudo[3080]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:02:43 vdev sudo[3080]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:43 vdev sudo[3080]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:44 vdev volumio[1381]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 08 22:02:44 vdev volumio[1381]: info: CoreStateMachine::getcurrentVolume Jul 08 22:02:44 vdev volumio[1381]: info: CoreCommandRouter::volumioRetrievevolume Jul 08 22:02:44 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:44 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:44 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:44 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:44 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:44 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:44 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:46 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:46 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:46 vdev volumio[1381]: info: TidalConnect service started! Jul 08 22:02:46 vdev volumio[1381]: info: TidalConnect service started! Jul 08 22:02:48 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:48 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:48 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:48 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:48 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:48 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:50 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:50 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:50 vdev systemd[1]: systemd-timedated.service: Deactivated successfully. Jul 08 22:02:52 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:52 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:52 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:52 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:52 vdev volumio[1381]: info: Executing endpoint metavolumio Jul 08 22:02:52 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:53 vdev volumio[1381]: info: Getting Alsa Cards List without I2S DAC Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:02:53 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:02:56 vdev volumio[1381]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 08 22:02:56 vdev volumio[1381]: info: Preparing to save Alsa Options, stopping services first Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:56 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioPause Jul 08 22:02:56 vdev volumio[1381]: info: CoreStateMachine::pause Jul 08 22:02:56 vdev volumio[1381]: 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:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:56 vdev volumio[1381]: info: Disabling I2S DAC: Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:56 vdev volumio[1381]: info: Found match in Cards Database: setting mixer undefined for card Hifiberry DAC Jul 08 22:02:56 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:56 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:56 vdev vtcs[3055]: [2025-07-08 22:02:56.443] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jul 08 22:02:56 vdev vtcs[3055]: [2025-07-08 22:02:56.443] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jul 08 22:02:56 vdev sudo[3121]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:56 vdev sudo[3121]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev volumio[1381]: info: Device 0 does not have any Mixer Control Available Jul 08 22:02:56 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:56 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:56 vdev sudo[3127]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:56 vdev systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jul 08 22:02:56 vdev sudo[3127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 08 22:02:56 vdev volumio[1381]: info: Updating Volume Controller Parameters: Device: 0 Name: Hifiberry DAC Mixer: undefined Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 08 22:02:56 vdev volumio[1381]: info: Disabling external Volume Control Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:02:56 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:56 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:56 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:56 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:56 vdev systemd[1]: vtcs.service: Deactivated successfully. Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:56 vdev systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jul 08 22:02:56 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:56 vdev volumio[1381]: info: Preparing to generate the ALSA configuration file Jul 08 22:02:56 vdev sudo[3121]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev sudo[3133]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:56 vdev sudo[3133]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3136]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:56 vdev sudo[3136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3127]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev sudo[3145]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:56 vdev sudo[3145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev volumio[1381]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:02:56 vdev volumio[1381]: info: Reading ALSA contributions from plugins. Jul 08 22:02:56 vdev sudo[3133]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev sudo[3152]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:56 vdev sudo[3152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3145]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev sudo[3136]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev sudo[3155]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jul 08 22:02:56 vdev sudo[3155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3158]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:02:56 vdev sudo[3158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3155]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev volumio[1381]: info: No Overlays Loaded Jul 08 22:02:56 vdev sudo[3152]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jul 08 22:02:56 vdev qobuz-connect[3040]: 20250708 22:02:56.583 [3040.3040] INFO SampleApp: Stopping Local configuration server Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:56 vdev sudo[3164]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:02:56 vdev sudo[3164]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:02:56 vdev volumio[1381]: info: Asound.conf file unchanged, so no further update is needed Jul 08 22:02:56 vdev volumio[1381]: info: Output device has changed, restarting MPD Jul 08 22:02:56 vdev volumio[1381]: info: Output device has changed, restarting Shairport Sync Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:56 vdev sudo[3172]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:02:56 vdev sudo[3172]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:02:56 vdev sudo[3174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3172]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev volumio[1381]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:02:56 vdev volumio[1381]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:56 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:56 vdev systemd[1]: Stopping mpd.service - Music Player Daemon... Jul 08 22:02:56 vdev sudo[3184]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:56 vdev sudo[3184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev sudo[3186]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:56 vdev sudo[3186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:02:56 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:02:56 vdev volumio[1381]: info: MPD Permissions set Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev sudo[3194]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:56 vdev sudo[3194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:02:56 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:02:56 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:56 vdev volumio[1381]: info: Starting Shairport Sync Jul 08 22:02:56 vdev sudo[3203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:02:56 vdev sudo[3203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:02:56 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:02:56 vdev sudo[3194]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 22:02:56 vdev sudo[3207]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:02:56 vdev sudo[3207]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:56 vdev systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 22:02:56 vdev systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:02:56 vdev systemd[1]: shairport-sync.service: Consumed 1.536s CPU time. Jul 08 22:02:56 vdev sudo[3186]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev sudo[3206]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 08 22:02:56 vdev sudo[3206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:02:56 vdev sudo[3206]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev sudo[3184]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:02:56 vdev sudo[3203]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:56 vdev volumio[1381]: info: Shairport-Sync Started Jul 08 22:02:57 vdev qobuz-connect[3040]: 20250708 22:02:57.000 [3040.3040] INFO SampleApp: shat down connection on UNIX socket Jul 08 22:02:57 vdev systemd[1]: qobuz-connect.service: Deactivated successfully. Jul 08 22:02:57 vdev volumio[1381]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jul 08 22:02:57 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:57 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:57 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:57 vdev systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:02:57 vdev systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jul 08 22:02:57 vdev sudo[3158]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:57 vdev sudo[3164]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:57 vdev sudo[3207]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:57 vdev volumio[1381]: info: Executing endpoint qc_getconfig Jul 08 22:02:57 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.063 [3228.3228] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.065 [3228.3228] INFO VolumeManager: [0xc6a258]: Setting new playback volume: 75 Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.065 [3228.3228] INFO VolumeManager: [0xc6a258]: Setting new mute state: 0 Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.065 [3228.3228] INFO QobuzConnect: [0xc6ac28]: Client initialized! Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.065 [3228.3228] INFO SampleApp: Starting Avahi advertising, name: VDev, service name: _qobuz-connect._tcp Jul 08 22:02:57 vdev volumio[1381]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jul 08 22:02:57 vdev volumio[1381]: info: QobuzConnect: QOBUZ Connect daemon connected Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.073 [3228.3228] INFO LocalConfigManager: [0xc69b38]: Starting Local Configuration server Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.074 [3228.3228] INFO SampleApp: Starting Local configuration server Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.074 [3228.3228] INFO SampleApp: Connected to UNIX socket client 0xc54818 Jul 08 22:02:57 vdev qobuz-connect[3228]: 20250708 22:02:57.213 [3228.3228] INFO SampleApp: Playback volume changed: 75 Jul 08 22:02:57 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:57 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:57 vdev mpd[3212]: 2025-07-08T22:02:57 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 08 22:02:57 vdev systemd[1]: Started mpd.service - Music Player Daemon. Jul 08 22:02:57 vdev sudo[3174]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:57 vdev volumio[1381]: error: updateQueue error: null Jul 08 22:02:59 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:59 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:59 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:59 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:59 vdev volumio[1381]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:59 vdev volumio[1381]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:59 vdev sudo[3246]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:02:59 vdev volumio[1381]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:59 vdev volumio[1381]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:59 vdev sudo[3246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3253]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:02:59 vdev sudo[3253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jul 08 22:02:59 vdev sudo[3246]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3253]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev volumio[1381]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 08 22:02:59 vdev volumio[1381]: info: Preparing to save Alsa Options, stopping services first Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:59 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioPause Jul 08 22:02:59 vdev volumio[1381]: info: CoreStateMachine::pause Jul 08 22:02:59 vdev volumio[1381]: 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:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:59 vdev volumio[1381]: info: Found match in Cards Database: setting mixer for card HDMI 0 Out Jul 08 22:02:59 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:59 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:59 vdev volumio[1381]: info: Device 1 does not have any Mixer Control Available Jul 08 22:02:59 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:59 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:59 vdev sudo[3268]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 08 22:02:59 vdev volumio[1381]: info: Updating Volume Controller Parameters: Device: 1 Name: HDMI 0 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 08 22:02:59 vdev volumio[1381]: info: Disabling external Volume Control Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 22:02:59 vdev systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jul 08 22:02:59 vdev sudo[3275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev systemd[1]: vtcs.service: Deactivated successfully. Jul 08 22:02:59 vdev systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jul 08 22:02:59 vdev volumio[1381]: info: CoreStateMachine::pushState Jul 08 22:02:59 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioPushState Jul 08 22:02:59 vdev volumio[1381]: info: MRS: Pushing multiroomSync output update for this device Jul 08 22:02:59 vdev volumio[1381]: info: MRS: Pushing multiroomSync output Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:59 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:59 vdev volumio[1381]: info: Preparing to generate the ALSA configuration file Jul 08 22:02:59 vdev sudo[3268]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3275]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3281]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3283]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3283]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3292]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:59 vdev sudo[3292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3281]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3299]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:59 vdev volumio[1381]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 08 22:02:59 vdev volumio[1381]: info: Reading ALSA contributions from plugins. Jul 08 22:02:59 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:59 vdev volumio[1381]: info: TidalConnect service stoped! Jul 08 22:02:59 vdev sudo[3299]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3283]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3299]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3292]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3307]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:02:59 vdev sudo[3307]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3308]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 22:02:59 vdev sudo[3308]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 22:02:59 vdev systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jul 08 22:02:59 vdev qobuz-connect[3228]: 20250708 22:02:59.851 [3228.3228] INFO SampleApp: Stopping Local configuration server Jul 08 22:02:59 vdev volumio[1381]: info: Asound.conf file written Jul 08 22:02:59 vdev sudo[3323]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 08 22:02:59 vdev sudo[3323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3323]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev volumio[1381]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jul 08 22:02:59 vdev volumio[1381]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jul 08 22:02:59 vdev volumio[1381]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jul 08 22:02:59 vdev volumio[1381]: info: Output device has changed, restarting MPD Jul 08 22:02:59 vdev volumio[1381]: info: Output device has changed, restarting Shairport Sync Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:59 vdev sudo[3329]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:02:59 vdev sudo[3329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3329]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev sudo[3331]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:02:59 vdev sudo[3331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev volumio[1381]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:02:59 vdev volumio[1381]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:59 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:59 vdev volumio[1381]: info: Output device has changed, restarting MPD Jul 08 22:02:59 vdev systemd[1]: Stopping mpd.service - Music Player Daemon... Jul 08 22:02:59 vdev sudo[3341]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev volumio[1381]: info: Output device has changed, restarting Shairport Sync Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:02:59 vdev sudo[3343]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 22:02:59 vdev sudo[3343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3343]: pam_unix(sudo:session): session closed for user root Jul 08 22:02:59 vdev volumio[1381]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 22:02:59 vdev volumio[1381]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:02:59 vdev sudo[3346]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 22:02:59 vdev sudo[3346]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:02:59 vdev volumio[1381]: info: QobuzConnect: setDeactiveState invoked Jul 08 22:02:59 vdev volumio[1381]: info: CoreCommandRouter::volumioGetState Jul 08 22:02:59 vdev volumio[1381]: info: CorePlayQueue::getTrack 0 Jul 08 22:02:59 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:02:59 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:02:59 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:02:59 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:02:59 vdev sudo[3357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev sudo[3359]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:02:59 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:02:59 vdev sudo[3361]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 08 22:02:59 vdev sudo[3361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev volumio[1381]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:59 vdev volumio[1381]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 08 22:02:59 vdev sudo[3371]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:59 vdev sudo[3371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:02:59 vdev volumio[1381]: info: MPD Permissions set Jul 08 22:02:59 vdev volumio[1381]: info: MPD Permissions set Jul 08 22:02:59 vdev sudo[3377]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jul 08 22:02:59 vdev sudo[3377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev sudo[3381]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 08 22:03:00 vdev sudo[3381]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev sudo[3371]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev sudo[3377]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 22:03:00 vdev volumio[1381]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 22:03:00 vdev sudo[3359]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev sudo[3361]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev sudo[3341]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev sudo[3357]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev volumio[1381]: info: Starting Shairport Sync Jul 08 22:03:00 vdev volumio[1381]: info: Starting Shairport Sync Jul 08 22:03:00 vdev sudo[3396]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:03:00 vdev sudo[3396]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:03:00 vdev sudo[3394]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:03:00 vdev sudo[3394]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:03:00 vdev sudo[3398]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 22:03:00 vdev sudo[3398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:03:00 vdev volumio[1381]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jul 08 22:03:00 vdev volumio[1381]: Job for vtcs.service canceled. Jul 08 22:03:00 vdev volumio[1381]: {"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":""} Jul 08 22:03:00 vdev volumio[1381]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 22:03:00 vdev sudo[3393]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jul 08 22:03:00 vdev sudo[3393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 22:03:00 vdev volumio[1381]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jul 08 22:03:00 vdev volumio[1381]: Job for vtcs.service canceled. Jul 08 22:03:00 vdev volumio[1381]: at ChildProcess.exithandler (node:child_process:421:12) Jul 08 22:03:00 vdev volumio[1381]: at ChildProcess.emit (node:events:514:28) Jul 08 22:03:00 vdev volumio[1381]: at maybeClose (node:internal/child_process:1105:16) Jul 08 22:03:00 vdev volumio[1381]: at Socket. (node:internal/child_process:457:11) Jul 08 22:03:00 vdev volumio[1381]: at Socket.emit (node:events:514:28) Jul 08 22:03:00 vdev volumio[1381]: at Pipe. (node:net:337:12) { Jul 08 22:03:00 vdev volumio[1381]: code: 1, Jul 08 22:03:00 vdev volumio[1381]: killed: false, Jul 08 22:03:00 vdev volumio[1381]: signal: null, Jul 08 22:03:00 vdev volumio[1381]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Jul 08 22:03:00 vdev volumio[1381]: stdout: '', Jul 08 22:03:00 vdev volumio[1381]: stderr: 'Job for vtcs.service canceled.\n' Jul 08 22:03:00 vdev volumio[1381]: } Jul 08 22:03:00 vdev volumio[1381]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 22:03:00 vdev systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jul 08 22:03:00 vdev sudo[3381]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev systemd[1]: mpd.service: Deactivated successfully. Jul 08 22:03:00 vdev systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 22:03:00 vdev systemd[1]: mpd.socket: Deactivated successfully. Jul 08 22:03:00 vdev systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 22:03:00 vdev systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 22:03:00 vdev systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 22:03:00 vdev systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 22:03:00 vdev systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 22:03:00 vdev systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 22:03:00 vdev systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:03:00 vdev systemd[1]: shairport-sync.service: Consumed 1.529s CPU time. Jul 08 22:03:00 vdev systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 22:03:00 vdev sudo[3396]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev sudo[3398]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev sudo[3419]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 08 22:03:00 vdev sudo[3419]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 22:03:00 vdev sudo[3419]: pam_unix(sudo:session): session closed for user root Jul 08 22:03:00 vdev sudo[3439]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-08 22:02' Jul 08 22:03:00 vdev sudo[3439]: 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"