-- Logs begin at Tue 2025-07-01 14:05:25 UTC, end at Tue 2025-07-01 14:22:25 UTC. -- Jul 01 14:21:00 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d49.f4fc5455 does not match aorg 0xec0e6d4b.f4fc6372 from server@45.84.199.136 xmt 0xec0e6d4b.fd41ff4d Jul 01 14:21:03 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 01 14:21:03 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 14:21:03 volumio volumio[1045]: info: Discovery: Getting this device information Jul 01 14:21:03 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState Jul 01 14:21:03 volumio volumio[1045]: info: CorePlayQueue::getTrack 0 Jul 01 14:21:03 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4e.f509b276 does not match aorg 0xec0e6d52.f50471b4 from server@137.110.222.27 xmt 0xec0e6d52.ccc3fcfb Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4e.f5060d0f does not match aorg 0xec0e6d52.f5033281 from server@74.6.168.72 xmt 0xec0e6d52.d04342e4 Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4e.f5010c69 does not match aorg 0xec0e6d52.f4fc6663 from server@104.167.215.195 xmt 0xec0e6d52.ce35b8a8 Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4e.f504d8cd does not match aorg 0xec0e6d52.f501de39 from server@67.217.246.127 xmt 0xec0e6d52.cec0ade0 Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4e.f503a1bd does not match aorg 0xec0e6d50.f504f87d from server@96.231.54.40 xmt 0xec0e6d52.d3fe6bec Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4e.f50267cc does not match aorg 0xec0e6d50.f50339f9 from server@15.204.87.223 xmt 0xec0e6d52.cd83c86e Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4e.f508767e does not match aorg 0xec0e6d50.f50c336b from server@24.229.44.105 xmt 0xec0e6d52.d73f632f Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d50.f50e03cb does not match aorg 0xec0e6d52.f50471b4 from server@137.110.222.27 xmt 0xec0e6d53.0b9b06b5 Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d50.f5087929 does not match aorg 0xec0e6d52.f5033281 from server@74.6.168.72 xmt 0xec0e6d53.0f1cc712 Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d50.f5013034 does not match aorg 0xec0e6d52.f4fc6663 from server@104.167.215.195 xmt 0xec0e6d53.0d0b92b4 Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d50.f506bcd5 does not match aorg 0xec0e6d52.f501de39 from server@67.217.246.127 xmt 0xec0e6d53.0d9d0616 Jul 01 14:21:07 volumio ntpd[7228]: receive: Unexpected origin timestamp 0xec0e6d4f.f4fc9506 does not match aorg 0xec0e6d51.f4fc6abf from server@45.84.199.136 xmt 0xec0e6d53.1daec608 Jul 01 14:21:33 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 01 14:21:33 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 14:21:33 volumio volumio[1045]: info: Discovery: Getting this device information Jul 01 14:21:33 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState Jul 01 14:21:33 volumio volumio[1045]: info: CorePlayQueue::getTrack 0 Jul 01 14:21:33 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 14:21:45 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.2.77 from 192.168.2.62 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::volumioGetVisibleSources Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState Jul 01 14:21:45 volumio volumio[1045]: info: CorePlayQueue::getTrack 0 Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 01 14:21:45 volumio volumio[1045]: info: Received Get System Info Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 14:21:45 volumio volumio[1045]: info: Discovery: Getting this device information Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState Jul 01 14:21:45 volumio volumio[1045]: info: CorePlayQueue::getTrack 0 Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState Jul 01 14:21:45 volumio volumio[1045]: info: CorePlayQueue::getTrack 0 Jul 01 14:21:45 volumio volumio[1045]: info: Listing playlists Jul 01 14:21:45 volumio volumio[1045]: info: Running setup.py bdist_wheel for pycryptodome: still running... Jul 01 14:21:45 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 01 14:22:03 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 01 14:22:03 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 14:22:03 volumio volumio[1045]: info: Discovery: Getting this device information Jul 01 14:22:03 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState Jul 01 14:22:03 volumio volumio[1045]: info: CorePlayQueue::getTrack 0 Jul 01 14:22:03 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 14:22:05 volumio volumio[1045]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/amd64 Jul 01 14:22:12 volumio volumio[1045]: info: Running setup.py bdist_wheel for pycryptodome: finished with status 'done' Jul 01 14:22:12 volumio volumio[1045]: info: Stored in directory: /root/.cache/pip/wheels/7e/27/8a/e88857cfe02353fd45963010a33d9c5fadbb9cd17abdfa7bab Jul 01 14:22:13 volumio volumio[1045]: info: Running setup.py bdist_wheel for pycountry: started Jul 01 14:22:19 volumio volumio[1045]: info: Running setup.py bdist_wheel for pycountry: finished with status 'done' Jul 01 14:22:19 volumio volumio[1045]: info: Stored in directory: /root/.cache/pip/wheels/7a/c3/f8/3e164430062ee08d5b8bc8fcd1b891ce54c7ad99871aa3adc1 Jul 01 14:22:20 volumio volumio[1045]: info: Successfully built pycryptodome pycountry Jul 01 14:22:20 volumio volumio[1045]: info: Installing collected packages: isodate, websocket-client, urllib3, PySocks, pycryptodome, pycountry, lxml, charset-normalizer, requests, streamlink Jul 01 14:22:21 volumio volumio[1045]: info: Found existing installation: urllib3 1.24.1 Jul 01 14:22:21 volumio volumio[1045]: info: Not uninstalling urllib3 at /usr/lib/python3/dist-packages, outside environment /usr Jul 01 14:22:21 volumio volumio[1045]: info: Can't uninstall 'urllib3'. No files were found to uninstall. Jul 01 14:22:23 volumio volumio[1045]: info: Found existing installation: requests 2.21.0 Jul 01 14:22:23 volumio volumio[1045]: info: Not uninstalling requests at /usr/lib/python3/dist-packages, outside environment /usr Jul 01 14:22:23 volumio volumio[1045]: info: Can't uninstall 'requests'. No files were found to uninstall. Jul 01 14:22:24 volumio volumio[1045]: info: Successfully installed PySocks-1.7.1 charset-normalizer-3.4.2 isodate-0.7.2 lxml-4.9.4 pycountry-22.3.5 pycryptodome-3.23.0 requests-2.31.0 streamlink-5.5.1 urllib3-2.0.7 websocket-client-1.6.1 Jul 01 14:22:24 volumio volumio[1045]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/amd64 Jul 01 14:22:24 volumio volumio[1045]: info: Folder /tmp/plugins removed Jul 01 14:22:24 volumio sudo[6708]: pam_unix(sudo:session): session closed for user root Jul 01 14:22:24 volumio sudo[6393]: pam_unix(sudo:session): session closed for user root Jul 01 14:22:24 volumio volumio[1045]: info: Mixcloud plugin installed Jul 01 14:22:24 volumio volumio[1045]: Plugin install end detected on script Jul 01 14:22:24 volumio volumio[1045]: info: Install script completed Jul 01 14:22:24 volumio volumio[1045]: info: Adding reference to registry Jul 01 14:22:24 volumio volumio[1045]: info: Done installing plugin. Jul 01 14:22:24 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 14:22:24 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 01 14:22:24 volumio volumio[1045]: info: Folder /tmp/plugins removed Jul 01 14:22:24 volumio volumio[1045]: info: Folder /tmp/downloaded_plugin.zip removed Jul 01 14:22:24 volumio volumio[1045]: info: Folder /data/temp removed Jul 01 14:22:24 volumio volumio[1045]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 01 14:22:24 volumio volumio[1045]: Error: Unable to resolve or reject the same promise twice Jul 01 14:22:24 volumio volumio[1045]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 01 14:22:24 volumio volumio[1045]: at /volumio/app/pluginmanager.js:1087:11 Jul 01 14:22:24 volumio volumio[1045]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Jul 01 14:22:24 volumio volumio[1045]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 Jul 01 14:22:24 volumio volumio[1045]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Jul 01 14:22:24 volumio volumio[1045]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 Jul 01 14:22:24 volumio volumio[1045]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Jul 01 14:22:24 volumio volumio[1045]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 Jul 01 14:22:24 volumio volumio[1045]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Jul 01 14:22:24 volumio volumio[1045]: at FSReqCallback.oncomplete (fs.js:180:23) Jul 01 14:22:24 volumio volumio[1045]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 01 14:22:25 volumio sudo[8271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-01 14:21 Jul 01 14:22:25 volumio sudo[8271]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"