May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] DAB scan complete, parsing results... May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] Extracted JSON from position 0 May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] No DAB ensembles found May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] Found 0 DAB services May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] Merging DAB scan results with existing database May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] DAB merge complete: 0 scanned, 0 total, 0 reappeared May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] Saved stations database May 31 23:08:03 studio4 volumio[1236]: info: [RTL-SDR Radio] Device state: scanning_dab -> idle May 31 23:08:28 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:08:30 studio4 volumio[1236]: info: Executing endpoint metavolumio May 31 23:08:30 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 31 23:08:30 studio4 volumio[1236]: info: Executing endpoint metavolumio May 31 23:08:30 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 31 23:08:30 studio4 volumio[1236]: info: Executing endpoint metavolumio May 31 23:08:30 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 31 23:08:35 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 23:08:35 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 31 23:08:42 studio4 volumio[1236]: info: Starting Uninstall of plugin music_service - rtlsdr_radio May 31 23:08:42 studio4 volumio[1236]: info: Uninstalling plugin rtlsdr_radio May 31 23:08:42 studio4 volumio[1236]: info: [RTL-SDR Radio] onStop - force terminating all processes May 31 23:08:42 studio4 sudo[3937]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/pkill -9 -f fn-rtl_fm May 31 23:08:42 studio4 sudo[3937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 volumio[1236]: info: [RTL-SDR Radio] onStop - processes terminated May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesFM/DAB Radio May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 23:08:42 studio4 volumio[1236]: Cannot find translation for source Loopback May 31 23:08:42 studio4 volumio[1236]: info: [RTL-SDR Radio] Management server stopped May 31 23:08:42 studio4 volumio[1236]: info: [RTL-SDR Radio] Plugin stopped May 31 23:08:42 studio4 volumio5-onboarding[1855]: time=2026-05-31T23:08:42.444+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 23:08:42 studio4 volumio[1236]: info: Disabling plugin rtlsdr_radio May 31 23:08:42 studio4 volumio[1236]: info: Preparing to generate the ALSA configuration file May 31 23:08:42 studio4 volumio[1236]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 31 23:08:42 studio4 volumio[1236]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 31 23:08:42 studio4 volumio[1236]: info: Reading ALSA contributions from plugins. May 31 23:08:42 studio4 volumio[1236]: info: Asound.conf file unchanged, so no further update is needed May 31 23:08:42 studio4 volumio[1236]: info: Output device has changed, restarting MPD May 31 23:08:42 studio4 volumio[1236]: info: Output device has changed, restarting Shairport Sync May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 23:08:42 studio4 sudo[3940]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 31 23:08:42 studio4 sudo[3940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 sudo[3940]: pam_unix(sudo:session): session closed for user root May 31 23:08:42 studio4 sudo[3942]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 31 23:08:42 studio4 sudo[3942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 volumio[1236]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 31 23:08:42 studio4 volumio[1236]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: QobuzConnect: setDeactiveState invoked May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:08:42 studio4 vtcs[2170]: [2026-05-31 23:08:42.518] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected May 31 23:08:42 studio4 vtcs[2170]: [2026-05-31 23:08:42.519] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE May 31 23:08:42 studio4 volumio5-onboarding[1855]: time=2026-05-31T23:08:42.536+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 23:08:42 studio4 volumio[1236]: info: Checking if uninstall.sh is present May 31 23:08:42 studio4 sudo[3952]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 31 23:08:42 studio4 sudo[3952]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 systemd[1]: Stopping mpd.service - Music Player Daemon... May 31 23:08:42 studio4 sudo[3955]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 31 23:08:42 studio4 sudo[3955]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 volumio[1236]: info: Executing uninstall.sh May 31 23:08:42 studio4 systemd[1]: mpd.service: Deactivated successfully. May 31 23:08:42 studio4 systemd[1]: Stopped mpd.service - Music Player Daemon. May 31 23:08:42 studio4 systemd[1]: mpd.service: Consumed 1.421s CPU time. May 31 23:08:42 studio4 volumio[1236]: info: MPD Permissions set May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 sudo[3964]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 31 23:08:42 studio4 sudo[3964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 systemd[1]: mpd.socket: Deactivated successfully. May 31 23:08:42 studio4 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 31 23:08:42 studio4 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: Starting Shairport Sync May 31 23:08:42 studio4 volumio[1236]: info: Preparing to generate the ALSA configuration file May 31 23:08:42 studio4 sudo[3966]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/rtlsdr_radio/uninstall.sh May 31 23:08:42 studio4 sudo[3966]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 31 23:08:42 studio4 systemd[1]: Starting mpd.service - Music Player Daemon... May 31 23:08:42 studio4 systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... May 31 23:08:42 studio4 systemd[1]: vtcs.service: Killing process 2191 (vtcs) with signal SIGKILL. May 31 23:08:42 studio4 systemd[1]: vtcs.service: Deactivated successfully. May 31 23:08:42 studio4 systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. May 31 23:08:42 studio4 sudo[3976]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 31 23:08:42 studio4 sudo[3976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 volumio[1236]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 31 23:08:42 studio4 volumio[1236]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 31 23:08:42 studio4 volumio[1236]: info: Reading ALSA contributions from plugins. May 31 23:08:42 studio4 volumio[1236]: info: Asound.conf file unchanged, so no further update is needed May 31 23:08:42 studio4 volumio[1236]: info: Output device has changed, restarting MPD May 31 23:08:42 studio4 sudo[3964]: pam_unix(sudo:session): session closed for user root May 31 23:08:42 studio4 sudo[3952]: pam_unix(sudo:session): session closed for user root May 31 23:08:42 studio4 volumio[1236]: info: Output device has changed, restarting Shairport Sync May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 23:08:42 studio4 sudo[3982]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 31 23:08:42 studio4 sudo[3982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 sudo[3955]: pam_unix(sudo:session): session closed for user root May 31 23:08:42 studio4 sudo[3983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 31 23:08:42 studio4 sudo[3983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 sudo[3982]: pam_unix(sudo:session): session closed for user root May 31 23:08:42 studio4 sudo[3985]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 31 23:08:42 studio4 sudo[3985]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 volumio[1236]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 31 23:08:42 studio4 volumio[1236]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 sudo[3979]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 31 23:08:42 studio4 sudo[3979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 23:08:42 studio4 sudo[3979]: pam_unix(sudo:session): session closed for user root May 31 23:08:42 studio4 volumio[1236]: info: QobuzConnect: setDeactiveState invoked May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:08:42 studio4 sudo[4001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 31 23:08:42 studio4 sudo[4001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 sudo[4003]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 31 23:08:42 studio4 sudo[4003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 volumio[1236]: info: MPD Permissions set May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 sudo[4012]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 31 23:08:42 studio4 sudo[4012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 23:08:42 studio4 volumio[1236]: info: Starting Shairport Sync May 31 23:08:42 studio4 qobuz-connect[2214]: 20260531 23:08:42.929 [2214.2214] INFO SampleApp: Stopping Local configuration server May 31 23:08:42 studio4 systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... May 31 23:08:42 studio4 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 31 23:08:42 studio4 qobuz-connect[2214]: 20260531 23:08:42.945 [2214.2214] INFO SampleApp: shat down connection on UNIX socket May 31 23:08:42 studio4 volumio[1236]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 31 23:08:42 studio4 volumio[1236]: info: QobuzConnect: setDeactiveState invoked May 31 23:08:42 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:08:42 studio4 systemd[1]: shairport-sync.service: Deactivated successfully. May 31 23:08:42 studio4 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 23:08:42 studio4 systemd[1]: shairport-sync.service: Consumed 3.667s CPU time. May 31 23:08:42 studio4 systemd[1]: qobuz-connect.service: Deactivated successfully. May 31 23:08:42 studio4 systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. May 31 23:08:42 studio4 sudo[4020]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 31 23:08:42 studio4 systemd[1]: mpd.service: Deactivated successfully. May 31 23:08:42 studio4 systemd[1]: Stopped mpd.service - Music Player Daemon. May 31 23:08:42 studio4 sudo[4020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:43 studio4 sudo[4001]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 sudo[4003]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 sudo[4012]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 systemd[1]: mpd.socket: Deactivated successfully. May 31 23:08:43 studio4 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 31 23:08:43 studio4 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 31 23:08:43 studio4 sudo[4024]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 31 23:08:43 studio4 sudo[4024]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:43 studio4 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 31 23:08:43 studio4 systemd[1]: Starting mpd.service - Music Player Daemon... May 31 23:08:43 studio4 systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. May 31 23:08:43 studio4 sudo[3983]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 23:08:43 studio4 sudo[3976]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 sudo[4020]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 volumio[1236]: info: Shairport-Sync Started May 31 23:08:43 studio4 volumio[1236]: info: Shairport-Sync Started May 31 23:08:43 studio4 systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... May 31 23:08:43 studio4 systemd[1]: qobuz-connect.service: Deactivated successfully. May 31 23:08:43 studio4 systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. May 31 23:08:43 studio4 systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. May 31 23:08:43 studio4 sudo[4024]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 volumio[1236]: info: Executing endpoint qc_getconfig May 31 23:08:43 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.234 [4035.4035] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.239 [4035.4035] INFO VolumeManager: [0x1841118]: Setting new playback volume: 75 May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.239 [4035.4035] INFO VolumeManager: [0x1841118]: Setting new mute state: 0 May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.239 [4035.4035] INFO AudioStreamManager: [0x1840e70]: Setting new audio download buffer size: 1048576 May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.239 [4035.4035] INFO QobuzConnect: [0x18419e0]: Client initialized! May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.239 [4035.4035] INFO SampleApp: Starting Avahi advertising, name: Studio4, service name: _qobuz-connect._tcp May 31 23:08:43 studio4 volumio[1236]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 31 23:08:43 studio4 volumio[1236]: info: QobuzConnect: QOBUZ Connect daemon connected May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.260 [4035.4035] INFO LocalConfigManager: [0x1840b98]: Starting Local Configuration server May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.260 [4035.4035] INFO SampleApp: Starting Local configuration server May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.261 [4035.4035] INFO SampleApp: Connected to UNIX socket client 0x182b818 May 31 23:08:43 studio4 sudo[4029]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 31 23:08:43 studio4 sudo[4029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 23:08:43 studio4 sudo[4029]: pam_unix(sudo:session): session closed for user root May 31 23:08:43 studio4 qobuz-connect[4035]: 20260531 23:08:43.385 [4035.4035] INFO SampleApp: Playback volume changed: 75 May 31 23:08:43 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:08:44 studio4 mpd[4062]: 2026-05-31T23:08:44 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 31 23:08:44 studio4 systemd[1]: Started mpd.service - Music Player Daemon. May 31 23:08:44 studio4 sudo[3942]: pam_unix(sudo:session): session closed for user root May 31 23:08:44 studio4 sudo[3985]: pam_unix(sudo:session): session closed for user root May 31 23:08:44 studio4 volumio[1236]: error: MPD error: The expression evaluated to a falsy value: May 31 23:08:44 studio4 volumio[1236]: assert.ok(self.idling) May 31 23:08:44 studio4 volumio[1236]: error: The expression evaluated to a falsy value: May 31 23:08:44 studio4 volumio[1236]: assert.ok(self.idling) May 31 23:08:44 studio4 volumio[1236]: error: updateQueue error: null May 31 23:08:45 studio4 volumio[1236]: info: TidalConnect service stoped! May 31 23:08:45 studio4 volumio[1236]: info: TidalConnect service stoped! May 31 23:08:45 studio4 volumio[1236]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 31 23:08:45 studio4 volumio[1236]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 31 23:08:45 studio4 sudo[4119]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 31 23:08:45 studio4 sudo[4119]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:45 studio4 systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. May 31 23:08:45 studio4 sudo[4119]: pam_unix(sudo:session): session closed for user root May 31 23:08:45 studio4 sudo[3966]: pam_unix(sudo:session): session closed for user root May 31 23:08:45 studio4 volumio[1236]: info: Uninstall script completed May 31 23:08:45 studio4 volumio5-onboarding[1855]: time=2026-05-31T23:08:45.987+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 23:08:45 studio4 volumio[1236]: info: Removing plugin rtlsdr_radio from configuration May 31 23:08:46 studio4 volumio[1236]: info: Successfully removed rtlsdr_radio configuration files May 31 23:08:46 studio4 volumio5-onboarding[1855]: time=2026-05-31T23:08:46.195+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 23:08:46 studio4 volumio[1236]: info: Plugin folders cleanup May 31 23:08:46 studio4 volumio[1236]: info: Scanning into folder /volumio/app/plugins/ May 31 23:08:46 studio4 volumio[1236]: info: Scanning category audio_interface May 31 23:08:46 studio4 volumio[1236]: info: Scanning category miscellanea May 31 23:08:46 studio4 volumio[1236]: info: Scanning category music_service May 31 23:08:46 studio4 volumio[1236]: info: Scanning category plugins.json May 31 23:08:46 studio4 volumio[1236]: info: Scanning category system_controller May 31 23:08:46 studio4 volumio[1236]: info: Scanning category user_interface May 31 23:08:46 studio4 volumio[1236]: info: Scanning into folder /data/plugins/ May 31 23:08:46 studio4 volumio[1236]: info: Scanning category music_service May 31 23:08:46 studio4 volumio[1236]: info: Cleaning folder for rtlsdr_radio May 31 23:08:46 studio4 systemd-logind[766]: Watching system buttons on /dev/input/event0 (vc4-hdmi-0) May 31 23:08:46 studio4 systemd-logind[766]: Watching system buttons on /dev/input/event2 (vc4-hdmi-1) May 31 23:08:47 studio4 volumio[1236]: info: Scanning category system_controller May 31 23:08:47 studio4 volumio[1236]: info: Plugin folders cleanup completed May 31 23:08:47 studio4 volumio5-onboarding[1855]: time=2026-05-31T23:08:47.064+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 23:08:47 studio4 volumio[1236]: info: [{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"4.1.1","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true}] May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 31 23:08:47 studio4 volumio[1236]: info: TidalConnect service stoped! May 31 23:08:47 studio4 volumio[1236]: info: TidalConnect service stoped! May 31 23:08:47 studio4 volumio[1236]: info: Executing endpoint tc_getconfig May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 31 23:08:47 studio4 vtcs[4122]: STARTING TidalConnect services, version: 1.6.1 May 31 23:08:47 studio4 vtcs[4122]: STARTED TidalConnect services. May 31 23:08:47 studio4 volumio[1236]: info: Executing endpoint tc_connect May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 31 23:08:47 studio4 volumio[1236]: info: Connecting to TidalConnect May 31 23:08:47 studio4 volumio[1236]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 31 23:08:47 studio4 volumio[1236]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::servicePushState May 31 23:08:47 studio4 volumio[1236]: info: CoreStateMachine::pushState May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::volumioPushState May 31 23:08:47 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output update for this device May 31 23:08:47 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:08:47 studio4 volumio[1236]: info: CorePlayQueue::getTrack 0 May 31 23:08:47 studio4 volumio[1236]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rtlsdr_radio Received tidalconnect May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::servicePushState May 31 23:08:47 studio4 volumio[1236]: info: CoreStateMachine::pushState May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::volumioPushState May 31 23:08:47 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output update for this device May 31 23:08:47 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output May 31 23:08:47 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:08:47 studio4 volumio[1236]: info: CorePlayQueue::getTrack 0 May 31 23:08:47 studio4 volumio[1236]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rtlsdr_radio Received tidalconnect May 31 23:08:47 studio4 sudo[4208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 31 23:08:47 studio4 sudo[4208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:08:47 studio4 sudo[4208]: pam_unix(sudo:session): session closed for user root May 31 23:08:48 studio4 volumio[1236]: info: TidalConnect service started! May 31 23:08:50 studio4 volumio[1236]: info: TidalConnect service started! May 31 23:09:00 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:09:02 studio4 volumio[1236]: info: Executing endpoint metavolumio May 31 23:09:02 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 31 23:09:02 studio4 volumio[1236]: info: Executing endpoint metavolumio May 31 23:09:02 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 31 23:09:02 studio4 volumio[1236]: info: Executing endpoint metavolumio May 31 23:09:02 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 31 23:09:19 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , handleBrowseUri May 31 23:09:19 studio4 volumio[1236]: info: Unsetting Volatile before setting PC Input May 31 23:09:19 studio4 volumio[1236]: info: CoreCommandRouter::volumioStop May 31 23:09:19 studio4 volumio[1236]: info: CoreStateMachine::stop May 31 23:09:19 studio4 volumio[1236]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 23:09:19 studio4 volumio[1236]: info: CoreStateMachine::updateTrackBlock May 31 23:09:19 studio4 volumio[1236]: info: CorePlayQueue::getTrackBlock May 31 23:09:19 studio4 volumio[1236]: info: CoreStateMachine::stPlaybackTimer May 31 23:09:19 studio4 volumio[1236]: info: CoreStateMachine::pushState May 31 23:09:19 studio4 volumio[1236]: info: CorePlayQueue::getTrack 0 May 31 23:09:19 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 23:09:19 studio4 volumio[1236]: info: CoreCommandRouter::volumioPushState May 31 23:09:19 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output update for this device May 31 23:09:19 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output May 31 23:09:19 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:09:19 studio4 volumio[1236]: info: CorePlayQueue::getTrack 0 May 31 23:09:19 studio4 volumio[1236]: info: CoreStateMachine::serviceStop May 31 23:09:19 studio4 volumio[1236]: info: CorePlayQueue::getTrack 0 May 31 23:09:19 studio4 volumio[1236]: info: CoreCommandRouter::serviceStop May 31 23:09:19 studio4 volumio[1236]: error: WARNING: No stop method for service rtlsdr_radio May 31 23:09:19 studio4 volumio[1236]: error: Failed to execute browseSource, failure: TypeError: Cannot read properties of undefined (reading 'then') May 31 23:09:19 studio4 volumio[1236]: info: Enabling Audio Input 4 May 31 23:09:19 studio4 sudo[4264]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart audioinput.service May 31 23:09:19 studio4 sudo[4264]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 23:09:19 studio4 systemd[1]: /lib/systemd/system/audioinput.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 31 23:09:19 studio4 systemd[1]: /lib/systemd/system/audioinput.service:11: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 31 23:09:20 studio4 systemd[1]: Started audioinput.service - Audio Input Service. May 31 23:09:20 studio4 sudo[4264]: pam_unix(sudo:session): session closed for user root May 31 23:09:20 studio4 volumio[1236]: info: Successfully Started Audio Input May 31 23:09:20 studio4 volumio[1236]: info: Notifying AUDIO INPUT May 31 23:09:20 studio4 volumio[1236]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 23:09:20 studio4 volumio[1236]: info: CoreCommandRouter::servicePushState May 31 23:09:20 studio4 volumio[1236]: info: CoreStateMachine::pushState May 31 23:09:20 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 23:09:20 studio4 volumio[1236]: info: CoreCommandRouter::volumioPushState May 31 23:09:20 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output update for this device May 31 23:09:20 studio4 volumio[1236]: info: MRS: Pushing multiroomSync output May 31 23:09:20 studio4 volumio[1236]: info: CoreCommandRouter::volumioGetState May 31 23:09:20 studio4 volumio[1236]: info: CoreCommandRouter::volumiosetSourceActiveaudio_input/4 May 31 23:09:20 studio4 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 23:09:20 studio4 volumio[1236]: Cannot find translation for source Loopback May 31 23:09:20 studio4 audioinput[4267]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for 4 May 31 23:09:20 studio4 audioinput[4267]: /usr/bin/sox FAIL formats: can't open input `plughw:4,0': snd_pcm_open error: No such file or directory May 31 23:09:20 studio4 systemd[1]: audioinput.service: Main process exited, code=exited, status=2/INVALIDARGUMENT May 31 23:09:20 studio4 systemd[1]: audioinput.service: Failed with result 'exit-code'. May 31 23:09:20 studio4 volumio[1236]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 23:09:20 studio4 volumio[1236]: ReferenceError: elf is not defined May 31 23:09:20 studio4 volumio[1236]: at SmartInputs.detectInputResolution (/myvolumio/plugins/music_service/smart_inputs/smart_inputs_real:1:9592) May 31 23:09:20 studio4 volumio[1236]: at Timeout._onTimeout (/myvolumio/plugins/music_service/smart_inputs/smart_inputs_real:1:8382) May 31 23:09:20 studio4 volumio[1236]: at listOnTimeout (node:internal/timers:573:17) May 31 23:09:20 studio4 volumio[1236]: at process.processTimers (node:internal/timers:514:7) May 31 23:09:20 studio4 volumio[1236]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 23:09:20 studio4 sudo[4282]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-31 23:08' May 31 23:09:20 studio4 sudo[4282]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"