-- Logs begin at Wed 2021-10-06 10:53:26 UTC, end at Wed 2024-10-09 19:31:33 UTC. -- Oct 09 19:30:09 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 09 19:30:09 volumiopi0w systemd[1]: Starting Cleanup of Temporary Directories... Oct 09 19:30:09 volumiopi0w volumio[827]: Error Retrieving last played file: Error: /data/laststates.json: ENOENT: no such file or directory, open '/data/laststates.json' Oct 09 19:30:09 volumiopi0w systemd[1]: Started Cleanup of Temporary Directories. Oct 09 19:30:10 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:13 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:15 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:23 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:28 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 09 19:30:28 volumiopi0w volumio[827]: info: CURURI: music-library Oct 09 19:30:28 volumiopi0w volumio[827]: error: Failed LSINFO: null Oct 09 19:30:31 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:33 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:35 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:36 volumiopi0w volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Oct 09 19:30:37 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:38 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:30:53 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 09 19:30:53 volumiopi0w volumio[827]: Error Retrieving last played file: Error: /data/laststates.json: ENOENT: no such file or directory, open '/data/laststates.json' Oct 09 19:31:04 volumiopi0w volumio[827]: info: Downloading plugin at http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip Oct 09 19:31:09 volumiopi0w volumio[827]: info: END DOWNLOAD: http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip Oct 09 19:31:09 volumiopi0w volumio[827]: info: Folder /tmp/plugins removed Oct 09 19:31:13 volumiopi0w volumio[827]: info: Checking if plugin already exists Oct 09 19:31:13 volumiopi0w volumio[827]: info: Rename folder Oct 09 19:31:13 volumiopi0w volumio[827]: info: Folder /tmp/downloaded_plugin.zip removed Oct 09 19:31:13 volumiopi0w volumio[827]: info: Move to category Oct 09 19:31:17 volumiopi0w volumio[827]: info: Checking if install.sh is present Oct 09 19:31:17 volumiopi0w volumio[827]: info: Executing install.sh Oct 09 19:31:17 volumiopi0w sudo[3248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Oct 09 19:31:17 volumiopi0w sudo[3248]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:31:17 volumiopi0w volumio[827]: info: Writing systemd unit Oct 09 19:31:17 volumiopi0w sudo[3248]: pam_unix(sudo:session): session closed for user root Oct 09 19:31:17 volumiopi0w volumio[827]: info: Setting permissions Oct 09 19:31:17 volumiopi0w volumio[827]: info: Writing startconnect unit Oct 09 19:31:17 volumiopi0w volumio[827]: info: Install script completed Oct 09 19:31:17 volumiopi0w volumio[827]: info: Adding reference to registry Oct 09 19:31:18 volumiopi0w volumio[827]: info: Done installing plugin. Oct 09 19:31:18 volumiopi0w volumio[827]: Plugin install end detected on script Oct 09 19:31:18 volumiopi0w volumio[827]: info: Folder /tmp/plugins removed Oct 09 19:31:18 volumiopi0w volumio[827]: info: Folder /tmp/downloaded_plugin.zip removed Oct 09 19:31:18 volumiopi0w volumio[827]: info: Folder /data/temp removed Oct 09 19:31:19 volumiopi0w volumio[827]: info: Enabling plugin spop Oct 09 19:31:19 volumiopi0w volumio[827]: info: Loading plugin "spop"... Oct 09 19:31:23 volumiopi0w nmbd[712]: [2024/10/09 19:31:23.431791, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 09 19:31:23 volumiopi0w nmbd[712]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.169 for name WORKGROUP<1d>. Oct 09 19:31:23 volumiopi0w nmbd[712]: This response was from IP 192.168.1.174, reporting an IP address of 192.168.1.174. Oct 09 19:31:25 volumiopi0w volumio[827]: info: PLUGIN START: spop Oct 09 19:31:25 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 19:31:25 volumiopi0w volumio[827]: [SpotifyConnect] Creating VLS config file Oct 09 19:31:25 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:25 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:25 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:25 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:25 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:25 volumiopi0w volumio[827]: [SpotifyConnect] Starting metadata listener Oct 09 19:31:25 volumiopi0w sudo[3284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Oct 09 19:31:25 volumiopi0w sudo[3284]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:31:25 volumiopi0w sudo[3284]: pam_unix(sudo:session): session closed for user root Oct 09 19:31:25 volumiopi0w sudo[3290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Oct 09 19:31:25 volumiopi0w sudo[3290]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:31:25 volumiopi0w systemd[1]: Starting Volspotconnect2 Daemon... Oct 09 19:31:25 volumiopi0w systemd[1]: Started Volspotconnect2 Daemon. Oct 09 19:31:25 volumiopi0w sudo[3290]: pam_unix(sudo:session): session closed for user root Oct 09 19:31:25 volumiopi0w volumio[3300]: /usr/lib/startconnect.sh: line 5: 3302 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 09 19:31:26 volumiopi0w volumio[827]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 09 19:31:26 volumiopi0w volumio[827]: [Metrics] SpotifyConnect: 0s 819.15ms Oct 09 19:31:26 volumiopi0w volumio[827]: info: Done. Oct 09 19:31:26 volumiopi0w volumio[827]: info: Successfully fixed Spotify hosts Oct 09 19:31:26 volumiopi0w volumio[827]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Oct 09 19:31:26 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 19:31:26 volumiopi0w volumio[827]: [SpotifyConnect] Closing metadata listener Oct 09 19:31:26 volumiopi0w volumio[827]: info: Disabling plugin spop Oct 09 19:31:26 volumiopi0w volumio[827]: info: Done. Oct 09 19:31:26 volumiopi0w sudo[3308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Oct 09 19:31:26 volumiopi0w sudo[3308]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:31:26 volumiopi0w systemd[1]: Stopping Volspotconnect2 Daemon... Oct 09 19:31:26 volumiopi0w systemd[1]: Stopped Volspotconnect2 Daemon. Oct 09 19:31:26 volumiopi0w sudo[3308]: pam_unix(sudo:session): session closed for user root Oct 09 19:31:27 volumiopi0w volumio[827]: [SpotifyConnect] Vollibrespot Daemon service stoped! Oct 09 19:31:27 volumiopi0w volumio[827]: info: Enabling plugin spop Oct 09 19:31:27 volumiopi0w volumio[827]: info: Loading plugin "spop"... Oct 09 19:31:27 volumiopi0w volumio[827]: info: PLUGIN START: spop Oct 09 19:31:27 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 19:31:27 volumiopi0w volumio[827]: [SpotifyConnect] Creating VLS config file Oct 09 19:31:27 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:27 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:27 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:27 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:27 volumiopi0w volumio[827]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 19:31:27 volumiopi0w volumio[827]: [SpotifyConnect] Starting metadata listener Oct 09 19:31:27 volumiopi0w sudo[3319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Oct 09 19:31:27 volumiopi0w sudo[3319]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:31:27 volumiopi0w sudo[3319]: pam_unix(sudo:session): session closed for user root Oct 09 19:31:27 volumiopi0w sudo[3322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Oct 09 19:31:27 volumiopi0w sudo[3322]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:31:27 volumiopi0w systemd[1]: Starting Volspotconnect2 Daemon... Oct 09 19:31:27 volumiopi0w systemd[1]: Started Volspotconnect2 Daemon. Oct 09 19:31:27 volumiopi0w sudo[3322]: pam_unix(sudo:session): session closed for user root Oct 09 19:31:28 volumiopi0w volumio[3333]: /usr/lib/startconnect.sh: line 5: 3336 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 09 19:31:28 volumiopi0w volumio[827]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 09 19:31:28 volumiopi0w volumio[827]: [Metrics] SpotifyConnect: 0s 718.83ms Oct 09 19:31:28 volumiopi0w volumio[827]: info: Done. Oct 09 19:31:29 volumiopi0w volumio[827]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 19:31:30 volumiopi0w volumio[827]: info: Checking Spotify Web API Oct 09 19:31:30 volumiopi0w volumio[827]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 19:31:30 volumiopi0w volumio[827]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Oct 09 19:31:30 volumiopi0w volumio[827]: at Socket._healthCheck (dgram.js:638:11) Oct 09 19:31:30 volumiopi0w volumio[827]: at Socket.send (dgram.js:435:8) Oct 09 19:31:30 volumiopi0w volumio[827]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Oct 09 19:31:30 volumiopi0w volumio[827]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2318:23) Oct 09 19:31:30 volumiopi0w volumio[827]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/spop/index.js:2410:18) Oct 09 19:31:30 volumiopi0w volumio[827]: at ontimeout (timers.js:482:11) Oct 09 19:31:30 volumiopi0w volumio[827]: at tryOnTimeout (timers.js:317:5) Oct 09 19:31:30 volumiopi0w volumio[827]: at Timer.listOnTimeout (timers.js:277:5) Oct 09 19:31:30 volumiopi0w volumio[827]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 19:31:30 volumiopi0w systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 09 19:31:30 volumiopi0w systemd[1]: Stopping Volspotconnect2 Daemon... Oct 09 19:31:30 volumiopi0w systemd[1]: Starting Volspotconnect2 Daemon... Oct 09 19:31:30 volumiopi0w systemd[1]: Started Volspotconnect2 Daemon. Oct 09 19:31:30 volumiopi0w volumio[3349]: /usr/lib/startconnect.sh: line 5: 3350 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 09 19:31:32 volumiopi0w systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 09 19:31:32 volumiopi0w systemd[1]: Stopping Volspotconnect2 Daemon... Oct 09 19:31:32 volumiopi0w systemd[1]: Starting Volspotconnect2 Daemon... Oct 09 19:31:32 volumiopi0w systemd[1]: Started Volspotconnect2 Daemon. Oct 09 19:31:32 volumiopi0w volumio[3353]: /usr/lib/startconnect.sh: line 5: 3354 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 09 19:31:33 volumiopi0w sudo[3357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 19:30 Oct 09 19:31:33 volumiopi0w sudo[3357]: 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"