-- Logs begin at Thu 2019-02-14 10:12:00 GMT, end at Sun 2024-04-28 17:43:53 BST. -- Apr 28 17:42:00 larkascending volumio[873]: info: Check plugin dependencies Apr 28 17:42:00 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 17:42:00 larkascending volumio[873]: info: Rename folder Apr 28 17:42:00 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:42:00 larkascending volumio[873]: info: Move to category Apr 28 17:42:01 larkascending volumio[873]: info: Checking if install.sh is present Apr 28 17:42:01 larkascending volumio[873]: info: Executing install.sh Apr 28 17:42:01 larkascending sudo[3442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/soundcloud/install.sh Apr 28 17:42:01 larkascending sudo[3442]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:42:01 larkascending sudo[3442]: pam_unix(sudo:session): session closed for user root Apr 28 17:42:01 larkascending volumio[873]: info: SoundCloud plugin installed Apr 28 17:42:01 larkascending volumio[873]: info: Install script completed Apr 28 17:42:01 larkascending volumio[873]: info: Done installing plugin. Apr 28 17:42:01 larkascending volumio[873]: info: Enabling plugin soundcloud Apr 28 17:42:01 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 17:42:01 larkascending volumio[873]: info: [{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.1.1","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Logitech Media Server","name":"lms","category":"music_service","version":"1.2.6","icon":"fa fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Plex and PlexAmp","name":"plexamp","category":"music_service","version":"1.0.3","icon":"fa-server","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"3.0.9","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Volusonic","name":"volusonic","category":"music_service","version":"2.3.0","icon":"fa-ship","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"0.1.3","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.0.0","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"LastFM Scrobbler","name":"lastfm","category":"user_interface","version":"1.5.6","icon":"fa-lastfm","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.3.8","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 28 17:42:01 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 28 17:42:01 larkascending volumio[873]: Plugin install end detected on script Apr 28 17:42:01 larkascending volumio[873]: info: Folder /tmp/plugins removed Apr 28 17:42:01 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:42:01 larkascending volumio[873]: info: Folder /data/temp removed Apr 28 17:42:04 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:42:12 larkascending volumio[873]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Apr 28 17:42:14 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:42:14 larkascending volumio[873]: info: Listing playlists Apr 28 17:42:14 larkascending volumio[873]: info: Listing playlists Apr 28 17:42:14 larkascending volumio[873]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Apr 28 17:42:14 larkascending volumio[873]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Apr 28 17:42:14 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 17:42:14 larkascending volumio[873]: Cannot find translation for source YouTube Music Apr 28 17:42:14 larkascending volumio[873]: Cannot find translation for source Volusonic Apr 28 17:42:14 larkascending volumio[873]: Cannot find translation for source LastFM Apr 28 17:42:14 larkascending volumio[873]: Cannot find translation for source Plex Apr 28 17:42:14 larkascending volumio[873]: Cannot find translation for source TIDAL Apr 28 17:42:14 larkascending volumio[873]: [SpotifyConnect] Closing metadata listener Apr 28 17:42:14 larkascending sudo[3511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Apr 28 17:42:14 larkascending sudo[3511]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:42:14 larkascending systemd[1]: Stopping Volspotconnect2 Daemon... Apr 28 17:42:14 larkascending systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 28 17:42:14 larkascending systemd[1]: volspotconnect.service: Succeeded. Apr 28 17:42:14 larkascending systemd[1]: Stopped Volspotconnect2 Daemon. Apr 28 17:42:14 larkascending volumio[873]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 17:42:14 larkascending sudo[3511]: pam_unix(sudo:session): session closed for user root Apr 28 17:42:14 larkascending volumio[873]: [SpotifyConnect] Vollibrespot Daemon service stoped! Apr 28 17:42:15 larkascending volumio[873]: info: Check plugin dependencies Apr 28 17:42:15 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 17:42:15 larkascending volumio[873]: info: Rename folder Apr 28 17:42:15 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:42:15 larkascending volumio[873]: info: Move to category Apr 28 17:42:18 larkascending volumio[873]: info: Checking if install.sh is present Apr 28 17:42:18 larkascending volumio[873]: info: Executing install.sh Apr 28 17:42:18 larkascending sudo[3525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Apr 28 17:42:18 larkascending sudo[3525]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:42:18 larkascending volumio[873]: info: Installing Go-librespot Apr 28 17:42:18 larkascending volumio[873]: info: Checking old vollibrespot installs Apr 28 17:42:18 larkascending systemd[1]: Reloading. Apr 28 17:42:18 larkascending 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. Apr 28 17:42:18 larkascending systemd[1]: /data/plugins/music_service/lms/unit/logitechmediaserver.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/logitechmediaserver.pid → /run/logitechmediaserver.pid; please update the unit file accordingly. Apr 28 17:42:19 larkascending systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 28 17:42:19 larkascending systemd[1]: Reloading. Apr 28 17:42:19 larkascending 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. Apr 28 17:42:19 larkascending systemd[1]: /data/plugins/music_service/lms/unit/logitechmediaserver.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/logitechmediaserver.pid → /run/logitechmediaserver.pid; please update the unit file accordingly. Apr 28 17:42:20 larkascending volumio[873]: info: Clearing old vollibrespot Apr 28 17:42:20 larkascending volumio[873]: info: vollibrespot cleared Apr 28 17:42:20 larkascending volumio[873]: info: Dowloading daemon Apr 28 17:42:21 larkascending volumio[873]: info: Creating Start Script Apr 28 17:42:21 larkascending systemd[1]: Reloading. Apr 28 17:42:22 larkascending 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. Apr 28 17:42:22 larkascending systemd[1]: /data/plugins/music_service/lms/unit/logitechmediaserver.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/logitechmediaserver.pid → /run/logitechmediaserver.pid; please update the unit file accordingly. Apr 28 17:42:22 larkascending sudo[3525]: pam_unix(sudo:session): session closed for user root Apr 28 17:42:22 larkascending volumio[873]: info: Install script completed Apr 28 17:42:22 larkascending volumio[873]: info: Done installing plugin. Apr 28 17:42:22 larkascending volumio[873]: info: Enabling plugin spop Apr 28 17:42:22 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 17:42:22 larkascending volumio[873]: info: [{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.1.1","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Logitech Media Server","name":"lms","category":"music_service","version":"1.2.6","icon":"fa fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Plex and PlexAmp","name":"plexamp","category":"music_service","version":"1.0.3","icon":"fa-server","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.0.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Volusonic","name":"volusonic","category":"music_service","version":"2.3.0","icon":"fa-ship","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"0.1.3","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.0.0","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"LastFM Scrobbler","name":"lastfm","category":"user_interface","version":"1.5.6","icon":"fa-lastfm","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.3.8","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 28 17:42:22 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 28 17:42:22 larkascending volumio[873]: Plugin install end detected on script Apr 28 17:42:22 larkascending volumio[873]: info: Folder /tmp/plugins removed Apr 28 17:42:22 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:42:22 larkascending volumio[873]: info: Folder /data/temp removed Apr 28 17:42:24 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:42:34 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:42:34 larkascending volumio[873]: info: Listing playlists Apr 28 17:42:34 larkascending volumio[873]: info: Listing playlists Apr 28 17:42:35 larkascending volumio[873]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytcr/volumio/buster/armhf Apr 28 17:42:38 larkascending volumio[873]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytcr/volumio/buster/armhf Apr 28 17:42:38 larkascending volumio[873]: [yt-cast-receiver] Stopped Apr 28 17:42:42 larkascending volumio[873]: info: Check plugin dependencies Apr 28 17:42:42 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 17:42:42 larkascending volumio[873]: info: Rename folder Apr 28 17:42:42 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:42:42 larkascending volumio[873]: info: Move to category Apr 28 17:42:44 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:42:52 larkascending volumio[873]: info: Checking if install.sh is present Apr 28 17:42:52 larkascending volumio[873]: info: Executing install.sh Apr 28 17:42:52 larkascending sudo[3600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/ytcr/install.sh Apr 28 17:42:52 larkascending sudo[3600]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:42:52 larkascending sudo[3600]: pam_unix(sudo:session): session closed for user root Apr 28 17:42:52 larkascending volumio[873]: info: YouTube Cast Receiver installed Apr 28 17:42:52 larkascending volumio[873]: Plugin install end detected on script Apr 28 17:42:52 larkascending volumio[873]: info: Install script completed Apr 28 17:42:52 larkascending volumio[873]: info: Done installing plugin. Apr 28 17:42:52 larkascending volumio[873]: info: Enabling plugin ytcr Apr 28 17:42:52 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 17:42:52 larkascending volumio[873]: info: [{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.1.1","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Logitech Media Server","name":"lms","category":"music_service","version":"1.2.6","icon":"fa fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Plex and PlexAmp","name":"plexamp","category":"music_service","version":"1.0.3","icon":"fa-server","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.0.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Volusonic","name":"volusonic","category":"music_service","version":"2.3.0","icon":"fa-ship","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.0.6","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.0.0","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"LastFM Scrobbler","name":"lastfm","category":"user_interface","version":"1.5.6","icon":"fa-lastfm","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.3.8","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 28 17:42:52 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 28 17:42:52 larkascending volumio[873]: info: Folder /tmp/plugins removed Apr 28 17:42:52 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:42:52 larkascending volumio[873]: info: Folder /data/temp removed Apr 28 17:42:54 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:42:54 larkascending volumio[873]: info: Listing playlists Apr 28 17:42:54 larkascending volumio[873]: info: Listing playlists Apr 28 17:43:04 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:43:05 larkascending volumio[873]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf Apr 28 17:43:07 larkascending volumio[873]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf Apr 28 17:43:07 larkascending volumio[873]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesYouTube Music Apr 28 17:43:07 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 17:43:07 larkascending volumio[873]: Cannot find translation for source Volusonic Apr 28 17:43:07 larkascending volumio[873]: Cannot find translation for source LastFM Apr 28 17:43:07 larkascending volumio[873]: Cannot find translation for source Plex Apr 28 17:43:07 larkascending volumio[873]: Cannot find translation for source TIDAL Apr 28 17:43:08 larkascending volumio[873]: info: Check plugin dependencies Apr 28 17:43:08 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 17:43:08 larkascending volumio[873]: info: Rename folder Apr 28 17:43:08 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:43:08 larkascending volumio[873]: info: Move to category Apr 28 17:43:14 larkascending volumio[873]: info: Checking if install.sh is present Apr 28 17:43:14 larkascending volumio[873]: info: Executing install.sh Apr 28 17:43:14 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:43:14 larkascending volumio[873]: info: Listing playlists Apr 28 17:43:14 larkascending volumio[873]: info: Listing playlists Apr 28 17:43:14 larkascending sudo[3678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/ytmusic/install.sh Apr 28 17:43:14 larkascending sudo[3678]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:43:14 larkascending sudo[3678]: pam_unix(sudo:session): session closed for user root Apr 28 17:43:14 larkascending volumio[873]: info: Install script completed Apr 28 17:43:14 larkascending volumio[873]: info: Done installing plugin. Apr 28 17:43:14 larkascending volumio[873]: info: Enabling plugin ytmusic Apr 28 17:43:14 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 17:43:14 larkascending volumio[873]: info: [{"prettyName":"Bandcamp Discover","name":"bandcamp","category":"music_service","version":"1.1.1","icon":"fa-bandcamp","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Logitech Media Server","name":"lms","category":"music_service","version":"1.2.6","icon":"fa fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Mixcloud","name":"mixcloud","category":"music_service","version":"1.0.1","icon":"fa-mixcloud","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Plex and PlexAmp","name":"plexamp","category":"music_service","version":"1.0.3","icon":"fa-server","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"SoundCloud","name":"soundcloud","category":"music_service","version":"1.0.3","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.0.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Volusonic","name":"volusonic","category":"music_service","version":"2.3.0","icon":"fa-ship","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.0.6","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.0.2","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"LastFM Scrobbler","name":"lastfm","category":"user_interface","version":"1.5.6","icon":"fa-lastfm","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.3.8","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 28 17:43:14 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 28 17:43:14 larkascending volumio[873]: info: YouTube Music plugin installed Apr 28 17:43:14 larkascending volumio[873]: Plugin install end detected on script Apr 28 17:43:14 larkascending volumio[873]: info: Folder /tmp/plugins removed Apr 28 17:43:14 larkascending volumio[873]: info: Folder /tmp/downloaded_plugin.zip removed Apr 28 17:43:14 larkascending volumio[873]: info: Folder /data/temp removed Apr 28 17:43:24 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:43:34 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:43:34 larkascending volumio[873]: info: Listing playlists Apr 28 17:43:34 larkascending volumio[873]: info: Listing playlists Apr 28 17:43:44 larkascending volumio[873]: info: CoreCommandRouter::volumioGetState Apr 28 17:43:45 larkascending volumio[873]: info: Enabling plugin soundcloud Apr 28 17:43:45 larkascending volumio[873]: info: Loading plugin "soundcloud"... Apr 28 17:43:45 larkascending volumio[873]: info: PLUGIN START: soundcloud Apr 28 17:43:45 larkascending volumio[873]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 28 17:43:45 larkascending volumio[873]: info: [1714322625810] CoreMusicLibrary::Adding element SoundCloud Apr 28 17:43:45 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 17:43:45 larkascending volumio[873]: Cannot find translation for source Volusonic Apr 28 17:43:45 larkascending volumio[873]: Cannot find translation for source LastFM Apr 28 17:43:45 larkascending volumio[873]: Cannot find translation for source Plex Apr 28 17:43:45 larkascending volumio[873]: Cannot find translation for source TIDAL Apr 28 17:43:45 larkascending volumio[873]: Cannot find translation for source SoundCloud Apr 28 17:43:45 larkascending volumio[873]: info: Done. Apr 28 17:43:46 larkascending volumio[873]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSoundCloud Apr 28 17:43:46 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source Volusonic Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source LastFM Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source Plex Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source TIDAL Apr 28 17:43:46 larkascending volumio[873]: info: Disabling plugin soundcloud Apr 28 17:43:46 larkascending volumio[873]: info: Done. Apr 28 17:43:46 larkascending volumio[873]: info: Enabling plugin soundcloud Apr 28 17:43:46 larkascending volumio[873]: info: Loading plugin "soundcloud"... Apr 28 17:43:46 larkascending volumio[873]: info: PLUGIN START: soundcloud Apr 28 17:43:46 larkascending volumio[873]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 28 17:43:46 larkascending volumio[873]: info: [1714322626940] CoreMusicLibrary::Adding element SoundCloud Apr 28 17:43:46 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source Volusonic Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source LastFM Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source Plex Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source TIDAL Apr 28 17:43:46 larkascending volumio[873]: Cannot find translation for source SoundCloud Apr 28 17:43:46 larkascending volumio[873]: info: Done. Apr 28 17:43:48 larkascending volumio[873]: info: Enabling plugin spop Apr 28 17:43:48 larkascending volumio[873]: info: Loading plugin "spop"... Apr 28 17:43:48 larkascending volumio[873]: info: PLUGIN START: spop Apr 28 17:43:48 larkascending volumio[873]: info: Checking for old spotify connect plugin installed Apr 28 17:43:48 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 17:43:48 larkascending volumio[873]: [SpotifyConnect] Creating VLS config file Apr 28 17:43:48 larkascending volumio[873]: error: Failed to read template file: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/spop/volspotify.tmpl' Apr 28 17:43:48 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:48 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:48 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:48 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:48 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:48 larkascending volumio[873]: [SpotifyConnect] Starting metadata listener Apr 28 17:43:48 larkascending volumio[873]: (node:873) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'replace' of undefined Apr 28 17:43:48 larkascending volumio[873]: at ControllerSpotify.createConfigFile (/data/plugins/music_service/spop/index.js:2607:27) Apr 28 17:43:48 larkascending volumio[873]: at ControllerSpotify.init (/data/plugins/music_service/spop/index.js:2470:14) Apr 28 17:43:48 larkascending volumio[873]: at Promise._successFn (/data/plugins/music_service/spop/index.js:134:14) Apr 28 17:43:48 larkascending volumio[873]: at nextTickCallback (/data/plugins/music_service/spop/node_modules/kew/kew.js:47:28) Apr 28 17:43:48 larkascending volumio[873]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 28 17:43:48 larkascending volumio[873]: (Use `node --trace-warnings ...` to show where the warning was created) Apr 28 17:43:48 larkascending volumio[873]: (node:873) 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: 1) Apr 28 17:43:48 larkascending volumio[873]: (node:873) [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. Apr 28 17:43:48 larkascending sudo[3685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Apr 28 17:43:48 larkascending sudo[3685]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:43:48 larkascending volumio[873]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 28 17:43:48 larkascending systemd[1]: Started Volspotconnect2 Daemon. Apr 28 17:43:48 larkascending sudo[3685]: pam_unix(sudo:session): session closed for user root Apr 28 17:43:48 larkascending volumio[3687]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Apr 28 17:43:48 larkascending systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Apr 28 17:43:48 larkascending systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Apr 28 17:43:48 larkascending volumio[873]: [SpotifyConnect] Vollibrespot Daemon service started! Apr 28 17:43:48 larkascending volumio[873]: [Metrics] SpotifyConnect: 0s 169.79ms Apr 28 17:43:48 larkascending volumio[873]: info: Done. Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 17:43:49 larkascending volumio[873]: Cannot find translation for source Volusonic Apr 28 17:43:49 larkascending volumio[873]: Cannot find translation for source LastFM Apr 28 17:43:49 larkascending volumio[873]: Cannot find translation for source Plex Apr 28 17:43:49 larkascending volumio[873]: Cannot find translation for source TIDAL Apr 28 17:43:49 larkascending volumio[873]: Cannot find translation for source SoundCloud Apr 28 17:43:49 larkascending volumio[873]: [SpotifyConnect] Closing metadata listener Apr 28 17:43:49 larkascending volumio[873]: info: Disabling plugin spop Apr 28 17:43:49 larkascending volumio[873]: info: Done. Apr 28 17:43:49 larkascending sudo[3690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Apr 28 17:43:49 larkascending sudo[3690]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:43:49 larkascending systemd[1]: Stopped Volspotconnect2 Daemon. Apr 28 17:43:49 larkascending sudo[3690]: pam_unix(sudo:session): session closed for user root Apr 28 17:43:49 larkascending volumio[873]: [SpotifyConnect] Vollibrespot Daemon service stoped! Apr 28 17:43:49 larkascending volumio[873]: info: Enabling plugin spop Apr 28 17:43:49 larkascending volumio[873]: info: Loading plugin "spop"... Apr 28 17:43:49 larkascending volumio[873]: info: PLUGIN START: spop Apr 28 17:43:49 larkascending volumio[873]: info: Checking for old spotify connect plugin installed Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 17:43:49 larkascending volumio[873]: [SpotifyConnect] Creating VLS config file Apr 28 17:43:49 larkascending volumio[873]: error: Failed to read template file: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/spop/volspotify.tmpl' Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:49 larkascending volumio[873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 17:43:49 larkascending volumio[873]: [SpotifyConnect] Starting metadata listener Apr 28 17:43:49 larkascending volumio[873]: (node:873) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'replace' of undefined Apr 28 17:43:49 larkascending volumio[873]: at ControllerSpotify.createConfigFile (/data/plugins/music_service/spop/index.js:2607:27) Apr 28 17:43:49 larkascending volumio[873]: at ControllerSpotify.init (/data/plugins/music_service/spop/index.js:2470:14) Apr 28 17:43:49 larkascending volumio[873]: at Promise._successFn (/data/plugins/music_service/spop/index.js:134:14) Apr 28 17:43:49 larkascending volumio[873]: at nextTickCallback (/data/plugins/music_service/spop/node_modules/kew/kew.js:47:28) Apr 28 17:43:49 larkascending volumio[873]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 28 17:43:49 larkascending volumio[873]: (node:873) 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) Apr 28 17:43:49 larkascending volumio[873]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 28 17:43:49 larkascending sudo[3693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Apr 28 17:43:49 larkascending sudo[3693]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:43:49 larkascending systemd[1]: Started Volspotconnect2 Daemon. Apr 28 17:43:49 larkascending sudo[3693]: pam_unix(sudo:session): session closed for user root Apr 28 17:43:49 larkascending volumio[3695]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Apr 28 17:43:50 larkascending systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Apr 28 17:43:50 larkascending systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Apr 28 17:43:50 larkascending volumio[873]: [SpotifyConnect] Vollibrespot Daemon service started! Apr 28 17:43:50 larkascending volumio[873]: [Metrics] SpotifyConnect: 0s 135.96ms Apr 28 17:43:50 larkascending volumio[873]: info: Done. Apr 28 17:43:51 larkascending volumio[873]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 17:43:51 larkascending volumio[873]: error: Cannot populate Spotify configuration: TypeError: Cannot read property 'bars' of undefined Apr 28 17:43:52 larkascending systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Apr 28 17:43:52 larkascending systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 1. Apr 28 17:43:52 larkascending systemd[1]: Stopped Volspotconnect2 Daemon. Apr 28 17:43:52 larkascending systemd[1]: Started Volspotconnect2 Daemon. Apr 28 17:43:52 larkascending volumio[3697]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Apr 28 17:43:52 larkascending systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Apr 28 17:43:52 larkascending systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Apr 28 17:43:52 larkascending volumio[873]: info: Checking Spotify Web API Apr 28 17:43:52 larkascending volumio[873]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 17:43:52 larkascending volumio[873]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Apr 28 17:43:52 larkascending volumio[873]: at healthCheck (dgram.js:897:11) Apr 28 17:43:52 larkascending volumio[873]: at Socket.send (dgram.js:622:3) Apr 28 17:43:52 larkascending volumio[873]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:121:21) Apr 28 17:43:52 larkascending volumio[873]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2383:23) Apr 28 17:43:52 larkascending volumio[873]: at Timeout._onTimeout (/data/plugins/music_service/spop/index.js:2475:18) Apr 28 17:43:52 larkascending volumio[873]: at listOnTimeout (internal/timers.js:554:17) Apr 28 17:43:52 larkascending volumio[873]: at processTimers (internal/timers.js:497:7) { Apr 28 17:43:52 larkascending volumio[873]: code: 'ERR_SOCKET_DGRAM_NOT_RUNNING' Apr 28 17:43:52 larkascending volumio[873]: } Apr 28 17:43:52 larkascending volumio[873]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 17:43:53 larkascending sudo[3708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-28 17:42 Apr 28 17:43:53 larkascending sudo[3708]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"