-- Logs begin at Wed 2025-04-30 11:21:44 +03, end at Fri 2025-05-09 17:29:56 +03. -- May 09 17:28:00 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:01 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:02 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:03 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:04 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:05 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:06 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:07 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:08 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:10 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 17:28:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 09 17:28:11 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 17:28:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 17:28:11 volumio volumio[793]: info: Discovery: Getting this device information May 09 17:28:11 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:28:12 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:13 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:14 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:15 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:16 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:17 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:18 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:19 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:20 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:21 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:22 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:22 volumio volumio[793]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesRadio Paradise May 09 17:28:22 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 17:28:22 volumio volumio[793]: Cannot find translation for sourceMedia Servers May 09 17:28:22 volumio volumio[793]: Cannot find translation for source80s80s Radio May 09 17:28:22 volumio volumio[793]: Cannot find translation for sourceMother Earth Radio May 09 17:28:22 volumio volumio[793]: info: Disabling plugin radio_paradise May 09 17:28:22 volumio volumio[793]: info: Done. May 09 17:28:23 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:24 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:24 volumio volumio[793]: info: Enabling plugin radio_paradise May 09 17:28:24 volumio volumio[793]: info: Loading plugin "radio_paradise"... May 09 17:28:24 volumio volumio[793]: info: Applying required configuration parameters for plugin radio_paradise May 09 17:28:24 volumio volumio[793]: info: [1746800904796] [RadioParadise] API delay: 5 May 09 17:28:24 volumio volumio[793]: info: PLUGIN START: radio_paradise May 09 17:28:24 volumio volumio[793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 09 17:28:24 volumio volumio[793]: info: [1746800904803] CoreMusicLibrary::Adding element Radio Paradise May 09 17:28:24 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 17:28:24 volumio volumio[793]: Cannot find translation for sourceMedia Servers May 09 17:28:24 volumio volumio[793]: Cannot find translation for source80s80s Radio May 09 17:28:24 volumio volumio[793]: Cannot find translation for sourceMother Earth Radio May 09 17:28:24 volumio volumio[793]: Cannot find translation for sourceRadio Paradise May 09 17:28:24 volumio volumio[793]: info: Done. May 09 17:28:25 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:26 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:26 volumio volumio[793]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify May 09 17:28:26 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 17:28:26 volumio volumio[793]: Cannot find translation for sourceMedia Servers May 09 17:28:26 volumio volumio[793]: Cannot find translation for source80s80s Radio May 09 17:28:26 volumio volumio[793]: Cannot find translation for sourceMother Earth Radio May 09 17:28:26 volumio volumio[793]: Cannot find translation for sourceRadio Paradise May 09 17:28:26 volumio volumio[793]: [SpotifyConnect] Closing metadata listener May 09 17:28:26 volumio volumio[793]: info: Disabling plugin spop May 09 17:28:26 volumio volumio[793]: info: Done. May 09 17:28:26 volumio sudo[6599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service May 09 17:28:26 volumio sudo[6599]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:28:26 volumio systemd[1]: Stopping Volspotconnect2 Daemon... May 09 17:28:26 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM May 09 17:28:26 volumio systemd[1]: volspotconnect.service: Succeeded. May 09 17:28:26 volumio systemd[1]: Stopped Volspotconnect2 Daemon. May 09 17:28:26 volumio sudo[6599]: pam_unix(sudo:session): session closed for user root May 09 17:28:26 volumio volumio[793]: [SpotifyConnect] Vollibrespot Daemon service stoped! May 09 17:28:27 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:28 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:28 volumio volumio[793]: info: Enabling plugin spop May 09 17:28:28 volumio volumio[793]: info: Loading plugin "spop"... May 09 17:28:28 volumio volumio[793]: info: PLUGIN START: spop May 09 17:28:28 volumio volumio[793]: info: Checking for old spotify connect plugin installed May 09 17:28:28 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 09 17:28:28 volumio volumio[793]: [SpotifyConnect] Creating VLS config file May 09 17:28:28 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:28:28 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:28:28 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:28:28 volumio volumio[793]: [SpotifyConnect] Starting metadata listener May 09 17:28:28 volumio sudo[6606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 09 17:28:28 volumio sudo[6606]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:28:28 volumio volumio[793]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12 May 09 17:28:28 volumio systemd[1]: Started Volspotconnect2 Daemon. May 09 17:28:28 volumio sudo[6606]: pam_unix(sudo:session): session closed for user root May 09 17:28:28 volumio volumio[793]: [SpotifyConnect] Vollibrespot Daemon service started! May 09 17:28:28 volumio volumio[793]: [Metrics] SpotifyConnect: 0s 98.98ms May 09 17:28:28 volumio volumio[793]: info: Done. May 09 17:28:28 volumio volumio[6608]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 May 09 17:28:28 volumio volumio[6608]: Reading Config from "/tmp/volspotify.toml" May 09 17:28:28 volumio volumio[6608]: [Vollibrespot] : Using Alsa backend with device: volumio May 09 17:28:28 volumio volumio[6608]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } May 09 17:28:28 volumio volumio[6608]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" May 09 17:28:29 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:30 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:31 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:32 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:32 volumio volumio[793]: info: Checking Spotify Web API May 09 17:28:33 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:34 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:35 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:36 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:37 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:38 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:39 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:40 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:41 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 17:28:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 17:28:41 volumio volumio[793]: info: Discovery: Getting this device information May 09 17:28:41 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:28:42 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:43 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:44 volumio nmbd[705]: [2025/05/09 17:28:44.258053, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 09 17:28:44 volumio nmbd[705]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.20 for name WORKGROUP<1d>. May 09 17:28:44 volumio nmbd[705]: This response was from IP 192.168.1.25, reporting an IP address of 192.168.1.25. May 09 17:28:44 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:45 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:46 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:47 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:48 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:49 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:50 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:51 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:52 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:53 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:54 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:55 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:56 volumio volumio[793]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf May 09 17:28:56 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:57 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:58 volumio volumio[793]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf May 09 17:28:58 volumio volumio[793]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify May 09 17:28:58 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 17:28:58 volumio volumio[793]: Cannot find translation for sourceMedia Servers May 09 17:28:58 volumio volumio[793]: Cannot find translation for source80s80s Radio May 09 17:28:58 volumio volumio[793]: Cannot find translation for sourceMother Earth Radio May 09 17:28:58 volumio volumio[793]: Cannot find translation for sourceRadio Paradise May 09 17:28:58 volumio volumio[793]: [SpotifyConnect] Closing metadata listener May 09 17:28:58 volumio sudo[6695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service May 09 17:28:58 volumio sudo[6695]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:28:58 volumio systemd[1]: Stopping Volspotconnect2 Daemon... May 09 17:28:58 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM May 09 17:28:58 volumio systemd[1]: volspotconnect.service: Succeeded. May 09 17:28:58 volumio systemd[1]: Stopped Volspotconnect2 Daemon. May 09 17:28:58 volumio sudo[6695]: pam_unix(sudo:session): session closed for user root May 09 17:28:58 volumio volumio[793]: [SpotifyConnect] Vollibrespot Daemon service stoped! May 09 17:28:58 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:28:59 volumio volumio[793]: info: Check plugin dependencies May 09 17:28:59 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 09 17:28:59 volumio volumio[793]: info: Rename folder May 09 17:28:59 volumio volumio[793]: info: Folder /tmp/downloaded_plugin.zip removed May 09 17:28:59 volumio volumio[793]: info: Move to category May 09 17:28:59 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: Checking if install.sh is present May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio volumio[793]: info: Executing install.sh May 09 17:29:09 volumio volumio[793]: Upnp client error: Error: This socket has been ended by the other party May 09 17:29:09 volumio volumio[793]: Upnp client error: Error: This socket has been ended by the other party May 09 17:29:09 volumio volumio[793]: Upnp client error: Error: This socket has been ended by the other party May 09 17:29:09 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:09 volumio sudo[6720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh May 09 17:29:09 volumio sudo[6720]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:29:09 volumio volumio[793]: info: Installing Go-librespot May 09 17:29:09 volumio volumio[793]: info: Checking old vollibrespot installs May 09 17:29:09 volumio systemd[1]: Reloading. May 09 17:29:10 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 09 17:29:10 volumio systemd[1]: Reloading. May 09 17:29:10 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:10 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 09 17:29:11 volumio volumio[793]: info: Clearing old vollibrespot May 09 17:29:11 volumio volumio[793]: info: vollibrespot cleared May 09 17:29:11 volumio volumio[793]: info: Clearing old volspotconnect2 plugin May 09 17:29:11 volumio systemd[1]: Reloading. May 09 17:29:11 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:11 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 09 17:29:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 17:29:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 17:29:11 volumio volumio[793]: info: Discovery: Getting this device information May 09 17:29:11 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:11 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:29:12 volumio volumio[793]: info: volspotconnect2 plugin cleared May 09 17:29:12 volumio volumio[793]: info: Downloading daemon May 09 17:29:12 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:13 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:14 volumio volumio[793]: info: Creating directories May 09 17:29:14 volumio volumio[793]: info: Creating data directory May 09 17:29:14 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:14 volumio volumio[793]: info: Creating Start Script May 09 17:29:14 volumio systemd[1]: Reloading. May 09 17:29:15 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 09 17:29:15 volumio sudo[6720]: pam_unix(sudo:session): session closed for user root May 09 17:29:15 volumio volumio[793]: Plugin install end detected on script May 09 17:29:15 volumio volumio[793]: info: Install script completed May 09 17:29:15 volumio volumio[793]: info: Done installing plugin. May 09 17:29:15 volumio volumio[793]: info: Enabling plugin spop May 09 17:29:15 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 17:29:15 volumio volumio[793]: info: [{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"miscellanea","version":"1.3.0","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true},{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"MotherEarthRadio","name":"motherearthradio","category":"music_service","version":"1.0.0","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.3","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"0.2.2","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.0","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.3.5","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":true,"active":true}] May 09 17:29:15 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 09 17:29:15 volumio volumio[793]: info: Folder /tmp/plugins removed May 09 17:29:15 volumio volumio[793]: info: Folder /tmp/downloaded_plugin.zip removed May 09 17:29:15 volumio volumio[793]: info: Folder /data/temp removed May 09 17:29:15 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:16 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:17 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:18 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:19 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:20 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:21 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:22 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:23 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:24 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:25 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:26 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:27 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:28 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:29 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:30 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:30 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 17:29:30 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 09 17:29:31 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:32 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:33 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:34 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:35 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:36 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:37 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:38 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:39 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:40 volumio volumio[793]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 17:29:40 volumio volumio[793]: error: Cannot populate Spotify configuration: TypeError: Cannot read property 'bars' of undefined May 09 17:29:40 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:41 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 17:29:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 17:29:41 volumio volumio[793]: info: Discovery: Getting this device information May 09 17:29:41 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:29:42 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:43 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:44 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:45 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:46 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 17:29:46 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 09 17:29:46 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:47 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:48 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:49 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:50 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:51 volumio volumio[793]: info: Enabling plugin spop May 09 17:29:51 volumio volumio[793]: info: Loading plugin "spop"... May 09 17:29:51 volumio volumio[793]: info: PLUGIN START: spop May 09 17:29:51 volumio volumio[793]: info: Checking for old spotify connect plugin installed May 09 17:29:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 09 17:29:51 volumio volumio[793]: [SpotifyConnect] Creating VLS config file May 09 17:29:51 volumio volumio[793]: error: Failed to read template file: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/spop/volspotify.tmpl' May 09 17:29:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:29:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:29:51 volumio volumio[793]: [SpotifyConnect] Starting metadata listener May 09 17:29:51 volumio volumio[793]: (node:793) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'replace' of undefined May 09 17:29:51 volumio volumio[793]: at ControllerSpotify.createConfigFile (/data/plugins/music_service/spop/index.js:2607:27) May 09 17:29:51 volumio volumio[793]: at ControllerSpotify.init (/data/plugins/music_service/spop/index.js:2470:14) May 09 17:29:51 volumio volumio[793]: at Promise._successFn (/data/plugins/music_service/spop/index.js:134:14) May 09 17:29:51 volumio volumio[793]: at nextTickCallback (/data/plugins/music_service/spop/node_modules/kew/kew.js:47:28) May 09 17:29:51 volumio volumio[793]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 09 17:29:51 volumio volumio[793]: (Use `node --trace-warnings ...` to show where the warning was created) May 09 17:29:51 volumio volumio[793]: (node:793) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 2) May 09 17:29:51 volumio volumio[793]: (node:793) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. May 09 17:29:51 volumio volumio[793]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12 May 09 17:29:51 volumio sudo[6909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 09 17:29:51 volumio sudo[6909]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:29:51 volumio systemd[1]: Started Volspotconnect2 Daemon. May 09 17:29:51 volumio volumio[6911]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory May 09 17:29:51 volumio sudo[6909]: pam_unix(sudo:session): session closed for user root May 09 17:29:51 volumio volumio[793]: [SpotifyConnect] Vollibrespot Daemon service started! May 09 17:29:51 volumio volumio[793]: [Metrics] SpotifyConnect: 0s 108.66ms May 09 17:29:51 volumio volumio[793]: info: Done. May 09 17:29:51 volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a May 09 17:29:51 volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'. May 09 17:29:51 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:52 volumio volumio[793]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify May 09 17:29:52 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 17:29:52 volumio volumio[793]: Cannot find translation for sourceMedia Servers May 09 17:29:52 volumio volumio[793]: Cannot find translation for source80s80s Radio May 09 17:29:52 volumio volumio[793]: Cannot find translation for sourceMother Earth Radio May 09 17:29:52 volumio volumio[793]: Cannot find translation for sourceRadio Paradise May 09 17:29:52 volumio volumio[793]: [SpotifyConnect] Closing metadata listener May 09 17:29:52 volumio volumio[793]: info: Disabling plugin spop May 09 17:29:52 volumio volumio[793]: info: Done. May 09 17:29:52 volumio sudo[6917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service May 09 17:29:52 volumio sudo[6917]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:29:52 volumio systemd[1]: Stopped Volspotconnect2 Daemon. May 09 17:29:52 volumio sudo[6917]: pam_unix(sudo:session): session closed for user root May 09 17:29:52 volumio volumio[793]: [SpotifyConnect] Vollibrespot Daemon service stoped! May 09 17:29:52 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:53 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:54 volumio volumio[793]: info: Enabling plugin spop May 09 17:29:54 volumio volumio[793]: info: Loading plugin "spop"... May 09 17:29:54 volumio volumio[793]: info: PLUGIN START: spop May 09 17:29:54 volumio volumio[793]: info: Checking for old spotify connect plugin installed May 09 17:29:54 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 09 17:29:54 volumio volumio[793]: [SpotifyConnect] Creating VLS config file May 09 17:29:54 volumio volumio[793]: error: Failed to read template file: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/spop/volspotify.tmpl' May 09 17:29:54 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:29:54 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:29:54 volumio volumio[793]: [SpotifyConnect] Starting metadata listener May 09 17:29:54 volumio volumio[793]: (node:793) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'replace' of undefined May 09 17:29:54 volumio volumio[793]: at ControllerSpotify.createConfigFile (/data/plugins/music_service/spop/index.js:2607:27) May 09 17:29:54 volumio volumio[793]: at ControllerSpotify.init (/data/plugins/music_service/spop/index.js:2470:14) May 09 17:29:54 volumio volumio[793]: at Promise._successFn (/data/plugins/music_service/spop/index.js:134:14) May 09 17:29:54 volumio volumio[793]: at nextTickCallback (/data/plugins/music_service/spop/node_modules/kew/kew.js:47:28) May 09 17:29:54 volumio volumio[793]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 09 17:29:54 volumio volumio[793]: (node:793) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 3) May 09 17:29:54 volumio volumio[793]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12 May 09 17:29:54 volumio sudo[6922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 09 17:29:54 volumio sudo[6922]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:29:54 volumio systemd[1]: Started Volspotconnect2 Daemon. May 09 17:29:54 volumio sudo[6922]: pam_unix(sudo:session): session closed for user root May 09 17:29:54 volumio volumio[6924]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory May 09 17:29:54 volumio volumio[793]: [SpotifyConnect] Vollibrespot Daemon service started! May 09 17:29:54 volumio volumio[793]: [Metrics] SpotifyConnect: 0s 95.13ms May 09 17:29:54 volumio volumio[793]: info: Done. May 09 17:29:54 volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a May 09 17:29:54 volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'. May 09 17:29:54 volumio volumio[793]: info: CoreCommandRouter::volumioGetState May 09 17:29:55 volumio volumio[793]: info: Checking Spotify Web API May 09 17:29:55 volumio volumio[793]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 17:29:55 volumio volumio[793]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running May 09 17:29:55 volumio volumio[793]: at healthCheck (dgram.js:897:11) May 09 17:29:55 volumio volumio[793]: at Socket.send (dgram.js:622:3) May 09 17:29:55 volumio volumio[793]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:121:21) May 09 17:29:55 volumio volumio[793]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2383:23) May 09 17:29:55 volumio volumio[793]: at Timeout._onTimeout (/data/plugins/music_service/spop/index.js:2475:18) May 09 17:29:55 volumio volumio[793]: at listOnTimeout (internal/timers.js:554:17) May 09 17:29:55 volumio volumio[793]: at processTimers (internal/timers.js:497:7) { May 09 17:29:55 volumio volumio[793]: code: 'ERR_SOCKET_DGRAM_NOT_RUNNING' May 09 17:29:55 volumio volumio[793]: } May 09 17:29:55 volumio volumio[793]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 17:29:56 volumio sudo[6942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 17:28 May 09 17:29:56 volumio sudo[6942]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"