Jan 09 18:16:08 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:16:08 volumio volumio[1193]: info: Listing playlists Jan 09 18:16:08 volumio volumio[1193]: info: Listing playlists Jan 09 18:16:18 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:16:28 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:16:28 volumio volumio[1193]: info: Listing playlists Jan 09 18:16:28 volumio volumio[1193]: info: Listing playlists Jan 09 18:16:38 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:16:48 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:16:48 volumio volumio[1193]: info: Listing playlists Jan 09 18:16:48 volumio volumio[1193]: info: Listing playlists Jan 09 18:16:58 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:16:59 volumio kernel: usb 1-1.4: new high-speed USB device number 3 using xhci_hcd Jan 09 18:16:59 volumio kernel: usb 1-1.4: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.23 Jan 09 18:16:59 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 09 18:16:59 volumio kernel: usb 1-1.4: Product: SMSL USB AUDIO Jan 09 18:16:59 volumio kernel: usb 1-1.4: Manufacturer: SMSL Jan 09 18:16:59 volumio kernel: hid-generic 0003:152A:85DD.0001: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.4/input3 Jan 09 18:16:59 volumio kernel: usb 1-1.4: 1:1: cannot set freq 768000 (v2/v3): err -71 Jan 09 18:16:59 volumio kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Jan 09 18:16:59 volumio kernel: usb 1-1.4: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Jan 09 18:16:59 volumio kernel: usbcore: registered new interface driver snd-usb-audio Jan 09 18:16:59 volumio (udev-worker)[21268]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99. Jan 09 18:17:00 volumio volumio[1193]: info: Jan 09 18:17:00 volumio volumio[1193]: ---------------------------- USB Audio Device Attached Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::Close All Modals sent Jan 09 18:17:00 volumio volumio[1193]: info: Preparing to save Alsa Options, stopping services first Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:17:00 volumio volumio[1193]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:00 volumio volumio[1193]: info: Device 5 does not have any Mixer Control Available Jan 09 18:17:00 volumio vtcs[1828]: [2026-01-09 18:17:00.101] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 09 18:17:00 volumio vtcs[1828]: [2026-01-09 18:17:00.102] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 09 18:17:00 volumio sudo[21298]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:00 volumio sudo[21298]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 18:17:00 volumio volumio[1193]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 18:17:00 volumio volumio[1193]: info: Disabling external Volume Control Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 18:17:00 volumio volumio[1193]: info: CoreStateMachine::pushState Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::volumioPushState Jan 09 18:17:00 volumio volumio[1193]: info: Preparing to generate the ALSA configuration file Jan 09 18:17:00 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 09 18:17:00 volumio systemd[1]: vtcs.service: Killing process 1834 (vtcs) with signal SIGKILL. Jan 09 18:17:00 volumio systemd[1]: vtcs.service: Deactivated successfully. Jan 09 18:17:00 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 09 18:17:00 volumio systemd[1]: vtcs.service: Consumed 4min 38.834s CPU time. Jan 09 18:17:00 volumio sudo[21298]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:00 volumio volumio[1193]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.J9l7yp8uk9fScBiAkIzc7AC7I343.dd9ee2991e47d15ce6c44d6791b51f62.state.status' Jan 09 18:17:00 volumio kernel: usb 1-1.4: USB disconnect, device number 3 Jan 09 18:17:00 volumio sudo[21306]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:00 volumio sudo[21306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:00 volumio sudo[21306]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:00 volumio volumio[1193]: Invalid card number '5'. Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 18:17:00 volumio volumio[1193]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:17:00 volumio volumio[1193]: info: Output device has changed, restarting MPD Jan 09 18:17:00 volumio volumio[1193]: info: Output device has changed, restarting Shairport Sync Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:00 volumio sudo[21329]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:17:00 volumio sudo[21329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:00 volumio sudo[21329]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:00 volumio sudo[21331]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:17:00 volumio sudo[21331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:00 volumio volumio[1193]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:17:00 volumio volumio[1193]: info: MPD Permissions set Jan 09 18:17:00 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 09 18:17:00 volumio volumio[1193]: info: Jan 09 18:17:00 volumio volumio[1193]: ---------------------------- USB Audio Device Detached Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jan 09 18:17:00 volumio sudo[21339]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:00 volumio sudo[21339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:00 volumio sudo[21341]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:00 volumio sudo[21341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:00 volumio volumio[1193]: info: Starting Shairport Sync Jan 09 18:17:00 volumio sudo[21339]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:00 volumio sudo[21341]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:00 volumio sudo[21359]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:17:00 volumio sudo[21359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:00 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 18:17:00 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 18:17:00 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:00 volumio systemd[1]: shairport-sync.service: Consumed 50min 30.490s CPU time. Jan 09 18:17:00 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:00 volumio sudo[21359]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:00 volumio volumio[1193]: info: Shairport-Sync Started Jan 09 18:17:00 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 18:17:00 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 18:17:00 volumio systemd[1]: mpd.service: Consumed 15.943s CPU time. Jan 09 18:17:00 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 18:17:00 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 18:17:00 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 18:17:00 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jan 09 18:17:00 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 18:17:00 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 18:17:00 volumio sudo[21377]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 18:17:00 volumio sudo[21377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 18:17:00 volumio sudo[21377]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:00 volumio kernel: usb 1-1.4: new high-speed USB device number 4 using xhci_hcd Jan 09 18:17:01 volumio kernel: usb 1-1.4: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.23 Jan 09 18:17:01 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 09 18:17:01 volumio kernel: usb 1-1.4: Product: SMSL USB AUDIO Jan 09 18:17:01 volumio kernel: usb 1-1.4: Manufacturer: SMSL Jan 09 18:17:01 volumio kernel: hid-generic 0003:152A:85DD.0002: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.4/input3 Jan 09 18:17:01 volumio (udev-worker)[21266]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99. Jan 09 18:17:01 volumio volumio[1193]: info: Jan 09 18:17:01 volumio volumio[1193]: ---------------------------- USB Audio Device Attached Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::Close All Modals sent Jan 09 18:17:01 volumio volumio[1193]: info: Preparing to save Alsa Options, stopping services first Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:17:01 volumio volumio[1193]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:01 volumio volumio[1193]: info: Device 5 does not have any Mixer Control Available Jan 09 18:17:01 volumio sudo[21398]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:01 volumio sudo[21398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 18:17:01 volumio volumio[1193]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 18:17:01 volumio volumio[1193]: info: Disabling external Volume Control Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 18:17:01 volumio volumio[1193]: info: CoreStateMachine::pushState Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::volumioPushState Jan 09 18:17:01 volumio volumio[1193]: info: Preparing to generate the ALSA configuration file Jan 09 18:17:01 volumio kernel: usb 1-1.4: USB disconnect, device number 4 Jan 09 18:17:01 volumio volumio[1193]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.J9l7yp8uk9fScBiAkIzc7AC7I343.dd9ee2991e47d15ce6c44d6791b51f62.state.status' Jan 09 18:17:01 volumio sudo[21398]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:01 volumio sudo[21403]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:01 volumio sudo[21403]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio sudo[21403]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:01 volumio volumio[1193]: Invalid card number '5'. Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 18:17:01 volumio volumio[1193]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:17:01 volumio volumio[1193]: info: Output device has changed, restarting MPD Jan 09 18:17:01 volumio volumio[1193]: info: Output device has changed, restarting Shairport Sync Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:01 volumio sudo[21416]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:17:01 volumio sudo[21416]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio sudo[21416]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:01 volumio sudo[21418]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:17:01 volumio sudo[21418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio volumio[1193]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:17:01 volumio volumio[1193]: info: MPD Permissions set Jan 09 18:17:01 volumio kernel: usb 1-1.4: new high-speed USB device number 5 using xhci_hcd Jan 09 18:17:01 volumio volumio[1193]: info: Jan 09 18:17:01 volumio volumio[1193]: ---------------------------- USB Audio Device Detached Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:01 volumio sudo[21428]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:01 volumio sudo[21428]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 18:17:01 volumio sudo[21427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:01 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 18:17:01 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 18:17:01 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 18:17:01 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 18:17:01 volumio sudo[21427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:01 volumio volumio[1193]: info: Starting Shairport Sync Jan 09 18:17:01 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 18:17:01 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 18:17:01 volumio sudo[21441]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:17:01 volumio sudo[21441]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio kernel: usb 1-1.4: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.23 Jan 09 18:17:01 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 09 18:17:01 volumio kernel: usb 1-1.4: Product: SMSL USB AUDIO Jan 09 18:17:01 volumio kernel: usb 1-1.4: Manufacturer: SMSL Jan 09 18:17:01 volumio kernel: hid-generic 0003:152A:85DD.0003: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.4/input3 Jan 09 18:17:01 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 18:17:01 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 18:17:01 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:01 volumio systemd[1]: shairport-sync.service: Consumed 1.145s CPU time. Jan 09 18:17:01 volumio (udev-worker)[21266]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99. Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jan 09 18:17:01 volumio volumio[1193]: info: Jan 09 18:17:01 volumio volumio[1193]: ---------------------------- USB Audio Device Attached Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::Close All Modals sent Jan 09 18:17:01 volumio volumio[1193]: info: Preparing to save Alsa Options, stopping services first Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:17:01 volumio volumio[1193]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:01 volumio sudo[21428]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:01 volumio sudo[21442]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 18:17:01 volumio sudo[21442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 18:17:01 volumio sudo[21442]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:01 volumio sudo[21427]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:01 volumio volumio[1193]: info: Device 5 does not have any Mixer Control Available Jan 09 18:17:01 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:01 volumio sudo[21441]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 18:17:01 volumio volumio[1193]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 18:17:01 volumio volumio[1193]: info: Disabling external Volume Control Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 18:17:01 volumio sudo[21471]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:01 volumio sudo[21471]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:01 volumio volumio[1193]: info: CoreStateMachine::pushState Jan 09 18:17:01 volumio volumio[1193]: info: CoreCommandRouter::volumioPushState Jan 09 18:17:01 volumio volumio[1193]: info: Preparing to generate the ALSA configuration file Jan 09 18:17:01 volumio volumio[1193]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.J9l7yp8uk9fScBiAkIzc7AC7I343.dd9ee2991e47d15ce6c44d6791b51f62.state.status' Jan 09 18:17:02 volumio volumio[1193]: info: Shairport-Sync Started Jan 09 18:17:02 volumio sudo[21471]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:02 volumio sudo[21489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:02 volumio sudo[21489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:02 volumio sudo[21489]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 18:17:02 volumio volumio[1193]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:17:02 volumio volumio[1193]: info: Output device has changed, restarting MPD Jan 09 18:17:02 volumio volumio[1193]: info: Output device has changed, restarting Shairport Sync Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:02 volumio sudo[21501]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:17:02 volumio sudo[21501]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:02 volumio sudo[21501]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:02 volumio volumio[1193]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:17:02 volumio sudo[21507]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:17:02 volumio sudo[21507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:02 volumio volumio[1193]: info: MPD Permissions set Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio sudo[21513]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:02 volumio sudo[21513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:02 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 18:17:02 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 18:17:02 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 18:17:02 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 18:17:02 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:02 volumio volumio[1193]: info: Starting Shairport Sync Jan 09 18:17:02 volumio sudo[21514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:02 volumio sudo[21514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:02 volumio sudo[21524]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:17:02 volumio sudo[21524]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:02 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 18:17:02 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 18:17:02 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 18:17:02 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 18:17:02 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:02 volumio kernel: usb 1-1.4: USB disconnect, device number 5 Jan 09 18:17:02 volumio sudo[21513]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:02 volumio sudo[21514]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:02 volumio sudo[21526]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 18:17:02 volumio sudo[21526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 18:17:02 volumio sudo[21526]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jan 09 18:17:02 volumio volumio[1193]: info: Jan 09 18:17:02 volumio volumio[1193]: ---------------------------- USB Audio Device Detached Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:02 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jan 09 18:17:02 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:02 volumio sudo[21524]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:02 volumio volumio[1193]: info: Shairport-Sync Started Jan 09 18:17:02 volumio kernel: usb 1-1.4: new high-speed USB device number 6 using xhci_hcd Jan 09 18:17:03 volumio kernel: usb 1-1.4: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.23 Jan 09 18:17:03 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 09 18:17:03 volumio kernel: usb 1-1.4: Product: SMSL USB AUDIO Jan 09 18:17:03 volumio kernel: usb 1-1.4: Manufacturer: SMSL Jan 09 18:17:03 volumio kernel: hid-generic 0003:152A:85DD.0004: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.4/input3 Jan 09 18:17:03 volumio (udev-worker)[21268]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99. Jan 09 18:17:03 volumio volumio[1193]: info: TidalConnect service stoped! Jan 09 18:17:03 volumio volumio[1193]: info: Jan 09 18:17:03 volumio volumio[1193]: ---------------------------- USB Audio Device Attached Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::Close All Modals sent Jan 09 18:17:03 volumio volumio[1193]: info: Preparing to save Alsa Options, stopping services first Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::volumioGetState Jan 09 18:17:03 volumio volumio[1193]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SMSL USB AUDIO","alsacard":"AUDIO"},"i2s":false} Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:03 volumio volumio[1193]: info: Device 5 does not have any Mixer Control Available Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 18:17:03 volumio volumio[1193]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 18:17:03 volumio volumio[1193]: info: Disabling external Volume Control Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 18:17:03 volumio sudo[21571]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:03 volumio sudo[21571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio volumio[1193]: info: CoreStateMachine::pushState Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::volumioPushState Jan 09 18:17:03 volumio volumio[1193]: info: Preparing to generate the ALSA configuration file Jan 09 18:17:03 volumio volumio[1193]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.J9l7yp8uk9fScBiAkIzc7AC7I343.dd9ee2991e47d15ce6c44d6791b51f62.state.status' Jan 09 18:17:03 volumio volumio[1193]: info: TidalConnect service stoped! Jan 09 18:17:03 volumio sudo[21571]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:03 volumio sudo[21575]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:03 volumio sudo[21575]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio volumio[1193]: info: TidalConnect service stoped! Jan 09 18:17:03 volumio volumio[1193]: info: TidalConnect service stoped! Jan 09 18:17:03 volumio sudo[21575]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 18:17:03 volumio volumio[1193]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:17:03 volumio volumio[1193]: info: Output device has changed, restarting MPD Jan 09 18:17:03 volumio sudo[21598]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:17:03 volumio sudo[21598]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio sudo[21598]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:03 volumio volumio[1193]: info: Output device has changed, restarting Shairport Sync Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:03 volumio sudo[21601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:17:03 volumio sudo[21601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio volumio[1193]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:17:03 volumio volumio[1193]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:17:03 volumio volumio[1193]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:17:03 volumio volumio[1193]: info: MPD Permissions set Jan 09 18:17:03 volumio sudo[21608]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:03 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 18:17:03 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 18:17:03 volumio systemd[1]: mpd.service: Consumed 1.289s CPU time. Jan 09 18:17:03 volumio sudo[21610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:17:03 volumio sudo[21610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 18:17:03 volumio sudo[21608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 18:17:03 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio sudo[21620]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:17:03 volumio sudo[21620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:17:03 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 18:17:03 volumio volumio[1193]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:17:03 volumio volumio[1193]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:17:03 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 18:17:03 volumio volumio[1193]: info: Starting Shairport Sync Jan 09 18:17:03 volumio sudo[21628]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:17:03 volumio sudo[21628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio volumio[1193]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jan 09 18:17:03 volumio sudo[21633]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:17:03 volumio sudo[21633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 18:17:03 volumio sudo[21610]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:03 volumio volumio[1193]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jan 09 18:17:03 volumio volumio[1193]: Job for vtcs.service canceled. Jan 09 18:17:03 volumio volumio[1193]: {"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":""} Jan 09 18:17:03 volumio sudo[21608]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:03 volumio volumio[1193]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 18:17:03 volumio volumio[1193]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jan 09 18:17:03 volumio volumio[1193]: Job for vtcs.service canceled. Jan 09 18:17:03 volumio volumio[1193]: at ChildProcess.exithandler (node:child_process:421:12) Jan 09 18:17:03 volumio volumio[1193]: at ChildProcess.emit (node:events:514:28) Jan 09 18:17:03 volumio volumio[1193]: at maybeClose (node:internal/child_process:1105:16) Jan 09 18:17:03 volumio volumio[1193]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) { Jan 09 18:17:03 volumio volumio[1193]: code: 1, Jan 09 18:17:03 volumio volumio[1193]: killed: false, Jan 09 18:17:03 volumio volumio[1193]: signal: null, Jan 09 18:17:03 volumio volumio[1193]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Jan 09 18:17:03 volumio volumio[1193]: stdout: '', Jan 09 18:17:03 volumio volumio[1193]: stderr: 'Job for vtcs.service canceled.\n' Jan 09 18:17:03 volumio volumio[1193]: } Jan 09 18:17:03 volumio volumio[1193]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 18:17:03 volumio sudo[21626]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 18:17:03 volumio sudo[21626]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 18:17:03 volumio sudo[21626]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:03 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 09 18:17:03 volumio sudo[21633]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:03 volumio sudo[21620]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:04 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 18:17:04 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 18:17:04 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:04 volumio systemd[1]: shairport-sync.service: Consumed 1.471s CPU time. Jan 09 18:17:04 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 18:17:04 volumio sudo[21628]: pam_unix(sudo:session): session closed for user root Jan 09 18:17:04 volumio sudo[21682]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 18:16' Jan 09 18:17:04 volumio sudo[21682]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"