-- Logs begin at Tue 2022-09-06 10:01:32 UTC, end at Wed 2026-10-14 10:05:07 UTC. -- Oct 14 10:04:07 musical-fidelity volumio[1022]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"} Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CorePlayQueue::getTrack 0 Oct 14 10:04:07 musical-fidelity volumio[1022]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received inputs Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 10:04:07 musical-fidelity volumio[1022]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"} Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus Oct 14 10:04:07 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4: new high-speed USB device number 6 using dwc_otg Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4: New USB device found, idVendor=0424, idProduct=2412 Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Oct 14 10:04:08 musical-fidelity kernel: hub 1-1.4:1.0: USB hub found Oct 14 10:04:08 musical-fidelity kernel: hub 1-1.4:1.0: 2 ports detected Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: new high-speed USB device number 7 using dwc_otg Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: New USB device found, idVendor=20b1, idProduct=3086 Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: Product: Singxer USB Audio 2.0 G2 Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: Manufacturer: Singxer Oct 14 10:04:08 musical-fidelity volumio[1022]: info: Received Push USB{"activeRoute":"1","powerShutdown":"0"} Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , enablePCInput Oct 14 10:04:08 musical-fidelity volumio[1022]: info: Unsetting Volatile before setting PC Input Oct 14 10:04:08 musical-fidelity volumio[1022]: verbose: UNSET VOLATILE Oct 14 10:04:08 musical-fidelity volumio[1022]: info: unSetVolatile called Oct 14 10:04:08 musical-fidelity volumio[1022]: info: Relinquishing Volumio State to another service Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioStop Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreStateMachine::stop Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:04:08 musical-fidelity volumio[1022]: verbose: UNSET VOLATILE Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreStateMachine::stPlaybackTimer Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreStateMachine::updateTrackBlock Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CorePlayQueue::getTrackBlock Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CorePlayQueue::getTrack 0 Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreStateMachine::serviceStop Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CorePlayQueue::getTrack 0 Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::serviceStop Oct 14 10:04:08 musical-fidelity volumio[1022]: info: [1791972248855] ControllerWebradio::stop Oct 14 10:04:08 musical-fidelity volumio[1022]: verbose: ControllerMpd::sendMpdCommand stop Oct 14 10:04:08 musical-fidelity volumio[1022]: info: Updating push state because input changed Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 14 10:04:08 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 10:04:08 musical-fidelity volumio[1022]: info: sendMpdCommand stop took 17 milliseconds Oct 14 10:04:08 musical-fidelity kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Oct 14 10:04:08 musical-fidelity kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4: USB disconnect, device number 6 Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: USB disconnect, device number 7 Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: parse_audio_format_rates_v2(): unable to find clock source (clock -19) Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: parse_audio_format_rates_v2(): unable to find clock source (clock -19) Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: cannot get ctl value: req = 0x83, wValue = 0x201, wIndex = 0xa00, type = 4 Oct 14 10:04:08 musical-fidelity kernel: usb 1-1.4.2: 10:0: cannot get min/max values for control 2 (id 10) Oct 14 10:04:08 musical-fidelity kernel: usbcore: registered new interface driver snd-usb-audio Oct 14 10:04:08 musical-fidelity systemd-udevd[6591]: error opening ATTR{/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4.2/1-1.4.2:1.0/sound/card5/controlC5/../uevent} for writing: No such file or directory Oct 14 10:04:08 musical-fidelity systemd-udevd[6591]: Failed to apply ACL on /dev/snd/controlC5: No such file or directory Oct 14 10:04:08 musical-fidelity systemd[1]: Starting Sound Card. Oct 14 10:04:08 musical-fidelity systemd[1]: Reached target Sound Card. Oct 14 10:04:08 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:08 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Oct 14 10:04:09 musical-fidelity volumio[1022]: ---------------------------- USB Audio Device Attached Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , usbAudioAttach Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: raat , returnFromUSB Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 14 10:04:09 musical-fidelity volumio[1022]: aplay: device_list:268: no soundcards found... Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Oct 14 10:04:09 musical-fidelity volumio[1022]: aplay: device_list:268: no soundcards found... Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::Close All Modals sent Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Output device has changed, restarting MPD Oct 14 10:04:09 musical-fidelity sudo[6615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Output device has changed, restarting Shairport Sync Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 10:04:09 musical-fidelity volumio[1022]: [SpotifyConnect] Creating VLS config file Oct 14 10:04:09 musical-fidelity sudo[6615]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Relinquishing Volumio State Oct 14 10:04:09 musical-fidelity volumio[1022]: verbose: UNSET VOLATILE Oct 14 10:04:09 musical-fidelity sudo[6619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 10:04:09 musical-fidelity sudo[6615]: pam_unix(sudo:session): session closed for user root Oct 14 10:04:09 musical-fidelity sudo[6619]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 14 10:04:09 musical-fidelity systemd[1]: Stopping Music Player Daemon... Oct 14 10:04:09 musical-fidelity sudo[6631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 10:04:09 musical-fidelity sudo[6631]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 14 10:04:09 musical-fidelity systemd[1]: Stopped Volumio Tidal Connect Service. Oct 14 10:04:09 musical-fidelity volumio[1022]: aplay: device_list:268: no soundcards found... Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 10:04:09 musical-fidelity sudo[6631]: pam_unix(sudo:session): session closed for user root Oct 14 10:04:09 musical-fidelity volumio[1022]: Invalid card number. Oct 14 10:04:09 musical-fidelity volumio[1022]: aplay: device_list:268: no soundcards found... Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 14 10:04:09 musical-fidelity systemd-udevd[6597]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Notifying PC INPUT Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CorePlayQueue::getTrack 0 Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received inputs Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumiosetSourceActivepc_input Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 10:04:09 musical-fidelity sudo[6650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity sudo[6650]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 14 10:04:09 musical-fidelity volumio[1022]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 14 10:04:09 musical-fidelity systemd[1]: Stopped Volumio Tidal Connect Service. Oct 14 10:04:09 musical-fidelity sudo[6650]: pam_unix(sudo:session): session closed for user root Oct 14 10:04:09 musical-fidelity volumio[1022]: info: MPD Permissions set Oct 14 10:04:09 musical-fidelity systemd[1]: Starting Music Player Daemon... Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: [SpotifyConnect] Restarting Vollibrespot Daemon Oct 14 10:04:09 musical-fidelity sudo[6667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Oct 14 10:04:09 musical-fidelity sudo[6667]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 14 10:04:09 musical-fidelity volumio[1022]: aplay: device_list:268: no soundcards found... Oct 14 10:04:09 musical-fidelity systemd[1]: Stopping Volspotconnect2 Daemon... Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 10:04:09 musical-fidelity systemd[1]: Starting Volspotconnect2 Daemon... Oct 14 10:04:09 musical-fidelity systemd[1]: Started Volspotconnect2 Daemon. Oct 14 10:04:09 musical-fidelity sudo[6667]: pam_unix(sudo:session): session closed for user root Oct 14 10:04:09 musical-fidelity volumio[1022]: Invalid card number. Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 14 10:04:09 musical-fidelity volumio[6676]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 14 10:04:09 musical-fidelity volumio[6676]: Reading Config from "/tmp/volspotify.toml" Oct 14 10:04:09 musical-fidelity volumio[6676]: [Vollibrespot] : Using Alsa backend with device: plughw:5 Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Oct 14 10:04:09 musical-fidelity volumio[1022]: ---------------------------- USB Audio Device Detached Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: inputs , usbAudioDetach Oct 14 10:04:09 musical-fidelity systemd[1]: Service sound.target is not needed anymore. Stopping. Oct 14 10:04:09 musical-fidelity systemd[1]: Stopping Sound Card. Oct 14 10:04:09 musical-fidelity systemd[1]: Stopped target Sound Card. Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:09 musical-fidelity volumio[1022]: error: Upnp client error: Error: This socket has been ended by the other party Oct 14 10:04:09 musical-fidelity volumio[6676]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Oct 14 10:04:09 musical-fidelity volumio[1022]: info: VolumeController:: Volume=undefined Mute =false Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:09 musical-fidelity volumio[1022]: [SpotifyConnect] Vollibrespot Daemon service restarted! Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Not Reporting Auto name since its the default one Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 10:04:09 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 10:04:09 musical-fidelity volumio[1022]: aplay: device_list:268: no soundcards found... Oct 14 10:04:09 musical-fidelity volumio[1022]: info: Configured Audio card not found, not starting RAAT Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreStateMachine::getcurrentVolume Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioRetrievevolume Oct 14 10:04:11 musical-fidelity volumio[1022]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 14 10:04:11 musical-fidelity volumio[1022]: info: VolumeController:: Volume=undefined Mute =false Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreStateMachine::updateTrackBlock Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CorePlayQueue::getTrackBlock Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioRetrievevolume Oct 14 10:04:11 musical-fidelity volumio[1022]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 14 10:04:11 musical-fidelity volumio[1022]: info: VolumeController:: Volume=undefined Mute =false Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:11 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:12 musical-fidelity volumio[1022]: info: TidalConnect service stoped! Oct 14 10:04:12 musical-fidelity volumio[1022]: info: TidalConnect service stoped! Oct 14 10:04:12 musical-fidelity volumio[1022]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 10:04:12 musical-fidelity volumio[1022]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 10:04:12 musical-fidelity sudo[6721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 10:04:12 musical-fidelity sudo[6721]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 14 10:04:12 musical-fidelity systemd[1]: Starting Volumio Tidal Connect Service... Oct 14 10:04:12 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:12 musical-fidelity systemd[1]: Started Volumio Tidal Connect Service. Oct 14 10:04:12 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:12 musical-fidelity sudo[6721]: pam_unix(sudo:session): session closed for user root Oct 14 10:04:12 musical-fidelity volumio[1022]: info: Executing endpoint tc_getconfig Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 14 10:04:12 musical-fidelity vtcs[6726]: STARTING TidalConnect services, version: 1.1.7.5 Oct 14 10:04:12 musical-fidelity vtcs[6726]: STARTED TidalConnect services. Oct 14 10:04:12 musical-fidelity volumio[1022]: info: Executing endpoint tc_connect Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 14 10:04:12 musical-fidelity volumio[1022]: info: Connecting to TidalConnect Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:12 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:12 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:15 musical-fidelity volumio[1022]: info: TidalConnect service started! Oct 14 10:04:15 musical-fidelity volumio[1022]: info: Checking Spotify Web API Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioGetState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioGetState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: Currently active: tidalconnect Oct 14 10:04:18 musical-fidelity volumio[1022]: info: Not requsting volumioStop on our own service Oct 14 10:04:18 musical-fidelity volumio[1022]: info: TidalConnect Active Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioGetState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: Currently active: tidalconnect Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity vtcs[6726]: [2026-10-14 10:04:18.364] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:1 Oct 14 10:04:18 musical-fidelity volumio[1022]: info: Pushing metadata Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity vtcs[6726]: [2026-10-14 10:04:18.942] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data! Oct 14 10:04:18 musical-fidelity volumio[1022]: info: Pushing metadata Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:18 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:19 musical-fidelity volumio[1022]: info: CoreCommandRouter::servicePushState Oct 14 10:04:19 musical-fidelity volumio[1022]: info: CoreStateMachine::pushState Oct 14 10:04:19 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioPushState Oct 14 10:04:19 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:04:19 musical-fidelity vtcs[6726]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card Oct 14 10:04:19 musical-fidelity vtcs[6726]: Segmentation fault Oct 14 10:04:19 musical-fidelity systemd[1]: vtcs.service: main process exited, code=exited, status=139/n/a Oct 14 10:04:19 musical-fidelity systemd[1]: Unit vtcs.service entered failed state. Oct 14 10:04:19 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:19 musical-fidelity systemd[1]: vtcs.service holdoff time over, scheduling restart. Oct 14 10:04:19 musical-fidelity systemd[1]: Stopping Volumio Tidal Connect Service... Oct 14 10:04:19 musical-fidelity systemd[1]: Starting Volumio Tidal Connect Service... Oct 14 10:04:19 musical-fidelity systemd[1]: Started Volumio Tidal Connect Service. Oct 14 10:04:19 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:19 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:19 musical-fidelity volumio[1022]: info: Executing endpoint tc_getconfig Oct 14 10:04:19 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 14 10:04:19 musical-fidelity vtcs[6789]: BYE Oct 14 10:04:19 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:19 musical-fidelity systemd[1]: vtcs.service holdoff time over, scheduling restart. Oct 14 10:04:19 musical-fidelity systemd[1]: Stopping Volumio Tidal Connect Service... Oct 14 10:04:19 musical-fidelity systemd[1]: Starting Volumio Tidal Connect Service... Oct 14 10:04:19 musical-fidelity systemd[1]: Started Volumio Tidal Connect Service. Oct 14 10:04:19 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:19 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:20 musical-fidelity volumio[1022]: info: Executing endpoint tc_getconfig Oct 14 10:04:20 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 14 10:04:20 musical-fidelity vtcs[6797]: BYE Oct 14 10:04:20 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:20 musical-fidelity systemd[1]: vtcs.service holdoff time over, scheduling restart. Oct 14 10:04:20 musical-fidelity systemd[1]: Stopping Volumio Tidal Connect Service... Oct 14 10:04:20 musical-fidelity systemd[1]: Starting Volumio Tidal Connect Service... Oct 14 10:04:20 musical-fidelity systemd[1]: Started Volumio Tidal Connect Service. Oct 14 10:04:20 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:20 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:20 musical-fidelity volumio[1022]: info: Executing endpoint tc_getconfig Oct 14 10:04:20 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 14 10:04:20 musical-fidelity vtcs[6802]: BYE Oct 14 10:04:20 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:20 musical-fidelity systemd[1]: vtcs.service holdoff time over, scheduling restart. Oct 14 10:04:20 musical-fidelity systemd[1]: Stopping Volumio Tidal Connect Service... Oct 14 10:04:20 musical-fidelity systemd[1]: Starting Volumio Tidal Connect Service... Oct 14 10:04:20 musical-fidelity systemd[1]: Started Volumio Tidal Connect Service. Oct 14 10:04:20 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:20 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:21 musical-fidelity volumio[1022]: info: Executing endpoint tc_getconfig Oct 14 10:04:21 musical-fidelity volumio[1022]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 14 10:04:21 musical-fidelity vtcs[6809]: BYE Oct 14 10:04:21 musical-fidelity volumio[1022]: Error in parsing play status: TypeError: Cannot read property '0' of undefined Oct 14 10:04:21 musical-fidelity systemd[1]: vtcs.service holdoff time over, scheduling restart. Oct 14 10:04:21 musical-fidelity systemd[1]: Stopping Volumio Tidal Connect Service... Oct 14 10:04:21 musical-fidelity systemd[1]: Starting Volumio Tidal Connect Service... Oct 14 10:04:21 musical-fidelity systemd[1]: vtcs.service start request repeated too quickly, refusing to start. Oct 14 10:04:21 musical-fidelity systemd[1]: Failed to start Volumio Tidal Connect Service. Oct 14 10:04:21 musical-fidelity systemd[1]: Unit vtcs.service entered failed state. Oct 14 10:04:21 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:04:21 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:05:05 musical-fidelity systemd[1]: Started Music Player Daemon. Oct 14 10:05:05 musical-fidelity volumio[1022]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Oct 14 10:05:05 musical-fidelity sudo[6619]: pam_unix(sudo:session): session closed for user root Oct 14 10:05:05 musical-fidelity volumio[1022]: error: updateQueue error: null Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Authenticated as "ayxoqm9b2z4hqwusn8cm2zqsu" ! Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Using alsa sink Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Country: "NL" Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Metadata pipe established Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Event: Volume { volume_to_mixer: 65535 } Oct 14 10:05:06 musical-fidelity volumio[1022]: [SpotifyConnect] Volume Spotify: 100 Volumio: 100 Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Fetching autoplay context uri Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Event: SessionActive { became_active_at: 1791972306560 } Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : SessionActive! Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 212096100890464588364646524752025673649, audio_type: Track } } Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 212096100890464588364646524752025673649, audio_type: Track } } Oct 14 10:05:06 musical-fidelity volumio[1022]: [SpotifyConnect] A connect session has begun Oct 14 10:05:06 musical-fidelity volumio[1022]: info: Acquiring new spotify session Oct 14 10:05:06 musical-fidelity volumio[1022]: info: CoreCommandRouter::volumioStop Oct 14 10:05:06 musical-fidelity volumio[1022]: info: CoreStateMachine::stop Oct 14 10:05:06 musical-fidelity volumio[1022]: info: CoreStateMachine::serviceStop Oct 14 10:05:06 musical-fidelity volumio[1022]: info: CoreCommandRouter::serviceStop Oct 14 10:05:06 musical-fidelity volumio[1022]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 10:05:06 musical-fidelity volumio[1022]: TypeError: Cannot read property 'then' of undefined Oct 14 10:05:06 musical-fidelity volumio[1022]: at SpotConnEvents.SpotConn.on (/volumio/app/plugins/music_service/spop/index.js:2073:31) Oct 14 10:05:06 musical-fidelity volumio[1022]: at emitNone (events.js:106:13) Oct 14 10:05:06 musical-fidelity volumio[1022]: at SpotConnEvents.emit (events.js:208:7) Oct 14 10:05:06 musical-fidelity volumio[1022]: at SpotConnEvents.parseData (/volumio/app/plugins/music_service/spop/SpotConnController.js:81:16) Oct 14 10:05:06 musical-fidelity volumio[1022]: at Socket.SpotConnEvents._udpsource.on.msg (/volumio/app/plugins/music_service/spop/SpotConnController.js:15:12) Oct 14 10:05:06 musical-fidelity volumio[1022]: at emitTwo (events.js:126:13) Oct 14 10:05:06 musical-fidelity volumio[1022]: at Socket.emit (events.js:214:7) Oct 14 10:05:06 musical-fidelity volumio[1022]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Oct 14 10:05:06 musical-fidelity volumio[1022]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Loading with Spotify URI Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:2yLEwwgv9MiYi1zyxBUveb"> Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Resolving uri "spotify:station:playlist:2yLEwwgv9MiYi1zyxBUveb" Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQA_PlwvkZWosBxKl0BZcUgTJSCdzaBcC1mEwi_UVgOy3CoHa6NJy6xvowLtkH9Vl2narsrLS18AYur39aRdewV8024Mpo-LRGEoMx2AadVaS_tJLHgrwttnb_NHI5nxHnhn7B7KUG236VE9Z2RdDbAQacOm-jUhLeFJymXHLSmpezXHumuDNMwPTXxoPriTaSdZqzqi6fT-LFPq9_tRSdch4EvDAG0qsfT3mRklTn7DOShoYxOJNSCqK9HZEahIiAxepqm7sQ", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-modify-playback-state", "user-read-playback-state", "user-read-currently-playing", "user-read-private"] } } Oct 14 10:05:06 musical-fidelity volumio[6676]: [Vollibrespot] : Resolved 50 tracks from <"spotify:playlist:2yLEwwgv9MiYi1zyxBUveb"> Oct 14 10:05:07 musical-fidelity volumio[6676]: [Vollibrespot] : (240653 ms) loaded Oct 14 10:05:07 musical-fidelity volumio[6676]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 212096100890464588364646524752025673649, audio_type: Track } } Oct 14 10:05:07 musical-fidelity sudo[7042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-14 10:04 Oct 14 10:05:07 musical-fidelity sudo[7042]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Sep 6 12:01:32 CEST 2022" VOLUMIO_VERSION="1.081" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="fcc4f08af4feb5d7558230fb59bf1e14"