-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-11-29 16:49:19 CET. -- Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:04 blueplayer volumio[916]: info: Retrieving Cloud Streaming UI Nov 29 16:48:04 blueplayer volumio[916]: info: Getting Tidal Cloud Configuration Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:04 blueplayer volumio[916]: info: Getting Qobuz Cloud Configuration Nov 29 16:48:04 blueplayer volumio[916]: info: Asking plugin for UI Config Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:04 blueplayer volumio[916]: info: Getting Spotify Cloud Configuration Nov 29 16:48:04 blueplayer volumio[916]: info: Asking plugin for UI Config Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:04 blueplayer volumio[916]: info: Saving Spotify Acccount Nov 29 16:48:04 blueplayer volumio[916]: info: Got Tidal Cloud Configuration Nov 29 16:48:04 blueplayer volumio[916]: info: Got it Nov 29 16:48:04 blueplayer volumio[916]: info: Got it Nov 29 16:48:04 blueplayer volumio[916]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:04 blueplayer volumio[916]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetBrowseSources Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:04 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 29 16:48:07 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 29 16:48:07 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 29 16:48:08 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:11 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 29 16:48:11 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 29 16:48:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:16 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:20 blueplayer volumio[916]: info: Enabling MyMusic plugin tidalconnect Nov 29 16:48:20 blueplayer volumio[916]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service tidalconnect Nov 29 16:48:20 blueplayer volumio[916]: info: [MyVolumio PluginManager] Plugin music_service tidalconnect not in user plan, not enabling Nov 29 16:48:20 blueplayer volumio[916]: info: Error: Plugin music_service tidalconnect not in user plan, not enabling Nov 29 16:48:20 blueplayer volumio[916]: error: Could not Enable MyMusic Plugin: Error Nov 29 16:48:20 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:24 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:28 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:29 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 16:48:29 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 16:48:29 blueplayer volumio[916]: info: Discovery: Getting this device information Nov 29 16:48:29 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:48:29 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:48:29 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 16:48:32 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:36 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:40 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:44 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:55 blueplayer volumio[916]: info: Retrieving Cloud Streaming UI Nov 29 16:48:55 blueplayer volumio[916]: info: Getting Tidal Cloud Configuration Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:55 blueplayer volumio[916]: info: Getting Qobuz Cloud Configuration Nov 29 16:48:55 blueplayer volumio[916]: info: Asking plugin for UI Config Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:55 blueplayer volumio[916]: info: Getting Spotify Cloud Configuration Nov 29 16:48:55 blueplayer volumio[916]: info: Asking plugin for UI Config Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:55 blueplayer volumio[916]: info: Saving Spotify Acccount Nov 29 16:48:55 blueplayer volumio[916]: info: Got Tidal Cloud Configuration Nov 29 16:48:55 blueplayer volumio[916]: info: Got it Nov 29 16:48:55 blueplayer volumio[916]: info: Got it Nov 29 16:48:55 blueplayer volumio[916]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:48:55 blueplayer volumio[916]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetBrowseSources Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 16:48:55 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 29 16:48:59 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 16:48:59 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 16:48:59 blueplayer volumio[916]: info: Discovery: Getting this device information Nov 29 16:48:59 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:48:59 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:48:59 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 16:49:02 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:49:02 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 16:49:02 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:02 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 16:49:02 blueplayer volumio[916]: info: Getting Alsa Cards List without I2S DAC Nov 29 16:49:02 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Nov 29 16:49:02 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 16:49:03 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 16:49:12 blueplayer volumio[916]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 16:49:12 blueplayer volumio[916]: info: Disabling I2S DAC: Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 16:49:12 blueplayer volumio[916]: info: Setting default mixerSoftMaster for Softvolume device Nov 29 16:49:12 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 29 16:49:12 blueplayer volumio[916]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 29 16:49:12 blueplayer volumio[916]: info: Disabling external Volume Control Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:49:12 blueplayer volumio[916]: info: Enable softmixer device for audio device undefined Nov 29 16:49:12 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:12 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:12 blueplayer sudo[2017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:12 blueplayer sudo[2017]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:49:12 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:12 blueplayer volumio[916]: info: CoreStateMachine::pushState Nov 29 16:49:12 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::volumioPushState Nov 29 16:49:12 blueplayer sudo[2020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:12 blueplayer sudo[2020]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:12 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Nov 29 16:49:12 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:12 blueplayer systemd[1]: volspotconnect.service: Succeeded. Nov 29 16:49:12 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 29 16:49:12 blueplayer volumio[916]: info: Software Volume ALSA configuration written Nov 29 16:49:12 blueplayer volumio[916]: info: Preparing to generate the ALSA configuration file Nov 29 16:49:12 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Nov 29 16:49:12 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Nov 29 16:49:12 blueplayer sudo[2017]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:12 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:12 blueplayer systemd[1]: volspotconnect.service: Succeeded. Nov 29 16:49:12 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 29 16:49:12 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Nov 29 16:49:12 blueplayer sudo[2020]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:12 blueplayer volumio[2023]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Nov 29 16:49:12 blueplayer volumio[2023]: Reading Config from "/tmp/volspotify.toml" Nov 29 16:49:12 blueplayer volumio[2023]: [Vollibrespot] : Using Alsa backend with device: volumio Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 16:49:12 blueplayer volumio[2023]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 16:49:12 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 16:49:12 blueplayer volumio[916]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 29 16:49:12 blueplayer volumio[916]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 29 16:49:12 blueplayer volumio[916]: info: Reading ALSA contributions from plugins. Nov 29 16:49:12 blueplayer sudo[2030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Nov 29 16:49:12 blueplayer sudo[2030]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:12 blueplayer sudo[2030]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:12 blueplayer volumio[916]: info: No Overlays Loaded Nov 29 16:49:12 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:12 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:12 blueplayer volumio[916]: info: Asound.conf file written Nov 29 16:49:12 blueplayer sudo[2033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 29 16:49:12 blueplayer sudo[2033]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:12 blueplayer sudo[2033]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer volumio[916]: /usr/share/alsa/init/bcm2835:14: control element not found Nov 29 16:49:13 blueplayer volumio[916]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #1 (No such file or directory) Nov 29 16:49:13 blueplayer volumio[916]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #2 (No such file or directory) Nov 29 16:49:13 blueplayer volumio[916]: No state is present for card D20 Nov 29 16:49:13 blueplayer volumio[916]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:2009" "" "" Nov 29 16:49:13 blueplayer volumio[916]: Hardware is initialized using a generic method Nov 29 16:49:13 blueplayer volumio[916]: No state is present for card D20 Nov 29 16:49:13 blueplayer volumio[916]: info: Output device has changed, restarting MPD Nov 29 16:49:13 blueplayer sudo[2040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 16:49:13 blueplayer sudo[2040]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer volumio[916]: info: Output device has changed, restarting Shairport Sync Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:13 blueplayer sudo[2040]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer sudo[2043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 16:49:13 blueplayer sudo[2043]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer systemd[1]: Stopping Music Player Daemon... Nov 29 16:49:13 blueplayer volumio[916]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: Output device has changed, restarting MPD Nov 29 16:49:13 blueplayer sudo[2049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 16:49:13 blueplayer sudo[2049]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer volumio[916]: info: Output device has changed, restarting Shairport Sync Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:13 blueplayer sudo[2049]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer sudo[2052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 16:49:13 blueplayer sudo[2052]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer volumio[916]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:13 blueplayer sudo[2058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:13 blueplayer systemd[1]: mpd.service: Succeeded. Nov 29 16:49:13 blueplayer sudo[2058]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer systemd[1]: Stopped Music Player Daemon. Nov 29 16:49:13 blueplayer sudo[2060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:13 blueplayer sudo[2060]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:13 blueplayer volumio[916]: info: MPD Permissions set Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer sudo[2065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:13 blueplayer systemd[1]: Starting Music Player Daemon... Nov 29 16:49:13 blueplayer sudo[2065]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer sudo[2067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:13 blueplayer sudo[2067]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Nov 29 16:49:13 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:13 blueplayer systemd[1]: volspotconnect.service: Succeeded. Nov 29 16:49:13 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 29 16:49:13 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Nov 29 16:49:13 blueplayer sudo[2060]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer sudo[2065]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer sudo[2067]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer sudo[2058]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer volumio[2078]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Nov 29 16:49:13 blueplayer volumio[2078]: Reading Config from "/tmp/volspotify.toml" Nov 29 16:49:13 blueplayer volumio[2078]: [Vollibrespot] : Using Alsa backend with device: volumio Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:13 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:13 blueplayer volumio[916]: info: Starting Shairport Sync Nov 29 16:49:13 blueplayer volumio[916]: info: Starting Shairport Sync Nov 29 16:49:13 blueplayer volumio[2078]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Nov 29 16:49:13 blueplayer sudo[2082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 16:49:13 blueplayer sudo[2082]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 16:49:13 blueplayer sudo[2085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 16:49:13 blueplayer sudo[2085]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:13 blueplayer systemd[1]: shairport-sync.service: Succeeded. Nov 29 16:49:13 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 29 16:49:13 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 16:49:13 blueplayer sudo[2082]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer volumio[916]: info: Shairport-Sync Started Nov 29 16:49:13 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 16:49:13 blueplayer systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:13 blueplayer systemd[1]: shairport-sync.service: Succeeded. Nov 29 16:49:13 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 29 16:49:13 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 16:49:13 blueplayer sudo[2085]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:13 blueplayer volumio[916]: info: Shairport-Sync Started Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:13 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 16:49:14 blueplayer volumio[916]: info: Setting default mixerSoftMaster for Softvolume device Nov 29 16:49:14 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 29 16:49:14 blueplayer volumio[916]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 29 16:49:14 blueplayer volumio[916]: info: Disabling external Volume Control Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 16:49:14 blueplayer volumio[916]: info: Enable softmixer device for audio device undefined Nov 29 16:49:14 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:14 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:14 blueplayer sudo[2108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:14 blueplayer sudo[2108]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:49:14 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:14 blueplayer volumio[916]: info: CoreStateMachine::pushState Nov 29 16:49:14 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::volumioPushState Nov 29 16:49:14 blueplayer sudo[2111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:14 blueplayer sudo[2111]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:14 blueplayer volumio[916]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'SoftMaster',0 Nov 29 16:49:14 blueplayer volumio[916]: info: Software Volume ALSA configuration written Nov 29 16:49:14 blueplayer volumio[916]: info: Preparing to generate the ALSA configuration file Nov 29 16:49:14 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Nov 29 16:49:14 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:14 blueplayer systemd[1]: volspotconnect.service: Succeeded. Nov 29 16:49:14 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 16:49:14 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Nov 29 16:49:14 blueplayer sudo[2108]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:14 blueplayer sudo[2111]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:14 blueplayer volumio[2113]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Nov 29 16:49:14 blueplayer volumio[2113]: Reading Config from "/tmp/volspotify.toml" Nov 29 16:49:14 blueplayer volumio[2113]: [Vollibrespot] : Using Alsa backend with device: volumio Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 16:49:14 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 16:49:14 blueplayer volumio[916]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 29 16:49:14 blueplayer volumio[916]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 29 16:49:14 blueplayer volumio[916]: info: Reading ALSA contributions from plugins. Nov 29 16:49:14 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:14 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:14 blueplayer volumio[2113]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Nov 29 16:49:14 blueplayer volumio[916]: info: Asound.conf file unchanged, so no further update is needed Nov 29 16:49:14 blueplayer volumio[916]: info: Output device has changed, restarting MPD Nov 29 16:49:15 blueplayer sudo[2121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 16:49:15 blueplayer sudo[2121]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:15 blueplayer volumio[916]: info: Output device has changed, restarting Shairport Sync Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:15 blueplayer sudo[2121]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:15 blueplayer sudo[2124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 16:49:15 blueplayer sudo[2124]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:15 blueplayer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:15 blueplayer systemd[1]: mpd.service: Succeeded. Nov 29 16:49:15 blueplayer systemd[1]: Stopped Music Player Daemon. Nov 29 16:49:15 blueplayer volumio[916]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 16:49:15 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: [SpotifyConnect] Creating VLS config file Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:15 blueplayer volumio[916]: [SpotifyConnect] Restarting Vollibrespot Daemon Nov 29 16:49:15 blueplayer sudo[2131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:15 blueplayer sudo[2131]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:15 blueplayer systemd[1]: Starting Music Player Daemon... Nov 29 16:49:15 blueplayer volumio[916]: info: MPD Permissions set Nov 29 16:49:15 blueplayer sudo[2134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Nov 29 16:49:15 blueplayer sudo[2134]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:15 blueplayer systemd[1]: volspotconnect.service: Succeeded. Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer systemd[1]: Started Volspotconnect2 Daemon. Nov 29 16:49:15 blueplayer sudo[2131]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:15 blueplayer volumio[2137]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Nov 29 16:49:15 blueplayer volumio[2137]: Reading Config from "/tmp/volspotify.toml" Nov 29 16:49:15 blueplayer volumio[2137]: [Vollibrespot] : Using Alsa backend with device: volumio Nov 29 16:49:15 blueplayer systemd[1]: Stopping Volspotconnect2 Daemon... Nov 29 16:49:15 blueplayer systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Nov 29 16:49:15 blueplayer systemd[1]: volspotconnect.service: Succeeded. Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 16:49:15 blueplayer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer systemd[1]: volspotconnect.service: Start request repeated too quickly. Nov 29 16:49:15 blueplayer systemd[1]: volspotconnect.service: Failed with result 'start-limit-hit'. Nov 29 16:49:15 blueplayer volumio[916]: [SpotifyConnect] Vollibrespot Daemon service restarted! Nov 29 16:49:15 blueplayer volumio[916]: info: Starting Shairport Sync Nov 29 16:49:15 blueplayer systemd[1]: Failed to start Volspotconnect2 Daemon. Nov 29 16:49:15 blueplayer sudo[2134]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:15 blueplayer sudo[2143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 16:49:15 blueplayer sudo[2143]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 16:49:15 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 16:49:15 blueplayer systemd[1]: shairport-sync.service: Succeeded. Nov 29 16:49:15 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 29 16:49:15 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 16:49:15 blueplayer sudo[2143]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:15 blueplayer volumio[916]: info: Shairport-Sync Started Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:15 blueplayer volumio[916]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 16:49:16 blueplayer volumio[916]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 29 16:49:16 blueplayer volumio[916]: info: CoreStateMachine::getcurrentVolume Nov 29 16:49:16 blueplayer volumio[916]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 16:49:16 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:49:16 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:16 blueplayer volumio[916]: info: CoreStateMachine::pushState Nov 29 16:49:16 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:16 blueplayer volumio[916]: info: CoreCommandRouter::volumioPushState Nov 29 16:49:16 blueplayer volumio[916]: info: CoreStateMachine::updateTrackBlock Nov 29 16:49:16 blueplayer volumio[916]: info: CorePlayQueue::getTrackBlock Nov 29 16:49:16 blueplayer volumio[916]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 16:49:16 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:49:16 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:16 blueplayer volumio[916]: info: CoreStateMachine::pushState Nov 29 16:49:16 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:16 blueplayer volumio[916]: info: CoreCommandRouter::volumioPushState Nov 29 16:49:16 blueplayer mpd[2150]: Nov 29 16:49 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 29 16:49:16 blueplayer mpd[2150]: Nov 29 16:49 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 29 16:49:16 blueplayer mpd[2150]: Nov 29 16:49 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 29 16:49:16 blueplayer systemd[1]: Started Music Player Daemon. Nov 29 16:49:16 blueplayer sudo[2124]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:16 blueplayer sudo[2043]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:16 blueplayer sudo[2052]: pam_unix(sudo:session): session closed for user root Nov 29 16:49:16 blueplayer volumio[916]: error: MPD error: The expression evaluated to a falsy value: Nov 29 16:49:16 blueplayer volumio[916]: assert.ok(self.idling) Nov 29 16:49:16 blueplayer volumio[916]: error: The expression evaluated to a falsy value: Nov 29 16:49:16 blueplayer volumio[916]: assert.ok(self.idling) Nov 29 16:49:16 blueplayer volumio[916]: error: MPD error: The expression evaluated to a falsy value: Nov 29 16:49:16 blueplayer volumio[916]: assert.ok(self.idling) Nov 29 16:49:16 blueplayer volumio[916]: error: The expression evaluated to a falsy value: Nov 29 16:49:16 blueplayer volumio[916]: assert.ok(self.idling) Nov 29 16:49:16 blueplayer volumio[916]: error: updateQueue error: null Nov 29 16:49:18 blueplayer volumio[916]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 29 16:49:18 blueplayer volumio[916]: info: CoreStateMachine::getcurrentVolume Nov 29 16:49:18 blueplayer volumio[916]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 16:49:18 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:49:18 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:18 blueplayer volumio[916]: info: CoreStateMachine::pushState Nov 29 16:49:18 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:18 blueplayer volumio[916]: info: CoreCommandRouter::volumioPushState Nov 29 16:49:18 blueplayer volumio[916]: info: CoreStateMachine::updateTrackBlock Nov 29 16:49:18 blueplayer volumio[916]: info: CorePlayQueue::getTrackBlock Nov 29 16:49:18 blueplayer volumio[916]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 16:49:18 blueplayer volumio[916]: info: CoreCommandRouter::volumioGetState Nov 29 16:49:18 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:18 blueplayer volumio[916]: info: CoreStateMachine::pushState Nov 29 16:49:18 blueplayer volumio[916]: info: CorePlayQueue::getTrack 0 Nov 29 16:49:18 blueplayer volumio[916]: info: CoreCommandRouter::volumioPushState Nov 29 16:49:18 blueplayer volumio[916]: info: Checking Spotify Web API Nov 29 16:49:18 blueplayer volumio[916]: info: Checking Spotify Web API Nov 29 16:49:18 blueplayer volumio[916]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 16:49:18 blueplayer volumio[916]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Nov 29 16:49:18 blueplayer volumio[916]: at healthCheck (dgram.js:897:11) Nov 29 16:49:18 blueplayer volumio[916]: at Socket.send (dgram.js:622:3) Nov 29 16:49:18 blueplayer volumio[916]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:121:21) Nov 29 16:49:18 blueplayer volumio[916]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2383:23) Nov 29 16:49:18 blueplayer volumio[916]: at Timeout._onTimeout (/data/plugins/music_service/spop/index.js:2723:18) Nov 29 16:49:18 blueplayer volumio[916]: at listOnTimeout (internal/timers.js:554:17) Nov 29 16:49:18 blueplayer volumio[916]: at processTimers (internal/timers.js:497:7) { Nov 29 16:49:18 blueplayer volumio[916]: code: 'ERR_SOCKET_DGRAM_NOT_RUNNING' Nov 29 16:49:18 blueplayer volumio[916]: } Nov 29 16:49:18 blueplayer volumio[916]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 16:49:19 blueplayer sudo[2186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-29 16:48 Nov 29 16:49:19 blueplayer sudo[2186]: pam_unix(sudo:session): session opened for user root by (uid=0) 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"