Dec 23 12:36:15 volumio---pete volumio[1183]: info: Pushing metadata
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::servicePushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreStateMachine::pushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output update for this device
Dec 23 12:36:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::servicePushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreStateMachine::pushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output update for this device
Dec 23 12:36:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::servicePushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreStateMachine::pushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPushState
Dec 23 12:36:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output update for this device
Dec 23 12:36:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output
Dec 23 12:36:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:36:18 volumio---pete volumio[1183]: info: Executing endpoint metavolumio
Dec 23 12:36:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 23 12:36:18 volumio---pete volumio[1183]: info: Executing endpoint metavolumio
Dec 23 12:36:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 23 12:36:18 volumio---pete volumio[1183]: info: Executing endpoint metavolumio
Dec 23 12:36:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 23 12:37:14 volumio---pete kernel: usb 1-1.2: USB disconnect, device number 14
Dec 23 12:37:14 volumio---pete vtcs[30214]: ALSA lib ./src/pcm_volumioswitch.c:912:(_snd_pcm_volumioswitch_advance) PCM volumioMultiRoomServer cannot write to target PCM volumioOutput as it has failed its update check.
Dec 23 12:37:14 volumio---pete vtcs[30214]: ALSA lib pcm.c:8573:(snd_pcm_recover) cannot recovery from underrun, prepare failed: No such device
Dec 23 12:37:14 volumio---pete vtcs[30214]: [feedThread:265] ALSA error: No such device
Dec 23 12:37:14 volumio---pete vtcs[30214]: [feedThread:276] Exiting
Dec 23 12:37:14 volumio---pete volumio[1183]: info:
Dec 23 12:37:14 volumio---pete volumio[1183]: ---------------------------- USB Audio Device Detached
Dec 23 12:37:14 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Dec 23 12:37:14 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:14 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Dec 23 12:37:14 volumio---pete kernel: usb 1-1.2: new high-speed USB device number 15 using dwc_otg
Dec 23 12:37:15 volumio---pete kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3079, bcdDevice= 0.03
Dec 23 12:37:15 volumio---pete kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0
Dec 23 12:37:15 volumio---pete kernel: usb 1-1.2: Product: HIFI USB AUDIO
Dec 23 12:37:15 volumio---pete kernel: usb 1-1.2: Manufacturer: SUCA
Dec 23 12:37:15 volumio---pete (udev-worker)[21603]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99.
Dec 23 12:37:15 volumio---pete volumio[1183]: info:
Dec 23 12:37:15 volumio---pete volumio[1183]: ---------------------------- USB Audio Device Attached
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::Close All Modals sent
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Preparing to save Alsa Options, stopping services first
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPause
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreStateMachine::pause
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreStateMachine::stPlaybackTimer
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreStateMachine::servicePause
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::servicePause
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Received pause
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"HIFI USB AUDIO","alsacard":"AUDIO"},"i2s":false}
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:15 volumio---pete vtcs[30214]: [pause:147] Entering
Dec 23 12:37:15 volumio---pete vtcs[30214]: [pause:154] ALSA error: No such device
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Setting mixer HIFI USB AUDIO for card HIFI USB AUDIO
Dec 23 12:37:15 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:15 volumio---pete volumio[1183]: verbose: UNSET VOLATILE: Service: tidalconnect
Dec 23 12:37:15 volumio---pete volumio[1183]: info: unSetVolatile called
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Relinquishing Volumio State to another service
Dec 23 12:37:15 volumio---pete vtcs[30214]: [2025-12-23 12:37:15.244] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer
Dec 23 12:37:15 volumio---pete vtcs[30214]: [2025-12-23 12:37:15.244] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Dec 23 12:37:15 volumio---pete vtcs[30214]: [2025-12-23 12:37:15.244] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Dec 23 12:37:15 volumio---pete vtcs[30214]: [close:85] Entering
Dec 23 12:37:15 volumio---pete vtcs[30214]: vtcs: pcm_plug.c:71: snd_pcm_plug_close: Assertion `plug->gen.slave == plug->req_slave' failed.
Dec 23 12:37:15 volumio---pete sudo[21630]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:15 volumio---pete sudo[21630]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Updating Volume Controller Parameters: Device: 5 Name: HIFI USB AUDIO Mixer: HIFI USB AUDIO Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Disabling external Volume Control
Dec 23 12:37:15 volumio---pete vtcs[30213]: Aborted
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 12:37:15 volumio---pete systemd[1]: vtcs.service: Main process exited, code=exited, status=134/n/a
Dec 23 12:37:15 volumio---pete systemd[1]: vtcs.service: Failed with result 'exit-code'.
Dec 23 12:37:15 volumio---pete systemd[1]: vtcs.service: Consumed 1min 35.856s CPU time.
Dec 23 12:37:15 volumio---pete systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service.
Dec 23 12:37:15 volumio---pete systemd[1]: vtcs.service: Consumed 1min 35.856s CPU time.
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Preparing to generate the ALSA configuration file
Dec 23 12:37:15 volumio---pete sudo[21630]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:15 volumio---pete sudo[21639]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:15 volumio---pete sudo[21639]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete volumio[1183]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Reading ALSA contributions from plugins.
Dec 23 12:37:15 volumio---pete sudo[21646]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:15 volumio---pete sudo[21646]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete kernel: usb 1-1.2: USB disconnect, device number 15
Dec 23 12:37:15 volumio---pete sudo[21646]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:15 volumio---pete sudo[21652]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:15 volumio---pete sudo[21652]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 23 12:37:15 volumio---pete sudo[21639]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:15 volumio---pete systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service...
Dec 23 12:37:15 volumio---pete volumio[1183]: Invalid card number '5'.
Dec 23 12:37:15 volumio---pete qobuz-connect[30181]: 20251223 12:37:15.535 [30181.30181] INFO SampleApp: Stopping Local configuration server
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 23 12:37:15 volumio---pete volumio[1183]: info: VolumeController:: Volume=100 Mute =false
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreStateMachine::pushState
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPushState
Dec 23 12:37:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output update for this device
Dec 23 12:37:15 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:15 volumio---pete volumio[1183]: info:
Dec 23 12:37:15 volumio---pete volumio[1183]: ---------------------------- USB Audio Device Detached
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Asound.conf file unchanged, so no further update is needed
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Output device has changed, restarting MPD
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Output device has changed, restarting Shairport Sync
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:15 volumio---pete sudo[21664]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 23 12:37:15 volumio---pete sudo[21664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete sudo[21664]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:15 volumio---pete sudo[21666]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 23 12:37:15 volumio---pete sudo[21666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 23 12:37:15 volumio---pete volumio[1183]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:15 volumio---pete systemd[1]: Stopping mpd.service - Music Player Daemon...
Dec 23 12:37:15 volumio---pete sudo[21676]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:15 volumio---pete sudo[21676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete sudo[21678]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:15 volumio---pete sudo[21678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete systemd[1]: mpd.service: Deactivated successfully.
Dec 23 12:37:15 volumio---pete systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 23 12:37:15 volumio---pete systemd[1]: mpd.service: Consumed 4.085s CPU time.
Dec 23 12:37:15 volumio---pete volumio[1183]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split')
Dec 23 12:37:15 volumio---pete volumio[1183]: info: MPD Permissions set
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete sudo[21686]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:15 volumio---pete sudo[21686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete systemd[1]: mpd.socket: Deactivated successfully.
Dec 23 12:37:15 volumio---pete systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:15 volumio---pete systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:15 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Starting Shairport Sync
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Preparing to generate the ALSA configuration file
Dec 23 12:37:15 volumio---pete systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:15 volumio---pete sudo[21696]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 23 12:37:15 volumio---pete sudo[21696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 23 12:37:15 volumio---pete volumio[1183]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Reading ALSA contributions from plugins.
Dec 23 12:37:15 volumio---pete volumio[1183]: info: Asound.conf file written
Dec 23 12:37:15 volumio---pete sudo[21676]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:15 volumio---pete sudo[21701]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 23 12:37:15 volumio---pete sudo[21701]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:15 volumio---pete sudo[21701]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:15 volumio---pete sudo[21678]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:15 volumio---pete sudo[21686]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Dec 23 12:37:16 volumio---pete volumio[1183]: No state is present for card b1
Dec 23 12:37:16 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Dec 23 12:37:16 volumio---pete volumio[1183]: /usr/share/alsa/init/bcm2835:14: control element not found
Dec 23 12:37:16 volumio---pete volumio[1183]: No state is present for card b1
Dec 23 12:37:16 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Dec 23 12:37:16 volumio---pete volumio[1183]: No state is present for card Headphones
Dec 23 12:37:16 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Dec 23 12:37:16 volumio---pete volumio[1183]: /usr/share/alsa/init/bcm2835:20: control element not found
Dec 23 12:37:16 volumio---pete volumio[1183]: No state is present for card Headphones
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Output device has changed, restarting MPD
Dec 23 12:37:16 volumio---pete systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 23 12:37:16 volumio---pete systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 23 12:37:16 volumio---pete systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:16 volumio---pete systemd[1]: shairport-sync.service: Consumed 19.838s CPU time.
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Output device has changed, restarting Shairport Sync
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:16 volumio---pete sudo[21709]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:16 volumio---pete sudo[21709]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete sudo[21712]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 23 12:37:16 volumio---pete sudo[21712]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 23 12:37:16 volumio---pete volumio[1183]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 23 12:37:16 volumio---pete sudo[21697]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 23 12:37:16 volumio---pete sudo[21697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete sudo[21717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 23 12:37:16 volumio---pete sudo[21712]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete sudo[21717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete sudo[21697]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:16 volumio---pete sudo[21696]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:16 volumio---pete kernel: usb 1-1.2: new high-speed USB device number 16 using dwc_otg
Dec 23 12:37:16 volumio---pete systemd[1]: mpd.service: Deactivated successfully.
Dec 23 12:37:16 volumio---pete systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 23 12:37:16 volumio---pete systemd[1]: mpd.socket: Deactivated successfully.
Dec 23 12:37:16 volumio---pete systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:16 volumio---pete systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 23 12:37:16 volumio---pete sudo[21739]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:16 volumio---pete sudo[21739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete sudo[21742]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:16 volumio---pete sudo[21742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3079, bcdDevice= 0.03
Dec 23 12:37:16 volumio---pete kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0
Dec 23 12:37:16 volumio---pete kernel: usb 1-1.2: Product: HIFI USB AUDIO
Dec 23 12:37:16 volumio---pete kernel: usb 1-1.2: Manufacturer: SUCA
Dec 23 12:37:16 volumio---pete volumio[1183]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split')
Dec 23 12:37:16 volumio---pete volumio[1183]: info: MPD Permissions set
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Shairport-Sync Started
Dec 23 12:37:16 volumio---pete systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:16 volumio---pete volumio[1183]: (node:1183) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Dec 23 12:37:16 volumio---pete volumio[1183]: (Use `node --trace-warnings ...` to show where the warning was created)
Dec 23 12:37:16 volumio---pete volumio[1183]: (node:1183) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Dec 23 12:37:16 volumio---pete volumio[1183]: (node:1183) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Dec 23 12:37:16 volumio---pete volumio[1183]: (node:1183) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Dec 23 12:37:16 volumio---pete volumio[1183]: (node:1183) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Dec 23 12:37:16 volumio---pete sudo[21751]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete sudo[21751]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 23 12:37:16 volumio---pete (udev-worker)[21603]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99.
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Starting Shairport Sync
Dec 23 12:37:16 volumio---pete volumio[1183]: info:
Dec 23 12:37:16 volumio---pete volumio[1183]: ---------------------------- USB Audio Device Attached
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::Close All Modals sent
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Preparing to save Alsa Options, stopping services first
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioStop
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreStateMachine::stop
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreStateMachine::updateTrackBlock
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CorePlayQueue::getTrackBlock
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreStateMachine::stPlaybackTimer
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreStateMachine::pushState
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPushState
Dec 23 12:37:16 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output update for this device
Dec 23 12:37:16 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreStateMachine::serviceStop
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::serviceStop
Dec 23 12:37:16 volumio---pete volumio[1183]: info: [1766489836452] ControllerWebradio::stop
Dec 23 12:37:16 volumio---pete volumio[1183]: verbose: ControllerMpd::sendMpdCommand stop
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"HIFI USB AUDIO","alsacard":"AUDIO"},"i2s":false}
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:16 volumio---pete sudo[21764]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 23 12:37:16 volumio---pete sudo[21764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete sudo[21751]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete sudo[21771]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:16 volumio---pete sudo[21771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete sudo[21755]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 23 12:37:16 volumio---pete sudo[21755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 23 12:37:16 volumio---pete sudo[21739]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete sudo[21755]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete sudo[21742]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Setting mixer HIFI USB AUDIO for card HIFI USB AUDIO
Dec 23 12:37:16 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Updating Volume Controller Parameters: Device: 5 Name: HIFI USB AUDIO Mixer: HIFI USB AUDIO Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Disabling external Volume Control
Dec 23 12:37:16 volumio---pete systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 23 12:37:16 volumio---pete kernel: usb 1-1.2: USB disconnect, device number 16
Dec 23 12:37:16 volumio---pete sudo[21800]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:16 volumio---pete sudo[21800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:16 volumio---pete volumio[1183]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 12:37:16 volumio---pete systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 23 12:37:16 volumio---pete systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:16 volumio---pete systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:16 volumio---pete sudo[21764]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete volumio[1183]: info: Preparing to generate the ALSA configuration file
Dec 23 12:37:16 volumio---pete sudo[21800]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:16 volumio---pete kernel: usb 1-1.2: new high-speed USB device number 17 using dwc_otg
Dec 23 12:37:16 volumio---pete sudo[21824]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:16 volumio---pete sudo[21824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete sudo[21831]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:17 volumio---pete sudo[21831]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete volumio[1183]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Reading ALSA contributions from plugins.
Dec 23 12:37:17 volumio---pete sudo[21831]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete volumio[1183]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'.
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Shairport-Sync Started
Dec 23 12:37:17 volumio---pete volumio[1183]: info: VolumeController:: Volume=undefined Mute =false
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreStateMachine::pushState
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPushState
Dec 23 12:37:17 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output update for this device
Dec 23 12:37:17 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:17 volumio---pete volumio[1183]: info:
Dec 23 12:37:17 volumio---pete volumio[1183]: ---------------------------- USB Audio Device Detached
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:17 volumio---pete sudo[21834]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:17 volumio---pete sudo[21834]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Dec 23 12:37:17 volumio---pete sudo[21824]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:17 volumio---pete volumio[1183]: Invalid card number '5'.
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Dec 23 12:37:17 volumio---pete qobuz-connect[30181]: 20251223 12:37:17.353 [30181.30181] INFO SampleApp: shat down connection on UNIX socket
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Asound.conf file unchanged, so no further update is needed
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Output device has changed, restarting MPD
Dec 23 12:37:17 volumio---pete systemd[1]: qobuz-connect.service: Deactivated successfully.
Dec 23 12:37:17 volumio---pete systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Output device has changed, restarting Shairport Sync
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:17 volumio---pete sudo[21849]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 23 12:37:17 volumio---pete sudo[21849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete sudo[21849]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete sudo[21851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 23 12:37:17 volumio---pete sudo[21851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 23 12:37:17 volumio---pete volumio[1183]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 23 12:37:17 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:17 volumio---pete sudo[21771]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete sudo[21834]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete sudo[21652]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete kernel: usb 1-1.2: device not accepting address 17, error -71
Dec 23 12:37:17 volumio---pete sudo[21709]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete systemd[1]: mpd.service: Deactivated successfully.
Dec 23 12:37:17 volumio---pete systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 23 12:37:17 volumio---pete systemd[1]: mpd.socket: Deactivated successfully.
Dec 23 12:37:17 volumio---pete systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:17 volumio---pete systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 23 12:37:17 volumio---pete sudo[21861]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:17 volumio---pete sudo[21861]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete sudo[21863]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:17 volumio---pete sudo[21863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete volumio[1183]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Dec 23 12:37:17 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:17 volumio---pete volumio[1183]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split')
Dec 23 12:37:17 volumio---pete volumio[1183]: info: MPD Permissions set
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Executing endpoint qc_getconfig
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Dec 23 12:37:17 volumio---pete sudo[21872]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:17 volumio---pete sudo[21872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:17 volumio---pete systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.675 [21848.21848] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.686 [21848.21848] INFO VolumeManager: [0x39b348]: Setting new playback volume: 75
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.686 [21848.21848] INFO VolumeManager: [0x39b348]: Setting new mute state: 0
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.686 [21848.21848] INFO QobuzConnect: [0x39bd18]: Client initialized!
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.686 [21848.21848] INFO SampleApp: Starting Avahi advertising, name: Volumio - Pete, service name: _qobuz-connect._tcp
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.732 [21848.21848] INFO LocalConfigManager: [0x39ac28]: Starting Local Configuration server
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.733 [21848.21848] INFO SampleApp: Starting Local configuration server
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.737 [21848.21848] INFO SampleApp: Connected to UNIX socket client 0x385818
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:17 volumio---pete volumio[1183]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Dec 23 12:37:17 volumio---pete sudo[21872]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete volumio[1183]: info: QobuzConnect: QOBUZ Connect daemon connected
Dec 23 12:37:17 volumio---pete volumio[1183]: info: Starting Shairport Sync
Dec 23 12:37:17 volumio---pete kernel: usb 1-1.2: new high-speed USB device number 18 using dwc_otg
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.826 [21848.21848] INFO SampleApp: Playback volume changed: 75
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:17 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:17 volumio---pete sudo[21888]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 23 12:37:17 volumio---pete sudo[21888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete sudo[21863]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete sudo[21861]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:17 volumio---pete sudo[21886]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:17 volumio---pete sudo[21886]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:17 volumio---pete kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3079, bcdDevice= 0.03
Dec 23 12:37:17 volumio---pete kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0
Dec 23 12:37:17 volumio---pete kernel: usb 1-1.2: Product: HIFI USB AUDIO
Dec 23 12:37:17 volumio---pete kernel: usb 1-1.2: Manufacturer: SUCA
Dec 23 12:37:17 volumio---pete systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service...
Dec 23 12:37:17 volumio---pete systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 23 12:37:17 volumio---pete systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 23 12:37:17 volumio---pete systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:17 volumio---pete qobuz-connect[21848]: 20251223 12:37:17.952 [21848.21848] INFO SampleApp: Stopping Local configuration server
Dec 23 12:37:17 volumio---pete sudo[21877]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 23 12:37:17 volumio---pete sudo[21877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 23 12:37:17 volumio---pete sudo[21877]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:18 volumio---pete systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:18 volumio---pete sudo[21888]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:18 volumio---pete (udev-worker)[21604]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99.
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Shairport-Sync Started
Dec 23 12:37:18 volumio---pete volumio[1183]: info:
Dec 23 12:37:18 volumio---pete volumio[1183]: ---------------------------- USB Audio Device Attached
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::Close All Modals sent
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Preparing to save Alsa Options, stopping services first
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioStop
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreStateMachine::stop
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"HIFI USB AUDIO","alsacard":"AUDIO"},"i2s":false}
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Setting mixer HIFI USB AUDIO for card HIFI USB AUDIO
Dec 23 12:37:18 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:18 volumio---pete sudo[21928]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:18 volumio---pete sudo[21928]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Updating Volume Controller Parameters: Device: 5 Name: HIFI USB AUDIO Mixer: HIFI USB AUDIO Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Disabling external Volume Control
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Preparing to generate the ALSA configuration file
Dec 23 12:37:18 volumio---pete sudo[21928]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:18 volumio---pete sudo[21935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:18 volumio---pete volumio[1183]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Reading ALSA contributions from plugins.
Dec 23 12:37:18 volumio---pete sudo[21935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete volumio[1183]: info: TidalConnect service stoped!
Dec 23 12:37:18 volumio---pete sudo[21942]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:18 volumio---pete sudo[21942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete volumio[1183]: info: TidalConnect service stoped!
Dec 23 12:37:18 volumio---pete sudo[21935]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:18 volumio---pete sudo[21942]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 23 12:37:18 volumio---pete sudo[21953]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:18 volumio---pete sudo[21953]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 23 12:37:18 volumio---pete volumio[1183]: info: VolumeController:: Volume=100 Mute =false
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreStateMachine::pushState
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioPushState
Dec 23 12:37:18 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output update for this device
Dec 23 12:37:18 volumio---pete volumio[1183]: info: MRS: Pushing multiroomSync output
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Asound.conf file unchanged, so no further update is needed
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Output device has changed, restarting MPD
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Output device has changed, restarting Shairport Sync
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:18 volumio---pete sudo[21964]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 23 12:37:18 volumio---pete sudo[21964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete sudo[21964]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:18 volumio---pete sudo[21966]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 23 12:37:18 volumio---pete sudo[21966]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 23 12:37:18 volumio---pete volumio[1183]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:18 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:18 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:18 volumio---pete sudo[21975]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:18 volumio---pete sudo[21975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete systemd[1]: mpd.service: Deactivated successfully.
Dec 23 12:37:18 volumio---pete systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 23 12:37:18 volumio---pete systemd[1]: mpd.service: Consumed 1.010s CPU time.
Dec 23 12:37:18 volumio---pete systemd[1]: mpd.socket: Deactivated successfully.
Dec 23 12:37:18 volumio---pete systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:18 volumio---pete systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 23 12:37:18 volumio---pete sudo[21978]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:18 volumio---pete sudo[21978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:18 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Dec 23 12:37:18 volumio---pete volumio[1183]: error: Upnp client error: Error: read ECONNRESET
Dec 23 12:37:18 volumio---pete volumio[1183]: info: MPD Permissions set
Dec 23 12:37:18 volumio---pete volumio[1183]: info: TidalConnect service stoped!
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete sudo[21987]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:19 volumio---pete sudo[21987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 23 12:37:19 volumio---pete volumio[1183]: info: TidalConnect service stoped!
Dec 23 12:37:19 volumio---pete sudo[21996]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 23 12:37:19 volumio---pete sudo[21996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Starting Shairport Sync
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Preparing to generate the ALSA configuration file
Dec 23 12:37:19 volumio---pete volumio[1183]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Reading ALSA contributions from plugins.
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Asound.conf file written
Dec 23 12:37:19 volumio---pete sudo[21987]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete sudo[21978]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete sudo[21975]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete sudo[22004]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 23 12:37:19 volumio---pete sudo[22004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete sudo[22009]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 23 12:37:19 volumio---pete sudo[22009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete sudo[22006]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:19 volumio---pete sudo[22006]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete sudo[22009]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete systemd[1]: Started vtcs.service - Volumio Tidal Connect Service.
Dec 23 12:37:19 volumio---pete sudo[21996]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete sudo[21994]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 23 12:37:19 volumio---pete sudo[21994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 23 12:37:19 volumio---pete sudo[21994]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Dec 23 12:37:19 volumio---pete volumio[1183]: No state is present for card b1
Dec 23 12:37:19 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Dec 23 12:37:19 volumio---pete volumio[1183]: /usr/share/alsa/init/bcm2835:14: control element not found
Dec 23 12:37:19 volumio---pete volumio[1183]: No state is present for card b1
Dec 23 12:37:19 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Dec 23 12:37:19 volumio---pete volumio[1183]: No state is present for card Headphones
Dec 23 12:37:19 volumio---pete volumio[1183]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Dec 23 12:37:19 volumio---pete volumio[1183]: /usr/share/alsa/init/bcm2835:20: control element not found
Dec 23 12:37:19 volumio---pete volumio[1183]: No state is present for card Headphones
Dec 23 12:37:19 volumio---pete volumio[1183]: No state is present for card AUDIO
Dec 23 12:37:19 volumio---pete volumio[1183]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:3079" "" ""
Dec 23 12:37:19 volumio---pete volumio[1183]: Hardware is initialized using a generic method
Dec 23 12:37:19 volumio---pete volumio[1183]: No state is present for card AUDIO
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Output device has changed, restarting MPD
Dec 23 12:37:19 volumio---pete systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 23 12:37:19 volumio---pete systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 23 12:37:19 volumio---pete systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:19 volumio---pete systemd[1]: shairport-sync.service: Consumed 1.287s CPU time.
Dec 23 12:37:19 volumio---pete systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 23 12:37:19 volumio---pete sudo[22004]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete sudo[22021]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 23 12:37:19 volumio---pete sudo[22021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Output device has changed, restarting Shairport Sync
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 23 12:37:19 volumio---pete sudo[22021]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete sudo[22025]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 23 12:37:19 volumio---pete sudo[22025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete systemd[1]: mpd.service: Deactivated successfully.
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 23 12:37:19 volumio---pete volumio[1183]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 23 12:37:19 volumio---pete systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 23 12:37:19 volumio---pete systemd[1]: mpd.socket: Deactivated successfully.
Dec 23 12:37:19 volumio---pete systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:19 volumio---pete systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 23 12:37:19 volumio---pete volumio[1183]: info: QobuzConnect: setDeactiveState invoked
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioGetState
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CorePlayQueue::getTrack 0
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Relinquishing Volumio State
Dec 23 12:37:19 volumio---pete sudo[22048]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:19 volumio---pete sudo[22051]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 23 12:37:19 volumio---pete sudo[22051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete sudo[22048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreStateMachine::getcurrentVolume
Dec 23 12:37:19 volumio---pete volumio[1183]: info: CoreCommandRouter::volumioRetrievevolume
Dec 23 12:37:19 volumio---pete systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 23 12:37:19 volumio---pete volumio[1183]: info: MPD Permissions set
Dec 23 12:37:19 volumio---pete volumio[1183]: info: TidalConnect service stoped!
Dec 23 12:37:19 volumio---pete qobuz-connect[21848]: 20251223 12:37:19.762 [21848.21848] INFO SampleApp: shat down connection on UNIX socket
Dec 23 12:37:19 volumio---pete systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service...
Dec 23 12:37:19 volumio---pete systemd[1]: qobuz-connect.service: Deactivated successfully.
Dec 23 12:37:19 volumio---pete volumio[1183]: info: TidalConnect service stoped!
Dec 23 12:37:19 volumio---pete systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 23 12:37:19 volumio---pete volumio[1183]: info: Shairport-Sync Started
Dec 23 12:37:19 volumio---pete sudo[22059]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 23 12:37:19 volumio---pete sudo[22059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:19 volumio---pete systemd[1]: vtcs.service: Deactivated successfully.
Dec 23 12:37:19 volumio---pete systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service.
Dec 23 12:37:19 volumio---pete volumio[1183]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 23 12:37:19 volumio---pete volumio[1183]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3
Dec 23 12:37:19 volumio---pete volumio[1183]: Job for vtcs.service canceled.
Dec 23 12:37:19 volumio---pete volumio[1183]: at ChildProcess.exithandler (node:child_process:421:12)
Dec 23 12:37:19 volumio---pete volumio[1183]: at ChildProcess.emit (node:events:514:28)
Dec 23 12:37:19 volumio---pete volumio[1183]: at maybeClose (node:internal/child_process:1105:16)
Dec 23 12:37:19 volumio---pete volumio[1183]: at Socket. (node:internal/child_process:457:11)
Dec 23 12:37:19 volumio---pete volumio[1183]: at Socket.emit (node:events:514:28)
Dec 23 12:37:19 volumio---pete volumio[1183]: at Pipe. (node:net:337:12) {
Dec 23 12:37:19 volumio---pete volumio[1183]: code: 1,
Dec 23 12:37:19 volumio---pete volumio[1183]: killed: false,
Dec 23 12:37:19 volumio---pete volumio[1183]: signal: null,
Dec 23 12:37:19 volumio---pete volumio[1183]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3',
Dec 23 12:37:19 volumio---pete volumio[1183]: stdout: '',
Dec 23 12:37:19 volumio---pete volumio[1183]: stderr: 'Job for vtcs.service canceled.\n'
Dec 23 12:37:19 volumio---pete volumio[1183]: }
Dec 23 12:37:19 volumio---pete volumio[1183]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 23 12:37:19 volumio---pete sudo[22051]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:19 volumio---pete sudo[22048]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:20 volumio---pete sudo[22060]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 23 12:37:20 volumio---pete sudo[22060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 23 12:37:20 volumio---pete sudo[22060]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:20 volumio---pete systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 23 12:37:20 volumio---pete sudo[21953]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:20 volumio---pete sudo[22006]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:20 volumio---pete sudo[21886]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:20 volumio---pete sudo[22059]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:20 volumio---pete sudo[22084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 23 12:37:20 volumio---pete sudo[22084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 23 12:37:20 volumio---pete systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service...
Dec 23 12:37:20 volumio---pete systemd[1]: qobuz-connect.service: Deactivated successfully.
Dec 23 12:37:20 volumio---pete systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 23 12:37:20 volumio---pete systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 23 12:37:20 volumio---pete sudo[22084]: pam_unix(sudo:session): session closed for user root
Dec 23 12:37:20 volumio---pete sudo[22089]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-23 12:36'
Dec 23 12:37:20 volumio---pete sudo[22089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"