-- Logs begin at Sun 2024-12-01 03:01:28 UTC, end at Sun 2024-12-01 11:30:07 UTC. -- Dec 01 11:29:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 11:29:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 11:29:01 volumijopy volumio[1236]: info: Discovery: Getting this device information Dec 01 11:29:01 volumijopy volumio[1236]: info: CoreCommandRouter::volumioGetState Dec 01 11:29:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 01 11:29:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 01 11:29:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 01 11:29:06 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:29:13 volumijopy volumio[1236]: info: Dec 01 11:29:13 volumijopy volumio[1236]: ---------------------------- MPD announces system playlist update Dec 01 11:29:13 volumijopy volumio[1236]: info: Ignoring MPD Status Update Dec 01 11:29:13 volumijopy volumio[1236]: info: Dec 01 11:29:13 volumijopy volumio[1236]: ---------------------------- MPD announces state update: player Dec 01 11:29:13 volumijopy volumio[1236]: info: ControllerMpd::getState Dec 01 11:29:13 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand status Dec 01 11:29:13 volumijopy volumio[1236]: info: ------------------------------ 2ms Dec 01 11:29:13 volumijopy volumio[1236]: info: sendMpdCommand status took 2 milliseconds Dec 01 11:29:13 volumijopy volumio[1236]: verbose: ControllerMpd::parseState Dec 01 11:29:13 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 11:29:13 volumijopy volumio[1236]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 01 11:29:13 volumijopy volumio[1236]: verbose: ControllerMpd::parseTrackInfo Dec 01 11:29:13 volumijopy volumio[1236]: info: ControllerMpd::pushState Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreCommandRouter::servicePushState Dec 01 11:29:13 volumijopy volumio[1236]: info: CorePlayQueue::getTrack 0 Dec 01 11:29:13 volumijopy volumio[1236]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8856839,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Chris de Burgh - Missing you","artist":"WDR 4, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-wdr4-live.icecastssl.wdr.de/wdr/wdr4/live/mp3/56/stream.mp3?aggregator=tunein","trackType":""} Dec 01 11:29:13 volumijopy volumio[1236]: verbose: CURRENT POSITION 0 Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreStateMachine::syncState stateService play Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreStateMachine::syncState currentStatus play Dec 01 11:29:13 volumijopy volumio[1236]: info: Received an update from plugin. extracting info from payload Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:29:13 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:29:13 volumijopy volumio[1236]: info: ------------------------------ 9ms Dec 01 11:29:13 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:29:21 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:29:25 volumijopy volumio[1236]: info: Dec 01 11:29:25 volumijopy volumio[1236]: ---------------------------- MPD announces system playlist update Dec 01 11:29:25 volumijopy volumio[1236]: info: Ignoring MPD Status Update Dec 01 11:29:25 volumijopy volumio[1236]: info: Dec 01 11:29:25 volumijopy volumio[1236]: ---------------------------- MPD announces state update: player Dec 01 11:29:25 volumijopy volumio[1236]: info: ControllerMpd::getState Dec 01 11:29:25 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand status Dec 01 11:29:25 volumijopy volumio[1236]: info: ------------------------------ 1ms Dec 01 11:29:25 volumijopy volumio[1236]: info: sendMpdCommand status took 1 milliseconds Dec 01 11:29:25 volumijopy volumio[1236]: verbose: ControllerMpd::parseState Dec 01 11:29:25 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 11:29:25 volumijopy volumio[1236]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 01 11:29:25 volumijopy volumio[1236]: verbose: ControllerMpd::parseTrackInfo Dec 01 11:29:25 volumijopy volumio[1236]: info: ControllerMpd::pushState Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreCommandRouter::servicePushState Dec 01 11:29:25 volumijopy volumio[1236]: info: CorePlayQueue::getTrack 0 Dec 01 11:29:25 volumijopy volumio[1236]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8869098,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"WDR 4 Knispel am Sonntag","artist":"WDR 4, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-wdr4-live.icecastssl.wdr.de/wdr/wdr4/live/mp3/56/stream.mp3?aggregator=tunein","trackType":""} Dec 01 11:29:25 volumijopy volumio[1236]: verbose: CURRENT POSITION 0 Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreStateMachine::syncState stateService play Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreStateMachine::syncState currentStatus play Dec 01 11:29:25 volumijopy volumio[1236]: info: Received an update from plugin. extracting info from payload Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:29:25 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:29:25 volumijopy volumio[1236]: info: ------------------------------ 8ms Dec 01 11:29:28 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:29:31 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 11:29:31 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 11:29:31 volumijopy volumio[1236]: info: Discovery: Getting this device information Dec 01 11:29:31 volumijopy volumio[1236]: info: CoreCommandRouter::volumioGetState Dec 01 11:29:31 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 01 11:29:31 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 01 11:29:31 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 01 11:29:33 volumijopy volumio[1236]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Dec 01 11:29:33 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 11:29:33 volumijopy volumio[1236]: [SpotifyConnect] Closing metadata listener Dec 01 11:29:33 volumijopy volumio[1236]: info: Disabling plugin spop Dec 01 11:29:33 volumijopy volumio[1236]: info: Done. Dec 01 11:29:33 volumijopy sudo[4111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Dec 01 11:29:33 volumijopy sudo[4111]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:29:33 volumijopy systemd[1]: Stopping Volspotconnect2 Daemon... Dec 01 11:29:33 volumijopy systemd[1]: Stopped Volspotconnect2 Daemon. Dec 01 11:29:33 volumijopy sudo[4111]: pam_unix(sudo:session): session closed for user root Dec 01 11:29:33 volumijopy volumio[1236]: [SpotifyConnect] Vollibrespot Daemon service stoped! Dec 01 11:29:34 volumijopy volumio[1236]: [SpotifyConnect] Stopping Vollibrespot daemon Dec 01 11:29:34 volumijopy volumio[1236]: [SpotifyConnect] Closing metadata listener Dec 01 11:29:34 volumijopy volumio[1236]: info: Disabling plugin volspotconnect2 Dec 01 11:29:34 volumijopy volumio[1236]: info: Done. Dec 01 11:29:34 volumijopy sudo[4125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect2.service Dec 01 11:29:34 volumijopy sudo[4125]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:29:34 volumijopy systemd[1]: Stopping Volspotconnect2 Daemon... Dec 01 11:29:34 volumijopy systemd[1]: Stopped Volspotconnect2 Daemon. Dec 01 11:29:34 volumijopy sudo[4125]: pam_unix(sudo:session): session closed for user root Dec 01 11:29:34 volumijopy volumio[1236]: [SpotifyConnect] Vollibrespot Daemon service stoped! Dec 01 11:29:36 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:29:43 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:29:46 volumijopy volumio[1236]: info: Dec 01 11:29:46 volumijopy volumio[1236]: ---------------------------- MPD announces system playlist update Dec 01 11:29:46 volumijopy volumio[1236]: info: Ignoring MPD Status Update Dec 01 11:29:46 volumijopy volumio[1236]: info: Dec 01 11:29:46 volumijopy volumio[1236]: ---------------------------- MPD announces state update: player Dec 01 11:29:46 volumijopy volumio[1236]: info: ControllerMpd::getState Dec 01 11:29:46 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand status Dec 01 11:29:46 volumijopy volumio[1236]: info: ------------------------------ 5ms Dec 01 11:29:46 volumijopy volumio[1236]: info: sendMpdCommand status took 4 milliseconds Dec 01 11:29:46 volumijopy volumio[1236]: verbose: ControllerMpd::parseState Dec 01 11:29:46 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 11:29:46 volumijopy volumio[1236]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 01 11:29:46 volumijopy volumio[1236]: verbose: ControllerMpd::parseTrackInfo Dec 01 11:29:46 volumijopy volumio[1236]: info: ControllerMpd::pushState Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreCommandRouter::servicePushState Dec 01 11:29:46 volumijopy volumio[1236]: info: CorePlayQueue::getTrack 0 Dec 01 11:29:46 volumijopy volumio[1236]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8889343,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Die WDR 4 Hotline: 0221 56789 444","artist":"WDR 4, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-wdr4-live.icecastssl.wdr.de/wdr/wdr4/live/mp3/56/stream.mp3?aggregator=tunein","trackType":""} Dec 01 11:29:46 volumijopy volumio[1236]: verbose: CURRENT POSITION 0 Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreStateMachine::syncState stateService play Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreStateMachine::syncState currentStatus play Dec 01 11:29:46 volumijopy volumio[1236]: info: Received an update from plugin. extracting info from payload Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:29:46 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:29:46 volumijopy volumio[1236]: info: ------------------------------ 14ms Dec 01 11:29:51 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:29:58 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:30:00 volumijopy volumio[1236]: info: Dec 01 11:30:00 volumijopy volumio[1236]: ---------------------------- MPD announces system playlist update Dec 01 11:30:00 volumijopy volumio[1236]: info: Ignoring MPD Status Update Dec 01 11:30:00 volumijopy volumio[1236]: info: Dec 01 11:30:00 volumijopy volumio[1236]: ---------------------------- MPD announces state update: player Dec 01 11:30:00 volumijopy volumio[1236]: info: ControllerMpd::getState Dec 01 11:30:00 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand status Dec 01 11:30:00 volumijopy volumio[1236]: info: ------------------------------ 4ms Dec 01 11:30:00 volumijopy volumio[1236]: info: sendMpdCommand status took 4 milliseconds Dec 01 11:30:00 volumijopy volumio[1236]: verbose: ControllerMpd::parseState Dec 01 11:30:00 volumijopy volumio[1236]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 11:30:00 volumijopy volumio[1236]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 01 11:30:00 volumijopy volumio[1236]: verbose: ControllerMpd::parseTrackInfo Dec 01 11:30:00 volumijopy volumio[1236]: info: ControllerMpd::pushState Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreCommandRouter::servicePushState Dec 01 11:30:00 volumijopy volumio[1236]: info: CorePlayQueue::getTrack 0 Dec 01 11:30:00 volumijopy volumio[1236]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8903589,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"WDR 4 - Wir sind Heimat","artist":"WDR 4, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-wdr4-live.icecastssl.wdr.de/wdr/wdr4/live/mp3/56/stream.mp3?aggregator=tunein","trackType":""} Dec 01 11:30:00 volumijopy volumio[1236]: verbose: CURRENT POSITION 0 Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreStateMachine::syncState stateService play Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreStateMachine::syncState currentStatus play Dec 01 11:30:00 volumijopy volumio[1236]: info: Received an update from plugin. extracting info from payload Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreStateMachine::pushState Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreCommandRouter::volumioPushState Dec 01 11:30:00 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 11:30:00 volumijopy volumio[1236]: info: ------------------------------ 13ms Dec 01 11:30:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 11:30:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 11:30:01 volumijopy volumio[1236]: info: Discovery: Getting this device information Dec 01 11:30:01 volumijopy volumio[1236]: info: CoreCommandRouter::volumioGetState Dec 01 11:30:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 01 11:30:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 01 11:30:01 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 01 11:30:03 volumijopy volumio[1236]: info: Enabling plugin spop Dec 01 11:30:03 volumijopy volumio[1236]: info: Loading plugin "spop"... Dec 01 11:30:03 volumijopy volumio[1236]: info: PLUGIN START: spop Dec 01 11:30:03 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 11:30:03 volumijopy volumio[1236]: [SpotifyConnect] Creating VLS config file Dec 01 11:30:03 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:03 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:03 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:03 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:03 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:03 volumijopy volumio[1236]: [SpotifyConnect] Starting metadata listener Dec 01 11:30:03 volumijopy sudo[4192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Dec 01 11:30:03 volumijopy sudo[4192]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:30:03 volumijopy sudo[4192]: pam_unix(sudo:session): session closed for user root Dec 01 11:30:03 volumijopy sudo[4197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Dec 01 11:30:03 volumijopy sudo[4197]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:30:03 volumijopy systemd[1]: Starting Volspotconnect2 Daemon... Dec 01 11:30:03 volumijopy systemd[1]: Started Volspotconnect2 Daemon. Dec 01 11:30:03 volumijopy sudo[4197]: pam_unix(sudo:session): session closed for user root Dec 01 11:30:03 volumijopy volumio[4206]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Dec 01 11:30:03 volumijopy volumio[4206]: Reading Config from "/tmp/volspotify.toml" Dec 01 11:30:03 volumijopy volumio[4206]: [Vollibrespot] : Using Alsa backend with device: plughw:1 Dec 01 11:30:03 volumijopy volumio[1236]: [SpotifyConnect] Vollibrespot Daemon service started! Dec 01 11:30:03 volumijopy volumio[1236]: [Metrics] SpotifyConnect: 0s 74.54ms Dec 01 11:30:03 volumijopy volumio[1236]: info: Done. Dec 01 11:30:03 volumijopy volumio[4206]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Dec 01 11:30:04 volumijopy volumio[1236]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Dec 01 11:30:04 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 11:30:04 volumijopy volumio[1236]: [SpotifyConnect] Closing metadata listener Dec 01 11:30:04 volumijopy volumio[1236]: info: Disabling plugin spop Dec 01 11:30:04 volumijopy volumio[1236]: info: Done. Dec 01 11:30:04 volumijopy sudo[4214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Dec 01 11:30:04 volumijopy sudo[4214]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:30:04 volumijopy systemd[1]: Stopping Volspotconnect2 Daemon... Dec 01 11:30:04 volumijopy systemd[1]: Stopped Volspotconnect2 Daemon. Dec 01 11:30:04 volumijopy sudo[4214]: pam_unix(sudo:session): session closed for user root Dec 01 11:30:04 volumijopy volumio[1236]: [SpotifyConnect] Vollibrespot Daemon service stoped! Dec 01 11:30:05 volumijopy volumio[1236]: info: Enabling plugin spop Dec 01 11:30:05 volumijopy volumio[1236]: info: Loading plugin "spop"... Dec 01 11:30:05 volumijopy volumio[1236]: info: PLUGIN START: spop Dec 01 11:30:05 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 11:30:05 volumijopy volumio[1236]: [SpotifyConnect] Creating VLS config file Dec 01 11:30:05 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:05 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:05 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:05 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:05 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:05 volumijopy volumio[1236]: [SpotifyConnect] Starting metadata listener Dec 01 11:30:05 volumijopy sudo[4226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Dec 01 11:30:05 volumijopy sudo[4226]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:30:05 volumijopy sudo[4226]: pam_unix(sudo:session): session closed for user root Dec 01 11:30:05 volumijopy sudo[4230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Dec 01 11:30:05 volumijopy sudo[4230]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:30:05 volumijopy systemd[1]: Starting Volspotconnect2 Daemon... Dec 01 11:30:05 volumijopy systemd[1]: Started Volspotconnect2 Daemon. Dec 01 11:30:05 volumijopy sudo[4230]: pam_unix(sudo:session): session closed for user root Dec 01 11:30:05 volumijopy volumio[4240]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Dec 01 11:30:05 volumijopy volumio[4240]: Reading Config from "/tmp/volspotify.toml" Dec 01 11:30:05 volumijopy volumio[4240]: [Vollibrespot] : Using Alsa backend with device: plughw:1 Dec 01 11:30:05 volumijopy volumio[1236]: [SpotifyConnect] Vollibrespot Daemon service started! Dec 01 11:30:05 volumijopy volumio[1236]: [Metrics] SpotifyConnect: 0s 65.77ms Dec 01 11:30:05 volumijopy volumio[1236]: info: Done. Dec 01 11:30:05 volumijopy volumio[4240]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Dec 01 11:30:06 volumijopy wpa_supplicant[927]: wlan0: Failed to initiate sched scan Dec 01 11:30:06 volumijopy volumio[1236]: info: Enabling plugin volspotconnect2 Dec 01 11:30:06 volumijopy volumio[1236]: info: Loading plugin "volspotconnect2"... Dec 01 11:30:06 volumijopy volumio[1236]: info: PLUGIN START: volspotconnect2 Dec 01 11:30:06 volumijopy volumio[1236]: [SpotifyConnect] Creating VLS config file Dec 01 11:30:06 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:06 volumijopy volumio[1236]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 11:30:06 volumijopy volumio[1236]: [SpotifyConnect] Starting metadata listener Dec 01 11:30:06 volumijopy volumio[1236]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Dec 01 11:30:06 volumijopy volumio[1236]: at Object._errnoException (util.js:1022:11) Dec 01 11:30:06 volumijopy volumio[1236]: at _exceptionWithHostPort (util.js:1044:20) Dec 01 11:30:06 volumijopy volumio[1236]: at _handle.lookup (dgram.js:266:18) Dec 01 11:30:06 volumijopy volumio[1236]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Dec 01 11:30:06 volumijopy volumio[1236]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 01 11:30:06 volumijopy volumio[1236]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Dec 01 11:30:06 volumijopy volumio[1236]: at Socket.onListenError (dgram.js:362:22) Dec 01 11:30:06 volumijopy volumio[1236]: at Object.onceWrapper (events.js:315:30) Dec 01 11:30:06 volumijopy volumio[1236]: at emitOne (events.js:121:20) Dec 01 11:30:06 volumijopy volumio[1236]: at Socket.emit (events.js:211:7) Dec 01 11:30:06 volumijopy volumio[1236]: at _handle.lookup (dgram.js:267:14) Dec 01 11:30:06 volumijopy volumio[1236]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Dec 01 11:30:06 volumijopy volumio[1236]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 01 11:30:06 volumijopy sudo[4248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Dec 01 11:30:06 volumijopy sudo[4248]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 11:30:06 volumijopy systemd[1]: Starting Volspotconnect2 Daemon... Dec 01 11:30:06 volumijopy systemd[1]: Started Volspotconnect2 Daemon. Dec 01 11:30:06 volumijopy sudo[4248]: pam_unix(sudo:session): session closed for user root Dec 01 11:30:06 volumijopy volumio[4253]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Dec 01 11:30:06 volumijopy volumio[4253]: Reading Config from "volspotify.toml" Dec 01 11:30:06 volumijopy volumio[4253]: [Vollibrespot] : Using Alsa backend with device: plughw:1 Dec 01 11:30:06 volumijopy volumio[1236]: [SpotifyConnect] Vollibrespot Daemon service started! Dec 01 11:30:06 volumijopy volumio[1236]: [Metrics] SpotifyConnect: 0s 56.95ms Dec 01 11:30:06 volumijopy volumio[1236]: info: Done. Dec 01 11:30:06 volumijopy volumio[4253]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Dec 01 11:30:07 volumijopy volumio[1236]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 11:30:07 volumijopy volumio[1236]: info: Checking Spotify Web API Dec 01 11:30:07 volumijopy volumio[1236]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 11:30:07 volumijopy volumio[1236]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Dec 01 11:30:07 volumijopy volumio[1236]: at Socket._healthCheck (dgram.js:638:11) Dec 01 11:30:07 volumijopy volumio[1236]: at Socket.send (dgram.js:435:8) Dec 01 11:30:07 volumijopy volumio[1236]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Dec 01 11:30:07 volumijopy volumio[1236]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2318:23) Dec 01 11:30:07 volumijopy volumio[1236]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/spop/index.js:2410:18) Dec 01 11:30:07 volumijopy volumio[1236]: at ontimeout (timers.js:482:11) Dec 01 11:30:07 volumijopy volumio[1236]: at tryOnTimeout (timers.js:317:5) Dec 01 11:30:07 volumijopy volumio[1236]: at Timer.listOnTimeout (timers.js:277:5) Dec 01 11:30:07 volumijopy volumio[1236]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 11:30:07 volumijopy sudo[4268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 11:29 Dec 01 11:30:07 volumijopy sudo[4268]: 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="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"