Mar 26 16:54:24 volumio go-librespot[22258]: time="2026-03-26T16:54:24+01:00" level=trace msg="received accesspoint ping" Mar 26 16:54:24 volumio go-librespot[22258]: time="2026-03-26T16:54:24+01:00" level=trace msg="sent dealer ping" Mar 26 16:54:24 volumio go-librespot[22258]: time="2026-03-26T16:54:24+01:00" level=trace msg="received dealer pong" Mar 26 16:54:24 volumio go-librespot[22258]: time="2026-03-26T16:54:24+01:00" level=trace msg="received accesspoint pong ack" Mar 26 16:54:24 volumio volumio[22031]: error: error Mar 26 16:54:25 volumio volumio[22031]: error: error Mar 26 16:54:54 volumio go-librespot[22258]: time="2026-03-26T16:54:54+01:00" level=trace msg="sent dealer ping" Mar 26 16:54:54 volumio go-librespot[22258]: time="2026-03-26T16:54:54+01:00" level=trace msg="received dealer pong" Mar 26 16:55:24 volumio go-librespot[22258]: time="2026-03-26T16:55:24+01:00" level=trace msg="sent dealer ping" Mar 26 16:55:24 volumio go-librespot[22258]: time="2026-03-26T16:55:24+01:00" level=trace msg="received dealer pong" Mar 26 16:55:24 volumio volumio[22031]: error: error Mar 26 16:55:24 volumio volumio[22031]: error: error Mar 26 16:55:37 volumio kernel: usb 1-1.2: new high-speed USB device number 40 using xhci_hcd Mar 26 16:55:37 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Mar 26 16:55:37 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 26 16:55:37 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Mar 26 16:55:37 volumio kernel: usb 1-1.2: Manufacturer: SMSL Mar 26 16:55:38 volumio kernel: usb 1-1.2: 1:1: cannot set freq 768000 (v2/v3): err -71 Mar 26 16:55:38 volumio kernel: usb 1-1.2: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Mar 26 16:55:38 volumio kernel: usb 1-1.2: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Mar 26 16:55:38 volumio kernel: usbhid 1-1.2:1.3: can't add hid device: -71 Mar 26 16:55:38 volumio kernel: usbhid 1-1.2:1.3: probe with driver usbhid failed with error -71 Mar 26 16:55:38 volumio kernel: usb 1-1.2: USB disconnect, device number 40 Mar 26 16:55:38 volumio (udev-worker)[8839]: controlC5: /usr/lib/udev/rules.d/78-sound-card.rules:5 Failed to write ATTR{/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.0/sound/card5/controlC5/../uevent}, ignoring: No such file or directory Mar 26 16:55:38 volumio volumio[22031]: info: Mar 26 16:55:38 volumio volumio[22031]: ---------------------------- USB Audio Device Attached Mar 26 16:55:38 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 26 16:55:38 volumio volumio[22031]: error: API:pushError: TypeError: Cannot read properties of null (reading 'name') Mar 26 16:55:38 volumio volumio[22031]: info: Mar 26 16:55:38 volumio volumio[22031]: ---------------------------- USB Audio Device Detached Mar 26 16:55:38 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 26 16:55:38 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:38 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 26 16:55:38 volumio kernel: usb 1-1.2: new high-speed USB device number 41 using xhci_hcd Mar 26 16:55:38 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Mar 26 16:55:38 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 26 16:55:38 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Mar 26 16:55:38 volumio kernel: usb 1-1.2: Manufacturer: SMSL Mar 26 16:55:39 volumio kernel: hid-generic 0003:152A:85DD.001E: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Mar 26 16:55:39 volumio volumio[22031]: info: Mar 26 16:55:39 volumio volumio[22031]: ---------------------------- USB Audio Device Attached Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::Close All Modals sent Mar 26 16:55:39 volumio volumio[22031]: info: Preparing to save Alsa Options, stopping services first Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioPause Mar 26 16:55:39 volumio volumio[22031]: info: CoreStateMachine::pause Mar 26 16:55:39 volumio volumio[22031]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:39 volumio volumio[22031]: info: Device 5 does not have any Mixer Control Available Mar 26 16:55:39 volumio volumio[22031]: info: QobuzConnect: setDeactiveState invoked Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:39 volumio volumio[22031]: info: QobuzConnect: setDeactiveState(): relinquishing Volumio State Mar 26 16:55:39 volumio volumio[22031]: verbose: UNSET VOLATILE: Service: qobuzconnect Mar 26 16:55:39 volumio volumio[22031]: info: QobuzConnect: onUnsetVolatile() called, relinquishing Volumio State to another service Mar 26 16:55:39 volumio volumio[22031]: info: QobuzConnect: Received stop Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:39 volumio qobuz-connect[4367]: 20260326 16:55:39.119 [4367.4367] INFO MediaEngine: [0x10edd10]: Stopping playback, keeping tracks Mar 26 16:55:39 volumio vtcs[4315]: [2026-03-26 16:55:39.119] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Mar 26 16:55:39 volumio vtcs[4315]: [2026-03-26 16:55:39.119] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Mar 26 16:55:39 volumio sudo[8875]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:39 volumio sudo[8875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 26 16:55:39 volumio volumio[22031]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 26 16:55:39 volumio volumio[22031]: info: Disabling external Volume Control Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 26 16:55:39 volumio volumio[22031]: info: CoreStateMachine::pushState Mar 26 16:55:39 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioPushState Mar 26 16:55:39 volumio volumio[22031]: info: MRS: Pushing multiroomSync output update for this device Mar 26 16:55:39 volumio volumio[22031]: info: MRS: Pushing multiroomSync output Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:39 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:39 volumio volumio[22031]: info: Preparing to generate the ALSA configuration file Mar 26 16:55:39 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Mar 26 16:55:39 volumio systemd[1]: vtcs.service: Deactivated successfully. Mar 26 16:55:39 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Mar 26 16:55:39 volumio systemd[1]: vtcs.service: Consumed 1.001s CPU time. Mar 26 16:55:39 volumio sudo[8875]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio sudo[8882]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:39 volumio sudo[8882]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio sudo[8890]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 26 16:55:39 volumio sudo[8890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio volumio[22031]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 26 16:55:39 volumio volumio[22031]: info: Reading ALSA contributions from plugins. Mar 26 16:55:39 volumio sudo[8890]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:39 volumio sudo[8882]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio sudo[8895]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 26 16:55:39 volumio sudo[8895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 26 16:55:39 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Mar 26 16:55:39 volumio qobuz-connect[4367]: 20260326 16:55:39.304 [4367.4367] INFO CloudClient: [0x10ee1d8]: Disconnecting from the cloud Mar 26 16:55:39 volumio qobuz-connect[4367]: 20260326 16:55:39.304 [4367.4367] INFO CloudClient: [0x10ee1d8]: Connection closed Mar 26 16:55:39 volumio volumio[22031]: info: Asound.conf file unchanged, so no further update is needed Mar 26 16:55:39 volumio volumio[22031]: info: Output device has changed, restarting MPD Mar 26 16:55:39 volumio qobuz-connect[4367]: 20260326 16:55:39.314 [4367.4367] INFO SampleApp: Stopping Local configuration server Mar 26 16:55:39 volumio volumio[22031]: info: Output device has changed, restarting Shairport Sync Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:39 volumio sudo[8902]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 26 16:55:39 volumio sudo[8902]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio sudo[8902]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio sudo[8904]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 26 16:55:39 volumio sudo[8904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio volumio[22031]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 26 16:55:39 volumio volumio[22031]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: QobuzConnect: setDeactiveState invoked Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:39 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:39 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Mar 26 16:55:39 volumio sudo[8914]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:39 volumio sudo[8914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio sudo[8916]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:39 volumio sudo[8916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio systemd[1]: mpd.service: Deactivated successfully. Mar 26 16:55:39 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 26 16:55:39 volumio systemd[1]: mpd.service: Consumed 1.565s CPU time. Mar 26 16:55:39 volumio volumio[22031]: info: MPD Permissions set Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio systemd[1]: mpd.socket: Deactivated successfully. Mar 26 16:55:39 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 26 16:55:39 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 26 16:55:39 volumio sudo[8924]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 26 16:55:39 volumio sudo[8924]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:39 volumio volumio[22031]: info: Starting Shairport Sync Mar 26 16:55:39 volumio sudo[8933]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 26 16:55:39 volumio sudo[8933]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 26 16:55:39 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Mar 26 16:55:39 volumio sudo[8924]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 26 16:55:39 volumio sudo[8933]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio sudo[8936]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 26 16:55:39 volumio sudo[8936]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:39 volumio volumio[22031]: info: Shairport-Sync Started Mar 26 16:55:39 volumio sudo[8916]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio sudo[8914]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio sudo[8935]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 26 16:55:39 volumio sudo[8935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 26 16:55:39 volumio kernel: usb 1-1.2: USB disconnect, device number 41 Mar 26 16:55:39 volumio sudo[8935]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Mar 26 16:55:39 volumio volumio[22031]: info: Mar 26 16:55:39 volumio volumio[22031]: ---------------------------- USB Audio Device Detached Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:39 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 26 16:55:40 volumio kernel: usb 1-1.2: new high-speed USB device number 42 using xhci_hcd Mar 26 16:55:40 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Mar 26 16:55:40 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 26 16:55:40 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Mar 26 16:55:40 volumio kernel: usb 1-1.2: Manufacturer: SMSL Mar 26 16:55:40 volumio kernel: hid-generic 0003:152A:85DD.001F: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Mar 26 16:55:40 volumio volumio[22031]: info: Mar 26 16:55:40 volumio volumio[22031]: ---------------------------- USB Audio Device Attached Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::Close All Modals sent Mar 26 16:55:40 volumio volumio[22031]: info: Preparing to save Alsa Options, stopping services first Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:40 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioPause Mar 26 16:55:40 volumio volumio[22031]: info: CoreStateMachine::pause Mar 26 16:55:40 volumio volumio[22031]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:40 volumio volumio[22031]: info: Device 5 does not have any Mixer Control Available Mar 26 16:55:40 volumio volumio[22031]: info: QobuzConnect: setDeactiveState invoked Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:40 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:40 volumio sudo[8982]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:40 volumio sudo[8982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 26 16:55:40 volumio volumio[22031]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 26 16:55:40 volumio volumio[22031]: info: Disabling external Volume Control Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 26 16:55:40 volumio volumio[22031]: info: CoreStateMachine::pushState Mar 26 16:55:40 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioPushState Mar 26 16:55:40 volumio volumio[22031]: info: MRS: Pushing multiroomSync output update for this device Mar 26 16:55:40 volumio volumio[22031]: info: MRS: Pushing multiroomSync output Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:40 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:40 volumio volumio[22031]: info: Preparing to generate the ALSA configuration file Mar 26 16:55:40 volumio sudo[8988]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:40 volumio sudo[8988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio sudo[8982]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:40 volumio sudo[8996]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 26 16:55:40 volumio sudo[8996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio volumio[22031]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 26 16:55:40 volumio volumio[22031]: info: Reading ALSA contributions from plugins. Mar 26 16:55:40 volumio sudo[8996]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:40 volumio sudo[8988]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:40 volumio sudo[8998]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 26 16:55:40 volumio sudo[8998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 26 16:55:40 volumio volumio[22031]: info: Asound.conf file unchanged, so no further update is needed Mar 26 16:55:40 volumio volumio[22031]: info: Output device has changed, restarting MPD Mar 26 16:55:40 volumio volumio[22031]: info: Output device has changed, restarting Shairport Sync Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:40 volumio sudo[9010]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 26 16:55:40 volumio sudo[9010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio sudo[9012]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 26 16:55:40 volumio volumio[22031]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 26 16:55:40 volumio volumio[22031]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio sudo[9010]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:40 volumio sudo[9012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio volumio[22031]: info: QobuzConnect: setDeactiveState invoked Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:40 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:40 volumio sudo[9021]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:40 volumio sudo[9021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio systemd[1]: mpd.service: Deactivated successfully. Mar 26 16:55:40 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 26 16:55:40 volumio systemd[1]: mpd.service: Consumed 1.236s CPU time. Mar 26 16:55:40 volumio systemd[1]: mpd.socket: Deactivated successfully. Mar 26 16:55:40 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 26 16:55:40 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 26 16:55:40 volumio sudo[9026]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:40 volumio volumio[22031]: info: MPD Permissions set Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio sudo[9031]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio sudo[9031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio kernel: usb 1-1.2: USB disconnect, device number 42 Mar 26 16:55:40 volumio sudo[9026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 26 16:55:40 volumio qobuz-connect[4367]: 20260326 16:55:40.939 [4367.4367] INFO SampleApp: shat down connection on UNIX socket Mar 26 16:55:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Mar 26 16:55:40 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Mar 26 16:55:40 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Mar 26 16:55:40 volumio systemd[1]: qobuz-connect.service: Consumed 49.937s CPU time. Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Mar 26 16:55:40 volumio volumio[22031]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Mar 26 16:55:40 volumio volumio[22031]: info: QobuzConnect: setDeactiveState invoked Mar 26 16:55:40 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:40 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:40 volumio volumio[22031]: info: Starting Shairport Sync Mar 26 16:55:41 volumio volumio[22031]: info: Mar 26 16:55:41 volumio volumio[22031]: ---------------------------- USB Audio Device Detached Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:41 volumio sudo[9044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 26 16:55:41 volumio sudo[9044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Mar 26 16:55:41 volumio sudo[8936]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio sudo[8998]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio sudo[8895]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio sudo[9031]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 26 16:55:41 volumio sudo[9050]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 26 16:55:41 volumio sudo[9050]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio sudo[9040]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 26 16:55:41 volumio volumio[22031]: info: Executing endpoint qc_getconfig Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Mar 26 16:55:41 volumio sudo[9040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 26 16:55:41 volumio sudo[9040]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio sudo[9026]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio sudo[9021]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.160 [9045.9045] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.164 [9045.9045] INFO VolumeManager: [0x581068]: Setting new playback volume: 75 Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.164 [9045.9045] INFO VolumeManager: [0x581068]: Setting new mute state: 0 Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.164 [9045.9045] INFO AudioStreamManager: [0x580dc0]: Setting new audio download buffer size: 1048576 Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.164 [9045.9045] INFO QobuzConnect: [0x581930]: Client initialized! Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.164 [9045.9045] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Mar 26 16:55:41 volumio volumio[22031]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Mar 26 16:55:41 volumio kernel: usb 1-1.2: new high-speed USB device number 43 using xhci_hcd Mar 26 16:55:41 volumio volumio[22031]: info: QobuzConnect: QOBUZ Connect daemon connected Mar 26 16:55:41 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 26 16:55:41 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 26 16:55:41 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 26 16:55:41 volumio systemd[1]: shairport-sync.service: Consumed 1.432s CPU time. Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.184 [9045.9045] INFO LocalConfigManager: [0x580ae8]: Starting Local Configuration server Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.184 [9045.9045] INFO SampleApp: Starting Local configuration server Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.184 [9045.9045] INFO SampleApp: Connected to UNIX socket client 0x56b818 Mar 26 16:55:41 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Mar 26 16:55:41 volumio qobuz-connect[9045]: 20260326 16:55:41.188 [9045.9045] INFO SampleApp: Stopping Local configuration server Mar 26 16:55:41 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 26 16:55:41 volumio sudo[9044]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio volumio[22031]: info: Shairport-Sync Started Mar 26 16:55:41 volumio volumio[22031]: (node:22031) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 26 16:55:41 volumio volumio[22031]: (Use `node --trace-warnings ...` to show where the warning was created) Mar 26 16:55:41 volumio volumio[22031]: (node:22031) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 26 16:55:41 volumio volumio[22031]: (node:22031) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 26 16:55:41 volumio volumio[22031]: (node:22031) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 26 16:55:41 volumio volumio[22031]: (node:22031) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 26 16:55:41 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Mar 26 16:55:41 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 26 16:55:41 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Mar 26 16:55:41 volumio kernel: usb 1-1.2: Manufacturer: SMSL Mar 26 16:55:41 volumio kernel: hid-generic 0003:152A:85DD.0020: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Mar 26 16:55:41 volumio volumio[22031]: info: Mar 26 16:55:41 volumio volumio[22031]: ---------------------------- USB Audio Device Attached Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::Close All Modals sent Mar 26 16:55:41 volumio volumio[22031]: info: Preparing to save Alsa Options, stopping services first Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:41 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::volumioPause Mar 26 16:55:41 volumio volumio[22031]: info: CoreStateMachine::pause Mar 26 16:55:41 volumio volumio[22031]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:41 volumio volumio[22031]: info: Device 5 does not have any Mixer Control Available Mar 26 16:55:41 volumio volumio[22031]: info: QobuzConnect: setDeactiveState invoked Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:41 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 26 16:55:41 volumio volumio[22031]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 26 16:55:41 volumio volumio[22031]: info: Disabling external Volume Control Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 26 16:55:41 volumio volumio[22031]: info: CoreStateMachine::pushState Mar 26 16:55:41 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::volumioPushState Mar 26 16:55:41 volumio volumio[22031]: info: MRS: Pushing multiroomSync output update for this device Mar 26 16:55:41 volumio volumio[22031]: info: MRS: Pushing multiroomSync output Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:41 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:41 volumio sudo[9095]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:41 volumio sudo[9095]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio volumio[22031]: info: Preparing to generate the ALSA configuration file Mar 26 16:55:41 volumio sudo[9102]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:41 volumio sudo[9102]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio sudo[9095]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio volumio[22031]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 26 16:55:41 volumio volumio[22031]: info: Reading ALSA contributions from plugins. Mar 26 16:55:41 volumio sudo[9102]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio sudo[9108]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 26 16:55:41 volumio sudo[9108]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:41 volumio sudo[9108]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio sudo[9116]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 26 16:55:41 volumio sudo[9116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 26 16:55:41 volumio volumio[22031]: info: Asound.conf file unchanged, so no further update is needed Mar 26 16:55:41 volumio volumio[22031]: info: Output device has changed, restarting MPD Mar 26 16:55:41 volumio volumio[22031]: info: Output device has changed, restarting Shairport Sync Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:41 volumio sudo[9121]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 26 16:55:41 volumio sudo[9123]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 26 16:55:41 volumio sudo[9121]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio sudo[9123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio volumio[22031]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 26 16:55:41 volumio volumio[22031]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 26 16:55:41 volumio sudo[9121]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:41 volumio volumio[22031]: info: QobuzConnect: setDeactiveState invoked Mar 26 16:55:41 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:41 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:41 volumio sudo[9133]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:41 volumio sudo[9133]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:41 volumio sudo[9136]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 26 16:55:41 volumio sudo[9136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:42 volumio volumio[22031]: info: MPD Permissions set Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio sudo[9143]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Mar 26 16:55:42 volumio sudo[9143]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Mar 26 16:55:42 volumio sudo[9136]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:42 volumio volumio[22031]: info: Starting Shairport Sync Mar 26 16:55:42 volumio sudo[9133]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:42 volumio sudo[9143]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:42 volumio sudo[9152]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 26 16:55:42 volumio sudo[9152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:42 volumio systemd[1]: mpd.service: Deactivated successfully. Mar 26 16:55:42 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 26 16:55:42 volumio systemd[1]: mpd.service: Consumed 1.054s CPU time. Mar 26 16:55:42 volumio systemd[1]: mpd.socket: Deactivated successfully. Mar 26 16:55:42 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 26 16:55:42 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 26 16:55:42 volumio sudo[9153]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Mar 26 16:55:42 volumio sudo[9153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:42 volumio volumio[22031]: info: TidalConnect service stoped! Mar 26 16:55:42 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 26 16:55:42 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Mar 26 16:55:42 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 26 16:55:42 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 26 16:55:42 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 26 16:55:42 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 26 16:55:42 volumio sudo[9152]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:42 volumio volumio[22031]: info: Shairport-Sync Started Mar 26 16:55:42 volumio volumio[22031]: info: TidalConnect service stoped! Mar 26 16:55:42 volumio volumio[22031]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 26 16:55:42 volumio volumio[22031]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 26 16:55:42 volumio sudo[9158]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 26 16:55:42 volumio sudo[9158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 26 16:55:42 volumio sudo[9158]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:42 volumio sudo[9183]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 26 16:55:42 volumio sudo[9183]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 16:55:42 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Mar 26 16:55:42 volumio sudo[9183]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:42 volumio kernel: usb 1-1.2: USB disconnect, device number 43 Mar 26 16:55:42 volumio volumio[22031]: info: Mar 26 16:55:42 volumio volumio[22031]: ---------------------------- USB Audio Device Detached Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 26 16:55:42 volumio volumio[22031]: info: TidalConnect service stoped! Mar 26 16:55:42 volumio volumio[22031]: info: TidalConnect service stoped! Mar 26 16:55:42 volumio volumio[22031]: info: Executing endpoint tc_getconfig Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 26 16:55:42 volumio vtcs[9190]: STARTING TidalConnect services, version: 1.6.1 Mar 26 16:55:42 volumio vtcs[9190]: STARTED TidalConnect services. Mar 26 16:55:42 volumio volumio[22031]: info: Executing endpoint tc_connect Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 26 16:55:42 volumio volumio[22031]: info: Connecting to TidalConnect Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::servicePushState Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::pushState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioPushState Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output update for this device Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 26 16:55:42 volumio volumio[22031]: verbose: CURRENT POSITION 0 Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::syncState stateService stop Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::syncState currentStatus pause Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::pushState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioPushState Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output update for this device Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::servicePushState Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::pushState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioPushState Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output update for this device Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 26 16:55:42 volumio volumio[22031]: verbose: CURRENT POSITION 0 Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::syncState stateService stop Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::syncState currentStatus pause Mar 26 16:55:42 volumio volumio[22031]: info: CoreStateMachine::pushState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioPushState Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output update for this device Mar 26 16:55:42 volumio volumio[22031]: info: MRS: Pushing multiroomSync output Mar 26 16:55:42 volumio volumio[22031]: info: CoreCommandRouter::volumioGetState Mar 26 16:55:42 volumio volumio[22031]: info: CorePlayQueue::getTrack 0 Mar 26 16:55:42 volumio volumio[22031]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 26 16:55:42 volumio volumio[22031]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 26 16:55:42 volumio volumio[22031]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 16:55:42 volumio volumio[22031]: Error: ENOENT: no such file or directory, unlink '/tmp/QUbNK2ZcdzhKqAUY5fU1kTlR2K2K1hprMJFrxBCiCNovBYjnwfyeB7zHkqRRgMeirGqVE2mz5c4adzDXKnuQvumcpNfKHWhLR3pu' Mar 26 16:55:42 volumio volumio[22031]: at Object.unlinkSync (node:fs:1899:3) Mar 26 16:55:42 volumio volumio[22031]: at ControllerTidalconnect.deleteCertificate (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:11265) Mar 26 16:55:42 volumio volumio[22031]: at TidalConnectClient. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:2774) Mar 26 16:55:42 volumio volumio[22031]: at TidalConnectClient.emit (node:events:514:28) Mar 26 16:55:42 volumio volumio[22031]: at TidalConnectClient.parseData (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:44713) Mar 26 16:55:42 volumio volumio[22031]: at /myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41683 Mar 26 16:55:42 volumio volumio[22031]: at Array.forEach () Mar 26 16:55:42 volumio volumio[22031]: at Socket. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41561) Mar 26 16:55:42 volumio volumio[22031]: at Socket.emit (node:events:514:28) Mar 26 16:55:42 volumio volumio[22031]: at addChunk (node:internal/streams/readable:343:12) Mar 26 16:55:42 volumio volumio[22031]: at readableAddChunk (node:internal/streams/readable:316:9) Mar 26 16:55:42 volumio volumio[22031]: at Readable.push (node:internal/streams/readable:253:10) Mar 26 16:55:42 volumio volumio[22031]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) { Mar 26 16:55:42 volumio volumio[22031]: errno: -2, Mar 26 16:55:42 volumio volumio[22031]: syscall: 'unlink', Mar 26 16:55:42 volumio volumio[22031]: code: 'ENOENT', Mar 26 16:55:42 volumio volumio[22031]: path: '/tmp/QUbNK2ZcdzhKqAUY5fU1kTlR2K2K1hprMJFrxBCiCNovBYjnwfyeB7zHkqRRgMeirGqVE2mz5c4adzDXKnuQvumcpNfKHWhLR3pu' Mar 26 16:55:42 volumio volumio[22031]: } Mar 26 16:55:42 volumio volumio[22031]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 16:55:42 volumio kernel: usb 1-1.2: new high-speed USB device number 44 using xhci_hcd Mar 26 16:55:42 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Mar 26 16:55:42 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 26 16:55:42 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Mar 26 16:55:42 volumio kernel: usb 1-1.2: Manufacturer: SMSL Mar 26 16:55:42 volumio kernel: usb 1-1.2: 1:1: cannot set freq 768000 (v2/v3): err -71 Mar 26 16:55:42 volumio kernel: usb 1-1.2: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Mar 26 16:55:42 volumio kernel: usb 1-1.2: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Mar 26 16:55:42 volumio kernel: usbhid 1-1.2:1.3: can't add hid device: -71 Mar 26 16:55:42 volumio kernel: usbhid 1-1.2:1.3: probe with driver usbhid failed with error -71 Mar 26 16:55:42 volumio kernel: usb 1-1.2: USB disconnect, device number 44 Mar 26 16:55:42 volumio (udev-worker)[8956]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 2. Mar 26 16:55:43 volumio qobuz-connect[9045]: 20260326 16:55:43.195 [9045.9045] INFO SampleApp: shat down connection on UNIX socket Mar 26 16:55:43 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Mar 26 16:55:43 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Mar 26 16:55:43 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Mar 26 16:55:43 volumio sudo[9116]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:43 volumio sudo[9153]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:43 volumio sudo[9050]: pam_unix(sudo:session): session closed for user root Mar 26 16:55:43 volumio sudo[9237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-26 16:54' Mar 26 16:55:43 volumio sudo[9237]: 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"