Aug 28 19:10:32 volumio kernel: usb 1-4: USB disconnect, device number 18 Aug 28 19:10:32 volumio volumio[1270]: info: Aug 28 19:10:32 volumio volumio[1270]: ---------------------------- USB Audio Device Detached Aug 28 19:10:32 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Aug 28 19:10:32 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 19:10:32 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Aug 28 19:10:33 volumio kernel: usb 1-4: new high-speed USB device number 19 using xhci_hcd Aug 28 19:10:33 volumio kernel: usb 1-4: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.09 Aug 28 19:10:33 volumio kernel: usb 1-4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Aug 28 19:10:33 volumio kernel: usb 1-4: Product: E50 Aug 28 19:10:33 volumio kernel: usb 1-4: Manufacturer: Topping Aug 28 19:10:33 volumio kernel: hid-generic 0003:152A:8750.0011: hiddev0,hidraw0: USB HID v1.10 Device [Topping E50] on usb-0000:00:14.0-4/input3 Aug 28 19:10:33 volumio (udev-worker)[3898507]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99. Aug 28 19:10:34 volumio volumio[1270]: info: Aug 28 19:10:34 volumio volumio[1270]: ---------------------------- USB Audio Device Attached Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::Close All Modals sent Aug 28 19:10:34 volumio volumio[1270]: info: Preparing to save Alsa Options, stopping services first Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Aug 28 19:10:34 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::volumioPause Aug 28 19:10:34 volumio volumio[1270]: info: CoreStateMachine::pause Aug 28 19:10:34 volumio volumio[1270]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"E50","alsacard":"E50"},"i2s":false} Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 19:10:34 volumio volumio[1270]: info: Device 5 does not have any Mixer Control Available Aug 28 19:10:34 volumio vtcs[3440455]: [2026-08-28 19:10:34.044] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Aug 28 19:10:34 volumio vtcs[3440455]: [2026-08-28 19:10:34.044] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 28 19:10:34 volumio volumio[1270]: info: Updating Volume Controller Parameters: Device: 5 Name: E50 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 28 19:10:34 volumio volumio[1270]: info: Disabling external Volume Control Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 19:10:34 volumio sudo[3898538]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 19:10:34 volumio sudo[3898538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 19:10:34 volumio volumio[1270]: info: CoreStateMachine::pushState Aug 28 19:10:34 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Aug 28 19:10:34 volumio volumio[1270]: info: MRS: Pushing multiroomSync output update for this device Aug 28 19:10:34 volumio volumio[1270]: info: MRS: Pushing multiroomSync output Aug 28 19:10:34 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 28 19:10:34 volumio systemd[1]: vtcs.service: Deactivated successfully. Aug 28 19:10:34 volumio volumio[1270]: info: Preparing to generate the ALSA configuration file Aug 28 19:10:34 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 28 19:10:34 volumio systemd[1]: vtcs.service: Consumed 1min 20.845s CPU time. Aug 28 19:10:34 volumio sudo[3898538]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:34 volumio volumio[1270]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 28 19:10:34 volumio volumio[1270]: info: Reading ALSA contributions from plugins. Aug 28 19:10:34 volumio sudo[3898545]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 19:10:34 volumio sudo[3898545]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 19:10:34 volumio sudo[3898545]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 28 19:10:34 volumio volumio[1270]: info: Asound.conf file unchanged, so no further update is needed Aug 28 19:10:34 volumio volumio[1270]: info: Output device has changed, restarting MPD Aug 28 19:10:34 volumio volumio[1270]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio sudo[3898555]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 19:10:34 volumio sudo[3898555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 19:10:34 volumio sudo[3898557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 19:10:34 volumio sudo[3898557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 19:10:34 volumio sudo[3898555]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:34 volumio sudo[3898563]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 19:10:34 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 28 19:10:34 volumio sudo[3898563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 19:10:34 volumio sudo[3898565]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 19:10:34 volumio sudo[3898565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 19:10:34 volumio volumio[1270]: info: MPD Permissions set Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 19:10:34 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 19:10:34 volumio systemd[1]: mpd.service: Consumed 1.903s CPU time. Aug 28 19:10:34 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 19:10:34 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 19:10:34 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 19:10:34 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 19:10:34 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 19:10:34 volumio sudo[3898565]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:34 volumio sudo[3898563]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:34 volumio sudo[3898577]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 19:10:34 volumio sudo[3898577]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 19:10:34 volumio sudo[3898577]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:34 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Aug 28 19:10:34 volumio mpd[3898581]: 2026-08-28T19:10:34 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 28 19:10:34 volumio systemd[1]: Started mpd.service - Music Player Daemon. Aug 28 19:10:34 volumio sudo[3898557]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:34 volumio volumio[1270]: error: updateQueue error: null Aug 28 19:10:37 volumio volumio[1270]: info: TidalConnect service stoped! Aug 28 19:10:37 volumio volumio[1270]: info: TidalConnect service stoped! Aug 28 19:10:37 volumio volumio[1270]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 28 19:10:37 volumio volumio[1270]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 28 19:10:37 volumio sudo[3898610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 28 19:10:37 volumio sudo[3898610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 19:10:37 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 28 19:10:37 volumio sudo[3898610]: pam_unix(sudo:session): session closed for user root Aug 28 19:10:37 volumio volumio[1270]: info: Executing endpoint tc_getconfig Aug 28 19:10:37 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 28 19:10:37 volumio vtcs[3898613]: STARTING TidalConnect services, version: 1.6.1 Aug 28 19:10:37 volumio volumio[1270]: info: TidalConnect service stoped! Aug 28 19:10:37 volumio vtcs[3898613]: STARTED TidalConnect services. Aug 28 19:10:37 volumio volumio[1270]: info: TidalConnect service stoped! Aug 28 19:10:37 volumio volumio[1270]: info: Executing endpoint tc_connect Aug 28 19:10:37 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 28 19:10:37 volumio volumio[1270]: info: Connecting to TidalConnect Aug 28 19:10:37 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Aug 28 19:10:37 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 28 19:10:37 volumio volumio[1270]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Naked Sunday (Demo)","artist":"Stone Temple Pilots","album":"Core (Super Deluxe Edition)","albumart":"https://resources.tidal.com/images/b55ace28/1c7f/4f6f/a79b/860ea719209f/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":222,"samplerate":"96 KHz","bitdepth":"24 bit","bitrate":4608000,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Aug 28 19:10:37 volumio volumio[1270]: verbose: CURRENT POSITION 0 Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::syncState stateService pause Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::syncState currentStatus pause Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::pushState Aug 28 19:10:37 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 28 19:10:37 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Aug 28 19:10:37 volumio volumio[1270]: info: MRS: Pushing multiroomSync output update for this device Aug 28 19:10:37 volumio volumio[1270]: info: MRS: Pushing multiroomSync output Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::stPlaybackTimer Aug 28 19:10:37 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Aug 28 19:10:37 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 28 19:10:37 volumio volumio[1270]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Naked Sunday (Demo)","artist":"Stone Temple Pilots","album":"Core (Super Deluxe Edition)","albumart":"https://resources.tidal.com/images/b55ace28/1c7f/4f6f/a79b/860ea719209f/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":222,"samplerate":"96 KHz","bitdepth":"24 bit","bitrate":4608000,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Aug 28 19:10:37 volumio volumio[1270]: verbose: CURRENT POSITION 0 Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::syncState stateService pause Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::syncState currentStatus pause Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::pushState Aug 28 19:10:37 volumio volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 28 19:10:37 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Aug 28 19:10:37 volumio volumio[1270]: info: MRS: Pushing multiroomSync output update for this device Aug 28 19:10:37 volumio volumio[1270]: info: MRS: Pushing multiroomSync output Aug 28 19:10:37 volumio volumio[1270]: info: CoreStateMachine::stPlaybackTimer Aug 28 19:10:37 volumio volumio[1270]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 28 19:10:37 volumio volumio[1270]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 28 19:10:37 volumio volumio[1270]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 19:10:37 volumio volumio[1270]: Error: ENOENT: no such file or directory, unlink '/tmp/2YHkdiJOa967wMfmBL1PEj2uVhcbcsB2fp79qtLQNEgTzTiF78PTc5mwFxAPiqN3sdv9IUj0X0OMkCT6aaazWOcOkKwpGZCQud4Y' Aug 28 19:10:37 volumio volumio[1270]: at Object.unlinkSync (node:fs:1899:3) Aug 28 19:10:37 volumio volumio[1270]: at ControllerTidalconnect.deleteCertificate (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:11265) Aug 28 19:10:37 volumio volumio[1270]: at TidalConnectClient. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:2774) Aug 28 19:10:37 volumio volumio[1270]: at TidalConnectClient.emit (node:events:514:28) Aug 28 19:10:37 volumio volumio[1270]: at TidalConnectClient.parseData (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:44713) Aug 28 19:10:37 volumio volumio[1270]: at /myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41683 Aug 28 19:10:37 volumio volumio[1270]: at Array.forEach () Aug 28 19:10:37 volumio volumio[1270]: at Socket. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41561) Aug 28 19:10:37 volumio volumio[1270]: at Socket.emit (node:events:514:28) Aug 28 19:10:37 volumio volumio[1270]: at addChunk (node:internal/streams/readable:343:12) { Aug 28 19:10:37 volumio volumio[1270]: errno: -2, Aug 28 19:10:37 volumio volumio[1270]: syscall: 'unlink', Aug 28 19:10:37 volumio volumio[1270]: code: 'ENOENT', Aug 28 19:10:37 volumio volumio[1270]: path: '/tmp/2YHkdiJOa967wMfmBL1PEj2uVhcbcsB2fp79qtLQNEgTzTiF78PTc5mwFxAPiqN3sdv9IUj0X0OMkCT6aaazWOcOkKwpGZCQud4Y' Aug 28 19:10:37 volumio volumio[1270]: } Aug 28 19:10:37 volumio volumio[1270]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 19:10:37 volumio sudo[3898651]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 19:09' Aug 28 19:10:37 volumio sudo[3898651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"