-- Logs begin at Thu 2021-08-05 16:05:54 UTC, end at Thu 2021-08-05 16:13:29 UTC. -- Aug 05 16:12:20 volumio volumio[970]: info: [{"prettyName":"Touch Display","name":"touch_display","category":"miscellanea","version":"1.1.9","icon":"fa-hand-pointer-o","enabled":false,"active":false},{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.2","icon":"fa-headphones","enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.1.5","icon":"fa-headphones","enabled":false,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"3.0.3","icon":"fa-spotify","enabled":true,"active":true},{"prettyName":"Volumio Spotify Connect2","name":"volspotconnect2","category":"music_service","version":"1.0.5","icon":"fa-spotify","active":false}] Aug 05 16:12:26 volumio volumio[970]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 05 16:12:26 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 05 16:12:26 volumio volumio[970]: info: Received Get System Version Aug 05 16:12:26 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 05 16:12:45 volumio volumio[970]: info: [{"prettyName":"Touch Display","name":"touch_display","category":"miscellanea","version":"1.1.9","icon":"fa-hand-pointer-o","enabled":false,"active":false},{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.2","icon":"fa-headphones","enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.1.5","icon":"fa-headphones","enabled":false,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"3.0.3","icon":"fa-spotify","enabled":true,"active":true},{"prettyName":"Volumio Spotify Connect2","name":"volspotconnect2","category":"music_service","version":"1.0.5","icon":"fa-spotify","active":false}] Aug 05 16:13:01 volumio volumio[970]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Aug 05 16:13:01 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 05 16:13:01 volumio volumio[970]: [SpotifyConnect] Closing metadata listener Aug 05 16:13:01 volumio volumio[970]: info: Disabling plugin spop Aug 05 16:13:01 volumio volumio[970]: info: Done. Aug 05 16:13:01 volumio sudo[1652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Aug 05 16:13:01 volumio sudo[1652]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:01 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Aug 05 16:13:01 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Aug 05 16:13:01 volumio sudo[1652]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:01 volumio volumio[970]: [SpotifyConnect] Vollibrespot Daemon service stoped! Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 05 16:13:05 volumio volumio[970]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 05 16:13:05 volumio volumio[970]: error: Could not retrieve plugin music_service raat Aug 05 16:13:22 volumio volumio[970]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: Output device has changed, restarting MPD Aug 05 16:13:22 volumio sudo[1691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 05 16:13:22 volumio volumio[970]: info: Output device has changed, restarting Shairport Sync Aug 05 16:13:22 volumio volumio[970]: [SpotifyConnect] Creating VLS config file Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:22 volumio sudo[1691]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:22 volumio sudo[1693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 05 16:13:22 volumio sudo[1693]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 05 16:13:22 volumio systemd[1]: Stopping Music Player Daemon... Aug 05 16:13:22 volumio volumio[970]: info: Found match in i2s Card Database: setting mixer Digital for card Aoide Digi Pro Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 05 16:13:22 volumio volumio[970]: info: Updating Volume Controller Parameters: Device: 1 Name: snd_rpi_aoide_digi Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 05 16:13:22 volumio volumio[970]: [SpotifyConnect] Restarting Vollibrespot Daemon Aug 05 16:13:22 volumio sudo[1711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Aug 05 16:13:22 volumio sudo[1711]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:22 volumio volumio[970]: info: MPD Permissions set Aug 05 16:13:22 volumio volumio[970]: info: VolumeController:: Volume=undefined Mute =false Aug 05 16:13:22 volumio volumio[970]: info: CoreStateMachine::pushState Aug 05 16:13:22 volumio volumio[970]: info: CoreStateMachine::getState Aug 05 16:13:22 volumio volumio[970]: info: CorePlayQueue::getTrack 0 Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::volumioPushState Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 05 16:13:22 volumio systemd[1]: Starting Volspotconnect2 Daemon... Aug 05 16:13:22 volumio systemd[1]: Started Volspotconnect2 Daemon. Aug 05 16:13:22 volumio sudo[1711]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:22 volumio volumio[1717]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Aug 05 16:13:22 volumio volumio[1717]: Reading Config from "/tmp/volspotify.toml" Aug 05 16:13:22 volumio volumio[1717]: [Vollibrespot] : Using Alsa backend with device: plughw:1 Aug 05 16:13:22 volumio sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 05 16:13:22 volumio systemd[1]: Starting Music Player Daemon... Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 05 16:13:22 volumio volumio[970]: [SpotifyConnect] Vollibrespot Daemon service restarted! Aug 05 16:13:22 volumio sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:22 volumio sudo[1721]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 05 16:13:22 volumio volumio[1717]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 05 16:13:22 volumio volumio[970]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 05 16:13:22 volumio volumio[970]: error: Could not retrieve plugin music_service raat Aug 05 16:13:22 volumio sudo[1738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Aug 05 16:13:22 volumio sudo[1738]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:22 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Aug 05 16:13:22 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Aug 05 16:13:22 volumio systemd[1]: Started ShairportSync AirTunes receiver. Aug 05 16:13:22 volumio sudo[1738]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:22 volumio shairport-sync[1744]: Successful Startup Aug 05 16:13:22 volumio volumio[970]: info: Shairport-Sync Started Aug 05 16:13:22 volumio systemd[1]: Started Music Player Daemon. Aug 05 16:13:22 volumio sudo[1693]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:22 volumio volumio[970]: info: Aug 05 16:13:22 volumio volumio[970]: error: Upnp client error: Error: This socket has been ended by the other party Aug 05 16:13:24 volumio volumio[970]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 05 16:13:24 volumio volumio[970]: info: CoreStateMachine::getcurrentVolume Aug 05 16:13:24 volumio volumio[970]: info: CoreCommandRouter::volumioRetrievevolume Aug 05 16:13:24 volumio volumio[970]: info: VolumeController:: Volume=undefined Mute =false Aug 05 16:13:24 volumio volumio[970]: info: CoreStateMachine::pushState Aug 05 16:13:24 volumio volumio[970]: info: CoreStateMachine::getState Aug 05 16:13:24 volumio volumio[970]: info: CorePlayQueue::getTrack 0 Aug 05 16:13:24 volumio volumio[970]: info: CoreCommandRouter::volumioPushState Aug 05 16:13:24 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 05 16:13:24 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 05 16:13:24 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:24 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:28 volumio volumio[970]: info: VolumeController::SetAlsaVolume0 Aug 05 16:13:28 volumio volumio[970]: info: CoreStateMachine::pushState Aug 05 16:13:28 volumio volumio[970]: info: CoreStateMachine::getState Aug 05 16:13:28 volumio volumio[970]: info: CorePlayQueue::getTrack 0 Aug 05 16:13:28 volumio volumio[970]: info: CoreCommandRouter::volumioPushState Aug 05 16:13:28 volumio volumio[970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 05 16:13:28 volumio sudo[1772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 05 16:13:28 volumio volumio[970]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'Digital',0 Aug 05 16:13:28 volumio sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 05 16:13:28 volumio sudo[1772]: pam_unix(sudo:session): session closed for user root Aug 05 16:13:28 volumio volumio[970]: info: Checking Spotify Web API Aug 05 16:13:28 volumio volumio[970]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 05 16:13:28 volumio volumio[970]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Aug 05 16:13:28 volumio volumio[970]: at Socket._healthCheck (dgram.js:638:11) Aug 05 16:13:28 volumio volumio[970]: at Socket.send (dgram.js:435:8) Aug 05 16:13:28 volumio volumio[970]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Aug 05 16:13:28 volumio volumio[970]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2318:23) Aug 05 16:13:28 volumio volumio[970]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/spop/index.js:2651:18) Aug 05 16:13:28 volumio volumio[970]: at ontimeout (timers.js:482:11) Aug 05 16:13:28 volumio volumio[970]: at tryOnTimeout (timers.js:317:5) Aug 05 16:13:28 volumio volumio[970]: at Timer.listOnTimeout (timers.js:277:5) Aug 05 16:13:28 volumio volumio[970]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 05 16:13:29 volumio sudo[1788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2021-08-05 16:12 Aug 05 16:13:29 volumio sudo[1788]: 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="44b2fa85b4b3fa34b9dce1402ab445658a4a845a" VOLUMIO_FE_VERSION="d09ca6aec236a0abcd0f3fe793ad8b7dc572560b" VOLUMIO_BE_VERSION="adf0384995b68dee9fc3a8eedb9a69a90d236430" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Feb 20 14:10:26 UTC 2019" VOLUMIO_VERSION="2.555" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="99521079c49c6fa637dec4ad9cb6bd93"