-- Logs begin at Tue 2024-02-27 18:45:35 +07, end at Thu 2024-04-11 19:29:39 +07. -- Apr 11 19:28:00 blueplayer kernel: usb 1-1.2: USB disconnect, device number 16 Apr 11 19:28:00 blueplayer volumio[729]: info: Apr 11 19:28:00 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:01 blueplayer kernel: usb 1-1.2: new high-speed USB device number 17 using xhci_hcd Apr 11 19:28:01 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:01 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:01 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:01 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:01 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:01 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.000D/input/input12 Apr 11 19:28:01 blueplayer kernel: hid-generic 0003:2D87:000E.000D: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:01 blueplayer volumio[729]: info: Apr 11 19:28:01 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:01 blueplayer systemd-udevd[3433]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:01 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:01 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:01 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:01 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:01 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:01 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:01 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:02 blueplayer sudo[3574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:02 blueplayer sudo[3574]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:02 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:02 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:02 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:02 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:02 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:02 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:02 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:02 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:02 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:02 blueplayer sudo[3574]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:02 blueplayer volumio[3582]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:02 blueplayer volumio[3582]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:02 blueplayer volumio[3582]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:02 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:02 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:02 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:02 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:02 blueplayer volumio[3582]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:02 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:02 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:02 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:02 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:02 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:02 blueplayer sudo[3600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:02 blueplayer sudo[3600]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:02 blueplayer sudo[3600]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:02 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:02 blueplayer sudo[3603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:02 blueplayer sudo[3603]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:02 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:02 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:02 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:02 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:02 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer sudo[3609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:02 blueplayer sudo[3609]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:02 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:02 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:02 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:02 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:02 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:02 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:02 blueplayer sudo[3617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:02 blueplayer sudo[3617]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:02 blueplayer sudo[3609]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:02 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:02 blueplayer volumio[3618]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:02 blueplayer volumio[3618]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:02 blueplayer volumio[3618]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:02 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:02 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:02 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:02 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:02 blueplayer sudo[3617]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:02 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:02 blueplayer volumio[3618]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:02 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:03 blueplayer mpd[3610]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:03 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:03 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:03 blueplayer sudo[3603]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:03 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 19:28:03 blueplayer volumio[729]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 11 19:28:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 11 19:28:03 blueplayer volumio[729]: info: Received Get System Version Apr 11 19:28:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 19:28:03 blueplayer volumio[729]: info: Received Get System Info Apr 11 19:28:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 19:28:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 19:28:03 blueplayer volumio[729]: info: Discovery: Getting this device information Apr 11 19:28:03 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 19:28:04 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:04 blueplayer kernel: usb 1-1.2: USB disconnect, device number 17 Apr 11 19:28:04 blueplayer volumio[729]: info: Apr 11 19:28:04 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:04 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:04 blueplayer kernel: usb 1-1.2: new high-speed USB device number 18 using xhci_hcd Apr 11 19:28:04 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:04 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:04 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:04 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:04 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:04 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.000E/input/input13 Apr 11 19:28:04 blueplayer kernel: hid-generic 0003:2D87:000E.000E: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:04 blueplayer volumio[729]: info: Apr 11 19:28:04 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:04 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:05 blueplayer systemd-udevd[3433]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:05 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:05 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:05 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:05 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:05 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:05 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:05 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:05 blueplayer sudo[3655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:05 blueplayer sudo[3655]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:05 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:05 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:05 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:05 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:05 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:05 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:05 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:05 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:05 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:05 blueplayer sudo[3655]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:05 blueplayer volumio[3657]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:05 blueplayer volumio[3657]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:05 blueplayer volumio[3657]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:05 blueplayer volumio[3657]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:05 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:05 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:05 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:05 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:05 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:05 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:05 blueplayer sudo[3664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:05 blueplayer sudo[3664]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:05 blueplayer sudo[3664]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:05 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:05 blueplayer sudo[3667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:05 blueplayer sudo[3667]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:05 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:05 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:05 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:05 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:05 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:05 blueplayer sudo[3673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:05 blueplayer sudo[3673]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:05 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:05 blueplayer sudo[3683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:05 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:05 blueplayer sudo[3683]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:05 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:05 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:05 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:05 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:05 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:05 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:05 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:05 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:05 blueplayer sudo[3683]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:05 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:05 blueplayer systemd[1]: volspotconnect.service: Start request repeated too quickly. Apr 11 19:28:05 blueplayer systemd[1]: volspotconnect.service: Failed with result 'start-limit-hit'. Apr 11 19:28:05 blueplayer systemd[1]: Failed to start Volspotconnect2 Daemon. Apr 11 19:28:05 blueplayer sudo[3673]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:05 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:06 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:06 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:06 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:06 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:06 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:06 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:06 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:06 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:06 blueplayer mpd[3676]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:06 blueplayer kernel: usb 1-1.2: USB disconnect, device number 18 Apr 11 19:28:06 blueplayer volumio[729]: info: Apr 11 19:28:06 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:06 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:06 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:06 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:06 blueplayer sudo[3667]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:06 blueplayer kernel: usb 1-1.2: new high-speed USB device number 19 using xhci_hcd Apr 11 19:28:06 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:06 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:06 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:06 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:06 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:06 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:06 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.000F/input/input14 Apr 11 19:28:06 blueplayer kernel: hid-generic 0003:2D87:000E.000F: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:07 blueplayer volumio[729]: info: Apr 11 19:28:07 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:07 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:07 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:07 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:07 blueplayer systemd-udevd[3431]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:07 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:07 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:07 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:07 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:07 blueplayer sudo[3730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:07 blueplayer sudo[3730]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:07 blueplayer systemd[1]: volspotconnect.service: Start request repeated too quickly. Apr 11 19:28:07 blueplayer systemd[1]: volspotconnect.service: Failed with result 'start-limit-hit'. Apr 11 19:28:07 blueplayer systemd[1]: Failed to start Volspotconnect2 Daemon. Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:07 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:07 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:07 blueplayer sudo[3730]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:07 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:07 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:07 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:07 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:07 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:07 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:07 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:07 blueplayer sudo[3737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:07 blueplayer sudo[3737]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:07 blueplayer sudo[3737]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:07 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:07 blueplayer sudo[3740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:07 blueplayer sudo[3740]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:07 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:07 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:07 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:07 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:07 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:07 blueplayer sudo[3746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:07 blueplayer sudo[3746]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:07 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:07 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:07 blueplayer sudo[3757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:07 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:07 blueplayer sudo[3757]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:07 blueplayer systemd[1]: volspotconnect.service: Start request repeated too quickly. Apr 11 19:28:07 blueplayer systemd[1]: volspotconnect.service: Failed with result 'start-limit-hit'. Apr 11 19:28:07 blueplayer systemd[1]: Failed to start Volspotconnect2 Daemon. Apr 11 19:28:07 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:07 blueplayer sudo[3746]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:07 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:07 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:07 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:07 blueplayer sudo[3757]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:07 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:07 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:08 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:08 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:08 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:08 blueplayer mpd[3747]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:08 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:08 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:08 blueplayer sudo[3740]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:08 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:08 blueplayer kernel: usb 1-1.2: USB disconnect, device number 19 Apr 11 19:28:08 blueplayer volumio[729]: info: Apr 11 19:28:08 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:08 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:08 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:08 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:09 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:09 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:09 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:09 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:09 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:09 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:09 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:09 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:09 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:09 blueplayer kernel: usb 1-1.2: new high-speed USB device number 20 using xhci_hcd Apr 11 19:28:10 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:10 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:10 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:10 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:10 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:10 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0010/input/input15 Apr 11 19:28:10 blueplayer kernel: hid-generic 0003:2D87:000E.0010: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:10 blueplayer volumio[729]: info: Apr 11 19:28:10 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:10 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:10 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:10 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:10 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:10 blueplayer systemd-udevd[3431]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:10 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:10 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:10 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:10 blueplayer sudo[3808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:10 blueplayer sudo[3808]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:10 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:10 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:10 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:10 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:10 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:10 blueplayer sudo[3808]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:10 blueplayer volumio[3810]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:10 blueplayer volumio[3810]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:10 blueplayer volumio[3810]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:10 blueplayer volumio[3810]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:10 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:10 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:10 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:10 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:10 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:10 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:10 blueplayer sudo[3819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:10 blueplayer sudo[3819]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:10 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:10 blueplayer sudo[3819]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:10 blueplayer sudo[3822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:10 blueplayer sudo[3822]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:10 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:10 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:10 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:10 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer sudo[3828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:10 blueplayer sudo[3828]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:10 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:10 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:10 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:10 blueplayer sudo[3836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:10 blueplayer sudo[3836]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:11 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:11 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:11 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:11 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:11 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:11 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:11 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:11 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:11 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:11 blueplayer sudo[3828]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:11 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:11 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:11 blueplayer sudo[3836]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:11 blueplayer volumio[3838]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:11 blueplayer volumio[3838]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:11 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:11 blueplayer volumio[3838]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:11 blueplayer volumio[3838]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:11 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:11 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:11 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:11 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:11 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:11 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:11 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:11 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:11 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:11 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:11 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:11 blueplayer mpd[3834]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:11 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:11 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:11 blueplayer sudo[3822]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:12 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:14 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:14 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:14 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:14 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:14 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:14 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:14 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:14 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:14 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:14 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:16 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:17 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:18 blueplayer kernel: usb 1-1.2: USB disconnect, device number 20 Apr 11 19:28:18 blueplayer volumio[729]: info: Apr 11 19:28:18 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:18 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:18 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:18 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:19 blueplayer kernel: usb 1-1.2: new high-speed USB device number 21 using xhci_hcd Apr 11 19:28:19 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:19 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:19 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:19 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:19 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:19 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0011/input/input16 Apr 11 19:28:19 blueplayer kernel: hid-generic 0003:2D87:000E.0011: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:19 blueplayer volumio[729]: info: Apr 11 19:28:19 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:19 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:19 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer systemd-udevd[3880]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:19 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:19 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:19 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:19 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:19 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:19 blueplayer sudo[3914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:19 blueplayer sudo[3914]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:19 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:19 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:19 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:19 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:19 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:19 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:19 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:19 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:19 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:19 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:19 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:19 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:19 blueplayer sudo[3914]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:19 blueplayer volumio[3916]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:19 blueplayer volumio[3916]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:19 blueplayer volumio[3916]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:19 blueplayer volumio[3916]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:19 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:19 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:19 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:19 blueplayer sudo[3923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:19 blueplayer sudo[3923]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:19 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:19 blueplayer sudo[3923]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:19 blueplayer sudo[3926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:19 blueplayer sudo[3926]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:19 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:19 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:19 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:19 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:19 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:20 blueplayer sudo[3932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:20 blueplayer sudo[3932]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:20 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:20 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:20 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:20 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:20 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:20 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:20 blueplayer sudo[3940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:20 blueplayer sudo[3940]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:20 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:20 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:20 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:20 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:20 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:20 blueplayer sudo[3932]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:20 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:20 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:20 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:20 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:20 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:20 blueplayer volumio[3942]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:20 blueplayer volumio[3942]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:20 blueplayer volumio[3942]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:20 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:20 blueplayer sudo[3940]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:20 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:20 blueplayer volumio[3942]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:20 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:20 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:20 blueplayer mpd[3938]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:21 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:21 blueplayer sudo[3926]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:21 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:22 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:22 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:22 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:23 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:23 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:23 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:23 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:23 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:23 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:23 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:23 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:23 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:23 blueplayer kernel: usb 1-1.2: USB disconnect, device number 21 Apr 11 19:28:23 blueplayer volumio[729]: info: Apr 11 19:28:23 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:23 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:24 blueplayer kernel: usb 1-1.2: new high-speed USB device number 22 using xhci_hcd Apr 11 19:28:24 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:24 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:24 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:24 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:24 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:24 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0012/input/input17 Apr 11 19:28:24 blueplayer kernel: hid-generic 0003:2D87:000E.0012: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:24 blueplayer volumio[729]: info: Apr 11 19:28:24 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:24 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:24 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:24 blueplayer systemd-udevd[3967]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:24 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:24 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:24 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:24 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:24 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:24 blueplayer sudo[3999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:24 blueplayer sudo[3999]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:24 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:24 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:24 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:24 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:24 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:24 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:24 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:24 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:24 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:24 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:24 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:24 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:24 blueplayer sudo[3999]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:24 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:24 blueplayer volumio[4001]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:24 blueplayer volumio[4001]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:24 blueplayer volumio[4001]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:25 blueplayer volumio[4001]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:25 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:25 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:25 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:25 blueplayer sudo[4010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:25 blueplayer sudo[4010]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:25 blueplayer sudo[4010]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:25 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:25 blueplayer sudo[4013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:25 blueplayer sudo[4013]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:25 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:25 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:25 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:25 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer sudo[4019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:25 blueplayer sudo[4019]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:25 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:25 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:25 blueplayer sudo[4027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:25 blueplayer sudo[4027]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:25 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:25 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:25 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:25 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:25 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:25 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:25 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:25 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:25 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:25 blueplayer sudo[4019]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:25 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:25 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:25 blueplayer volumio[4029]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:25 blueplayer volumio[4029]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:25 blueplayer volumio[4029]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:25 blueplayer sudo[4027]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:25 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:25 blueplayer volumio[4029]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:25 blueplayer mpd[4021]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:25 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:26 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:26 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:26 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:26 blueplayer sudo[4013]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:26 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:28 blueplayer kernel: usb 1-1.2: USB disconnect, device number 22 Apr 11 19:28:28 blueplayer volumio[729]: info: Apr 11 19:28:28 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:28 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:28 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:28 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:28 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:28 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:28 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:28 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:28 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:28 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:29 blueplayer kernel: usb 1-1.2: new high-speed USB device number 23 using xhci_hcd Apr 11 19:28:29 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:29 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:29 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:29 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:29 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:29 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0013/input/input18 Apr 11 19:28:29 blueplayer kernel: hid-generic 0003:2D87:000E.0013: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:29 blueplayer volumio[729]: info: Apr 11 19:28:29 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:29 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:29 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer systemd-udevd[4039]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:29 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:29 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:29 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:29 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:29 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:29 blueplayer sudo[4084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:29 blueplayer sudo[4084]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:29 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:29 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:29 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:29 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:29 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:29 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:29 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:29 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:29 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:29 blueplayer sudo[4084]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:29 blueplayer volumio[4086]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:29 blueplayer volumio[4086]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:29 blueplayer volumio[4086]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:29 blueplayer volumio[4086]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:29 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:29 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:29 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:29 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:29 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:29 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:29 blueplayer sudo[4093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:29 blueplayer sudo[4093]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:29 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:29 blueplayer sudo[4093]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:29 blueplayer sudo[4096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:29 blueplayer sudo[4096]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:29 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:29 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:29 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:29 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:30 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer sudo[4102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:30 blueplayer sudo[4102]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:30 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:30 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:30 blueplayer sudo[4110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:30 blueplayer sudo[4110]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:30 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:30 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:30 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:30 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:30 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:30 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:30 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:30 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:30 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:30 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:30 blueplayer sudo[4102]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:30 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:30 blueplayer volumio[4112]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:30 blueplayer volumio[4112]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:30 blueplayer volumio[4112]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:30 blueplayer sudo[4110]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:30 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:30 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:30 blueplayer volumio[4112]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:30 blueplayer mpd[4105]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:31 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:31 blueplayer sudo[4096]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:31 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:31 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:31 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:33 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:33 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:33 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:33 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:33 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:33 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:33 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:33 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:33 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:33 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:34 blueplayer kernel: usb 1-1.2: USB disconnect, device number 23 Apr 11 19:28:34 blueplayer volumio[729]: info: Apr 11 19:28:34 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:34 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:34 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:34 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:34 blueplayer kernel: usb 1-1.2: new high-speed USB device number 24 using xhci_hcd Apr 11 19:28:34 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:34 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:34 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:34 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:34 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:34 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0014/input/input19 Apr 11 19:28:34 blueplayer kernel: hid-generic 0003:2D87:000E.0014: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:34 blueplayer volumio[729]: info: Apr 11 19:28:34 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:34 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:34 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:34 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:35 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:35 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:35 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:35 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:35 blueplayer systemd-udevd[4146]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:35 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:35 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:35 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:35 blueplayer sudo[4171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:35 blueplayer sudo[4171]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:35 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:35 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:35 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:35 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:35 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:35 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:35 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:35 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:35 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:35 blueplayer sudo[4171]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:35 blueplayer volumio[4174]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:35 blueplayer volumio[4174]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:35 blueplayer volumio[4174]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:35 blueplayer volumio[4174]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:35 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:35 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:35 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:35 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:35 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:35 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:35 blueplayer sudo[4182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:35 blueplayer sudo[4182]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:35 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:35 blueplayer sudo[4182]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:35 blueplayer sudo[4185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:35 blueplayer sudo[4185]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:35 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:35 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:35 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:35 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer sudo[4191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:35 blueplayer sudo[4191]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:35 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:35 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:35 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:35 blueplayer sudo[4199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:35 blueplayer sudo[4199]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:35 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:35 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:35 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:35 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:35 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:35 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:35 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:35 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:35 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:35 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:35 blueplayer sudo[4191]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:35 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:35 blueplayer sudo[4199]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:35 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:35 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:35 blueplayer volumio[4201]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:35 blueplayer volumio[4201]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:35 blueplayer volumio[4201]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:35 blueplayer volumio[4201]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:35 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:36 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:36 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:36 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:36 blueplayer mpd[4194]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:36 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:36 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:36 blueplayer sudo[4185]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:36 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:39 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:39 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:39 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:39 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:39 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:39 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:39 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:39 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:39 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:39 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:40 blueplayer kernel: usb 1-1.2: USB disconnect, device number 24 Apr 11 19:28:40 blueplayer volumio[729]: info: Apr 11 19:28:40 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:40 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:40 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:40 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:40 blueplayer kernel: usb 1-1.2: new high-speed USB device number 25 using xhci_hcd Apr 11 19:28:40 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:40 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:40 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:40 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:40 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:40 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0015/input/input20 Apr 11 19:28:40 blueplayer kernel: hid-generic 0003:2D87:000E.0015: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:40 blueplayer volumio[729]: info: Apr 11 19:28:40 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:40 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:40 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:40 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:41 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:41 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:41 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:41 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:41 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:41 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:41 blueplayer systemd-udevd[4236]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:41 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:41 blueplayer sudo[4261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:41 blueplayer sudo[4261]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:41 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:41 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:41 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:41 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:41 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:41 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:41 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:41 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:41 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:41 blueplayer sudo[4261]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:41 blueplayer volumio[4263]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:41 blueplayer volumio[4263]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:41 blueplayer volumio[4263]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:41 blueplayer volumio[4263]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:41 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:41 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:41 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:41 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:41 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:41 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:41 blueplayer sudo[4272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:41 blueplayer sudo[4272]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:41 blueplayer sudo[4272]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:41 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:41 blueplayer sudo[4275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:41 blueplayer sudo[4275]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:41 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:41 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:41 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:41 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:41 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:41 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:41 blueplayer sudo[4281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:41 blueplayer sudo[4281]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:41 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:41 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:41 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:41 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:41 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:41 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:41 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:41 blueplayer sudo[4289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:41 blueplayer sudo[4281]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:41 blueplayer sudo[4289]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:41 blueplayer volumio[4290]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:41 blueplayer volumio[4290]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:41 blueplayer volumio[4290]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:41 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:41 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:41 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:41 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:41 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:41 blueplayer sudo[4289]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:41 blueplayer volumio[4290]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:41 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:41 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:41 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:42 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:42 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:42 blueplayer mpd[4283]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:42 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:42 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:42 blueplayer sudo[4275]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:42 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:45 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:45 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:45 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:45 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:45 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:45 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:45 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:45 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:45 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:45 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:47 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:47 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:48 blueplayer kernel: usb 1-1.2: USB disconnect, device number 25 Apr 11 19:28:48 blueplayer volumio[729]: info: Apr 11 19:28:48 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:48 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:48 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:48 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:48 blueplayer kernel: usb 1-1.2: new high-speed USB device number 26 using xhci_hcd Apr 11 19:28:48 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:48 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:48 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:48 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:48 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:48 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0016/input/input21 Apr 11 19:28:48 blueplayer kernel: hid-generic 0003:2D87:000E.0016: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:49 blueplayer volumio[729]: info: Apr 11 19:28:49 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:49 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:49 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:49 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:49 blueplayer systemd-udevd[4328]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:49 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:49 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:49 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:49 blueplayer sudo[4353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:49 blueplayer sudo[4353]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:49 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:49 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:49 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:49 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:49 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:49 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:49 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:49 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:49 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:49 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:49 blueplayer sudo[4353]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:49 blueplayer volumio[4355]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:49 blueplayer volumio[4355]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:49 blueplayer volumio[4355]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:49 blueplayer volumio[4355]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:49 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:49 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:49 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:49 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:49 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:49 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:49 blueplayer sudo[4364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:49 blueplayer sudo[4364]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:49 blueplayer sudo[4364]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:49 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:49 blueplayer sudo[4367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:49 blueplayer sudo[4367]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:49 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:49 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:49 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:49 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer sudo[4373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:49 blueplayer sudo[4373]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:49 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:49 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:49 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:49 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:49 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:49 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:49 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:49 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:49 blueplayer sudo[4381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:49 blueplayer sudo[4381]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:49 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:49 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:49 blueplayer sudo[4373]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:49 blueplayer volumio[4384]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:49 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:49 blueplayer volumio[4384]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:49 blueplayer volumio[4384]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:49 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:49 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:49 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:49 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:49 blueplayer sudo[4381]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:49 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:49 blueplayer volumio[4384]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:50 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:50 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:50 blueplayer mpd[4379]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:50 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:50 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:50 blueplayer sudo[4367]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:50 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:28:53 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:53 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:53 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:28:53 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:53 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:53 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:53 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:53 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:53 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:53 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:55 blueplayer kernel: usb 1-1.2: USB disconnect, device number 26 Apr 11 19:28:55 blueplayer volumio[729]: info: Apr 11 19:28:55 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:55 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:55 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:55 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:28:55 blueplayer kernel: usb 1-1.2: new high-speed USB device number 27 using xhci_hcd Apr 11 19:28:55 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:55 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:28:55 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:28:55 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:28:55 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:28:55 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:28:55 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0017/input/input22 Apr 11 19:28:55 blueplayer kernel: hid-generic 0003:2D87:000E.0017: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:28:55 blueplayer volumio[729]: info: Apr 11 19:28:55 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:28:55 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:28:55 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:28:55 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:56 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:28:56 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer systemd-udevd[4418]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:28:56 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:28:56 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:28:56 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:28:56 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:56 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:28:56 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:28:56 blueplayer sudo[4443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:56 blueplayer sudo[4443]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:56 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:28:56 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:28:56 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:28:56 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:56 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:56 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:56 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:28:56 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:28:56 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:56 blueplayer sudo[4443]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:56 blueplayer volumio[4445]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:56 blueplayer volumio[4445]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:56 blueplayer volumio[4445]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:56 blueplayer volumio[4445]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:28:56 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:28:56 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:28:56 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:28:56 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:56 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:28:56 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:28:56 blueplayer sudo[4452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:28:56 blueplayer sudo[4452]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:56 blueplayer sudo[4452]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:56 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:56 blueplayer sudo[4455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:28:56 blueplayer sudo[4455]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:56 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:28:56 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:28:56 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:28:56 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:28:56 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:28:56 blueplayer sudo[4461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:28:56 blueplayer sudo[4461]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:56 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:28:56 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:28:56 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:28:56 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:28:56 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:28:56 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:28:56 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:28:56 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:28:56 blueplayer sudo[4469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:28:56 blueplayer sudo[4469]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:28:56 blueplayer sudo[4461]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:56 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:28:56 blueplayer volumio[4470]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:28:56 blueplayer volumio[4470]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:28:56 blueplayer volumio[4470]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:28:56 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:28:56 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:28:56 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:56 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:28:56 blueplayer sudo[4469]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:56 blueplayer volumio[4470]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:28:56 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:28:56 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:28:57 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:57 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:28:57 blueplayer mpd[4462]: Apr 11 19:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:28:57 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:28:57 blueplayer sudo[4455]: pam_unix(sudo:session): session closed for user root Apr 11 19:28:57 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:28:59 blueplayer kernel: usb 1-1.2: USB disconnect, device number 27 Apr 11 19:28:59 blueplayer volumio[729]: info: Apr 11 19:28:59 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:28:59 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:28:59 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:28:59 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:29:00 blueplayer kernel: usb 1-1.2: new high-speed USB device number 28 using xhci_hcd Apr 11 19:29:00 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:29:00 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:29:00 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:29:00 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:29:00 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:29:00 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0018/input/input23 Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:00 blueplayer kernel: hid-generic 0003:2D87:000E.0018: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:29:00 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:00 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:00 blueplayer volumio[729]: info: Apr 11 19:29:00 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:00 blueplayer systemd-udevd[4536]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:00 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:29:00 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:29:00 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:29:00 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:29:00 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:29:00 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:00 blueplayer sudo[4568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:00 blueplayer sudo[4568]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:00 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:00 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:00 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:00 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:00 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:00 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:00 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:00 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:29:00 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:29:00 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:00 blueplayer sudo[4568]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:00 blueplayer volumio[4570]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:00 blueplayer volumio[4570]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:00 blueplayer volumio[4570]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:00 blueplayer volumio[4570]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:29:00 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:29:00 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:29:00 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:29:00 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:00 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:29:00 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:29:00 blueplayer sudo[4579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:29:00 blueplayer sudo[4579]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:00 blueplayer sudo[4579]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:00 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:00 blueplayer sudo[4582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:29:00 blueplayer sudo[4582]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:00 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:29:00 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:29:00 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:00 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:01 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer sudo[4588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:01 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:29:01 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:29:01 blueplayer sudo[4588]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:29:01 blueplayer sudo[4596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:29:01 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:29:01 blueplayer sudo[4596]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:01 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:29:01 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:01 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:29:01 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:01 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:01 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:01 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:29:01 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:01 blueplayer sudo[4588]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:01 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:01 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:01 blueplayer sudo[4596]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:01 blueplayer volumio[4598]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:01 blueplayer volumio[4598]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:01 blueplayer volumio[4598]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:01 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:29:01 blueplayer volumio[4598]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:01 blueplayer mpd[4590]: Apr 11 19:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:29:01 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:29:02 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:29:02 blueplayer sudo[4582]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:02 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:29:02 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:02 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:02 blueplayer volumio[729]: info: CoreCommandRouter::volumioPause Apr 11 19:29:02 blueplayer volumio[729]: info: CoreStateMachine::pause Apr 11 19:29:02 blueplayer volumio[729]: info: CoreStateMachine::stPlaybackTimer Apr 11 19:29:02 blueplayer volumio[729]: info: CoreStateMachine::servicePause Apr 11 19:29:02 blueplayer volumio[729]: info: CorePlayQueue::getTrack 0 Apr 11 19:29:02 blueplayer volumio[729]: info: Error: no service or no trackblock to pause Apr 11 19:29:03 blueplayer kernel: usb 1-1.2: USB disconnect, device number 28 Apr 11 19:29:03 blueplayer volumio[729]: info: Apr 11 19:29:03 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:29:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:29:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:03 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:29:03 blueplayer kernel: usb 1-1.2: new high-speed USB device number 29 using xhci_hcd Apr 11 19:29:04 blueplayer kernel: usb 1-1.2: device descriptor read/64, error -71 Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:29:04 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:04 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:29:04 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:29:04 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:29:04 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:29:04 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:04 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:04 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.0019/input/input24 Apr 11 19:29:04 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:29:04 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:04 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:04 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:04 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:04 blueplayer kernel: hid-generic 0003:2D87:000E.0019: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:04 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:04 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:04 blueplayer volumio[729]: info: Apr 11 19:29:04 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:04 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:29:04 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:04 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:04 blueplayer systemd-udevd[4536]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:29:05 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:29:05 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:29:05 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:29:05 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:05 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:05 blueplayer sudo[4649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:05 blueplayer sudo[4649]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:05 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:05 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:05 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:05 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:05 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:05 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:05 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:29:05 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:29:05 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:05 blueplayer sudo[4649]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:05 blueplayer volumio[4651]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:05 blueplayer volumio[4651]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:05 blueplayer volumio[4651]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:05 blueplayer volumio[4651]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:29:05 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:29:05 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:29:05 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:29:05 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:05 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:29:05 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:29:05 blueplayer sudo[4658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:29:05 blueplayer sudo[4658]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:05 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:05 blueplayer sudo[4658]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:05 blueplayer sudo[4661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:29:05 blueplayer sudo[4661]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:05 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:29:05 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:29:05 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:05 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer sudo[4667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:05 blueplayer sudo[4667]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:05 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:29:05 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:29:05 blueplayer sudo[4675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:29:05 blueplayer sudo[4675]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:05 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:29:05 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:29:05 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:05 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:29:05 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:05 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:05 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:05 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:29:05 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:05 blueplayer sudo[4667]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:05 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:05 blueplayer sudo[4675]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:05 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:05 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:29:05 blueplayer volumio[4677]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:05 blueplayer volumio[4677]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:05 blueplayer volumio[4677]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:05 blueplayer volumio[4677]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:05 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:05 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:06 blueplayer mpd[4670]: Apr 11 19:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:29:06 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:29:06 blueplayer sudo[4661]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:06 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:29:06 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:07 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:29:09 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:09 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:09 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:29:09 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:09 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:09 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:09 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:09 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:09 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:09 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:11 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:11 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:13 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 19:29:13 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 19:29:13 blueplayer volumio[729]: info: Discovery: Getting this device information Apr 11 19:29:13 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:13 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 19:29:14 blueplayer kernel: usb 1-1.2: USB disconnect, device number 29 Apr 11 19:29:14 blueplayer volumio[729]: info: Apr 11 19:29:14 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:29:14 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:29:14 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:14 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:29:14 blueplayer kernel: usb 1-1.2: new high-speed USB device number 30 using xhci_hcd Apr 11 19:29:14 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:29:14 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:29:14 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:29:14 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:29:14 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:29:14 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.001A/input/input25 Apr 11 19:29:14 blueplayer kernel: hid-generic 0003:2D87:000E.001A: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:29:14 blueplayer volumio[729]: info: Apr 11 19:29:14 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:29:14 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:29:14 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:29:14 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:15 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:29:15 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer systemd-udevd[4721]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:29:15 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:29:15 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:29:15 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:29:15 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:15 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:15 blueplayer sudo[4746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:15 blueplayer sudo[4746]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:15 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:15 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:15 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:15 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:15 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:15 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:15 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:29:15 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:29:15 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:15 blueplayer sudo[4746]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:15 blueplayer volumio[4748]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:15 blueplayer volumio[4748]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:15 blueplayer volumio[4748]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:15 blueplayer volumio[4748]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:29:15 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:29:15 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:29:15 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:29:15 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:15 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:29:15 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:29:15 blueplayer sudo[4758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:29:15 blueplayer sudo[4758]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:15 blueplayer sudo[4758]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:15 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:15 blueplayer sudo[4761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:29:15 blueplayer sudo[4761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:15 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:29:15 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:29:15 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:15 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer sudo[4767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:15 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:29:15 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:29:15 blueplayer sudo[4767]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:15 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:29:15 blueplayer sudo[4775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:29:15 blueplayer sudo[4775]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:15 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:29:15 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:15 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:29:15 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:29:15 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:15 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:15 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:15 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:15 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:15 blueplayer sudo[4767]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:15 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:15 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:15 blueplayer sudo[4775]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:15 blueplayer volumio[4777]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:15 blueplayer volumio[4777]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:15 blueplayer volumio[4777]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:15 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:29:15 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:29:15 blueplayer volumio[4777]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:16 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:16 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:16 blueplayer mpd[4769]: Apr 11 19:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:29:16 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:29:16 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:29:16 blueplayer sudo[4761]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:16 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:29:19 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:19 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:19 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:29:19 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:19 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:19 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:19 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:19 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:19 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:19 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:21 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:21 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:22 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 19:29:22 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 19:29:22 blueplayer volumio[729]: info: Discovery: Getting this device information Apr 11 19:29:22 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:22 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 19:29:23 blueplayer volumio[729]: verbose: New Socket.io Connection to 192.168.1.62 from 192.168.1.42 UA: okhttp/4.9.2 Total Clients: 9 Apr 11 19:29:23 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:23 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 11 19:29:23 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 11 19:29:25 blueplayer kernel: usb 1-1.2: USB disconnect, device number 30 Apr 11 19:29:25 blueplayer volumio[729]: info: Apr 11 19:29:25 blueplayer volumio[729]: ---------------------------- USB Audio Device Detached Apr 11 19:29:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 11 19:29:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:25 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 11 19:29:26 blueplayer kernel: usb 1-1.2: new high-speed USB device number 31 using xhci_hcd Apr 11 19:29:26 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:29:26 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:29:26 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:29:26 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:29:26 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:29:26 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.001B/input/input26 Apr 11 19:29:26 blueplayer kernel: hid-generic 0003:2D87:000E.001B: input,hidraw0: USB HID v1.10 Device [Cayin Cayin CS-100DAC] on usb-0000:01:00.0-1.2/input3 Apr 11 19:29:26 blueplayer volumio[729]: info: Apr 11 19:29:26 blueplayer volumio[729]: ---------------------------- USB Audio Device Attached Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::Close All Modals sent Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:26 blueplayer volumio[729]: info: Setting default mixerSoftMaster for Softvolume device Apr 11 19:29:26 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:26 blueplayer systemd-udevd[4813]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 11 19:29:26 blueplayer volumio[729]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 11 19:29:26 blueplayer volumio[729]: info: Disabling external Volume Control Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 19:29:26 blueplayer volumio[729]: info: Enable softmixer device for audio device undefined Apr 11 19:29:26 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:26 blueplayer sudo[4844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:26 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:26 blueplayer sudo[4844]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:26 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:26 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:26 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:26 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:26 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:26 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:26 blueplayer volumio[729]: info: Software Volume ALSA configuration written Apr 11 19:29:26 blueplayer volumio[729]: info: Preparing to generate the ALSA configuration file Apr 11 19:29:26 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:26 blueplayer sudo[4844]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:26 blueplayer volumio[4846]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:26 blueplayer volumio[4846]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:26 blueplayer volumio[4846]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:26 blueplayer volumio[4846]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 11 19:29:26 blueplayer volumio[729]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 19:29:26 blueplayer volumio[729]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 19:29:26 blueplayer volumio[729]: info: Reading ALSA contributions from plugins. Apr 11 19:29:26 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:26 blueplayer volumio[729]: info: Asound.conf file unchanged, so no further update is needed Apr 11 19:29:26 blueplayer volumio[729]: info: Output device has changed, restarting MPD Apr 11 19:29:26 blueplayer sudo[4855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 19:29:26 blueplayer sudo[4855]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:26 blueplayer volumio[729]: info: Output device has changed, restarting Shairport Sync Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:26 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:27 blueplayer sudo[4855]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:27 blueplayer sudo[4858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 19:29:27 blueplayer sudo[4858]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:27 blueplayer systemd[1]: Stopping Music Player Daemon... Apr 11 19:29:27 blueplayer volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 19:29:27 blueplayer volumio[729]: [SpotifyConnect] Creating VLS config file Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 11 19:29:27 blueplayer volumio[729]: info: MPD Permissions set Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer systemd[1]: mpd.service: Succeeded. Apr 11 19:29:27 blueplayer systemd[1]: Stopped Music Player Daemon. Apr 11 19:29:27 blueplayer sudo[4864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 11 19:29:27 blueplayer sudo[4864]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: Starting Shairport Sync Apr 11 19:29:27 blueplayer sudo[4873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 19:29:27 blueplayer sudo[4873]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:27 blueplayer systemd[1]: Starting Music Player Daemon... Apr 11 19:29:27 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 19:29:27 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 11 19:29:27 blueplayer systemd[1]: shairport-sync.service: Succeeded. Apr 11 19:29:27 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:27 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 11 19:29:27 blueplayer systemd[1]: volspotconnect.service: Succeeded. Apr 11 19:29:27 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Apr 11 19:29:27 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Apr 11 19:29:27 blueplayer sudo[4864]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:27 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 19:29:27 blueplayer volumio[729]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 11 19:29:27 blueplayer sudo[4873]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:27 blueplayer volumio[729]: info: Shairport-Sync Started Apr 11 19:29:27 blueplayer volumio[4875]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 11 19:29:27 blueplayer volumio[4875]: Reading Config from "/tmp/volspotify.toml" Apr 11 19:29:27 blueplayer volumio[4875]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 11 19:29:27 blueplayer volumio[4875]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 19:29:27 blueplayer mpd[4867]: Apr 11 19:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 19:29:27 blueplayer volumio[729]: error: Upnp client error: Error: This socket has been ended by the other party Apr 11 19:29:28 blueplayer systemd[1]: Started Music Player Daemon. Apr 11 19:29:28 blueplayer sudo[4858]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:28 blueplayer volumio[729]: error: updateQueue error: null Apr 11 19:29:28 blueplayer sudo[4883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 19:29:28 blueplayer sudo[4883]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:28 blueplayer sudo[4883]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:28 blueplayer sudo[4886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 19:29:28 blueplayer sudo[4886]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:28 blueplayer sudo[4886]: pam_unix(sudo:session): session closed for user root Apr 11 19:29:28 blueplayer volumio[729]: verbose: New Socket.io Connection to 192.168.1.62 from 192.168.1.42 UA: okhttp/4.9.2 Total Clients: 10 Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 11 19:29:28 blueplayer volumio[729]: info: Received Get System Info Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 19:29:28 blueplayer volumio[729]: info: Discovery: Getting this device information Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:28 blueplayer volumio[729]: info: Listing playlists Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 11 19:29:28 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 11 19:29:30 blueplayer volumio[729]: info: Received Get System Info Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 19:29:30 blueplayer volumio[729]: info: Discovery: Getting this device information Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 11 19:29:30 blueplayer volumio[729]: info: CoreStateMachine::getcurrentVolume Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:30 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:30 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:29:30 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:30 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CoreStateMachine::getQueue Apr 11 19:29:30 blueplayer volumio[729]: info: CorePlayQueue::getQueue Apr 11 19:29:32 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 19:29:32 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 19:29:32 blueplayer volumio[729]: info: Discovery: Getting this device information Apr 11 19:29:32 blueplayer volumio[729]: info: CoreCommandRouter::volumioGetState Apr 11 19:29:32 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 19:29:32 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:33 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 11 19:29:33 blueplayer volumio[729]: info: CURURI: music-library/USB/01DA5679BE0D5FB0 Apr 11 19:29:33 blueplayer volumio[729]: info: Preload queue cleared Apr 11 19:29:33 blueplayer volumio[729]: info: Checking Spotify Web API Apr 11 19:29:37 blueplayer volumio[729]: info: Preload queue cleared Apr 11 19:29:37 blueplayer volumio[729]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::ClearQueue Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::stop Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::updateTrackBlock Apr 11 19:29:37 blueplayer volumio[729]: info: CorePlayQueue::getTrackBlock Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::stPlaybackTimer Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::pushState Apr 11 19:29:37 blueplayer volumio[729]: info: CorePlayQueue::getTrack 0 Apr 11 19:29:37 blueplayer volumio[729]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 19:29:37 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushState Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::serviceStop Apr 11 19:29:37 blueplayer volumio[729]: info: CorePlayQueue::getTrack 0 Apr 11 19:29:37 blueplayer volumio[729]: info: ControllerMpd::stop Apr 11 19:29:37 blueplayer volumio[729]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 19:29:37 blueplayer volumio[729]: info: CorePlayQueue::clearPlayQueue Apr 11 19:29:37 blueplayer volumio[729]: info: CorePlayQueue::saveQueue Apr 11 19:29:37 blueplayer volumio[729]: info: CoreCommandRouter::volumioPushQueue Apr 11 19:29:37 blueplayer volumio[729]: info: CoreStateMachine::addQueueItems Apr 11 19:29:37 blueplayer volumio[729]: info: CorePlayQueue::addQueueItems Apr 11 19:29:37 blueplayer volumio[729]: info: Preload queue cleared Apr 11 19:29:37 blueplayer volumio[729]: info: Adding Item to queue: music-library/USB/01DA5679BE0D5FB0/1-(Vocal-Jazz) Apr 11 19:29:37 blueplayer volumio[729]: info: Exploding uri music-library/USB/01DA5679BE0D5FB0/1-(Vocal-Jazz) in service mpd Apr 11 19:29:39 blueplayer kernel: usb 1-1.2: USB disconnect, device number 31 Apr 11 19:29:39 blueplayer volumio[729]: info: ALBUMART /albumart?cacheid=224&web=/Inspiration%2C%20A%20Tribute%20To%20Nat%20King%20Cole/medium&path=%2Fmnt%2FUSB%2F01DA5679BE0D5FB0%2F1-(Vocal-Jazz)%2F(Smooth%20Jazz)%20George%20Benson%20-%20Inspiration%2C%20A%20Tribute%20To%20Nat%20King%20Cole%2Fgeorge_benson-inspiration_0888072345188.cue&metadata=false Apr 11 19:29:39 blueplayer volumio[729]: info: URI /mnt/USB/01DA5679BE0D5FB0/1-(Vocal-Jazz)/(Smooth Jazz) George Benson - Inspiration, A Tribute To Nat King Cole/george_benson-inspiration_0888072345188.cue Apr 11 19:29:39 blueplayer volumio[729]: info: ALBUMART /albumart?cacheid=224&web=/Inspiration%2C%20A%20Tribute%20To%20Nat%20King%20Cole/medium&path=%2Fmnt%2FUSB%2F01DA5679BE0D5FB0%2F1-(Vocal-Jazz)%2F(Smooth%20Jazz)%20George%20Benson%20-%20Inspiration%2C%20A%20Tribute%20To%20Nat%20King%20Cole%2Fgeorge_benson-inspiration_0888072345188.cue&metadata=false Apr 11 19:29:39 blueplayer volumio[729]: info: URI /mnt/USB/01DA5679BE0D5FB0/1-(Vocal-Jazz)/(Smooth Jazz) George Benson - Inspiration, A Tribute To Nat King Cole/george_benson-inspiration_0888072345188.cue Apr 11 19:29:39 blueplayer volumio[729]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 19:29:39 blueplayer volumio[729]: Error: Unable to resolve or reject the same promise twice Apr 11 19:29:39 blueplayer volumio[729]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 11 19:29:39 blueplayer volumio[729]: at /volumio/app/plugins/music_service/mpd/index.js:2542:21 Apr 11 19:29:39 blueplayer volumio[729]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 11 19:29:39 blueplayer volumio[729]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 11 19:29:39 blueplayer volumio[729]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 11 19:29:39 blueplayer volumio[729]: at Socket.emit (events.js:315:20) Apr 11 19:29:39 blueplayer volumio[729]: at addChunk (internal/streams/readable.js:309:12) Apr 11 19:29:39 blueplayer volumio[729]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 11 19:29:39 blueplayer volumio[729]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 11 19:29:39 blueplayer volumio[729]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 11 19:29:39 blueplayer volumio[729]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 19:29:39 blueplayer kernel: usb 1-1.2: new high-speed USB device number 32 using xhci_hcd Apr 11 19:29:39 blueplayer sudo[4941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-11 19:28 Apr 11 19:29:39 blueplayer sudo[4941]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 19:29:39 blueplayer kernel: usb 1-1.2: New USB device found, idVendor=2d87, idProduct=000e, bcdDevice= 1.00 Apr 11 19:29:39 blueplayer kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Apr 11 19:29:39 blueplayer kernel: usb 1-1.2: Product: Cayin CS-100DAC Apr 11 19:29:39 blueplayer kernel: usb 1-1.2: Manufacturer: Cayin Apr 11 19:29:39 blueplayer kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Apr 11 19:29:39 blueplayer kernel: input: Cayin Cayin CS-100DAC as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.3/0003:2D87:000E.001C/input/input27 PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"