Aug 26 16:31:01 volumio volumio[1349]: info: MRS: Found cast device: BRAVIA-TL2-39a242137b17e470066b846a89484826 Aug 26 16:31:10 volumio kernel: usb 1-1.2: new high-speed USB device number 10 using xhci_hcd Aug 26 16:31:10 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Aug 26 16:31:10 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Aug 26 16:31:10 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Aug 26 16:31:10 volumio kernel: usb 1-1.2: Manufacturer: SMSL Aug 26 16:31:12 volumio kernel: usb 1-1.2: 1:1: cannot set freq 768000 (v2/v3): err -71 Aug 26 16:31:12 volumio kernel: usb 1-1.2: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Aug 26 16:31:12 volumio kernel: usb 1-1.2: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Aug 26 16:31:12 volumio kernel: usbhid 1-1.2:1.3: can't add hid device: -71 Aug 26 16:31:12 volumio kernel: usbhid 1-1.2:1.3: probe with driver usbhid failed with error -71 Aug 26 16:31:12 volumio kernel: usb 1-1.2: USB disconnect, device number 10 Aug 26 16:31:12 volumio (udev-worker)[19976]: 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 Aug 26 16:31:12 volumio volumio[1349]: info: Aug 26 16:31:12 volumio volumio[1349]: ---------------------------- USB Audio Device Attached Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Aug 26 16:31:12 volumio volumio[1349]: error: API:pushError: TypeError: Cannot read properties of null (reading 'name') Aug 26 16:31:12 volumio volumio[1349]: info: Aug 26 16:31:12 volumio volumio[1349]: ---------------------------- USB Audio Device Detached Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Aug 26 16:31:12 volumio kernel: usb 1-1.2: new high-speed USB device number 11 using xhci_hcd Aug 26 16:31:12 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Aug 26 16:31:12 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Aug 26 16:31:12 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Aug 26 16:31:12 volumio kernel: usb 1-1.2: Manufacturer: SMSL Aug 26 16:31:12 volumio kernel: hid-generic 0003:152A:85DD.0005: hiddev97,hidraw3: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Aug 26 16:31:12 volumio volumio[1349]: info: Aug 26 16:31:12 volumio volumio[1349]: ---------------------------- USB Audio Device Attached Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::Close All Modals sent Aug 26 16:31:12 volumio volumio[1349]: info: Preparing to save Alsa Options, stopping services first Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioPause Aug 26 16:31:12 volumio volumio[1349]: info: CoreStateMachine::pause Aug 26 16:31:12 volumio volumio[1349]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:12 volumio volumio[1349]: info: Device 5 does not have any Mixer Control Available Aug 26 16:31:12 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:12 volumio volumio[1349]: info: QobuzConnect: setDeactiveState(): relinquishing Volumio State Aug 26 16:31:12 volumio volumio[1349]: verbose: UNSET VOLATILE: Service: qobuzconnect Aug 26 16:31:12 volumio volumio[1349]: info: QobuzConnect: onUnsetVolatile() called, relinquishing Volumio State to another service Aug 26 16:31:12 volumio volumio[1349]: info: QobuzConnect: Received stop Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:12 volumio qobuz-connect[1933]: 20260826 16:31:12.684 [1933.1933] INFO MediaEngine: [0x632d10]: Stopping playback, keeping tracks Aug 26 16:31:12 volumio vtcs[2000]: [2026-08-26 16:31:12.684] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Aug 26 16:31:12 volumio vtcs[2000]: [2026-08-26 16:31:12.684] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Aug 26 16:31:12 volumio sudo[20011]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:12 volumio sudo[20011]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 26 16:31:12 volumio volumio[1349]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 26 16:31:12 volumio volumio[1349]: info: Disabling external Volume Control Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 16:31:12 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 26 16:31:12 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:12 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:12 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:12 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:12 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:12 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:12 volumio systemd[1]: vtcs.service: Deactivated successfully. Aug 26 16:31:12 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:12 volumio systemd[1]: vtcs.service: Consumed 3.011s CPU time. Aug 26 16:31:12 volumio sudo[20011]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:12 volumio sudo[20019]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:12 volumio sudo[20019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:12 volumio sudo[20026]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:12 volumio sudo[20026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:12 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:12 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:12 volumio sudo[20026]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:12 volumio sudo[20019]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:12 volumio sudo[20031]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:12 volumio sudo[20031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:12 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 26 16:31:12 volumio qobuz-connect[1933]: 20260826 16:31:12.905 [1933.1933] INFO SampleApp: Stopping Local configuration server Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 26 16:31:12 volumio volumio[1349]: info: Asound.conf file unchanged, so no further update is needed Aug 26 16:31:12 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:12 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:12 volumio sudo[20040]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:12 volumio sudo[20040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:12 volumio sudo[20040]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:12 volumio sudo[20042]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:12 volumio sudo[20042]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:12 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:12 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:12 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:12 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:12 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:12 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 26 16:31:13 volumio sudo[20052]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:13 volumio sudo[20052]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:13 volumio sudo[20054]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:13 volumio sudo[20054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:13 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:13 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:13 volumio systemd[1]: mpd.service: Consumed 1.451s CPU time. Aug 26 16:31:13 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:13 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:13 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:13 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio sudo[20063]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:13 volumio sudo[20063]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:13 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:13 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:13 volumio sudo[20071]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:13 volumio sudo[20071]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:13 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:13 volumio kernel: usb 1-1.2: USB disconnect, device number 11 Aug 26 16:31:13 volumio sudo[20063]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:13 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 26 16:31:13 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 26 16:31:13 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:13 volumio sudo[20075]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:13 volumio systemd[1]: shairport-sync.service: Consumed 30.270s CPU time. Aug 26 16:31:13 volumio sudo[20075]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:13 volumio sudo[20073]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:13 volumio sudo[20073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:13 volumio sudo[20054]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:13 volumio sudo[20073]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Aug 26 16:31:13 volumio sudo[20052]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:13 volumio volumio[1349]: info: Aug 26 16:31:13 volumio volumio[1349]: ---------------------------- USB Audio Device Detached Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:13 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Aug 26 16:31:13 volumio sudo[20071]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:13 volumio volumio[1349]: info: Shairport-Sync Started Aug 26 16:31:13 volumio kernel: usb 1-1.2: new high-speed USB device number 12 using xhci_hcd Aug 26 16:31:13 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Aug 26 16:31:13 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Aug 26 16:31:13 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Aug 26 16:31:13 volumio kernel: usb 1-1.2: Manufacturer: SMSL Aug 26 16:31:13 volumio kernel: hid-generic 0003:152A:85DD.0006: hiddev97,hidraw3: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Aug 26 16:31:13 volumio volumio[1349]: info: Aug 26 16:31:13 volumio volumio[1349]: ---------------------------- USB Audio Device Attached Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::Close All Modals sent Aug 26 16:31:13 volumio volumio[1349]: info: Preparing to save Alsa Options, stopping services first Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:13 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::volumioPause Aug 26 16:31:13 volumio volumio[1349]: info: CoreStateMachine::pause Aug 26 16:31:13 volumio volumio[1349]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:13 volumio volumio[1349]: info: Device 5 does not have any Mixer Control Available Aug 26 16:31:13 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:13 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:13 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 26 16:31:14 volumio volumio[1349]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 26 16:31:14 volumio sudo[20120]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:14 volumio sudo[20120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 26 16:31:14 volumio volumio[1349]: info: Disabling external Volume Control Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 16:31:14 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:14 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:14 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:14 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:14 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:14 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:14 volumio sudo[20120]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio sudo[20127]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:14 volumio sudo[20127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:14 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:14 volumio sudo[20131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:14 volumio sudo[20131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio sudo[20127]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:14 volumio sudo[20131]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio sudo[20140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:14 volumio sudo[20140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 26 16:31:14 volumio volumio[1349]: info: Asound.conf file unchanged, so no further update is needed Aug 26 16:31:14 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:14 volumio sudo[20145]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:14 volumio sudo[20145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:14 volumio sudo[20145]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio sudo[20150]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:14 volumio sudo[20150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:14 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:14 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:14 volumio kernel: usb 1-1.2: USB disconnect, device number 12 Aug 26 16:31:14 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:14 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:14 volumio systemd[1]: mpd.service: Consumed 1.270s CPU time. Aug 26 16:31:14 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:14 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:14 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:14 volumio sudo[20159]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:14 volumio sudo[20159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Aug 26 16:31:14 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:14 volumio sudo[20161]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:14 volumio sudo[20161]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:14 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:14 volumio sudo[20169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Aug 26 16:31:14 volumio volumio[1349]: info: Aug 26 16:31:14 volumio volumio[1349]: ---------------------------- USB Audio Device Detached Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:14 volumio sudo[20169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio sudo[20159]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio sudo[20171]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:14 volumio sudo[20171]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:14 volumio sudo[20171]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:14 volumio qobuz-connect[1933]: 20260826 16:31:14.681 [1933.1933] INFO SampleApp: shat down connection on UNIX socket Aug 26 16:31:14 volumio volumio[1349]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Aug 26 16:31:14 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:14 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:14 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:14 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:14 volumio sudo[20187]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:14 volumio sudo[20187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio kernel: usb 1-1.2: new high-speed USB device number 13 using xhci_hcd Aug 26 16:31:14 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 26 16:31:14 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:14 volumio systemd[1]: qobuz-connect.service: Consumed 1h 3min 3.194s CPU time. Aug 26 16:31:14 volumio sudo[20169]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:14 volumio sudo[20031]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:14 volumio sudo[20075]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio sudo[20140]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:14 volumio sudo[20190]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:14 volumio sudo[20190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio volumio[1349]: info: Executing endpoint qc_getconfig Aug 26 16:31:14 volumio sudo[20161]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Aug 26 16:31:14 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Aug 26 16:31:14 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Aug 26 16:31:14 volumio kernel: usb 1-1.2: Manufacturer: SMSL Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 26 16:31:14 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 26 16:31:14 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 26 16:31:14 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:14 volumio systemd[1]: shairport-sync.service: Consumed 1.411s CPU time. Aug 26 16:31:14 volumio kernel: hid-generic 0003:152A:85DD.0007: hiddev97,hidraw3: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Aug 26 16:31:14 volumio qobuz-connect[20189]: 20260826 16:31:14.853 [20189.20189] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 26 16:31:14 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 26 16:31:14 volumio volumio[1349]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 26 16:31:14 volumio volumio[1349]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 26 16:31:14 volumio volumio[1349]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Aug 26 16:31:14 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:14 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:14 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:14 volumio volumio[1349]: info: Asound.conf file written Aug 26 16:31:14 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:14 volumio sudo[20187]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 26 16:31:14 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:14 volumio sudo[20204]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 26 16:31:14 volumio sudo[20204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:14 volumio sudo[20204]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:14 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:14 volumio sudo[20190]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:15 volumio sudo[20227]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:15 volumio sudo[20227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:15 volumio sudo[20227]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:15 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio sudo[20229]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:15 volumio sudo[20229]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:15 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:15 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:15 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:15 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:15 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:15 volumio sudo[20239]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:15 volumio sudo[20239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio sudo[20241]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:15 volumio sudo[20241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:15 volumio volumio[1349]: info: Shairport-Sync Started Aug 26 16:31:15 volumio volumio[1349]: info: Aug 26 16:31:15 volumio volumio[1349]: ---------------------------- USB Audio Device Attached Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Aug 26 16:31:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:15 volumio sudo[20251]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:15 volumio sudo[20251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::Close All Modals sent Aug 26 16:31:15 volumio volumio[1349]: info: Preparing to save Alsa Options, stopping services first Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:15 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::volumioPause Aug 26 16:31:15 volumio volumio[1349]: info: CoreStateMachine::pause Aug 26 16:31:15 volumio volumio[1349]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:15 volumio sudo[20241]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio sudo[20251]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:15 volumio sudo[20239]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio sudo[20266]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:15 volumio sudo[20266]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio sudo[20254]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:15 volumio sudo[20254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:15 volumio sudo[20254]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio volumio[1349]: info: Device 5 does not have any Mixer Control Available Aug 26 16:31:15 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:15 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:15 volumio sudo[20274]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:15 volumio sudo[20274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 26 16:31:15 volumio volumio[1349]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 26 16:31:15 volumio volumio[1349]: info: Disabling external Volume Control Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 16:31:15 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:15 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:15 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:15 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:15 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:15 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:15 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 26 16:31:15 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 26 16:31:15 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:15 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:15 volumio sudo[20266]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio sudo[20295]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:15 volumio sudo[20274]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio sudo[20295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio volumio[1349]: info: Executing endpoint qc_getconfig Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 26 16:31:15 volumio sudo[20306]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:15 volumio sudo[20306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio sudo[20295]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio sudo[20306]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:15 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:15 volumio volumio[1349]: info: Executing endpoint qc_getconfig Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 26 16:31:15 volumio sudo[20314]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:15 volumio sudo[20314]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.679 [20294.20294] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.687 [20294.20294] INFO VolumeManager: [0xa90068]: Setting new playback volume: 75 Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.687 [20294.20294] INFO VolumeManager: [0xa90068]: Setting new mute state: 0 Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.687 [20294.20294] INFO AudioStreamManager: [0xa8fdc0]: Setting new audio download buffer size: 1048576 Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.687 [20294.20294] INFO QobuzConnect: [0xa90930]: Client initialized! Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.687 [20294.20294] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Aug 26 16:31:15 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.702 [20294.20294] INFO LocalConfigManager: [0xa8fae8]: Starting Local Configuration server Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.702 [20294.20294] INFO SampleApp: Starting Local configuration server Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.703 [20294.20294] INFO SampleApp: Connected to UNIX socket client 0xa7a818 Aug 26 16:31:15 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 26 16:31:15 volumio qobuz-connect[20294]: 20260826 16:31:15.708 [20294.20294] INFO SampleApp: Stopping Local configuration server Aug 26 16:31:15 volumio volumio[1349]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 26 16:31:15 volumio volumio[1349]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 26 16:31:15 volumio sudo[20323]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:15 volumio sudo[20323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:15 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 26 16:31:15 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 26 16:31:15 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 26 16:31:15 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:15 volumio volumio[1349]: info: Asound.conf file written Aug 26 16:31:15 volumio sudo[20323]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:15 volumio sudo[20334]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 26 16:31:15 volumio sudo[20334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio sudo[20334]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Aug 26 16:31:15 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:15 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:15 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:15 volumio sudo[20354]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:15 volumio sudo[20354]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:15 volumio kernel: usb 1-1.2: USB disconnect, device number 13 Aug 26 16:31:15 volumio sudo[20354]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio sudo[20356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:16 volumio sudo[20356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:16 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:16 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:16 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:16 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:16 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:16 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:16 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:16 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:16 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:16 volumio sudo[20369]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:16 volumio sudo[20369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:16 volumio sudo[20372]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:16 volumio sudo[20372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:16 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:16 volumio sudo[20372]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio sudo[20376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:16 volumio sudo[20376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio sudo[20369]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:16 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:16 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:16 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:16 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:16 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:16 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:16 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:16 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:16 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:16 volumio sudo[20387]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:16 volumio sudo[20387]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio sudo[20393]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:16 volumio kernel: usb 1-1.2: new high-speed USB device number 14 using xhci_hcd Aug 26 16:31:16 volumio sudo[20393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio sudo[20387]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio sudo[20401]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:16 volumio sudo[20389]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:16 volumio sudo[20389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio sudo[20401]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Aug 26 16:31:16 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:16 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:16 volumio sudo[20407]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:16 volumio sudo[20407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.54 Aug 26 16:31:16 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Aug 26 16:31:16 volumio kernel: usb 1-1.2: Product: SMSL USB AUDIO Aug 26 16:31:16 volumio kernel: usb 1-1.2: Manufacturer: SMSL Aug 26 16:31:16 volumio sudo[20401]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio volumio[1349]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Aug 26 16:31:16 volumio sudo[20390]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:16 volumio sudo[20390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:16 volumio sudo[20390]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:16 volumio volumio[1349]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Aug 26 16:31:16 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:16 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:16 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:16 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:16 volumio sudo[20410]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:16 volumio kernel: hid-generic 0003:152A:85DD.0008: hiddev97,hidraw3: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.2/input3 Aug 26 16:31:16 volumio sudo[20410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio volumio[1349]: info: Shairport-Sync Started Aug 26 16:31:16 volumio volumio[1349]: info: Aug 26 16:31:16 volumio volumio[1349]: ---------------------------- USB Audio Device Detached Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Aug 26 16:31:16 volumio sudo[20393]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio sudo[20407]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio sudo[20389]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:16 volumio sudo[20442]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:16 volumio sudo[20442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:16 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:16 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 26 16:31:16 volumio volumio[1349]: info: CoreStateMachine::getcurrentVolume Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 16:31:16 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:16 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:16 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:16 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:16 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:16 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:16 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:16 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:16 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:16 volumio volumio[1349]: info: Aug 26 16:31:16 volumio volumio[1349]: ---------------------------- USB Audio Device Attached Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Aug 26 16:31:16 volumio sudo[20457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:16 volumio sudo[20457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio sudo[20459]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::Close All Modals sent Aug 26 16:31:16 volumio volumio[1349]: info: Preparing to save Alsa Options, stopping services first Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:16 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioPause Aug 26 16:31:16 volumio volumio[1349]: info: CoreStateMachine::pause Aug 26 16:31:16 volumio volumio[1349]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:16 volumio sudo[20459]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio sudo[20455]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:16 volumio sudo[20455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:16 volumio volumio[1349]: info: Device 5 does not have any Mixer Control Available Aug 26 16:31:16 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:16 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:16 volumio sudo[20477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:16 volumio sudo[20477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 26 16:31:16 volumio volumio[1349]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 26 16:31:16 volumio volumio[1349]: info: Disabling external Volume Control Aug 26 16:31:16 volumio volumio[1349]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 16:31:17 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:17 volumio sudo[20459]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:17 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:17 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:17 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:17 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:17 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 26 16:31:17 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 26 16:31:17 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 26 16:31:17 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:17 volumio systemd[1]: shairport-sync.service: Consumed 1.070s CPU time. Aug 26 16:31:17 volumio systemd[1]: vtcs.service: Deactivated successfully. Aug 26 16:31:17 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:17 volumio sudo[20485]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:17 volumio sudo[20485]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio sudo[20477]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20492]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:17 volumio sudo[20492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio volumio[1349]: info: Asound.conf file unchanged, so no further update is needed Aug 26 16:31:17 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:17 volumio sudo[20496]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:17 volumio sudo[20496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:17 volumio sudo[20499]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:17 volumio sudo[20499]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio sudo[20499]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20502]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:17 volumio sudo[20502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:17 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:17 volumio sudo[20455]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio sudo[20457]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20492]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:17 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:17 volumio sudo[20509]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:17 volumio sudo[20509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:17 volumio sudo[20485]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:17 volumio sudo[20514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio sudo[20528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:17 volumio sudo[20528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:17 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:17 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:17 volumio sudo[20539]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:17 volumio sudo[20539]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:17 volumio volumio[1349]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Aug 26 16:31:17 volumio volumio[1349]: Job for vtcs.service canceled. Aug 26 16:31:17 volumio volumio[1349]: {"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":""} Aug 26 16:31:17 volumio volumio[1349]: info: Shairport-Sync Started Aug 26 16:31:17 volumio volumio[1349]: info: Shairport-Sync Started Aug 26 16:31:17 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:17 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:17 volumio sudo[20496]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:17 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 16:31:17 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:17 volumio sudo[20539]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:17 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 26 16:31:17 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Aug 26 16:31:17 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:17 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio systemd[1]: vtcs.service: Deactivated successfully. Aug 26 16:31:17 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:17 volumio sudo[20554]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:17 volumio sudo[20554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:17 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:17 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:17 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:17 volumio sudo[20514]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20528]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20555]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:17 volumio sudo[20555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:17 volumio sudo[20567]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:17 volumio sudo[20567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio sudo[20555]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio volumio[1349]: info: Asound.conf file written Aug 26 16:31:17 volumio qobuz-connect[20294]: 20260826 16:31:17.709 [20294.20294] INFO SampleApp: shat down connection on UNIX socket Aug 26 16:31:17 volumio sudo[20572]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:17 volumio sudo[20572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio sudo[20577]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 26 16:31:17 volumio sudo[20577]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio sudo[20577]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 26 16:31:17 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:17 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Aug 26 16:31:17 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Aug 26 16:31:17 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Aug 26 16:31:17 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Aug 26 16:31:17 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:17 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:17 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 26 16:31:17 volumio sudo[20314]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 26 16:31:17 volumio sudo[20442]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20410]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20509]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20584]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:17 volumio sudo[20584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 26 16:31:17 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:17 volumio sudo[20554]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20586]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:17 volumio sudo[20584]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20586]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:17 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:17 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:17 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:17 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:17 volumio sudo[20567]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio sudo[20572]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:17 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:17 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:17 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:17 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:17 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:17 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:17 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:17 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:17 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:17 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:18 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:18 volumio sudo[20614]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:18 volumio sudo[20614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:18 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:18 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 26 16:31:18 volumio systemd[1]: vtcs.service: Deactivated successfully. Aug 26 16:31:18 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:18 volumio sudo[20620]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:18 volumio sudo[20620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20623]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:18 volumio sudo[20623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20620]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20614]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:18 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:18 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:18 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:18 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:18 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:18 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:18 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:18 volumio sudo[20634]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:18 volumio sudo[20634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:18 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:18 volumio sudo[20636]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:18 volumio sudo[20636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20640]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:18 volumio sudo[20640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20648]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 26 16:31:18 volumio volumio[1349]: info: CoreStateMachine::getcurrentVolume Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 16:31:18 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:18 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:18 volumio sudo[20648]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:18 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:18 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:18 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:18 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:18 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:18 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:18 volumio volumio[1349]: info: Shairport-Sync Started Aug 26 16:31:18 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:18 volumio sudo[20654]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:18 volumio sudo[20654]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio volumio[1349]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Aug 26 16:31:18 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:18 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:18 volumio volumio[1349]: info: Executing endpoint qc_getconfig Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 26 16:31:18 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.339 [20589.20589] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.347 [20589.20589] INFO VolumeManager: [0x10c6068]: Setting new playback volume: 75 Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.347 [20589.20589] INFO VolumeManager: [0x10c6068]: Setting new mute state: 0 Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.347 [20589.20589] INFO AudioStreamManager: [0x10c5dc0]: Setting new audio download buffer size: 1048576 Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.347 [20589.20589] INFO QobuzConnect: [0x10c6930]: Client initialized! Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.347 [20589.20589] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Aug 26 16:31:18 volumio sudo[20648]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20654]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.375 [20589.20589] INFO LocalConfigManager: [0x10c5ae8]: Starting Local Configuration server Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.375 [20589.20589] INFO SampleApp: Starting Local configuration server Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.375 [20589.20589] INFO SampleApp: Connected to UNIX socket client 0x10b0818 Aug 26 16:31:18 volumio volumio[1349]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 26 16:31:18 volumio volumio[1349]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 26 16:31:18 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio sudo[20642]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio sudo[20642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:18 volumio sudo[20642]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20636]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20667]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:18 volumio sudo[20667]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20668]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:18 volumio sudo[20668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:18 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.491 [20589.20589] INFO SampleApp: Playback volume changed: 75 Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:18 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:18 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:18 volumio sudo[20634]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:18 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:18 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:18 volumio sudo[20640]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20698]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:18 volumio sudo[20698]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:18 volumio sudo[20700]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:18 volumio sudo[20700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 26 16:31:18 volumio qobuz-connect[20589]: 20260826 16:31:18.602 [20589.20589] INFO SampleApp: Stopping Local configuration server Aug 26 16:31:18 volumio sudo[20703]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:18 volumio sudo[20703]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 26 16:31:18 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 26 16:31:18 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:18 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:18 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Aug 26 16:31:18 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Aug 26 16:31:18 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:18 volumio sudo[20698]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20700]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio volumio[1349]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Aug 26 16:31:18 volumio volumio[1349]: Job for shairport-sync.service failed because start of the service was attempted too often. Aug 26 16:31:18 volumio volumio[1349]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Aug 26 16:31:18 volumio volumio[1349]: To force a start use "systemctl reset-failed shairport-sync.service" Aug 26 16:31:18 volumio volumio[1349]: followed by "systemctl start shairport-sync.service" again. Aug 26 16:31:18 volumio volumio[1349]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Aug 26 16:31:18 volumio volumio[1349]: Job for shairport-sync.service failed because start of the service was attempted too often. Aug 26 16:31:18 volumio volumio[1349]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Aug 26 16:31:18 volumio volumio[1349]: To force a start use "systemctl reset-failed shairport-sync.service" Aug 26 16:31:18 volumio volumio[1349]: followed by "systemctl start shairport-sync.service" again. Aug 26 16:31:18 volumio volumio[1349]: info: Asound.conf file written Aug 26 16:31:18 volumio sudo[20708]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:18 volumio sudo[20708]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20721]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 26 16:31:18 volumio sudo[20721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20721]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Aug 26 16:31:18 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Aug 26 16:31:18 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Aug 26 16:31:18 volumio volumio[1349]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Aug 26 16:31:18 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:18 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:18 volumio sudo[20703]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:18 volumio sudo[20728]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:18 volumio sudo[20728]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20708]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20728]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:18 volumio sudo[20731]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:18 volumio sudo[20731]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:18 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:18 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:18 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:18 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:18 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:18 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:18 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:18 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:18 volumio sudo[20742]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:18 volumio sudo[20742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio sudo[20746]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:18 volumio sudo[20746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:18 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:18 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:18 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:18 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:18 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:18 volumio volumio[1349]: info: Executing endpoint tc_getconfig Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 26 16:31:18 volumio vtcs[20727]: STARTING TidalConnect services, version: 1.6.1 Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:18 volumio vtcs[20727]: STARTED TidalConnect services. Aug 26 16:31:19 volumio sudo[20753]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:19 volumio sudo[20753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:19 volumio volumio[1349]: info: Executing endpoint tc_connect Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 26 16:31:19 volumio volumio[1349]: info: Connecting to TidalConnect Aug 26 16:31:19 volumio sudo[20753]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 26 16:31:19 volumio sudo[20769]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:19 volumio sudo[20769]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20774]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:19 volumio sudo[20774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::servicePushState Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio systemd[1]: vtcs.service: Deactivated successfully. Aug 26 16:31:19 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: 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} Aug 26 16:31:19 volumio volumio[1349]: verbose: CURRENT POSITION 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::syncState stateService stop Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::syncState currentStatus pause Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::servicePushState Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: 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} Aug 26 16:31:19 volumio volumio[1349]: verbose: CURRENT POSITION 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::syncState stateService stop Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::syncState currentStatus pause Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:19 volumio sudo[20742]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio volumio[1349]: info: Asound.conf file unchanged, so no further update is needed Aug 26 16:31:19 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:19 volumio sudo[20778]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:19 volumio sudo[20778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20767]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:19 volumio sudo[20767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:19 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:19 volumio sudo[20767]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20780]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:19 volumio sudo[20780]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20785]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:19 volumio sudo[20780]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: Preparing to generate the ALSA configuration file Aug 26 16:31:19 volumio sudo[20796]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:19 volumio sudo[20796]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20746]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20799]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:19 volumio volumio[1349]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 26 16:31:19 volumio sudo[20799]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: Reading ALSA contributions from plugins. Aug 26 16:31:19 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:19 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio sudo[20806]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:19 volumio sudo[20806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20769]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Aug 26 16:31:19 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Aug 26 16:31:19 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3 Aug 26 16:31:19 volumio volumio[1349]: Job for vtcs.service canceled. Aug 26 16:31:19 volumio volumio[1349]: {"cmd":"/usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3","code":1,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl start 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":""} Aug 26 16:31:19 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:19 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:19 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:19 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:19 volumio volumio[1349]: info: Asound.conf file unchanged, so no further update is needed Aug 26 16:31:19 volumio volumio[1349]: info: Output device has changed, restarting MPD Aug 26 16:31:19 volumio sudo[20815]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:19 volumio sudo[20815]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: Output device has changed, restarting Shairport Sync Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:19 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:19 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:19 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:19 volumio sudo[20796]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20817]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 16:31:19 volumio sudo[20817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20822]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 16:31:19 volumio sudo[20822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio sudo[20817]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio volumio[1349]: info: QobuzConnect: setDeactiveState invoked Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio sudo[20832]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:19 volumio sudo[20832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20834]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 26 16:31:19 volumio sudo[20834]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::getcurrentVolume Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 16:31:19 volumio volumio[1349]: info: CoreStateMachine::pushState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioPushState Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output update for this device Aug 26 16:31:19 volumio volumio[1349]: info: MRS: Pushing multiroomSync output Aug 26 16:31:19 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::volumioGetState Aug 26 16:31:19 volumio volumio[1349]: info: CorePlayQueue::getTrack 0 Aug 26 16:31:19 volumio sudo[20842]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 26 16:31:19 volumio sudo[20842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: MPD Permissions set Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio sudo[20778]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20806]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 16:31:19 volumio volumio[1349]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Aug 26 16:31:19 volumio volumio[1349]: Job for shairport-sync.service failed because start of the service was attempted too often. Aug 26 16:31:19 volumio volumio[1349]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Aug 26 16:31:19 volumio volumio[1349]: To force a start use "systemctl reset-failed shairport-sync.service" Aug 26 16:31:19 volumio volumio[1349]: followed by "systemctl start shairport-sync.service" again. Aug 26 16:31:19 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:19 volumio sudo[20847]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:19 volumio sudo[20847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20799]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio volumio[1349]: info: Starting Shairport Sync Aug 26 16:31:19 volumio sudo[20843]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:19 volumio sudo[20843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:19 volumio sudo[20843]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20858]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 16:31:19 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:19 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:19 volumio sudo[20858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: TidalConnect service stoped! Aug 26 16:31:19 volumio sudo[20867]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:19 volumio sudo[20867]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio volumio[1349]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:19 volumio volumio[1349]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 26 16:31:19 volumio sudo[20878]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 26 16:31:19 volumio sudo[20878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20842]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20880]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 26 16:31:19 volumio sudo[20880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:19 volumio sudo[20832]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20834]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio volumio[1349]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Aug 26 16:31:19 volumio volumio[1349]: Job for vtcs.service canceled. Aug 26 16:31:19 volumio volumio[1349]: {"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 ChildProcess._handle.onexit (node:internal/child_process:305:5)","stderr":"Job for vtcs.service canceled.\n","stdout":""} Aug 26 16:31:19 volumio volumio[1349]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 16:31:19 volumio volumio[1349]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Aug 26 16:31:19 volumio volumio[1349]: Job for vtcs.service canceled. Aug 26 16:31:19 volumio volumio[1349]: at ChildProcess.exithandler (node:child_process:421:12) Aug 26 16:31:19 volumio volumio[1349]: at ChildProcess.emit (node:events:514:28) Aug 26 16:31:19 volumio volumio[1349]: at maybeClose (node:internal/child_process:1105:16) Aug 26 16:31:19 volumio volumio[1349]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) { Aug 26 16:31:19 volumio volumio[1349]: code: 1, Aug 26 16:31:19 volumio volumio[1349]: killed: false, Aug 26 16:31:19 volumio volumio[1349]: signal: null, Aug 26 16:31:19 volumio volumio[1349]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Aug 26 16:31:19 volumio volumio[1349]: stdout: '', Aug 26 16:31:19 volumio volumio[1349]: stderr: 'Job for vtcs.service canceled.\n' Aug 26 16:31:19 volumio volumio[1349]: } Aug 26 16:31:19 volumio volumio[1349]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 16:31:19 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Aug 26 16:31:19 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Aug 26 16:31:19 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 26 16:31:19 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 26 16:31:19 volumio sudo[20867]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 26 16:31:19 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 26 16:31:19 volumio sudo[20815]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20858]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio sudo[20878]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:19 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 26 16:31:19 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 26 16:31:19 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 26 16:31:19 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 26 16:31:20 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 26 16:31:20 volumio sudo[20899]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 16:31:20 volumio sudo[20899]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 26 16:31:20 volumio sudo[20899]: pam_unix(sudo:session): session closed for user root Aug 26 16:31:20 volumio sudo[20904]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-26 16:30' Aug 26 16:31:20 volumio sudo[20904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 16:31:20 volumio qobuz-connect[20589]: 20260826 16:31:20.380 [20589.20589] INFO SampleApp: shat down connection on UNIX socket Aug 26 16:31:20 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 26 16:31:20 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"