Oct 12 12:05:02 workshop volumio[1206]: warn: [cd-plugin] cdspeedctl: device or media not ready Oct 12 12:05:02 workshop volumio[1206]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Oct 12 12:05:02 workshop volumio[1206]: info: Adding inputs REST Endpoints Oct 12 12:05:02 workshop volumio[1206]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Oct 12 12:05:02 workshop volumio[1206]: info: Scanning Audio Inputs Oct 12 12:05:03 workshop volumio[1206]: info: Checking against Known Cards name Oct 12 12:05:03 workshop volumio[1206]: info: Adding Server instance for streaming Oct 12 12:05:03 workshop volumio[1206]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Oct 12 12:05:03 workshop volumio[1206]: error: Hi Res Audio Failed Login: Missing Login Data Oct 12 12:05:03 workshop volumio[1206]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 12 12:05:03 workshop volumio[1206]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 12 12:05:03 workshop volumio[1206]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Oct 12 12:05:03 workshop volumio[1206]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Oct 12 12:05:03 workshop volumio[1206]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Oct 12 12:05:03 workshop volumio[1206]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Oct 12 12:05:03 workshop volumio[1206]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Oct 12 12:05:03 workshop sudo[2234]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:05:03 workshop volumio[1206]: info: QobuzConnect: Starting Qobuz Connect socket and service Oct 12 12:05:03 workshop sudo[2234]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:03 workshop sudo[2240]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 12 12:05:03 workshop sudo[2240]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:03 workshop volumio[1206]: info: Adding TIDAL REST API Endpoints Oct 12 12:05:03 workshop volumio[1206]: info: Stopping AccessToken refresher cron for QOBUZ Oct 12 12:05:03 workshop sudo[2234]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:03 workshop sudo[2240]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:03 workshop sudo[2244]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 12 12:05:03 workshop sudo[2244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:03 workshop volumio[1206]: info: AccessToken refresher cron started for QOBUZ Oct 12 12:05:03 workshop volumio[1206]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Oct 12 12:05:03 workshop volumio[1206]: info: Adding QOBUZ REST API Endpoints Oct 12 12:05:03 workshop volumio[1206]: info: MRS: Getting audio outputs on start Oct 12 12:05:03 workshop volumio[1206]: info: MRS: Requesting all other devices output Oct 12 12:05:03 workshop systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 12 12:05:03 workshop sudo[2244]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:03 workshop volumio[1206]: info: MRS: Adding multiroomSync output Oct 12 12:05:03 workshop volumio[1206]: info: Adding audio output: Oct 12 12:05:03 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:05:03 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:03 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:04 workshop volumio[1206]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Oct 12 12:05:04 workshop volumio[1206]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Oct 12 12:05:04 workshop volumio[1206]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Oct 12 12:05:04 workshop volumio[1206]: info: MPD Permissions set Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:04 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:04 workshop sudo[2256]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Oct 12 12:05:04 workshop sudo[2256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:04 workshop systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Oct 12 12:05:04 workshop sudo[2256]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:04 workshop volumiobt[2260]: INFO [BTSTART] Ensuring Bluetooth directory exists... Oct 12 12:05:04 workshop sudo[2261]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Oct 12 12:05:04 workshop sudo[2261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:04 workshop sudo[2261]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:04 workshop sudo[2263]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Oct 12 12:05:04 workshop sudo[2263]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:04 workshop sudo[2263]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:04 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:04 workshop volumio[1206]: info: camilladsp respawn in 6400 ms (attempt 7/10) Oct 12 12:05:04 workshop volumiobt[2265]: INFO [BTSTART] Powering on Bluetooth if needed... Oct 12 12:05:04 workshop bluetoothd[751]: Adv Monitor app :1.24 disconnected from D-Bus Oct 12 12:05:04 workshop volumiobt[2268]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Oct 12 12:05:04 workshop volumio[1206]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Oct 12 12:05:04 workshop volumiobt[2269]: [176B blob data] Oct 12 12:05:04 workshop volumiobt[2269]: [157B blob data] Oct 12 12:05:04 workshop volumiobt[2269]: [157B blob data] Oct 12 12:05:04 workshop volumiobt[2269]: [157B blob data] Oct 12 12:05:04 workshop volumiobt[2269]: [113B blob data] Oct 12 12:05:04 workshop volumiobt[2269]: [bluetoothctl]> discoverable on Oct 12 12:05:04 workshop volumiobt[2269]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Oct 12 12:05:04 workshop volumiobt[2269]: [bluetoothctl]> pairable on Oct 12 12:05:04 workshop bluetoothd[751]: Path / reserved for Adv Monitor app :1.25 Oct 12 12:05:04 workshop bluetoothd[751]: Adv Monitor app :1.25 disconnected from D-Bus Oct 12 12:05:04 workshop volumiobt[2269]: [bluetoothctl]> Oct 12 12:05:04 workshop volumiobt[2270]: INFO [BTSTART] Registering Bluetooth agent... Oct 12 12:05:04 workshop volumio[1206]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Oct 12 12:05:04 workshop volumiobt[2271]: [NEW] Media /org/bluez/hci0 Oct 12 12:05:04 workshop volumiobt[2271]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Oct 12 12:05:04 workshop volumiobt[2271]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Oct 12 12:05:04 workshop volumiobt[2271]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop bluetoothd[751]: Adv Monitor app :1.26 disconnected from D-Bus Oct 12 12:05:04 workshop volumiobt[2273]: No agent is registered Oct 12 12:05:04 workshop volumiobt[2273]: [NEW] Media /org/bluez/hci0 Oct 12 12:05:04 workshop volumiobt[2273]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Oct 12 12:05:04 workshop volumiobt[2273]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Oct 12 12:05:04 workshop volumiobt[2273]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Oct 12 12:05:04 workshop bluetoothd[751]: Adv Monitor app :1.27 disconnected from D-Bus Oct 12 12:05:04 workshop volumiobt[2274]: INFO [BTSTART] Agent registered successfully. Oct 12 12:05:04 workshop volumiobt[2275]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:05:04 workshop volumio[1206]: error: updateQueue error: null Oct 12 12:05:05 workshop volumio[1206]: info: Starting Shairport Sync Oct 12 12:05:05 workshop sudo[2284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 12:05:05 workshop sudo[2284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:05 workshop systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 12:05:05 workshop systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 12:05:05 workshop systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:05:05 workshop systemd[1]: shairport-sync.service: Consumed 1.559s CPU time. Oct 12 12:05:05 workshop systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:05:05 workshop sudo[2284]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:05 workshop volumio[1206]: info: Executing endpoint qc_getconfig Oct 12 12:05:05 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.095 [2246.2246] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.252 [2246.2246] INFO VolumeManager: [0xd22378]: Setting new playback volume: 75 Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.252 [2246.2246] INFO VolumeManager: [0xd22378]: Setting new mute state: 0 Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.252 [2246.2246] INFO AudioStreamManager: [0xd220d0]: Setting new audio download buffer size: 1048576 Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.252 [2246.2246] INFO QobuzConnect: [0xd22c40]: Client initialized! Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.252 [2246.2246] INFO SampleApp: Starting Avahi advertising, name: workshop, service name: _qobuz-connect._tcp Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.269 [2246.2246] INFO LocalConfigManager: [0xd21df8]: Starting Local Configuration server Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.270 [2246.2246] INFO SampleApp: Starting Local configuration server Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.270 [2246.2246] INFO SampleApp: Connected to UNIX socket client 0xd0c908 Oct 12 12:05:06 workshop qobuz-connect[2246]: 20261012 12:05:06.270 [2246.2246] INFO SampleApp: Playback volume changed: 75 Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] Connecting to system D-Bus Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] Connected to system D-Bus Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 bluezutils [INFO] Found adapter at: /org/bluez/hci0 Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] Found Bluetooth adapter: /org/bluez/hci0 Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] Set DiscoverableTimeout to infinite Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] Enabled Discoverable mode Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] Agent registered at /local/a2dpagent Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] Agent set as default Oct 12 12:05:06 workshop volumiobt[2276]: 2026-10-12 12:05:06 a2dp-agent [INFO] A2DP agent running, waiting for connections... Oct 12 12:05:06 workshop volumio[1206]: info: Shairport-Sync Started Oct 12 12:05:06 workshop volumio[1206]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 12 12:05:06 workshop volumio[1206]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 12 12:05:06 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:06 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 12:05:06 workshop volumio[1206]: info: MRS: Found cast device: Google-Cast-Group-2D44795C152042DEAE12789CEF686B48 Oct 12 12:05:06 workshop volumio[1206]: info: Adding audio output: Oct 12 12:05:06 workshop volumio[1206]: info: MRS: Found cast device: Chromecast-Audio-0e13fe150a4150045ff7fa3e0493fe8d Oct 12 12:05:06 workshop volumio[1206]: info: Adding audio output: Oct 12 12:05:06 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:06 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:06 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:05:06 workshop volumio[1206]: info: MRS: Found cast device: Chromecast-Audio-5b025e9c458067c4cc141fe8c3ca082b Oct 12 12:05:06 workshop volumio[1206]: info: Adding audio output: Oct 12 12:05:07 workshop volumio[1206]: info: MRS: Found cast device: NAD-Amplifier-C338-b65d003f325e38fc4c5517faf3d7d97b Oct 12 12:05:07 workshop volumio[1206]: info: Adding audio output: Oct 12 12:05:07 workshop volumio[1206]: info: MRS: Found cast device: Google-Cast-Group-2D44795C152042DEAE12789CEF686B48-1 Oct 12 12:05:07 workshop volumio[1206]: info: Adding audio output: Oct 12 12:05:07 workshop volumio[1206]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:05:07 workshop volumio[1206]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:05:07 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 12:05:07 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 12:05:07 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Oct 12 12:05:08 workshop sudo[2335]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 12 12:05:08 workshop sudo[2335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:08 workshop systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Oct 12 12:05:08 workshop sudo[2335]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:08 workshop volumio[1206]: info: Executing endpoint tc_getconfig Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 12 12:05:08 workshop vtcs[2338]: STARTING TidalConnect services, version: 1.6.1 Oct 12 12:05:08 workshop vtcs[2338]: STARTED TidalConnect services. Oct 12 12:05:08 workshop volumio[1206]: info: Executing endpoint tc_connect Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 12 12:05:08 workshop volumio[1206]: info: Connecting to TidalConnect Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::servicePushState Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 12 12:05:08 workshop volumio[1206]: verbose: CURRENT POSITION 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::syncState stateService stop Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::syncState currentStatus stop Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: No code Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::servicePushState Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 12 12:05:08 workshop volumio[1206]: verbose: CURRENT POSITION 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::syncState stateService stop Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::syncState currentStatus stop Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: No code Oct 12 12:05:08 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:05:08 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:05:08 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:08 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:09 workshop volumio[1206]: info: FusionDsp - Volumio is not playing Oct 12 12:05:09 workshop volumio[1206]: info: FusionDsp - Clipped samples monitor stopped Oct 12 12:05:11 workshop volumio[1206]: info: camilladsp respawn in 10000 ms (attempt 8/10) Oct 12 12:05:11 workshop volumio[1206]: info: TidalConnect service started! Oct 12 12:05:13 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Oct 12 12:05:13 workshop volumio[1206]: info: CoreCommandRouter::Reload Ui Oct 12 12:05:15 workshop sudo[2389]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 12:05:15 workshop sudo[2389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:15 workshop sudo[2390]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 12:05:15 workshop sudo[2390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:15 workshop sudo[2389]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:15 workshop sudo[2390]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:15 workshop volumio[1206]: verbose: New Socket.io Connection to 192.168.4.50 from 192.168.4.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 27_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) CriOS/155.0.8059.37 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 8 Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Oct 12 12:05:16 workshop volumio[1206]: info: Received Get System Info Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 12:05:16 workshop volumio[1206]: info: Discovery: Getting this device information Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:16 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 12:05:16 workshop volumio-remote-updater[725]: Test mode enabled Oct 12 12:05:16 workshop volumio-remote-updater[725]: Alpha mode disabled Oct 12 12:05:16 workshop volumio-remote-updater[725]: Alpha legacy test mode disabled Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:16 workshop volumio[1206]: info: Retrieving Cloud Streaming UI Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 12:05:16 workshop volumio[1206]: info: Getting Tidal Cloud Configuration Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:16 workshop volumio[1206]: info: Getting Qobuz Cloud Configuration Oct 12 12:05:16 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:16 workshop volumio[1206]: info: Getting Spotify Cloud Configuration Oct 12 12:05:16 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:16 workshop volumio[1206]: info: Saving Spotify Acccount Oct 12 12:05:16 workshop volumio[1206]: info: Got it Oct 12 12:05:16 workshop volumio[1206]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 12:05:16 workshop volumio[1206]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 12:05:16 workshop volumio[1206]: info: Got it Oct 12 12:05:16 workshop volumio[1206]: info: Got Tidal Cloud Configuration Oct 12 12:05:16 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:17 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 12 12:05:17 workshop volumio[1206]: info: Loading i18n strings for locale en Oct 12 12:05:17 workshop volumio[1206]: info: Plugin fusiondsp has duplicated i18n key SAVE. It is ignored. Oct 12 12:05:17 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 12 12:05:17 workshop volumio[1206]: info: Setting timezone to America/New_York Oct 12 12:05:17 workshop sudo[2407]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 12 12:05:17 workshop sudo[2407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:17 workshop sudo[2407]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:17 workshop sudo[2411]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Oct 12 12:05:17 workshop sudo[2411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:17 workshop sudo[2411]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:17 workshop sudo[2415]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 12 12:05:18 workshop sudo[2415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:18 workshop sudo[2415]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:18 workshop sudo[2419]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Oct 12 12:05:18 workshop sudo[2419]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:18 workshop dbus-daemon[711]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.38' (uid=0 pid=2420 comm="/usr/bin/timedatectl set-timezone America/New_York") Oct 12 12:05:18 workshop systemd[1]: Starting systemd-timedated.service - Time & Date Service... Oct 12 12:05:18 workshop dbus-daemon[711]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 12 12:05:18 workshop systemd[1]: Started systemd-timedated.service - Time & Date Service. Oct 12 12:05:18 workshop sudo[2419]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:18 workshop volumio[1206]: info: Fetching Streaming Services browse cache Oct 12 12:05:18 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 12:05:18 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 12 12:05:18 workshop volumio[1206]: info: Loading i18n strings for locale en Oct 12 12:05:18 workshop volumio[1206]: info: Plugin fusiondsp has duplicated i18n key SAVE. It is ignored. Oct 12 12:05:18 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 12 12:05:18 workshop volumio[1206]: info: Setting timezone to America/New_York Oct 12 12:05:18 workshop sudo[2425]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 12 12:05:18 workshop sudo[2425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:18 workshop sudo[2425]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:19 workshop sudo[2441]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Oct 12 12:05:19 workshop sudo[2441]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:19 workshop sudo[2441]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:19 workshop sudo[2446]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 12 12:05:19 workshop sudo[2446]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:19 workshop sudo[2446]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:19 workshop sudo[2450]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Oct 12 12:05:19 workshop sudo[2450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:19 workshop sudo[2450]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:19 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 12 12:05:19 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 12 12:05:19 workshop volumio[1206]: info: Fetching Streaming Services browse cache Oct 12 12:05:19 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 12:05:19 workshop sudo[2453]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 12 12:05:19 workshop sudo[2453]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:20 workshop volumio[1206]: Updating browse sources language Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source YouTube Music Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source Radio Browser Oct 12 12:05:20 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source YouTube Music Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source Radio Browser Oct 12 12:05:20 workshop volumio[1206]: Updating browse sources language Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source YouTube Music Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source Radio Browser Oct 12 12:05:20 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source YouTube Music Oct 12 12:05:20 workshop volumio[1206]: Cannot find translation for source Radio Browser Oct 12 12:05:21 workshop sudo[2458]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 12:05:21 workshop sudo[2458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:21 workshop sudo[2460]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 12:05:21 workshop sudo[2460]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:21 workshop sudo[2458]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:21 workshop sudo[2460]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:21 workshop volumio[1206]: verbose: New Socket.io Connection to 192.168.4.50 from 192.168.4.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 27_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) CriOS/155.0.8059.37 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 9 Oct 12 12:05:21 workshop volumio[1206]: info: camilladsp respawn in 10000 ms (attempt 9/10) Oct 12 12:05:21 workshop sudo[2474]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 12:05:21 workshop sudo[2474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:21 workshop sudo[2472]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 12:05:21 workshop sudo[2472]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:21 workshop sudo[2474]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 12:05:21 workshop sudo[2472]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:21 workshop volumio[1206]: verbose: New Socket.io Connection to 192.168.4.50 from 192.168.4.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 27_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) CriOS/155.0.8059.37 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 9 Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Oct 12 12:05:21 workshop volumio[1206]: info: Received Get System Info Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 12:05:21 workshop volumio[1206]: info: Discovery: Getting this device information Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:21 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 12:05:21 workshop volumio-remote-updater[725]: Test mode enabled Oct 12 12:05:21 workshop volumio-remote-updater[725]: Alpha mode disabled Oct 12 12:05:21 workshop volumio-remote-updater[725]: Alpha legacy test mode disabled Oct 12 12:05:21 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:22 workshop volumio[1206]: info: Retrieving Cloud Streaming UI Oct 12 12:05:22 workshop volumio[1206]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 12:05:22 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 12:05:22 workshop volumio[1206]: info: Getting Tidal Cloud Configuration Oct 12 12:05:22 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:22 workshop volumio[1206]: info: Getting Qobuz Cloud Configuration Oct 12 12:05:22 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:05:22 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:22 workshop volumio[1206]: info: Getting Spotify Cloud Configuration Oct 12 12:05:22 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:05:22 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:22 workshop volumio[1206]: info: Saving Spotify Acccount Oct 12 12:05:22 workshop volumio[1206]: info: Got it Oct 12 12:05:22 workshop volumio[1206]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 12:05:22 workshop volumio[1206]: info: Got Tidal Cloud Configuration Oct 12 12:05:22 workshop volumio[1206]: info: Got it Oct 12 12:05:22 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:05:22 workshop sudo[2453]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:23 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 12:05:23 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 12 12:05:23 workshop volumio[1206]: info: Loading i18n strings for locale en Oct 12 12:05:23 workshop volumio[1206]: info: Plugin fusiondsp has duplicated i18n key SAVE. It is ignored. Oct 12 12:05:23 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 12 12:05:23 workshop volumio[1206]: info: Setting timezone to America/New_York Oct 12 12:05:23 workshop sudo[2484]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 12 12:05:23 workshop sudo[2484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:23 workshop sudo[2484]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:23 workshop sudo[2488]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Oct 12 12:05:23 workshop sudo[2488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:23 workshop sudo[2488]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:23 workshop sudo[2492]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 12 12:05:23 workshop sudo[2492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:23 workshop sudo[2492]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:23 workshop sudo[2496]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Oct 12 12:05:23 workshop sudo[2496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:05:24 workshop sudo[2496]: pam_unix(sudo:session): session closed for user root Oct 12 12:05:24 workshop volumio[1206]: info: Fetching Streaming Services browse cache Oct 12 12:05:24 workshop volumio[1206]: info: Received Get System Info Oct 12 12:05:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 12:05:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 12:05:24 workshop volumio[1206]: info: Discovery: Getting this device information Oct 12 12:05:24 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:24 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 12:05:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 12:05:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 12:05:24 workshop volumio[1206]: Updating browse sources language Oct 12 12:05:24 workshop volumio[1206]: Cannot find translation for source YouTube Music Oct 12 12:05:24 workshop volumio[1206]: Cannot find translation for source Radio Browser Oct 12 12:05:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 12:05:24 workshop volumio[1206]: Cannot find translation for source YouTube Music Oct 12 12:05:24 workshop volumio[1206]: Cannot find translation for source Radio Browser Oct 12 12:05:24 workshop volumio5-onboarding[1646]: time=2026-10-12T12:05:24.918-04:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 12:05:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 12 12:05:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Oct 12 12:05:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 12 12:05:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:05:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:05:31 workshop volumio[1206]: info: camilladsp respawn in 10000 ms (attempt 10/10) Oct 12 12:05:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 12:05:34 workshop volumio[1206]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 12 12:05:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 12 12:05:34 workshop volumio[1206]: info: Received Get System Version Oct 12 12:05:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 12:05:34 workshop volumio[1206]: info: Received Get System Info Oct 12 12:05:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 12:05:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 12:05:34 workshop volumio[1206]: info: Discovery: Getting this device information Oct 12 12:05:34 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:05:34 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:05:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 12:05:41 workshop volumio[1206]: error: camilladsp exceeded max consecutive respawns (10); stopping respawn. Plugin restart required. Oct 12 12:05:48 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 12 12:05:48 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 12:05:48 workshop volumio-remote-updater[725]: Test mode enabled Oct 12 12:05:48 workshop volumio-remote-updater[725]: Alpha mode disabled Oct 12 12:05:48 workshop volumio-remote-updater[725]: Alpha legacy test mode disabled Oct 12 12:05:48 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 12 12:05:48 workshop volumio[1206]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 12:05:48 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 12:05:49 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 12 12:05:49 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 12:05:49 workshop volumio-remote-updater[725]: Test mode enabled Oct 12 12:05:49 workshop volumio-remote-updater[725]: Alpha mode disabled Oct 12 12:05:49 workshop volumio-remote-updater[725]: Alpha legacy test mode disabled Oct 12 12:05:49 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 12 12:05:49 workshop volumio[1206]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 12:05:49 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 12:05:54 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 12 12:05:54 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 12:05:54 workshop systemd[1]: systemd-timedated.service: Deactivated successfully. Oct 12 12:05:54 workshop volumio-remote-updater[725]: Test mode enabled Oct 12 12:05:54 workshop volumio-remote-updater[725]: Alpha mode disabled Oct 12 12:05:54 workshop volumio-remote-updater[725]: Alpha legacy test mode disabled Oct 12 12:05:54 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 12 12:05:54 workshop volumio[1206]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 12:05:54 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 12:06:22 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 12 12:06:22 workshop volumio[1206]: info: Preparing to save Alsa Options, stopping services first Oct 12 12:06:22 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:22 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:22 workshop volumio[1206]: info: CoreCommandRouter::volumioPause Oct 12 12:06:22 workshop volumio[1206]: info: CoreStateMachine::pause Oct 12 12:06:22 workshop volumio[1206]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"2","label":"HiFiBerry DAC+ Pro"},"disallowPush":true} Oct 12 12:06:22 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:06:22 workshop volumio[1206]: info: Disabling I2S DAC: Oct 12 12:06:22 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Oct 12 12:06:22 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:22 workshop volumio[1206]: warn: Unable to locate the device HiFiBerry DAC+ Pro a reboot may be required. Oct 12 12:06:22 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:06:22 workshop volumio[1206]: Invalid card number '2'. Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 12 12:06:23 workshop volumio[1206]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC+ Pro Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 12 12:06:23 workshop volumio[1206]: info: Disabling external Volume Control Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:23 workshop volumio[1206]: info: Preparing to generate the ALSA configuration file Oct 12 12:06:23 workshop volumio[1206]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 12 12:06:23 workshop volumio[1206]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 12 12:06:23 workshop volumio[1206]: info: Reading ALSA contributions from plugins. Oct 12 12:06:23 workshop volumio[1206]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Oct 12 12:06:23 workshop volumio[1206]: info: VolumeController:: Volume=undefined Mute =false Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:23 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:23 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:23 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:23 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:23 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:23 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:23 workshop sudo[2638]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Oct 12 12:06:23 workshop sudo[2638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:23 workshop sudo[2638]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:23 workshop volumio[1206]: info: No Overlays Loaded Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:23 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:06:24 workshop volumio[1206]: Invalid card number '2'. Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:06:24 workshop volumio[1206]: info: Asound.conf file written Oct 12 12:06:24 workshop sudo[2651]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 12:06:24 workshop sudo[2651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:24 workshop sudo[2651]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:24 workshop volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 12 12:06:24 workshop volumio[1206]: No state is present for card KA11 Oct 12 12:06:24 workshop volumio[1206]: Found hardware: "USB-Audio" "USB Mixer" "USB2972:0081" "" "" Oct 12 12:06:24 workshop volumio[1206]: Hardware is initialized using a generic method Oct 12 12:06:24 workshop volumio[1206]: No state is present for card KA11 Oct 12 12:06:24 workshop volumio[1206]: info: Output device has changed, restarting MPD Oct 12 12:06:24 workshop volumio[1206]: info: Output device has changed, restarting Shairport Sync Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:24 workshop sudo[2657]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 12:06:24 workshop sudo[2657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:24 workshop sudo[2657]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:24 workshop sudo[2659]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 12:06:24 workshop sudo[2659]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:24 workshop volumio[1206]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 12:06:24 workshop volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 12 12:06:24 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:24 workshop systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 12 12:06:25 workshop upmpdcli[1583]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0 Oct 12 12:06:25 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:25 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:25 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:25 workshop vtcs[2338]: [2026-10-12 12:06:25.073] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Oct 12 12:06:25 workshop systemd[1]: mpd.service: Deactivated successfully. Oct 12 12:06:25 workshop systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 12 12:06:25 workshop systemd[1]: mpd.service: Consumed 1.588s CPU time. Oct 12 12:06:25 workshop systemd[1]: mpd.socket: Deactivated successfully. Oct 12 12:06:25 workshop systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 12 12:06:25 workshop systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 12 12:06:25 workshop vtcs[2338]: [2026-10-12 12:06:25.086] [tisoc] [error] [SpkconServer.cpp:383] recv error. client fd=8 errorno=104 error=Connection reset by peer Oct 12 12:06:25 workshop vtcs[2338]: [2026-10-12 12:06:25.086] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Oct 12 12:06:25 workshop volumio[1206]: info: Output device has changed, restarting MPD Oct 12 12:06:25 workshop systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 12 12:06:25 workshop systemd[1]: Starting mpd.service - Music Player Daemon... Oct 12 12:06:25 workshop sudo[2670]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:25 workshop sudo[2670]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:25 workshop sudo[2673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 12:06:25 workshop sudo[2672]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 12:06:25 workshop sudo[2672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 12 12:06:25 workshop volumio[1206]: info: Output device has changed, restarting Shairport Sync Oct 12 12:06:25 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:25 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:25 workshop sudo[2672]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:25 workshop sudo[2673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:25 workshop sudo[2677]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 12:06:25 workshop sudo[2677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:25 workshop systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Oct 12 12:06:25 workshop systemd[1]: vtcs.service: Deactivated successfully. Oct 12 12:06:25 workshop systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Oct 12 12:06:25 workshop sudo[2673]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:25 workshop sudo[2670]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:25 workshop volumio[1206]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 12:06:25 workshop volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 12 12:06:25 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:25 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:25 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:25 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:25 workshop systemd[1]: mpd.service: Deactivated successfully. Oct 12 12:06:25 workshop systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 12 12:06:25 workshop systemd[1]: mpd.socket: Deactivated successfully. Oct 12 12:06:25 workshop systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 12 12:06:25 workshop systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 12 12:06:25 workshop systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 12 12:06:25 workshop systemd[1]: Starting mpd.service - Music Player Daemon... Oct 12 12:06:25 workshop sudo[2691]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:25 workshop sudo[2691]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:25 workshop sudo[2690]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 12:06:25 workshop sudo[2690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 12 12:06:25 workshop sudo[2690]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:25 workshop sudo[2693]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:25 workshop sudo[2693]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:25 workshop sudo[2697]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:25 workshop sudo[2697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:25 workshop sudo[2693]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:25 workshop sudo[2691]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:25 workshop sudo[2705]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 12 12:06:26 workshop sudo[2705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:26 workshop sudo[2697]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:26 workshop sudo[2705]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:26 workshop sudo[2717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 12 12:06:26 workshop sudo[2717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:26 workshop sudo[2715]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 12 12:06:26 workshop sudo[2715]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:26 workshop volumio[1206]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Oct 12 12:06:26 workshop systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 12 12:06:26 workshop qobuz-connect[2246]: 20261012 12:06:26.382 [2246.2246] INFO SampleApp: Stopping Local configuration server Oct 12 12:06:26 workshop volumio[1206]: info: MPD Permissions set Oct 12 12:06:26 workshop volumio[1206]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Oct 12 12:06:26 workshop sudo[2717]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:26 workshop volumio[1206]: info: MPD Permissions set Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:26 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:26 workshop sudo[2720]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 12 12:06:26 workshop sudo[2720]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:26 workshop volumio[1206]: info: Starting Shairport Sync Oct 12 12:06:27 workshop volumio[1206]: info: Starting Shairport Sync Oct 12 12:06:27 workshop mpd[2699]: 2026-10-12T12:06:27 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 12 12:06:27 workshop volumio[1206]: info: CoreStateMachine::getcurrentVolume Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 12:06:27 workshop sudo[2739]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 12:06:27 workshop volumio[1206]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Oct 12 12:06:27 workshop sudo[2739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:27 workshop sudo[2741]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 12:06:27 workshop sudo[2741]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:27 workshop volumio[1206]: info: VolumeController:: Volume=undefined Mute =false Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:27 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:27 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:27 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:27 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:27 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:27 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:27 workshop volumio[1206]: info: CoreStateMachine::updateTrackBlock Oct 12 12:06:27 workshop volumio[1206]: info: CorePlayQueue::getTrackBlock Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 12:06:27 workshop systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 12:06:27 workshop systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 12:06:27 workshop systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:06:27 workshop systemd[1]: shairport-sync.service: Consumed 1.542s CPU time. Oct 12 12:06:27 workshop upmpdcli[1583]: :3:../src/mpdcli.cxx:148::MPDCli::startEventLoop: already started Oct 12 12:06:27 workshop systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:06:27 workshop sudo[2739]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:27 workshop systemd[1]: Started mpd.service - Music Player Daemon. Oct 12 12:06:27 workshop sudo[2659]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:27 workshop sudo[2741]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:27 workshop sudo[2677]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:27 workshop volumio[1206]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Oct 12 12:06:27 workshop volumio[1206]: info: Shairport-Sync Started Oct 12 12:06:27 workshop volumio[1206]: info: VolumeController:: Volume=undefined Mute =false Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:27 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:27 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:27 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:27 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:27 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:27 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:27 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:28 workshop volumio[1206]: info: Shairport-Sync Started Oct 12 12:06:28 workshop volumio[1206]: error: MPD error: The expression evaluated to a falsy value: Oct 12 12:06:28 workshop volumio[1206]: assert.ok(self.idling) Oct 12 12:06:28 workshop volumio[1206]: error: The expression evaluated to a falsy value: Oct 12 12:06:28 workshop volumio[1206]: assert.ok(self.idling) Oct 12 12:06:28 workshop volumio[1206]: error: updateQueue error: null Oct 12 12:06:28 workshop qobuz-connect[2246]: 20261012 12:06:28.367 [2246.2246] INFO SampleApp: shat down connection on UNIX socket Oct 12 12:06:28 workshop volumio[1206]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 12 12:06:28 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:28 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:28 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:28 workshop systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 12 12:06:28 workshop systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 12 12:06:28 workshop sudo[2720]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:28 workshop systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 12 12:06:28 workshop sudo[2715]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:28 workshop volumio[1206]: info: Executing endpoint qc_getconfig Oct 12 12:06:28 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.653 [2765.2765] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 12 12:06:28 workshop volumio[1206]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 12 12:06:28 workshop volumio[1206]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 12 12:06:28 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.657 [2765.2765] INFO VolumeManager: [0xcc3378]: Setting new playback volume: 75 Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.657 [2765.2765] INFO VolumeManager: [0xcc3378]: Setting new mute state: 0 Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.657 [2765.2765] INFO AudioStreamManager: [0xcc30d0]: Setting new audio download buffer size: 1048576 Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.657 [2765.2765] INFO QobuzConnect: [0xcc3c40]: Client initialized! Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.657 [2765.2765] INFO SampleApp: Starting Avahi advertising, name: workshop, service name: _qobuz-connect._tcp Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.679 [2765.2765] INFO LocalConfigManager: [0xcc2df8]: Starting Local Configuration server Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.679 [2765.2765] INFO SampleApp: Starting Local configuration server Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.680 [2765.2765] INFO SampleApp: Connected to UNIX socket client 0xcad908 Oct 12 12:06:28 workshop qobuz-connect[2765]: 20261012 12:06:28.803 [2765.2765] INFO SampleApp: Playback volume changed: 75 Oct 12 12:06:28 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:28 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:28 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:29 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:29 workshop volumio[1206]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:29 workshop volumio[1206]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:29 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:29 workshop sudo[2784]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 12 12:06:29 workshop sudo[2784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:29 workshop volumio[1206]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:29 workshop volumio[1206]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:29 workshop systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Oct 12 12:06:29 workshop sudo[2784]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:29 workshop sudo[2793]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 12 12:06:29 workshop sudo[2793]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:29 workshop volumio[1206]: info: Executing endpoint tc_getconfig Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 12 12:06:29 workshop vtcs[2792]: STARTING TidalConnect services, version: 1.6.1 Oct 12 12:06:29 workshop sudo[2793]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:29 workshop vtcs[2792]: STARTED TidalConnect services. Oct 12 12:06:29 workshop volumio[1206]: info: Executing endpoint tc_connect Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 12 12:06:29 workshop volumio[1206]: info: Connecting to TidalConnect Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::servicePushState Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 12 12:06:29 workshop volumio[1206]: verbose: CURRENT POSITION 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::syncState stateService stop Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::syncState currentStatus stop Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: No code Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::servicePushState Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 12 12:06:29 workshop volumio[1206]: verbose: CURRENT POSITION 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::syncState stateService stop Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::syncState currentStatus stop Oct 12 12:06:29 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:29 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:29 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:29 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:30 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:30 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:30 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:30 workshop volumio[1206]: info: No code Oct 12 12:06:30 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:30 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:30 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:30 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:30 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:30 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:30 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:32 workshop volumio[1206]: info: TidalConnect service started! Oct 12 12:06:32 workshop volumio[1206]: info: TidalConnect service started! Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 12 12:06:33 workshop volumio[1206]: info: Preparing to save Alsa Options, stopping services first Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:33 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::volumioPause Oct 12 12:06:33 workshop volumio[1206]: info: CoreStateMachine::pause Oct 12 12:06:33 workshop volumio[1206]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"FIIO KA11"},"disallowPush":true} Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:06:33 workshop volumio[1206]: info: Setting mixer PCM for card FIIO KA11 Oct 12 12:06:33 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:33 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:33 workshop vtcs[2792]: [2026-10-12 12:06:33.433] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Oct 12 12:06:33 workshop vtcs[2792]: [2026-10-12 12:06:33.433] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 12 12:06:33 workshop volumio[1206]: info: Updating Volume Controller Parameters: Device: 5 Name: FIIO KA11 Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 12 12:06:33 workshop volumio[1206]: info: Disabling external Volume Control Oct 12 12:06:33 workshop volumio[1206]: info: VolumeController:: Starting alsactl monitor Oct 12 12:06:33 workshop sudo[2836]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:33 workshop sudo[2836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:33 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:33 workshop volumio[1206]: info: Retrieving Cloud Streaming UI Oct 12 12:06:33 workshop volumio[1206]: info: Preparing to generate the ALSA configuration file Oct 12 12:06:33 workshop systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Oct 12 12:06:33 workshop systemd[1]: vtcs.service: Killing process 2797 (vtcs) with signal SIGKILL. Oct 12 12:06:33 workshop systemd[1]: vtcs.service: Deactivated successfully. Oct 12 12:06:33 workshop systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Oct 12 12:06:33 workshop sudo[2843]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:33 workshop sudo[2843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:33 workshop sudo[2836]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:33 workshop volumio[1206]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 12 12:06:33 workshop volumio[1206]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 12 12:06:33 workshop volumio[1206]: info: Reading ALSA contributions from plugins. Oct 12 12:06:34 workshop sudo[2843]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:34 workshop sudo[2851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 12 12:06:34 workshop sudo[2851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:34 workshop volumio[1206]: info: VolumeController:: Volume=41 Mute =false Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:34 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:34 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:34 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:34 workshop sudo[2851]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:34 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:34 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:34 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:34 workshop sudo[2855]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 12 12:06:34 workshop sudo[2855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:34 workshop systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 12 12:06:34 workshop qobuz-connect[2765]: 20261012 12:06:34.220 [2765.2765] INFO SampleApp: Stopping Local configuration server Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 12 12:06:34 workshop volumio[1206]: info: Getting Tidal Cloud Configuration Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:34 workshop volumio[1206]: info: Getting Qobuz Cloud Configuration Oct 12 12:06:34 workshop qobuz-connect[2765]: 20261012 12:06:34.693 [2765.2765] INFO SampleApp: shat down connection on UNIX socket Oct 12 12:06:34 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:34 workshop systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 12 12:06:34 workshop systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 12 12:06:34 workshop volumio[1206]: info: Getting Spotify Cloud Configuration Oct 12 12:06:34 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:34 workshop volumio[1206]: info: Saving Spotify Acccount Oct 12 12:06:34 workshop volumio[1206]: info: Got it Oct 12 12:06:34 workshop volumio[1206]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 12:06:34 workshop volumio[1206]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 12 12:06:34 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:34 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:34 workshop systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 12 12:06:34 workshop sudo[2855]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:34 workshop volumio[1206]: info: Executing endpoint qc_getconfig Oct 12 12:06:34 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.940 [2863.2863] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.943 [2863.2863] INFO VolumeManager: [0x182c378]: Setting new playback volume: 75 Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.944 [2863.2863] INFO VolumeManager: [0x182c378]: Setting new mute state: 0 Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.944 [2863.2863] INFO AudioStreamManager: [0x182c0d0]: Setting new audio download buffer size: 1048576 Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.944 [2863.2863] INFO QobuzConnect: [0x182cc40]: Client initialized! Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.944 [2863.2863] INFO SampleApp: Starting Avahi advertising, name: workshop, service name: _qobuz-connect._tcp Oct 12 12:06:34 workshop volumio[1206]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 12 12:06:34 workshop volumio[1206]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.984 [2863.2863] INFO LocalConfigManager: [0x182bdf8]: Starting Local Configuration server Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.984 [2863.2863] INFO SampleApp: Starting Local configuration server Oct 12 12:06:34 workshop qobuz-connect[2863]: 20261012 12:06:34.985 [2863.2863] INFO SampleApp: Connected to UNIX socket client 0x1816908 Oct 12 12:06:35 workshop volumio[1206]: info: Got Tidal Cloud Configuration Oct 12 12:06:35 workshop volumio[1206]: info: Got it Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:35 workshop qobuz-connect[2863]: 20261012 12:06:35.090 [2863.2863] INFO SampleApp: Playback volume changed: 75 Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:35 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:35 workshop volumio[1206]: info: Retrieving Cloud Streaming UI Oct 12 12:06:35 workshop volumio[1206]: info: Asound.conf file written Oct 12 12:06:35 workshop sudo[2871]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 12:06:35 workshop sudo[2871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:35 workshop sudo[2871]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:35 workshop volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 12 12:06:35 workshop volumio[1206]: No state is present for card KA11 Oct 12 12:06:35 workshop volumio[1206]: Found hardware: "USB-Audio" "USB Mixer" "USB2972:0081" "" "" Oct 12 12:06:35 workshop volumio[1206]: Hardware is initialized using a generic method Oct 12 12:06:35 workshop volumio[1206]: No state is present for card KA11 Oct 12 12:06:35 workshop volumio[1206]: info: Output device has changed, restarting MPD Oct 12 12:06:35 workshop volumio[1206]: info: Output device has changed, restarting Shairport Sync Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:35 workshop sudo[2879]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 12:06:35 workshop sudo[2879]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:35 workshop sudo[2878]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 12:06:35 workshop sudo[2878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:35 workshop sudo[2878]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:35 workshop volumio[1206]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 12:06:35 workshop volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:35 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:35 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:35 workshop systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 12 12:06:35 workshop volumio[1206]: info: Output device has changed, restarting MPD Oct 12 12:06:35 workshop upmpdcli[1583]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0 Oct 12 12:06:35 workshop volumio[1206]: info: Output device has changed, restarting Shairport Sync Oct 12 12:06:35 workshop systemd[1]: mpd.service: Deactivated successfully. Oct 12 12:06:35 workshop systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 12 12:06:35 workshop systemd[1]: mpd.service: Consumed 1.671s CPU time. Oct 12 12:06:35 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:35 workshop systemd[1]: mpd.socket: Deactivated successfully. Oct 12 12:06:36 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:36 workshop systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 12 12:06:36 workshop systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 12 12:06:36 workshop sudo[2891]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 12:06:36 workshop systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 12 12:06:36 workshop sudo[2889]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:36 workshop systemd[1]: Starting mpd.service - Music Player Daemon... Oct 12 12:06:36 workshop sudo[2889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:36 workshop sudo[2891]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:36 workshop sudo[2893]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 12:06:36 workshop sudo[2893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:36 workshop sudo[2891]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop volumio[1206]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 12:06:36 workshop volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 12 12:06:36 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:36 workshop sudo[2899]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 12:06:36 workshop sudo[2899]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 12 12:06:36 workshop sudo[2899]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:36 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:36 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:36 workshop sudo[2889]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop systemd[1]: mpd.service: Deactivated successfully. Oct 12 12:06:36 workshop systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 12 12:06:36 workshop systemd[1]: mpd.socket: Deactivated successfully. Oct 12 12:06:36 workshop systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 12 12:06:36 workshop systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 12 12:06:36 workshop systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 12 12:06:36 workshop systemd[1]: Starting mpd.service - Music Player Daemon... Oct 12 12:06:36 workshop sudo[2909]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:36 workshop sudo[2909]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:36 workshop sudo[2913]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 12:06:36 workshop sudo[2913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 12 12:06:36 workshop sudo[2913]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop sudo[2910]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:36 workshop sudo[2910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:36 workshop sudo[2916]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 12 12:06:36 workshop sudo[2916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:36 workshop sudo[2909]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop sudo[2910]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop sudo[2916]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop sudo[2927]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 12 12:06:36 workshop sudo[2927]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:36 workshop sudo[2927]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:36 workshop sudo[2937]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 12 12:06:36 workshop sudo[2937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 12 12:06:37 workshop sudo[2937]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:37 workshop sudo[2938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 12 12:06:37 workshop sudo[2938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:37 workshop systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 12 12:06:37 workshop qobuz-connect[2863]: 20261012 12:06:37.152 [2863.2863] INFO SampleApp: Stopping Local configuration server Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 12 12:06:37 workshop sudo[2943]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 12 12:06:37 workshop sudo[2943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:37 workshop volumio[1206]: info: MPD Permissions set Oct 12 12:06:37 workshop volumio[1206]: info: MPD Permissions set Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:37 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:37 workshop volumio[1206]: info: Getting Tidal Cloud Configuration Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:37 workshop volumio[1206]: info: Getting Qobuz Cloud Configuration Oct 12 12:06:37 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:37 workshop volumio[1206]: info: Getting Spotify Cloud Configuration Oct 12 12:06:37 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:37 workshop volumio[1206]: info: Saving Spotify Acccount Oct 12 12:06:37 workshop volumio[1206]: info: Got it Oct 12 12:06:37 workshop volumio[1206]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:37 workshop volumio[1206]: info: Retrieving Cloud Streaming UI Oct 12 12:06:37 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:37 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 12 12:06:37 workshop volumio[1206]: info: CoreStateMachine::getcurrentVolume Oct 12 12:06:37 workshop volumio[1206]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 12:06:37 workshop mpd[2921]: 2026-10-12T12:06:37 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop systemd[1]: Started mpd.service - Music Player Daemon. Oct 12 12:06:38 workshop upmpdcli[1583]: :3:../src/mpdcli.cxx:148::MPDCli::startEventLoop: already started Oct 12 12:06:38 workshop sudo[2893]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:38 workshop sudo[2879]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 12:06:38 workshop volumio[1206]: info: VolumeController:: Volume=41 Mute =false Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:38 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:38 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:38 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:38 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:38 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:38 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:38 workshop volumio[1206]: info: CoreStateMachine::updateTrackBlock Oct 12 12:06:38 workshop volumio[1206]: info: CorePlayQueue::getTrackBlock Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 12:06:38 workshop volumio[1206]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:38 workshop volumio[1206]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:38 workshop volumio[1206]: info: Getting Tidal Cloud Configuration Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:38 workshop volumio[1206]: info: Getting Qobuz Cloud Configuration Oct 12 12:06:38 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:38 workshop volumio[1206]: info: Getting Spotify Cloud Configuration Oct 12 12:06:38 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:38 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:38 workshop volumio[1206]: info: Saving Spotify Acccount Oct 12 12:06:38 workshop volumio[1206]: info: Got it Oct 12 12:06:38 workshop volumio[1206]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 12:06:38 workshop qobuz-connect[2863]: 20261012 12:06:38.994 [2863.2863] INFO SampleApp: shat down connection on UNIX socket Oct 12 12:06:38 workshop systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 12 12:06:38 workshop systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 12 12:06:39 workshop systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 12 12:06:39 workshop sudo[2943]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:39 workshop sudo[2938]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:39 workshop volumio[1206]: info: VolumeController:: Volume=41 Mute =false Oct 12 12:06:39 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:39 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:39 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:39 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:39 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:39 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:39 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:39 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:39 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:39 workshop volumio[1206]: info: Got Tidal Cloud Configuration Oct 12 12:06:39 workshop volumio[1206]: info: Got it Oct 12 12:06:39 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:39 workshop volumio[1206]: info: Starting Shairport Sync Oct 12 12:06:39 workshop sudo[2979]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 12:06:39 workshop sudo[2979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:39 workshop volumio[1206]: info: Starting Shairport Sync Oct 12 12:06:39 workshop systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 12:06:39 workshop systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 12:06:39 workshop systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:06:39 workshop systemd[1]: shairport-sync.service: Consumed 1.433s CPU time. Oct 12 12:06:39 workshop systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:06:39 workshop sudo[2984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 12 12:06:39 workshop sudo[2984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:39 workshop sudo[2982]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 12:06:39 workshop sudo[2982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 12:06:39 workshop sudo[2979]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:39 workshop systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Oct 12 12:06:39 workshop volumio[1206]: error: MPD error: The expression evaluated to a falsy value: Oct 12 12:06:39 workshop volumio[1206]: assert.ok(self.idling) Oct 12 12:06:39 workshop volumio[1206]: error: The expression evaluated to a falsy value: Oct 12 12:06:39 workshop volumio[1206]: assert.ok(self.idling) Oct 12 12:06:39 workshop sudo[2984]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:39 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:39 workshop volumio[1206]: info: Retrieving Cloud Streaming UI Oct 12 12:06:39 workshop volumio[1206]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 12 12:06:39 workshop volumio[1206]: info: QobuzConnect: setDeactiveState invoked Oct 12 12:06:39 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:39 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:39 workshop systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 12:06:39 workshop systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 12:06:39 workshop systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:06:39 workshop systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 12:06:39 workshop sudo[2982]: pam_unix(sudo:session): session closed for user root Oct 12 12:06:39 workshop volumio[1206]: info: Preparing to generate the ALSA configuration file Oct 12 12:06:39 workshop volumio[1206]: error: updateQueue error: null Oct 12 12:06:39 workshop volumio[1206]: info: Executing endpoint qc_getconfig Oct 12 12:06:39 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.903 [2977.2977] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.907 [2977.2977] INFO VolumeManager: [0x1e2a378]: Setting new playback volume: 75 Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.907 [2977.2977] INFO VolumeManager: [0x1e2a378]: Setting new mute state: 0 Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.907 [2977.2977] INFO AudioStreamManager: [0x1e2a0d0]: Setting new audio download buffer size: 1048576 Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.907 [2977.2977] INFO QobuzConnect: [0x1e2ac40]: Client initialized! Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.907 [2977.2977] INFO SampleApp: Starting Avahi advertising, name: workshop, service name: _qobuz-connect._tcp Oct 12 12:06:39 workshop volumio[1206]: info: Shairport-Sync Started Oct 12 12:06:39 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:39 workshop volumio[1206]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 12 12:06:39 workshop volumio[1206]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 12 12:06:39 workshop volumio[1206]: info: Reading ALSA contributions from plugins. Oct 12 12:06:39 workshop volumio[1206]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.922 [2977.2977] INFO LocalConfigManager: [0x1e29df8]: Starting Local Configuration server Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.922 [2977.2977] INFO SampleApp: Starting Local configuration server Oct 12 12:06:39 workshop qobuz-connect[2977]: 20261012 12:06:39.922 [2977.2977] INFO SampleApp: Connected to UNIX socket client 0x1e14908 Oct 12 12:06:39 workshop volumio[1206]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 12 12:06:39 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:40 workshop qobuz-connect[2977]: 20261012 12:06:40.053 [2977.2977] INFO SampleApp: Playback volume changed: 75 Oct 12 12:06:40 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:40 workshop volumio[1206]: info: TidalConnect service stoped! Oct 12 12:06:40 workshop volumio[1206]: info: Shairport-Sync Started Oct 12 12:06:40 workshop volumio[1206]: info: Executing endpoint tc_getconfig Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 12 12:06:40 workshop vtcs[3003]: STARTING TidalConnect services, version: 1.6.1 Oct 12 12:06:40 workshop vtcs[3003]: STARTED TidalConnect services. Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: info: Got Tidal Cloud Configuration Oct 12 12:06:40 workshop volumio[1206]: info: Got it Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:40 workshop volumio[1206]: info: Getting Tidal Cloud Configuration Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:40 workshop volumio[1206]: info: Getting Qobuz Cloud Configuration Oct 12 12:06:40 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:40 workshop volumio[1206]: info: Getting Spotify Cloud Configuration Oct 12 12:06:40 workshop volumio[1206]: info: Asking plugin for UI Config Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 12:06:40 workshop volumio[1206]: info: Saving Spotify Acccount Oct 12 12:06:40 workshop volumio[1206]: info: Got it Oct 12 12:06:40 workshop volumio[1206]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 12:06:40 workshop volumio[1206]: info: Executing endpoint tc_connect Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 12 12:06:40 workshop volumio[1206]: info: Connecting to TidalConnect Oct 12 12:06:40 workshop volumio[1206]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:40 workshop volumio[1206]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::servicePushState Oct 12 12:06:40 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:40 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:40 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 12 12:06:40 workshop volumio[1206]: verbose: CURRENT POSITION 0 Oct 12 12:06:40 workshop volumio[1206]: info: CoreStateMachine::syncState stateService stop Oct 12 12:06:40 workshop volumio[1206]: info: CoreStateMachine::syncState currentStatus stop Oct 12 12:06:40 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:40 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:40 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: info: No code Oct 12 12:06:40 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:40 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:40 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:40 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:40 workshop volumio[1206]: info: CoreCommandRouter::servicePushState Oct 12 12:06:41 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:41 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:41 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:41 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:41 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:41 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:41 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:41 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:41 workshop volumio[1206]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 12 12:06:41 workshop volumio[1206]: verbose: CURRENT POSITION 0 Oct 12 12:06:41 workshop volumio[1206]: info: CoreStateMachine::syncState stateService stop Oct 12 12:06:41 workshop volumio[1206]: info: CoreStateMachine::syncState currentStatus stop Oct 12 12:06:41 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:41 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:41 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:41 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:41 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:41 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:41 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:41 workshop volumio[1206]: info: No code Oct 12 12:06:41 workshop volumio[1206]: info: CoreStateMachine::pushState Oct 12 12:06:41 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:41 workshop volumio[1206]: info: CoreCommandRouter::volumioPushState Oct 12 12:06:41 workshop volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Oct 12 12:06:41 workshop volumio[1206]: info: MRS: Pushing multiroomSync output Oct 12 12:06:41 workshop volumio[1206]: info: CoreCommandRouter::volumioGetState Oct 12 12:06:41 workshop volumio[1206]: info: CorePlayQueue::getTrack 0 Oct 12 12:06:41 workshop volumio[1206]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:41 workshop volumio[1206]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 12 12:06:41 workshop volumio[1206]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 12:06:41 workshop volumio[1206]: Error: ENOENT: no such file or directory, unlink '/tmp/PCvnEznwr46HhdwQ59A0qPUWBCcGBISO03SdmwI0KzWPQGYTHoEs2cxaRi0rMLdovNKQLSau2GlV69lJ2V2ixUELsRuBH6neMzHG' Oct 12 12:06:41 workshop volumio[1206]: at Object.unlinkSync (node:fs:1899:3) Oct 12 12:06:41 workshop volumio[1206]: at ControllerTidalconnect.deleteCertificate (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:11265) Oct 12 12:06:41 workshop volumio[1206]: at TidalConnectClient. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:2774) Oct 12 12:06:41 workshop volumio[1206]: at TidalConnectClient.emit (node:events:514:28) Oct 12 12:06:41 workshop volumio[1206]: at TidalConnectClient.parseData (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:44713) Oct 12 12:06:41 workshop volumio[1206]: at /myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41683 Oct 12 12:06:41 workshop volumio[1206]: at Array.forEach () Oct 12 12:06:41 workshop volumio[1206]: at Socket. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41561) Oct 12 12:06:41 workshop volumio[1206]: at Socket.emit (node:events:514:28) Oct 12 12:06:41 workshop volumio[1206]: at addChunk (node:internal/streams/readable:343:12) Oct 12 12:06:41 workshop volumio[1206]: at readableAddChunk (node:internal/streams/readable:316:9) Oct 12 12:06:41 workshop volumio[1206]: at Readable.push (node:internal/streams/readable:253:10) Oct 12 12:06:41 workshop volumio[1206]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) { Oct 12 12:06:41 workshop volumio[1206]: errno: -2, Oct 12 12:06:41 workshop volumio[1206]: syscall: 'unlink', Oct 12 12:06:41 workshop volumio[1206]: code: 'ENOENT', Oct 12 12:06:41 workshop volumio[1206]: path: '/tmp/PCvnEznwr46HhdwQ59A0qPUWBCcGBISO03SdmwI0KzWPQGYTHoEs2cxaRi0rMLdovNKQLSau2GlV69lJ2V2ixUELsRuBH6neMzHG' Oct 12 12:06:41 workshop volumio[1206]: } Oct 12 12:06:41 workshop volumio[1206]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 12:06:44 workshop sudo[3091]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 12:05' Oct 12 12:06:44 workshop sudo[3091]: 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="ebd772339e193fb4b3a98c68e63a0009e72d6f27" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Sep 14 07:39:23 UTC 2026" VOLUMIO_VERSION="4.204" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="915e71dafc26fd850574d238b4f947d5"