Jan 09 16:40:04 volumio volumio[1215]: info: [jellyfin-poller] Polled https://jellyfin.grewe-stierbach.de: offline Jan 09 16:40:34 volumio volumio[1215]: info: [jellyfin-poller] Polled https://jellyfin.grewe-stierbach.de: offline Jan 09 16:41:04 volumio volumio[1215]: info: [jellyfin-poller] Polled https://jellyfin.grewe-stierbach.de: offline Jan 09 16:41:34 volumio volumio[1215]: info: [jellyfin-poller] Polled https://jellyfin.grewe-stierbach.de: offline Jan 09 16:41:39 volumio kernel: usb 1-1.2: new high-speed USB device number 5 using dwc_otg Jan 09 16:41:39 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=889b, bcdDevice= 1.08 Jan 09 16:41:39 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 09 16:41:39 volumio kernel: usb 1-1.2: Product: Fosi Audio ZD3 Jan 09 16:41:39 volumio kernel: usb 1-1.2: Manufacturer: XMOS Jan 09 16:41:39 volumio kernel: input: XMOS Fosi Audio ZD3 as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.3/0003:152A:889B.0002/input/input1 Jan 09 16:41:39 volumio kernel: input: XMOS Fosi Audio ZD3 Consumer Control as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.3/0003:152A:889B.0002/input/input2 Jan 09 16:41:39 volumio kernel: hid-generic 0003:152A:889B.0002: input,hiddev96,hidraw0: USB HID v1.10 Device [XMOS Fosi Audio ZD3] on usb-3f980000.usb-1.2/input3 Jan 09 16:41:39 volumio (udev-worker)[24020]: 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 16:41:39 volumio volumio[1215]: info: Jan 09 16:41:39 volumio volumio[1215]: ---------------------------- USB Audio Device Attached Jan 09 16:41:39 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jan 09 16:41:39 volumio volumio[1215]: info: CoreCommandRouter::Close All Modals sent Jan 09 16:41:39 volumio volumio[1215]: info: Preparing to save Alsa Options, stopping services first Jan 09 16:41:39 volumio volumio[1215]: info: CoreCommandRouter::volumioGetState Jan 09 16:41:39 volumio volumio[1215]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Fosi Audio ZD3","alsacard":"ZD3"},"i2s":false} Jan 09 16:41:39 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 16:41:39 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 16:41:39 volumio volumio[1215]: info: Device 5 does not have any Mixer Control Available Jan 09 16:41:39 volumio vtcs[1850]: [2026-01-09 16:41:39.994] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 09 16:41:39 volumio vtcs[1850]: [2026-01-09 16:41:39.994] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 09 16:41:40 volumio sudo[24045]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:40 volumio sudo[24045]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 16:41:40 volumio volumio[1215]: info: Updating Volume Controller Parameters: Device: 5 Name: Fosi Audio ZD3 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 16:41:40 volumio volumio[1215]: info: Disabling external Volume Control Jan 09 16:41:40 volumio kernel: usb 1-1.2: USB disconnect, device number 5 Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 16:41:40 volumio volumio[1215]: info: CoreStateMachine::pushState Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::volumioPushState Jan 09 16:41:40 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 09 16:41:40 volumio systemd[1]: vtcs.service: Killing process 1871 (vtcs) with signal SIGKILL. Jan 09 16:41:40 volumio systemd[1]: vtcs.service: Deactivated successfully. Jan 09 16:41:40 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 09 16:41:40 volumio systemd[1]: vtcs.service: Consumed 31.488s CPU time. Jan 09 16:41:40 volumio volumio[1215]: info: Preparing to generate the ALSA configuration file Jan 09 16:41:40 volumio sudo[24045]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio volumio[1215]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 16:41:40 volumio volumio[1215]: info: Reading ALSA contributions from plugins. Jan 09 16:41:40 volumio sudo[24053]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:40 volumio sudo[24053]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio volumio[1215]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 16:41:40 volumio sudo[24053]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio volumio[1215]: Invalid card number '5'. Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 16:41:40 volumio volumio[1215]: info: Asound.conf file written Jan 09 16:41:40 volumio sudo[24070]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 09 16:41:40 volumio sudo[24070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio sudo[24070]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio volumio[1215]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 16:41:40 volumio volumio[1215]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 16:41:40 volumio volumio[1215]: info: Output device has changed, restarting MPD Jan 09 16:41:40 volumio volumio[1215]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio sudo[24076]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 16:41:40 volumio sudo[24076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio sudo[24076]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio sudo[24078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 16:41:40 volumio sudo[24078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio volumio[1215]: info: Output device has changed, restarting MPD Jan 09 16:41:40 volumio volumio[1215]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio sudo[24084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:40 volumio sudo[24084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 09 16:41:40 volumio sudo[24088]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 16:41:40 volumio sudo[24086]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 16:41:40 volumio sudo[24086]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio sudo[24088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio sudo[24086]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio sudo[24095]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:40 volumio sudo[24095]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jan 09 16:41:40 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 16:41:40 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 16:41:40 volumio systemd[1]: mpd.service: Consumed 4.771s CPU time. Jan 09 16:41:40 volumio sudo[24100]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:40 volumio sudo[24100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio volumio[1215]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 16:41:40 volumio sudo[24098]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:40 volumio volumio[1215]: info: MPD Permissions set Jan 09 16:41:40 volumio sudo[24098]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio sudo[24084]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio volumio[1215]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 16:41:40 volumio volumio[1215]: info: MPD Permissions set Jan 09 16:41:40 volumio volumio[1215]: info: Jan 09 16:41:40 volumio volumio[1215]: ---------------------------- USB Audio Device Detached Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 16:41:40 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 16:41:40 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio volumio[1215]: info: Preparing to generate the ALSA configuration file Jan 09 16:41:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 16:41:40 volumio volumio[1215]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 16:41:40 volumio volumio[1215]: info: Reading ALSA contributions from plugins. Jan 09 16:41:40 volumio volumio[1215]: info: Asound.conf file unchanged, so no further update is needed Jan 09 16:41:40 volumio volumio[1215]: info: Output device has changed, restarting MPD Jan 09 16:41:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 16:41:40 volumio volumio[1215]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 16:41:40 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:40 volumio sudo[24122]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 16:41:40 volumio sudo[24122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio sudo[24122]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio sudo[24095]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio sudo[24124]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 16:41:40 volumio sudo[24124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio volumio[1215]: info: Preparing to generate the ALSA configuration file Jan 09 16:41:40 volumio sudo[24131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:40 volumio sudo[24131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:40 volumio sudo[24098]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:40 volumio sudo[24100]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:41 volumio volumio[1215]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 16:41:41 volumio volumio[1215]: info: Reading ALSA contributions from plugins. Jan 09 16:41:41 volumio volumio[1215]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 16:41:41 volumio volumio[1215]: info: MPD Permissions set Jan 09 16:41:41 volumio sudo[24136]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:41 volumio sudo[24136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio sudo[24120]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 16:41:41 volumio sudo[24120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 16:41:41 volumio sudo[24120]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: Asound.conf file unchanged, so no further update is needed Jan 09 16:41:41 volumio volumio[1215]: info: Output device has changed, restarting MPD Jan 09 16:41:41 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 16:41:41 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 16:41:41 volumio volumio[1215]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio sudo[24145]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 16:41:41 volumio sudo[24145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:41 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 16:41:41 volumio sudo[24145]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:41 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 16:41:41 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 16:41:41 volumio sudo[24131]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:41 volumio sudo[24147]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 16:41:41 volumio sudo[24147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:41 volumio sudo[24155]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:41 volumio sudo[24155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:41 volumio volumio[1215]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 16:41:41 volumio volumio[1215]: info: MPD Permissions set Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio sudo[24157]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:41 volumio sudo[24157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 16:41:41 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:41 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 16:41:41 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 16:41:41 volumio sudo[24136]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:41 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 16:41:41 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 16:41:41 volumio sudo[24155]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:41 volumio sudo[24157]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:41 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 16:41:41 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 16:41:41 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 16:41:41 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 16:41:41 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 16:41:41 volumio sudo[24170]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 16:41:41 volumio sudo[24170]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 16:41:41 volumio sudo[24170]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:42 volumio kernel: usb 1-1.2: new high-speed USB device number 6 using dwc_otg Jan 09 16:41:42 volumio kernel: usb 1-1.2: New USB device found, idVendor=152a, idProduct=889b, bcdDevice= 1.08 Jan 09 16:41:42 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 09 16:41:42 volumio kernel: usb 1-1.2: Product: Fosi Audio ZD3 Jan 09 16:41:42 volumio kernel: usb 1-1.2: Manufacturer: XMOS Jan 09 16:41:42 volumio kernel: input: XMOS Fosi Audio ZD3 as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.3/0003:152A:889B.0003/input/input3 Jan 09 16:41:42 volumio kernel: input: XMOS Fosi Audio ZD3 Consumer Control as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.3/0003:152A:889B.0003/input/input4 Jan 09 16:41:42 volumio kernel: hid-generic 0003:152A:889B.0003: input,hiddev96,hidraw0: USB HID v1.10 Device [XMOS Fosi Audio ZD3] on usb-3f980000.usb-1.2/input3 Jan 09 16:41:42 volumio (udev-worker)[24020]: 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 16:41:42 volumio volumio[1215]: info: Jan 09 16:41:42 volumio volumio[1215]: ---------------------------- USB Audio Device Attached Jan 09 16:41:42 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jan 09 16:41:42 volumio volumio[1215]: info: CoreCommandRouter::Close All Modals sent Jan 09 16:41:42 volumio volumio[1215]: info: Preparing to save Alsa Options, stopping services first Jan 09 16:41:42 volumio volumio[1215]: info: CoreCommandRouter::volumioGetState Jan 09 16:41:42 volumio volumio[1215]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Fosi Audio ZD3","alsacard":"ZD3"},"i2s":false} Jan 09 16:41:42 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 16:41:43 volumio volumio[1215]: info: Device 5 does not have any Mixer Control Available Jan 09 16:41:43 volumio sudo[24193]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:43 volumio sudo[24193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 09 16:41:43 volumio volumio[1215]: info: Updating Volume Controller Parameters: Device: 5 Name: Fosi Audio ZD3 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 09 16:41:43 volumio volumio[1215]: info: Disabling external Volume Control Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 16:41:43 volumio volumio[1215]: info: CoreStateMachine::pushState Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::volumioPushState Jan 09 16:41:43 volumio volumio[1215]: info: Preparing to generate the ALSA configuration file Jan 09 16:41:43 volumio volumio[1215]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.szcGF4zVgwWesmTHCZatv6BfGDg1.8093ce9dc81dcf5ca6d8cbb1eee8ed58.state.status' Jan 09 16:41:43 volumio volumio[1215]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 16:41:43 volumio volumio[1215]: info: Reading ALSA contributions from plugins. Jan 09 16:41:43 volumio volumio[1215]: info: TidalConnect service stoped! Jan 09 16:41:43 volumio sudo[24193]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio sudo[24199]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:43 volumio sudo[24199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 16:41:43 volumio volumio[1215]: info: TidalConnect service stoped! Jan 09 16:41:43 volumio volumio[1215]: info: Asound.conf file unchanged, so no further update is needed Jan 09 16:41:43 volumio volumio[1215]: info: Output device has changed, restarting MPD Jan 09 16:41:43 volumio sudo[24199]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio volumio[1215]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio sudo[24215]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 16:41:43 volumio sudo[24215]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio sudo[24216]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 16:41:43 volumio sudo[24215]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio sudo[24216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio sudo[24222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:43 volumio sudo[24222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio volumio[1215]: info: MPD Permissions set Jan 09 16:41:43 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 16:41:43 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 16:41:43 volumio systemd[1]: mpd.service: Consumed 1.669s CPU time. Jan 09 16:41:43 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 16:41:43 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 16:41:43 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio sudo[24225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:43 volumio sudo[24225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio volumio[1215]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 16:41:43 volumio volumio[1215]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 16:41:43 volumio volumio[1215]: info: Preparing to generate the ALSA configuration file Jan 09 16:41:43 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 16:41:43 volumio sudo[24238]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 16:41:43 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jan 09 16:41:43 volumio sudo[24238]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio volumio[1215]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 16:41:43 volumio volumio[1215]: info: Reading ALSA contributions from plugins. Jan 09 16:41:43 volumio volumio[1215]: info: Asound.conf file unchanged, so no further update is needed Jan 09 16:41:43 volumio volumio[1215]: info: Output device has changed, restarting MPD Jan 09 16:41:43 volumio volumio[1215]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 09 16:41:43 volumio volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 16:41:43 volumio sudo[24243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 16:41:43 volumio sudo[24243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio sudo[24243]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio sudo[24245]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 16:41:43 volumio sudo[24245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio sudo[24225]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio volumio[1215]: info: MPD Permissions set Jan 09 16:41:43 volumio volumio[1215]: info: TidalConnect service stoped! Jan 09 16:41:43 volumio sudo[24222]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio sudo[24250]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:43 volumio volumio[1215]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jan 09 16:41:43 volumio volumio[1215]: Job for vtcs.service canceled. Jan 09 16:41:43 volumio volumio[1215]: {"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":""} Jan 09 16:41:43 volumio sudo[24250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio sudo[24253]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 16:41:43 volumio volumio[1215]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 16:41:43 volumio sudo[24253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 16:41:43 volumio volumio[1215]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jan 09 16:41:43 volumio volumio[1215]: Job for vtcs.service canceled. Jan 09 16:41:43 volumio volumio[1215]: at ChildProcess.exithandler (node:child_process:421:12) Jan 09 16:41:43 volumio volumio[1215]: at ChildProcess.emit (node:events:514:28) Jan 09 16:41:43 volumio volumio[1215]: at maybeClose (node:internal/child_process:1105:16) Jan 09 16:41:43 volumio volumio[1215]: at Socket. (node:internal/child_process:457:11) Jan 09 16:41:43 volumio volumio[1215]: at Socket.emit (node:events:514:28) Jan 09 16:41:43 volumio volumio[1215]: at Pipe. (node:net:337:12) { Jan 09 16:41:43 volumio volumio[1215]: code: 1, Jan 09 16:41:43 volumio volumio[1215]: killed: false, Jan 09 16:41:43 volumio volumio[1215]: signal: null, Jan 09 16:41:43 volumio volumio[1215]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Jan 09 16:41:43 volumio volumio[1215]: stdout: '', Jan 09 16:41:43 volumio volumio[1215]: stderr: 'Job for vtcs.service canceled.\n' Jan 09 16:41:43 volumio volumio[1215]: } Jan 09 16:41:43 volumio volumio[1215]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 16:41:43 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 09 16:41:43 volumio sudo[24238]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio sudo[24240]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 16:41:43 volumio sudo[24240]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 16:41:43 volumio sudo[24240]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:43 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 09 16:41:43 volumio systemd[1]: vtcs.service: Deactivated successfully. Jan 09 16:41:43 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 09 16:41:43 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 09 16:41:43 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 16:41:44 volumio sudo[24253]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:44 volumio sudo[24250]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:44 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 09 16:41:44 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 16:41:44 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 16:41:44 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 16:41:44 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 16:41:44 volumio sudo[24277]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 16:41:44 volumio sudo[24277]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 16:41:44 volumio sudo[24277]: pam_unix(sudo:session): session closed for user root Jan 09 16:41:44 volumio sudo[24282]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 16:40' Jan 09 16:41:44 volumio sudo[24282]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"