Mar 26 13:09:02 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 26 13:09:04 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 26 13:09:05 perivolumiobt go-librespot[1634]: time="2026-03-26T13:09:05-04:00" level=trace msg="sent dealer ping" Mar 26 13:09:05 perivolumiobt go-librespot[1634]: time="2026-03-26T13:09:05-04:00" level=trace msg="received dealer pong" Mar 26 13:09:08 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:08 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:09 perivolumiobt volumio[1221]: verbose: New Socket.io Connection to 192.168.21.51 from 192.168.6.3 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetQueue Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CoreStateMachine::getQueue Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CorePlayQueue::getQueue Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Mar 26 13:09:09 perivolumiobt volumio[1221]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Mar 26 13:09:09 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Mar 26 13:09:10 perivolumiobt volumio[1221]: info: CALLMETHOD: system_controller system setTestPlugins true Mar 26 13:09:10 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Mar 26 13:09:10 perivolumiobt volumio[1221]: info: Plugins store is now in test mode Mar 26 13:09:12 perivolumiobt go-librespot[1634]: time="2026-03-26T13:09:12-04:00" level=trace msg="received accesspoint ping" Mar 26 13:09:12 perivolumiobt go-librespot[1634]: time="2026-03-26T13:09:12-04:00" level=trace msg="received accesspoint pong ack" Mar 26 13:09:12 perivolumiobt sudo[21685]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 26 13:09:12 perivolumiobt sudo[21685]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 13:09:12 perivolumiobt sudo[21685]: pam_unix(sudo:session): session closed for user root Mar 26 13:09:12 perivolumiobt sudo[21687]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 26 13:09:12 perivolumiobt sudo[21687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 13:09:12 perivolumiobt sudo[21687]: pam_unix(sudo:session): session closed for user root Mar 26 13:09:12 perivolumiobt volumio[1221]: verbose: New Socket.io Connection to 192.168.21.51 from 192.168.6.3 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Mar 26 13:09:13 perivolumiobt sudo[21691]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 26 13:09:13 perivolumiobt sudo[21691]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 13:09:13 perivolumiobt sudo[21691]: pam_unix(sudo:session): session closed for user root Mar 26 13:09:13 perivolumiobt sudo[21693]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 26 13:09:13 perivolumiobt sudo[21693]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 13:09:13 perivolumiobt sudo[21693]: pam_unix(sudo:session): session closed for user root Mar 26 13:09:13 perivolumiobt volumio[1221]: verbose: New Socket.io Connection to 192.168.21.51 from 192.168.6.3 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetVisibleSources Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 26 13:09:13 perivolumiobt volumio[1221]: info: Received Get System Info Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 13:09:13 perivolumiobt volumio[1221]: info: Discovery: Getting this device information Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:13 perivolumiobt volumio[1221]: info: Listing playlists Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 26 13:09:13 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 26 13:09:14 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:14 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:14 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 26 13:09:14 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 26 13:09:14 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 26 13:09:15 perivolumiobt volumio[1221]: info: Received Get System Info Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 13:09:15 perivolumiobt volumio[1221]: info: Discovery: Getting this device information Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 26 13:09:15 perivolumiobt volumio[1221]: info: Received Get System Info Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 13:09:15 perivolumiobt volumio[1221]: info: Discovery: Getting this device information Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:15 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 13:09:18 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:18 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:18 perivolumiobt volumio[1221]: info: Listing playlists Mar 26 13:09:18 perivolumiobt volumio[1221]: info: Listing playlists Mar 26 13:09:22 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 26 13:09:23 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 26 13:09:24 perivolumiobt volumio[1221]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/youtube2/2.5.1/volumio/bookworm/armhf Mar 26 13:09:24 perivolumiobt volumio5-onboarding[1564]: time=2026-03-26T13:09:24.138-04:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 26 13:09:26 perivolumiobt volumio[1221]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/youtube2/2.5.1/volumio/bookworm/armhf Mar 26 13:09:26 perivolumiobt volumio[1221]: info: Folder /tmp/plugins removed Mar 26 13:09:26 perivolumiobt volumio5-onboarding[1564]: time=2026-03-26T13:09:26.210-04:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 26 13:09:28 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:28 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 26 13:09:31 perivolumiobt volumio[1221]: info: Received Get System Version Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 26 13:09:31 perivolumiobt volumio[1221]: info: Received Get System Info Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 13:09:31 perivolumiobt volumio[1221]: info: Discovery: Getting this device information Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:31 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 13:09:31 perivolumiobt volumio5-onboarding[1564]: time=2026-03-26T13:09:31.315-04:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 26 13:09:31 perivolumiobt volumio[1221]: info: Check plugin dependencies Mar 26 13:09:32 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 26 13:09:32 perivolumiobt volumio5-onboarding[1564]: time=2026-03-26T13:09:32.189-04:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Checking if plugin already exists Mar 26 13:09:32 perivolumiobt volumio5-onboarding[1564]: time=2026-03-26T13:09:32.191-04:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 26 13:09:32 perivolumiobt volumio[1221]: info: An error occurred installing the plugin. Rolling back config Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Plugin folders cleanup Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning into folder /volumio/app/plugins/ Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category audio_interface Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category miscellanea Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category music_service Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category plugins.json Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category system_controller Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category user_interface Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning into folder /data/plugins/ Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category music_service Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Scanning category user_interface Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Plugin folders cleanup completed Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Error: Error Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Folder /tmp/plugins removed Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Folder /tmp/downloaded_plugin.zip removed Mar 26 13:09:32 perivolumiobt volumio[1221]: info: Folder /tmp/downloaded_plugin.zip removed Mar 26 13:09:35 perivolumiobt go-librespot[1634]: time="2026-03-26T13:09:35-04:00" level=trace msg="sent dealer ping" Mar 26 13:09:35 perivolumiobt go-librespot[1634]: time="2026-03-26T13:09:35-04:00" level=trace msg="received dealer pong" Mar 26 13:09:36 perivolumiobt volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 26 13:09:38 perivolumiobt volumio[1221]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/ytcr/2.2.1/volumio/bookworm/armhf Mar 26 13:09:38 perivolumiobt volumio5-onboarding[1564]: time=2026-03-26T13:09:38.527-04:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 26 13:09:40 perivolumiobt volumio[1221]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/ytcr/2.2.1/volumio/bookworm/armhf Mar 26 13:09:47 perivolumiobt volumio[1221]: info: CoreCommandRouter::volumioGetState Mar 26 13:09:47 perivolumiobt volumio[1221]: info: CorePlayQueue::getTrack 0 Mar 26 13:09:47 perivolumiobt volumio[1221]: info: Folder /tmp/plugins removed Mar 26 13:10:01 perivolumiobt volumio5-onboarding[1564]: time=2026-03-26T13:10:01.625-04:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 26 13:10:01 perivolumiobt volumio[1221]: info: Listing playlists Mar 26 13:10:01 perivolumiobt volumio[1221]: info: Listing playlists Mar 26 13:10:01 perivolumiobt volumio[1221]: info: Folder /data/temp removed Mar 26 13:10:01 perivolumiobt volumio[1221]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 13:10:01 perivolumiobt volumio[1221]: Error: Unable to resolve or reject the same promise twice Mar 26 13:10:01 perivolumiobt volumio[1221]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 26 13:10:01 perivolumiobt volumio[1221]: at /volumio/app/pluginmanager.js:1087:11 Mar 26 13:10:01 perivolumiobt volumio[1221]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Mar 26 13:10:01 perivolumiobt volumio[1221]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 Mar 26 13:10:01 perivolumiobt volumio[1221]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Mar 26 13:10:01 perivolumiobt volumio[1221]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 Mar 26 13:10:01 perivolumiobt volumio[1221]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Mar 26 13:10:01 perivolumiobt volumio[1221]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24 Mar 26 13:10:01 perivolumiobt volumio[1221]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Mar 26 13:10:01 perivolumiobt volumio[1221]: at FSReqCallback.oncomplete (node:fs:190:23) Mar 26 13:10:01 perivolumiobt volumio[1221]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 13:10:02 perivolumiobt sudo[21828]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-26 13:09' Mar 26 13:10:02 perivolumiobt sudo[21828]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"