-- Logs begin at Mon 2024-09-02 10:59:31 UTC, end at Wed 2024-09-04 06:25:04 UTC. -- Sep 04 06:24:02 productie volumio[883]: info: CALLMETHOD: miscellanea my_music updateMusicLibraryBrowseSourcesVisibility [object Object] Sep 04 06:24:02 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibraryBrowseSourcesVisibility Sep 04 06:24:02 productie volumio[883]: info: CoreCommandRouter::volumioUpdateToBrowseSources Sep 04 06:24:02 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 06:24:02 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 06:24:06 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 06:24:10 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 06:24:15 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 06:24:35 productie volumio[883]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Sep 04 06:24:35 productie sudo[21799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 06:24:35 productie sudo[21799]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie sudo[21802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 06:24:35 productie sudo[21799]: pam_unix(sudo:session): session closed for user root Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie sudo[21802]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 06:24:35 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:35 productie volumio[883]: info: MPD Permissions set Sep 04 06:24:35 productie systemd[1]: Stopping Music Player Daemon... Sep 04 06:24:36 productie systemd[1]: Starting Music Player Daemon... Sep 04 06:24:36 productie systemd[1]: Started Music Player Daemon. Sep 04 06:24:36 productie sudo[21802]: pam_unix(sudo:session): session closed for user root Sep 04 06:24:36 productie volumio[883]: error: updateQueue error: null Sep 04 06:24:36 productie volumio[883]: error: Upnp client error: Error: This socket has been ended by the other party Sep 04 06:24:57 productie volumio[883]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::volumioGetState Sep 04 06:24:57 productie volumio[883]: info: CorePlayQueue::getTrack 0 Sep 04 06:24:57 productie volumio[883]: info: Restoring Previous Volume level: 25 false false Sep 04 06:24:57 productie volumio[883]: info: Volume configurations have been set Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Creating VLS config file Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Creating VLS config file Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Creating VLS config file Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Creating VLS config file Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Creating VLS config file Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 04 06:24:57 productie volumio[883]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: Headphone Max Vol: 70 Vol Curve; logarithmic Vol Steps: 10 Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Restarting Vollibrespot Daemon Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Restarting Vollibrespot Daemon Sep 04 06:24:57 productie sudo[21833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Restarting Vollibrespot Daemon Sep 04 06:24:57 productie sudo[21833]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:24:57 productie sudo[21836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Sep 04 06:24:57 productie sudo[21836]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:24:57 productie systemd[1]: Stopping Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Starting Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Started Volspotconnect2 Daemon. Sep 04 06:24:57 productie sudo[21833]: pam_unix(sudo:session): session closed for user root Sep 04 06:24:57 productie volumio[21846]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 04 06:24:57 productie volumio[21846]: Reading Config from "/tmp/volspotify.toml" Sep 04 06:24:57 productie volumio[21846]: Malformed config key: expected newline, found an identifier at line 29 column 20 Sep 04 06:24:57 productie sudo[21843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Sep 04 06:24:57 productie systemd[1]: Stopping Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Starting Volspotconnect2 Daemon... Sep 04 06:24:57 productie sudo[21843]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:24:57 productie systemd[1]: Started Volspotconnect2 Daemon. Sep 04 06:24:57 productie sudo[21836]: pam_unix(sudo:session): session closed for user root Sep 04 06:24:57 productie volumio[21857]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 04 06:24:57 productie volumio[21857]: Reading Config from "/tmp/volspotify.toml" Sep 04 06:24:57 productie volumio[21857]: Malformed config key: expected newline, found an identifier at line 29 column 20 Sep 04 06:24:57 productie systemd[1]: Stopping Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Starting Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Started Volspotconnect2 Daemon. Sep 04 06:24:57 productie sudo[21843]: pam_unix(sudo:session): session closed for user root Sep 04 06:24:57 productie volumio[21865]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 04 06:24:57 productie volumio[21865]: Reading Config from "/tmp/volspotify.toml" Sep 04 06:24:57 productie volumio[21865]: Malformed config key: expected newline, found an identifier at line 29 column 20 Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Vollibrespot Daemon service restarted! Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Vollibrespot Daemon service restarted! Sep 04 06:24:57 productie volumio[883]: info: VolumeController:: Volume=25 Mute =false Sep 04 06:24:57 productie volumio[883]: info: CoreStateMachine::pushState Sep 04 06:24:57 productie volumio[883]: info: CorePlayQueue::getTrack 0 Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::volumioPushState Sep 04 06:24:57 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Vollibrespot Daemon service restarted! Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Restarting Vollibrespot Daemon Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Restarting Vollibrespot Daemon Sep 04 06:24:57 productie sudo[21875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Sep 04 06:24:57 productie sudo[21875]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:24:57 productie sudo[21878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Sep 04 06:24:57 productie systemd[1]: Stopping Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Starting Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Started Volspotconnect2 Daemon. Sep 04 06:24:57 productie sudo[21875]: pam_unix(sudo:session): session closed for user root Sep 04 06:24:57 productie sudo[21878]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 06:24:57 productie systemd-journal[186]: Suppressed 559 messages from /system.slice/volspotconnect2.service Sep 04 06:24:57 productie volumio[21885]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Sep 04 06:24:57 productie volumio[21885]: Reading Config from "volspotify.toml" Sep 04 06:24:57 productie volumio[21885]: [Vollibrespot] : Using Alsa backend with device: plughw:1 Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Vollibrespot Daemon service restarted! Sep 04 06:24:57 productie systemd[1]: Stopping Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Starting Volspotconnect2 Daemon... Sep 04 06:24:57 productie systemd[1]: Started Volspotconnect2 Daemon. Sep 04 06:24:57 productie sudo[21878]: pam_unix(sudo:session): session closed for user root Sep 04 06:24:57 productie volumio[21893]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Sep 04 06:24:57 productie volumio[21893]: Reading Config from "volspotify.toml" Sep 04 06:24:57 productie volumio[21893]: [Vollibrespot] : Using Alsa backend with device: plughw:1 Sep 04 06:24:57 productie volumio[883]: [SpotifyConnect] Vollibrespot Daemon service restarted! Sep 04 06:24:57 productie volumio[21893]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Sep 04 06:24:59 productie systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Sep 04 06:24:59 productie systemd[1]: Stopping Volspotconnect2 Daemon... Sep 04 06:24:59 productie systemd[1]: Starting Volspotconnect2 Daemon... Sep 04 06:24:59 productie systemd[1]: Started Volspotconnect2 Daemon. Sep 04 06:24:59 productie volumio[21899]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 04 06:24:59 productie volumio[21899]: Reading Config from "/tmp/volspotify.toml" Sep 04 06:24:59 productie volumio[21899]: Malformed config key: expected newline, found an identifier at line 29 column 20 Sep 04 06:25:01 productie volumio[883]: info: VolumeController::SetAlsaVolume25 Sep 04 06:25:01 productie volumio[883]: info: CoreStateMachine::pushState Sep 04 06:25:01 productie volumio[883]: info: CorePlayQueue::getTrack 0 Sep 04 06:25:01 productie volumio[883]: info: CoreCommandRouter::volumioPushState Sep 04 06:25:01 productie volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 06:25:02 productie systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Sep 04 06:25:02 productie systemd[1]: Stopping Volspotconnect2 Daemon... Sep 04 06:25:02 productie systemd[1]: Starting Volspotconnect2 Daemon... Sep 04 06:25:02 productie systemd[1]: Started Volspotconnect2 Daemon. Sep 04 06:25:02 productie volumio[21903]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 04 06:25:02 productie volumio[21903]: Reading Config from "/tmp/volspotify.toml" Sep 04 06:25:02 productie volumio[21903]: Malformed config key: expected newline, found an identifier at line 29 column 20 Sep 04 06:25:03 productie volumio[883]: info: Checking Spotify Web API Sep 04 06:25:03 productie volumio[883]: info: Checking Spotify Web API Sep 04 06:25:03 productie volumio[883]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 06:25:03 productie volumio[883]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Sep 04 06:25:03 productie volumio[883]: at Socket._healthCheck (dgram.js:638:11) Sep 04 06:25:03 productie volumio[883]: at Socket.send (dgram.js:435:8) Sep 04 06:25:03 productie volumio[883]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Sep 04 06:25:03 productie volumio[883]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2318:23) Sep 04 06:25:03 productie volumio[883]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/spop/index.js:2651:18) Sep 04 06:25:03 productie volumio[883]: at ontimeout (timers.js:482:11) Sep 04 06:25:03 productie volumio[883]: at tryOnTimeout (timers.js:317:5) Sep 04 06:25:03 productie volumio[883]: at Timer.listOnTimeout (timers.js:277:5) Sep 04 06:25:03 productie volumio[883]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 06:25:04 productie sudo[21914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 06:24 Sep 04 06:25:04 productie sudo[21914]: 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="e81b2037a65d8f554cb0c857a1007d659ad7f838" VOLUMIO_FE_VERSION="e489037accd8e0b2dcbd6e0b054400d8cd36d4e2" VOLUMIO_BE_VERSION="25875b197c75cd1ac7eb5664d94cdd19afb06985" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Feb 19 17:39:10 CET 2021" VOLUMIO_VERSION="2.873" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="781d4c9fbf86d562939968306a6a26f4"