Oct 15 15:31:02 volumio3kit volumio[1221]: info: Setting up gtk-update-icon-cache (1:3.24.38-2~deb12u3+rpi1+rpt1) ... Oct 15 15:31:02 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:02.381Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:02 volumio3kit volumio[1221]: info: Setting up libdouble-conversion3:armhf (3.2.1-1) ... Oct 15 15:31:02 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:02.451Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:02 volumio3kit volumio[1221]: info: Setting up libxdamage1:armhf (1:1.1.6-1) ... Oct 15 15:31:02 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:02.525Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:02 volumio3kit volumio[1221]: info: Setting up hicolor-icon-theme (0.17-2) ... Oct 15 15:31:02 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:02.600Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:03 volumio3kit volumio[1221]: info: Setting up libatspi2.0-0:armhf (2.50.0-1~bpo12+rpt1) ... Oct 15 15:31:03 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:03.073Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:03 volumio3kit volumio[1221]: info: Setting up libcolord2:armhf (1.4.6-2.2) ... Oct 15 15:31:03 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:03.234Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:03 volumio3kit volumio[1221]: info: Setting up libxnvctrl0:armhf (525.85.05-3~deb12u1) ... Oct 15 15:31:03 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:03.305Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:03 volumio3kit volumio[1221]: info: Setting up dbus-user-session (1.14.10-1~deb12u1) ... Oct 15 15:31:03 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:03.385Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:03 volumio3kit volumio[1221]: info: Setting up adwaita-icon-theme (43-1) ... Oct 15 15:31:03 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:03.485Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:04 volumio3kit volumio[1221]: info: update-alternatives: using /usr/share/icons/Adwaita/cursor.theme to provide /usr/share/icons/default/index.theme (x-cursor-theme) in auto mode Oct 15 15:31:04 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:04.486Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:04 volumio3kit volumio[1221]: info: Setting up libnspr4:armhf (2:4.35-1) ... Oct 15 15:31:04 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:04.592Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:04 volumio3kit volumio[1221]: info: Setting up libxinerama1:armhf (2:1.1.4-3) ... Oct 15 15:31:04 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:04.738Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:04 volumio3kit volumio[1221]: info: Setting up libopenh264-7:armhf (2.3.1+dfsg-3+deb12u2) ... Oct 15 15:31:04 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:04.802Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:04 volumio3kit volumio[1221]: info: Setting up at-spi2-common (2.50.0-1~bpo12+rpt1) ... Oct 15 15:31:04 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:04.874Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:04 volumio3kit volumio[1221]: info: Setting up libharfbuzz-subset0:armhf (6.0.0+dfsg-3) ... Oct 15 15:31:04 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:04.936Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: Setting up libatk1.0-0:armhf (2.50.0-1~bpo12+rpt1) ... Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.078Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: Setting up libxcomposite1:armhf (1:0.4.5-1) ... Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.199Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: Setting up xdg-utils (1.1.3-4.1) ... Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.314Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: update-alternatives: using /usr/bin/xdg-open to provide /usr/bin/open (open) in auto mode Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.422Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: Setting up dconf-service (0.40.0-4) ... Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.463Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: Setting up libnss3:armhf (2:3.87.1-1+deb12u4) ... Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.704Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: Setting up libatk-bridge2.0-0:armhf (2.50.0-1~bpo12+rpt1) ... Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.862Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:05 volumio3kit volumio[1221]: info: Setting up dconf-gsettings-backend:armhf (0.40.0-4) ... Oct 15 15:31:05 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:05.983Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:06 volumio3kit volumio[1221]: info: Setting up libgtk-3-common (1:3.24.38-2~deb12u3+rpi1+rpt1) ... Oct 15 15:31:06 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:06.103Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:06 volumio3kit volumio[1221]: info: Processing triggers for libglib2.0-0:armhf (2.74.6-2+deb12u8) ... Oct 15 15:31:06 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:06.277Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:06 volumio3kit volumio[1221]: info: Setting up libgtk-3-0:armhf (1:3.24.38-2~deb12u3+rpi1+rpt1) ... Oct 15 15:31:06 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:06.579Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:07 volumio3kit volumio[1221]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Oct 15 15:31:07 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:07.172Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:10 volumio3kit volumio[1221]: info: Setting up zenoty (0.2) ... Oct 15 15:31:10 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:10.348Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:10 volumio3kit volumio[1221]: info: Setting up chromium-common (1:155.0.8059.39-1~deb12u1+rpt1) ... Oct 15 15:31:10 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:10.473Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:10 volumio3kit volumio[1221]: info: Setting up chromium-headless-shell (1:155.0.8059.39-1~deb12u1+rpt1) ... Oct 15 15:31:10 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:10.733Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:10 volumio3kit nmbd[2598]: [2026/10/15 15:31:10.757730, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 15 15:31:10 volumio3kit nmbd[2598]: query_name_response: Multiple (2) responses received for a query on subnet 10.255.1.58 for name WORKGROUP<1d>. Oct 15 15:31:10 volumio3kit nmbd[2598]: This response was from IP 10.255.1.161, reporting an IP address of 10.255.1.161. Oct 15 15:31:10 volumio3kit volumio[1221]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Oct 15 15:31:10 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:10.898Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:21 volumio3kit sudo[3468]: pam_unix(sudo:session): session closed for user root Oct 15 15:31:21 volumio3kit volumio[1221]: info: Bandcamp Discover plugin installed Oct 15 15:31:21 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:21.963Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:21 volumio3kit volumio[1221]: Plugin install end detected on script Oct 15 15:31:21 volumio3kit volumio[1221]: info: Install script completed Oct 15 15:31:21 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:21.978Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:21 volumio3kit volumio[1221]: info: Adding reference to registry Oct 15 15:31:21 volumio3kit volumio5-onboarding[1774]: time=2026-10-15T06:31:21.996Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 15:31:22 volumio3kit volumio[1221]: info: Done installing plugin. Oct 15 15:31:22 volumio3kit volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 15:31:22 volumio3kit volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 15 15:31:22 volumio3kit volumio[1221]: info: Folder /tmp/plugins removed Oct 15 15:31:22 volumio3kit volumio[1221]: info: Folder /tmp/downloaded_plugin.zip removed Oct 15 15:31:22 volumio3kit volumio[1221]: info: Folder /data/temp removed Oct 15 15:31:44 volumio3kit volumio[1221]: info: Enabling plugin bandcamp Oct 15 15:31:44 volumio3kit volumio[1221]: info: Loading plugin "bandcamp"... Oct 15 15:31:47 volumio3kit volumio[1221]: info: PLUGIN START: bandcamp Oct 15 15:31:47 volumio3kit volumio[1221]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 15:31:47 volumio3kit volumio[1221]: info: [1792045907757] CoreMusicLibrary::Adding element Bandcamp Discover Oct 15 15:31:47 volumio3kit volumio[1221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 15:31:47 volumio3kit volumio[1221]: Cannot find translation for source Bandcamp Discover Oct 15 15:31:47 volumio3kit volumio[1221]: info: Done. Oct 15 15:31:50 volumio3kit volumio[1221]: info: CoreCommandRouter::volumioGetState Oct 15 15:31:50 volumio3kit volumio[1221]: info: CorePlayQueue::getTrack 0 Oct 15 15:31:53 volumio3kit volumio[1221]: info: CoreCommandRouter::volumioGetQueue Oct 15 15:31:53 volumio3kit volumio[1221]: info: CoreStateMachine::getQueue Oct 15 15:31:53 volumio3kit volumio[1221]: info: CorePlayQueue::getQueue Oct 15 15:31:55 volumio3kit volumio[1221]: info: CoreCommandRouter::executeOnPlugin: bandcamp , handleBrowseUri Oct 15 15:31:55 volumio3kit volumio[1221]: info: [bandcamp-browse] browseUri: bandcamp Oct 15 15:31:59 volumio3kit volumio[1221]: info: Preload queue cleared Oct 15 15:31:59 volumio3kit volumio[1221]: info: Preload queue cleared Oct 15 15:31:59 volumio3kit volumio[1221]: info: Preload queue cleared Oct 15 15:31:59 volumio3kit volumio[1221]: info: Preload queue cleared Oct 15 15:31:59 volumio3kit volumio[1221]: info: Preload queue cleared Oct 15 15:32:03 volumio3kit volumio[1221]: info: Preload queue cleared Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::ClearQueue Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::stop Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:32:03 volumio3kit volumio[1221]: info: CorePlayQueue::clearPlayQueue Oct 15 15:32:03 volumio3kit volumio[1221]: info: CorePlayQueue::saveQueue Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::addQueueItems Oct 15 15:32:03 volumio3kit volumio[1221]: info: CorePlayQueue::addQueueItems Oct 15 15:32:03 volumio3kit volumio[1221]: info: Preload queue cleared Oct 15 15:32:03 volumio3kit volumio[1221]: info: Adding Item to queue: bandcamp/show@inSection=1/show@showUrl=https%3A%2F%2Fbandcamp.com%2F%3Fshow%3D991@explode:o=%7B%22title%22%3A%22The%20Indie%20Show%22%2C%22artist%22%3A%2210%2F14%2F2026%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2F46863059_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Fshow%40showUrl%3Dhttps%253A%252F%252Fbandcamp.com%252F%253Fshow%253D991%22%7D Oct 15 15:32:03 volumio3kit volumio[1221]: info: Exploding uri bandcamp/show@inSection=1/show@showUrl=https%3A%2F%2Fbandcamp.com%2F%3Fshow%3D991@explode:o=%7B%22title%22%3A%22The%20Indie%20Show%22%2C%22artist%22%3A%2210%2F14%2F2026%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2F46863059_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Fshow%40showUrl%3Dhttps%253A%252F%252Fbandcamp.com%252F%253Fshow%253D991%22%7D in service bandcamp Oct 15 15:32:03 volumio3kit volumio[1221]: info: [bandcamp-browse] explodeUri: bandcamp/show@inSection=1/show@showUrl=https%3A%2F%2Fbandcamp.com%2F%3Fshow%3D991@explode:o=%7B%22title%22%3A%22The%20Indie%20Show%22%2C%22artist%22%3A%2210%2F14%2F2026%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2F46863059_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Fshow%40showUrl%3Dhttps%253A%252F%252Fbandcamp.com%252F%253Fshow%253D991%22%7D Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreCommandRouter::volumioPushQueue Oct 15 15:32:03 volumio3kit volumio[1221]: info: CorePlayQueue::saveQueue Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::updateTrackBlock Oct 15 15:32:03 volumio3kit volumio[1221]: info: CorePlayQueue::getTrackBlock Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreCommandRouter::volumioPlay Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::play index 0 Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::stop Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::play index undefined Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 15:32:03 volumio3kit volumio[1221]: info: CorePlayQueue::getTrack 0 Oct 15 15:32:03 volumio3kit volumio[1221]: info: CoreStateMachine::startPlaybackTimer Oct 15 15:32:03 volumio3kit volumio[1221]: info: CorePlayQueue::getTrack 0 Oct 15 15:32:03 volumio3kit volumio[1221]: info: [bandcamp-play] clearAddPlayTrack: bandcamp/show@startIndex=0@showUrl=https%3A%2F%2Fbandcamp.com%2F%3Fshow%3D991@explode:o=%7B%22title%22%3A%22The%20Indie%20Show%22%2C%22artist%22%3A%2210%2F14%2F2026%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2F46863059_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Fshow%40showUrl%3Dhttps%253A%252F%252Fbandcamp.com%252F%253Fshow%253D991%22%7D Oct 15 15:32:04 volumio3kit volumio[1221]: error: [bandcamp-play] Error getting stream: Error: Failed to parse show: JSON error in data-blob. Oct 15 15:32:04 volumio3kit volumio[1221]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:32:04 volumio3kit volumio[1221]: [UnhandledPromiseRejection: This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). The promise rejected with the reason "Error: Failed to parse show: JSON error in data-blob.".] { Oct 15 15:32:04 volumio3kit volumio[1221]: code: 'ERR_UNHANDLED_REJECTION' Oct 15 15:32:04 volumio3kit volumio[1221]: } Oct 15 15:32:04 volumio3kit volumio[1221]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:32:05 volumio3kit sudo[4679]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 15:31' Oct 15 15:32:05 volumio3kit sudo[4679]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"