-- Logs begin at Mon 2024-07-22 19:22:29 CEST, end at Sun 2024-09-08 23:08:04 CEST. -- Sep 08 23:07:01 volumio volumio[907]: verbose: New Socket.io Connection to 192.168.0.60 from 192.168.0.20 UA: Mozilla/5.0 (X11; Linux x86_64; rv:130.0) Gecko/20100101 Firefox/130.0 Engine version: 3 Transport: polling Total Clients: 7 Sep 08 23:07:03 volumio volumio[907]: verbose: New Socket.io Connection to 192.168.0.60 from 192.168.0.20 UA: Mozilla/5.0 (X11; Linux x86_64; rv:130.0) Gecko/20100101 Firefox/130.0 Engine version: 3 Transport: polling Total Clients: 8 Sep 08 23:07:04 volumio ntpd[771]: Soliciting pool server 185.252.140.126 Sep 08 23:07:05 volumio ntpd[771]: Soliciting pool server 128.140.109.119 Sep 08 23:07:09 volumio volumio[907]: verbose: New Socket.io Connection to 192.168.0.60 from 192.168.0.20 UA: Mozilla/5.0 (X11; Linux x86_64; rv:130.0) Gecko/20100101 Firefox/130.0 Engine version: 3 Transport: polling Total Clients: 8 Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::volumioGetVisibleSources Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:09 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:09 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 08 23:07:09 volumio volumio[907]: info: Received Get System Info Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 23:07:09 volumio volumio[907]: info: Discovery: Getting this device information Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:09 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:09 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:09 volumio volumio[907]: info: Listing playlists Sep 08 23:07:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 08 23:07:13 volumio ntpd[771]: Soliciting pool server 213.239.234.28 Sep 08 23:07:14 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:25 volumio ntpd[771]: Soliciting pool server 141.144.230.32 Sep 08 23:07:40 volumio volumio[907]: verbose: New Socket.io Connection to 192.168.0.60 from 192.168.0.20 UA: Mozilla/5.0 (X11; Linux x86_64; rv:130.0) Gecko/20100101 Firefox/130.0 Engine version: 3 Transport: polling Total Clients: 5 Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::volumioGetVisibleSources Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:40 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:40 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 08 23:07:40 volumio volumio[907]: info: Received Get System Info Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 23:07:40 volumio volumio[907]: info: Discovery: Getting this device information Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:40 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::volumioGetState Sep 08 23:07:40 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Sep 08 23:07:40 volumio volumio[907]: info: Listing playlists Sep 08 23:07:40 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 08 23:07:41 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:41 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:41 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 08 23:07:41 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:41 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:41 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:41 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:42 volumio volumio[907]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:44 volumio volumio[907]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:07:44 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:07:44 volumio volumio[907]: info: Check plugin dependencies Sep 08 23:07:45 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 23:07:45 volumio volumio[907]: info: Checking if plugin already exists Sep 08 23:07:45 volumio volumio[907]: info: Rename folder Sep 08 23:07:45 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:07:45 volumio volumio[907]: info: Move to category Sep 08 23:07:59 volumio volumio-remote-updater[2152]: [2024-09-08 21:07:59] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Sep 08 23:07:59 volumio volumio[907]: info: Checking if install.sh is present Sep 08 23:08:00 volumio volumio[907]: info: Executing install.sh Sep 08 23:08:00 volumio volumio[907]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:08:00 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:00 volumio sudo[3315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Sep 08 23:08:00 volumio sudo[3315]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 23:08:00 volumio volumio[907]: info: An error occurred installing the plugin. Rolling back config Sep 08 23:08:00 volumio volumio[907]: info: Plugin folders cleanup Sep 08 23:08:00 volumio volumio[907]: info: Scanning into folder /volumio/app/plugins/ Sep 08 23:08:00 volumio volumio[907]: info: Scanning category audio_interface Sep 08 23:08:00 volumio volumio[907]: info: Scanning category miscellanea Sep 08 23:08:00 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:00 volumio volumio[907]: info: Scanning category plugins.json Sep 08 23:08:00 volumio volumio[907]: info: Scanning category system_controller Sep 08 23:08:00 volumio volumio[907]: info: Scanning category user_interface Sep 08 23:08:00 volumio volumio[907]: info: Scanning into folder /data/plugins/ Sep 08 23:08:00 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:00 volumio volumio[907]: info: Plugin folders cleanup completed Sep 08 23:08:00 volumio volumio[907]: info: Error: Error Sep 08 23:08:00 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:00 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:00 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:00 volumio volumio[907]: info: Installing Go-librespot Sep 08 23:08:00 volumio volumio[907]: info: Checking old vollibrespot installs Sep 08 23:08:00 volumio volumio[907]: info: Folder /data/temp removed Sep 08 23:08:00 volumio systemd[1]: Reloading. Sep 08 23:08:00 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. Sep 08 23:08:01 volumio volumio[907]: info: Dowloading daemon Sep 08 23:08:02 volumio volumio[907]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:08:02 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:02 volumio volumio[907]: info: An error occurred installing the plugin. Rolling back config Sep 08 23:08:02 volumio volumio[907]: info: Plugin folders cleanup Sep 08 23:08:02 volumio volumio[907]: info: Scanning into folder /volumio/app/plugins/ Sep 08 23:08:02 volumio volumio[907]: info: Scanning category audio_interface Sep 08 23:08:02 volumio volumio[907]: info: Scanning category miscellanea Sep 08 23:08:02 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:02 volumio volumio[907]: info: Scanning category plugins.json Sep 08 23:08:02 volumio volumio[907]: info: Scanning category system_controller Sep 08 23:08:02 volumio volumio[907]: info: Scanning category user_interface Sep 08 23:08:02 volumio volumio[907]: info: Scanning into folder /data/plugins/ Sep 08 23:08:02 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:02 volumio volumio[907]: info: Plugin folders cleanup completed Sep 08 23:08:02 volumio volumio[907]: info: Error: Error Sep 08 23:08:02 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:02 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:02 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:02 volumio volumio[907]: info: Folder /data/temp removed Sep 08 23:08:03 volumio volumio[907]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:03 volumio volumio[907]: info: An error occurred installing the plugin. Rolling back config Sep 08 23:08:03 volumio volumio[907]: info: Plugin folders cleanup Sep 08 23:08:03 volumio volumio[907]: info: Scanning into folder /volumio/app/plugins/ Sep 08 23:08:03 volumio volumio[907]: info: Scanning category audio_interface Sep 08 23:08:03 volumio volumio[907]: info: Scanning category miscellanea Sep 08 23:08:03 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:03 volumio volumio[907]: info: Scanning category plugins.json Sep 08 23:08:03 volumio volumio[907]: info: Scanning category system_controller Sep 08 23:08:03 volumio volumio[907]: info: Scanning category user_interface Sep 08 23:08:03 volumio volumio[907]: info: Scanning into folder /data/plugins/ Sep 08 23:08:03 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:03 volumio volumio[907]: info: Plugin folders cleanup completed Sep 08 23:08:03 volumio volumio[907]: info: Error: Error Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:03 volumio volumio[907]: info: Folder /data/temp removed Sep 08 23:08:03 volumio volumio[907]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:03 volumio volumio[907]: info: An error occurred installing the plugin. Rolling back config Sep 08 23:08:03 volumio volumio[907]: info: Plugin folders cleanup Sep 08 23:08:03 volumio volumio[907]: info: Scanning into folder /volumio/app/plugins/ Sep 08 23:08:03 volumio volumio[907]: info: Scanning category audio_interface Sep 08 23:08:03 volumio volumio[907]: info: Scanning category miscellanea Sep 08 23:08:03 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:03 volumio volumio[907]: info: Scanning category plugins.json Sep 08 23:08:03 volumio volumio[907]: info: Scanning category system_controller Sep 08 23:08:03 volumio volumio[907]: info: Scanning category user_interface Sep 08 23:08:03 volumio volumio[907]: info: Scanning into folder /data/plugins/ Sep 08 23:08:03 volumio volumio[907]: info: Scanning category music_service Sep 08 23:08:03 volumio volumio[907]: info: Plugin folders cleanup completed Sep 08 23:08:03 volumio volumio[907]: info: Error: Error Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/downloaded_plugin.zip removed Sep 08 23:08:03 volumio volumio[907]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Sep 08 23:08:03 volumio volumio[907]: info: Folder /tmp/plugins removed Sep 08 23:08:03 volumio volumio[907]: info: Folder /data/temp removed Sep 08 23:08:03 volumio volumio[907]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 23:08:03 volumio volumio[907]: Error: Unable to resolve or reject the same promise twice Sep 08 23:08:03 volumio volumio[907]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 08 23:08:03 volumio volumio[907]: at /volumio/app/pluginmanager.js:1087:11 Sep 08 23:08:03 volumio volumio[907]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Sep 08 23:08:03 volumio volumio[907]: at FSReqCallback.oncomplete (fs.js:171:23) Sep 08 23:08:03 volumio volumio[907]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 23:08:04 volumio sudo[3360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-08 23:07 Sep 08 23:08:04 volumio sudo[3360]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"