-- Logs begin at Sat 2026-03-28 08:34:56 UTC, end at Sat 2026-03-28 12:50:45 UTC. -- Mar 28 12:49:00 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Mar 28 12:49:00 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:00 volumio systemd[1]: Starting Volspotconnect2 Daemon... Mar 28 12:49:00 volumio systemd[1]: Started Volspotconnect2 Daemon. Mar 28 12:49:00 volumio volumio[19171]: /usr/lib/startconnect.sh: line 5: 19172 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Mar 28 12:49:02 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Mar 28 12:49:02 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:02 volumio systemd[1]: Starting Volspotconnect2 Daemon... Mar 28 12:49:02 volumio systemd[1]: Started Volspotconnect2 Daemon. Mar 28 12:49:02 volumio volumio[19194]: /usr/lib/startconnect.sh: line 5: 19196 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Mar 28 12:49:04 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Mar 28 12:49:04 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:04 volumio systemd[1]: Starting Volspotconnect2 Daemon... Mar 28 12:49:04 volumio systemd[1]: Started Volspotconnect2 Daemon. Mar 28 12:49:04 volumio volumio[19202]: /usr/lib/startconnect.sh: line 5: 19203 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Mar 28 12:49:06 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Mar 28 12:49:06 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:06 volumio systemd[1]: Starting Volspotconnect2 Daemon... Mar 28 12:49:06 volumio systemd[1]: Started Volspotconnect2 Daemon. Mar 28 12:49:06 volumio volumio[19209]: /usr/lib/startconnect.sh: line 5: 19210 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Mar 28 12:49:09 volumio volumio[3478]: info: Starting Uninstall of plugin music_service - spop Mar 28 12:49:09 volumio volumio[3478]: info: Uninstalling plugin spop Mar 28 12:49:09 volumio volumio[3478]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Mar 28 12:49:09 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 28 12:49:09 volumio volumio[3478]: [SpotifyConnect] Closing metadata listener Mar 28 12:49:09 volumio volumio[3478]: info: Disabling plugin spop Mar 28 12:49:09 volumio volumio[3478]: info: Checking if uninstall.sh is present Mar 28 12:49:09 volumio volumio[3478]: info: Executing uninstall.sh Mar 28 12:49:09 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Mar 28 12:49:09 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:09 volumio systemd[1]: Starting Volspotconnect2 Daemon... Mar 28 12:49:09 volumio systemd[1]: Started Volspotconnect2 Daemon. Mar 28 12:49:09 volumio sudo[19217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Mar 28 12:49:09 volumio volumio[19219]: /usr/lib/startconnect.sh: line 5: 19220 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Mar 28 12:49:09 volumio sudo[19217]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 12:49:09 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:09 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Mar 28 12:49:09 volumio sudo[19217]: pam_unix(sudo:session): session closed for user root Mar 28 12:49:09 volumio volumio[3478]: [SpotifyConnect] Vollibrespot Daemon service stoped! Mar 28 12:49:09 volumio sudo[19226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/uninstall.sh Mar 28 12:49:09 volumio sudo[19226]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 12:49:09 volumio sudo[19226]: pam_unix(sudo:session): session closed for user root Mar 28 12:49:09 volumio volumio[3478]: info: Uninstall script completed Mar 28 12:49:09 volumio volumio[3478]: info: Removing plugin spop from configuration Mar 28 12:49:10 volumio volumio[3478]: info: Successfully removed spop configuration files Mar 28 12:49:10 volumio volumio[3478]: info: Plugin folders cleanup Mar 28 12:49:10 volumio volumio[3478]: info: Scanning into folder /volumio/app/plugins/ Mar 28 12:49:10 volumio volumio[3478]: info: Scanning category audio_interface Mar 28 12:49:10 volumio volumio[3478]: info: Scanning category miscellanea Mar 28 12:49:10 volumio volumio[3478]: info: Scanning category music_service Mar 28 12:49:10 volumio volumio[3478]: info: Scanning category plugins.json Mar 28 12:49:10 volumio volumio[3478]: info: Scanning category system_controller Mar 28 12:49:10 volumio volumio[3478]: info: Scanning category user_interface Mar 28 12:49:10 volumio volumio[3478]: info: Scanning into folder /data/plugins/ Mar 28 12:49:10 volumio volumio[3478]: info: Scanning category music_service Mar 28 12:49:10 volumio volumio[3478]: info: Cleaning folder for spop Mar 28 12:49:13 volumio volumio[3478]: info: Plugin folders cleanup completed Mar 28 12:49:13 volumio volumio[3478]: info: [{"prettyName":"Personal Radio","name":"personal_radio","category":"music_service","version":"1.1.5","icon":"fa-headphones","enabled":true,"active":true},{"prettyName":"Volumio Spotify Connect2","name":"volspotconnect2","category":"music_service","version":"1.0.5","icon":"fa-spotify","enabled":true,"active":true}] Mar 28 12:49:13 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 12:49:13 volumio volumio[3478]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 28 12:49:13 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 28 12:49:13 volumio volumio[3478]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Mar 28 12:49:13 volumio volumio[3478]: info: Received Get System Version Mar 28 12:49:13 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 12:49:19 volumio volumio[3478]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 12:49:19 volumio volumio[3478]: [SpotifyConnect] config : toggling initvol/volume_ctrl Mar 28 12:49:26 volumio volumio[3478]: info: CALLMETHOD: music_service volspotconnect2 saveVolspotconnectAccount [object Object] Mar 28 12:49:26 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volspotconnect2 , saveVolspotconnectAccount Mar 28 12:49:26 volumio volumio[3478]: [SpotifyConnect] Creating VLS config file Mar 28 12:49:26 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 28 12:49:26 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 28 12:49:26 volumio volumio[3478]: [SpotifyConnect] Restarting Vollibrespot Daemon Mar 28 12:49:27 volumio sudo[19280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Mar 28 12:49:27 volumio sudo[19280]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 12:49:27 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:27 volumio systemd[1]: Starting Volspotconnect2 Daemon... Mar 28 12:49:27 volumio systemd[1]: Started Volspotconnect2 Daemon. Mar 28 12:49:27 volumio sudo[19280]: pam_unix(sudo:session): session closed for user root Mar 28 12:49:27 volumio volumio[3478]: [SpotifyConnect] Vollibrespot Daemon service restarted! Mar 28 12:49:27 volumio volumio[19287]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Mar 28 12:49:27 volumio volumio[19287]: Reading Config from "volspotify.toml" Mar 28 12:49:27 volumio volumio[19287]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Mar 28 12:49:27 volumio volumio[19287]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Mar 28 12:49:58 volumio volumio[3478]: [SpotifyConnect] Stopping Vollibrespot daemon Mar 28 12:49:58 volumio volumio[3478]: [SpotifyConnect] Closing metadata listener Mar 28 12:49:58 volumio volumio[3478]: info: Disabling plugin volspotconnect2 Mar 28 12:49:58 volumio volumio[3478]: info: Done. Mar 28 12:49:58 volumio sudo[19356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect2.service Mar 28 12:49:58 volumio sudo[19356]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 12:49:58 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Mar 28 12:49:58 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Mar 28 12:49:58 volumio sudo[19356]: pam_unix(sudo:session): session closed for user root Mar 28 12:49:58 volumio volumio[3478]: [SpotifyConnect] Vollibrespot Daemon service stoped! Mar 28 12:50:02 volumio volumio[3478]: info: Enabling plugin volspotconnect2 Mar 28 12:50:02 volumio volumio[3478]: info: Loading plugin "volspotconnect2"... Mar 28 12:50:02 volumio volumio[3478]: info: PLUGIN START: volspotconnect2 Mar 28 12:50:02 volumio volumio[3478]: [SpotifyConnect] Creating VLS config file Mar 28 12:50:02 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 28 12:50:02 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 28 12:50:02 volumio volumio[3478]: [SpotifyConnect] Starting metadata listener Mar 28 12:50:02 volumio sudo[19372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Mar 28 12:50:02 volumio sudo[19372]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 12:50:02 volumio systemd[1]: Starting Volspotconnect2 Daemon... Mar 28 12:50:02 volumio systemd[1]: Started Volspotconnect2 Daemon. Mar 28 12:50:02 volumio sudo[19372]: pam_unix(sudo:session): session closed for user root Mar 28 12:50:02 volumio volumio[3478]: [SpotifyConnect] Vollibrespot Daemon service started! Mar 28 12:50:02 volumio volumio[3478]: [Metrics] SpotifyConnect: 0s 479.46ms Mar 28 12:50:02 volumio volumio[3478]: info: Done. Mar 28 12:50:02 volumio volumio[19389]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Mar 28 12:50:02 volumio volumio[19389]: Reading Config from "volspotify.toml" Mar 28 12:50:02 volumio volumio[19389]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Mar 28 12:50:03 volumio volumio[19389]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Mar 28 12:50:07 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Mar 28 12:50:08 volumio volumio[3478]: info: CoreCommandRouter::volumioGetQueue Mar 28 12:50:08 volumio volumio[3478]: info: CoreStateMachine::getQueue Mar 28 12:50:08 volumio volumio[3478]: info: CorePlayQueue::getQueue Mar 28 12:50:09 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Mar 28 12:50:12 volumio volumio[3478]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 12:50:12 volumio volumio[3478]: info: CoreStateMachine::ClearQueue Mar 28 12:50:12 volumio volumio[3478]: info: CoreStateMachine::stop Mar 28 12:50:12 volumio volumio[3478]: info: CoreStateMachine::serviceStop Mar 28 12:50:12 volumio volumio[3478]: info: CoreCommandRouter::serviceStop Mar 28 12:50:12 volumio volumio[3478]: error: WARNING: No stop method for service spop Mar 28 12:50:12 volumio volumio[3478]: info: CorePlayQueue::clearPlayQueue Mar 28 12:50:12 volumio volumio[3478]: info: CorePlayQueue::saveQueue Mar 28 12:50:12 volumio volumio[3478]: info: CoreCommandRouter::volumioPushState Mar 28 12:50:12 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 12:50:12 volumio volumio[3478]: info: CoreCommandRouter::volumioPushQueue Mar 28 12:50:12 volumio volumio[3478]: info: CoreStateMachine::addQueueItems Mar 28 12:50:12 volumio volumio[3478]: info: CorePlayQueue::addQueueItems Mar 28 12:50:12 volumio volumio[3478]: info: Adding Item to queue: websbs/1 Mar 28 12:50:12 volumio volumio[3478]: info: Exploding uri websbs/1 in service personal_radio Mar 28 12:50:13 volumio volumio[3478]: info: CorePlayQueue::saveQueue Mar 28 12:50:13 volumio volumio[3478]: info: CoreCommandRouter::volumioPushQueue Mar 28 12:50:13 volumio volumio[3478]: info: CoreStateMachine::updateTrackBlock Mar 28 12:50:13 volumio volumio[3478]: info: CorePlayQueue::getTrackBlock Mar 28 12:50:13 volumio volumio[3478]: info: CoreCommandRouter::volumioPlay Mar 28 12:50:13 volumio volumio[3478]: verbose: UNSET VOLATILE Mar 28 12:50:13 volumio volumio[3478]: [SpotifyConnect] unSetVolatile called Mar 28 12:50:13 volumio volumio[3478]: info: Spotify Unset Volatile called Mar 28 12:50:13 volumio volumio[3478]: [SpotifyConnect] Relinquishing Volumio State to another service Mar 28 12:50:13 volumio volumio[3478]: [SpotifyConnect] Spotify Received stop Mar 28 12:50:33 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Mar 28 12:50:36 volumio volumio[3478]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 12:50:36 volumio volumio[3478]: info: CoreStateMachine::ClearQueue Mar 28 12:50:36 volumio volumio[3478]: info: CoreStateMachine::stop Mar 28 12:50:36 volumio volumio[3478]: info: CoreStateMachine::serviceStop Mar 28 12:50:36 volumio volumio[3478]: info: CoreCommandRouter::serviceStop Mar 28 12:50:36 volumio volumio[3478]: error: WARNING: No stop method for service spop Mar 28 12:50:36 volumio volumio[3478]: info: CorePlayQueue::clearPlayQueue Mar 28 12:50:36 volumio volumio[3478]: info: CorePlayQueue::saveQueue Mar 28 12:50:36 volumio volumio[3478]: info: CoreCommandRouter::volumioPushState Mar 28 12:50:36 volumio volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 12:50:36 volumio volumio[3478]: info: CoreCommandRouter::volumioPushQueue Mar 28 12:50:36 volumio volumio[3478]: info: CoreStateMachine::addQueueItems Mar 28 12:50:36 volumio volumio[3478]: info: CorePlayQueue::addQueueItems Mar 28 12:50:36 volumio volumio[3478]: info: Adding Item to queue: webmbc/0 Mar 28 12:50:36 volumio volumio[3478]: info: Exploding uri webmbc/0 in service personal_radio Mar 28 12:50:36 volumio volumio[3478]: info: CorePlayQueue::saveQueue Mar 28 12:50:36 volumio volumio[3478]: info: CoreCommandRouter::volumioPushQueue Mar 28 12:50:36 volumio volumio[3478]: info: CoreStateMachine::updateTrackBlock Mar 28 12:50:36 volumio volumio[3478]: info: CorePlayQueue::getTrackBlock Mar 28 12:50:36 volumio volumio[3478]: info: CoreCommandRouter::volumioPlay Mar 28 12:50:36 volumio volumio[3478]: verbose: UNSET VOLATILE Mar 28 12:50:36 volumio volumio[3478]: [SpotifyConnect] unSetVolatile called Mar 28 12:50:36 volumio volumio[3478]: info: Spotify Unset Volatile called Mar 28 12:50:36 volumio volumio[3478]: [SpotifyConnect] Relinquishing Volumio State to another service Mar 28 12:50:36 volumio volumio[3478]: [SpotifyConnect] Spotify Received stop Mar 28 12:50:42 volumio volumio[3478]: info: CoreCommandRouter::volumioRemoveQueueItem Mar 28 12:50:42 volumio volumio[3478]: info: CoreStateMachine::removeQueueItem Mar 28 12:50:42 volumio volumio[3478]: info: CoreStateMachine::stop Mar 28 12:50:42 volumio volumio[3478]: info: CoreStateMachine::serviceStop Mar 28 12:50:42 volumio volumio[3478]: info: CoreCommandRouter::serviceStop Mar 28 12:50:42 volumio volumio[3478]: error: WARNING: No stop method for service spop Mar 28 12:50:42 volumio volumio[3478]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 12:50:42 volumio volumio[3478]: TypeError: Cannot read property 'then' of undefined Mar 28 12:50:42 volumio volumio[3478]: at CoreStateMachine.removeQueueItem (/volumio/app/statemachine.js:1335:7) Mar 28 12:50:42 volumio volumio[3478]: at CoreCommandRouter.volumioRemoveQueueItem (/volumio/app/index.js:111:28) Mar 28 12:50:42 volumio volumio[3478]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:136:33) Mar 28 12:50:42 volumio volumio[3478]: at emitTwo (events.js:126:13) Mar 28 12:50:42 volumio volumio[3478]: at Socket.emit (events.js:214:7) Mar 28 12:50:42 volumio volumio[3478]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 28 12:50:42 volumio volumio[3478]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Mar 28 12:50:42 volumio volumio[3478]: at process._tickCallback (internal/process/next_tick.js:180:9) Mar 28 12:50:42 volumio volumio[3478]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 12:50:45 volumio sudo[19487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-28 12:49 Mar 28 12:50:45 volumio sudo[19487]: 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"