-- Logs begin at Fri 2024-11-08 18:57:21 CET, end at Fri 2024-11-29 21:20:01 CET. -- Nov 29 21:19:00 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:00 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:01 volumio systemd[1]: Reloading. Nov 29 21:19:01 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:01 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. Nov 29 21:19:01 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 29 21:19:01 volumio sudo[3532]: pam_unix(sudo:session): session closed for user root Nov 29 21:19:01 volumio volumio[946]: info: Install script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/user_interface/touch_display/install.sh > /tmp/installog Nov 29 21:19:01 volumio volumio[946]: [sudo] password for volumio: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: E: Could not get lock /var/lib/dpkg/lock-frontend - open (11: Resource temporarily unavailable) Nov 29 21:19:01 volumio volumio[946]: E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it? Nov 29 21:19:01 volumio volumio[946]: rm: cannot remove '/opt/volumiokiosk.sh': No such file or directory Nov 29 21:19:01 volumio volumio[946]: rm: cannot remove '/lib/systemd/system/volumio-kiosk.service': No such file or directory Nov 29 21:19:01 volumio volumio[946]: info: An error occurred installing the plugin. Rolling back config Nov 29 21:19:01 volumio volumio[946]: info: Plugin folders cleanup Nov 29 21:19:01 volumio volumio[946]: info: Scanning into folder /volumio/app/plugins/ Nov 29 21:19:01 volumio volumio[946]: info: Scanning category audio_interface Nov 29 21:19:01 volumio volumio[946]: info: Scanning category miscellanea Nov 29 21:19:01 volumio volumio[946]: info: Scanning category music_service Nov 29 21:19:01 volumio volumio[946]: info: Scanning category plugins.json Nov 29 21:19:01 volumio volumio[946]: info: Scanning category system_controller Nov 29 21:19:01 volumio volumio[946]: info: Scanning category user_interface Nov 29 21:19:01 volumio volumio[946]: info: Scanning into folder /data/plugins/ Nov 29 21:19:01 volumio volumio[946]: info: Scanning category user_interface Nov 29 21:19:01 volumio volumio[946]: info: Plugin folders cleanup completed Nov 29 21:19:01 volumio volumio[946]: info: Error: Error Nov 29 21:19:01 volumio volumio[946]: info: Folder /tmp/plugins removed Nov 29 21:19:01 volumio volumio[946]: info: Folder /tmp/downloaded_plugin.zip removed Nov 29 21:19:01 volumio volumio[946]: info: Folder /data/temp removed Nov 29 21:19:01 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:02 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:02 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:03 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:03 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:04 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:04 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:05 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:05 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:06 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 29 21:19:38 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:40 volumio volumio[946]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:40 volumio volumio[946]: info: Folder /tmp/plugins removed Nov 29 21:19:40 volumio volumio[946]: info: Check plugin dependencies Nov 29 21:19:40 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 29 21:19:40 volumio volumio[946]: info: Checking if plugin already exists Nov 29 21:19:40 volumio volumio[946]: info: Rename folder Nov 29 21:19:40 volumio volumio[946]: info: Folder /tmp/downloaded_plugin.zip removed Nov 29 21:19:40 volumio volumio[946]: info: Move to category Nov 29 21:19:51 volumio volumio-remote-updater[624]: [2024-11-29 21:19:51] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Nov 29 21:19:53 volumio volumio[946]: info: Checking if install.sh is present Nov 29 21:19:53 volumio volumio[946]: info: Executing install.sh Nov 29 21:19:53 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:53 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:53 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:53 volumio sudo[3956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Nov 29 21:19:53 volumio sudo[3956]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 29 21:19:53 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:53 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:53 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:53 volumio volumio[946]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:53 volumio systemd[1]: Reloading. Nov 29 21:19:53 volumio volumio[946]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 13; SM-G780F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.108 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 29 21:19:53 volumio volumio[946]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 13; SM-G780F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.108 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Nov 29 21:19:53 volumio volumio[946]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 13; SM-G780F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.108 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 29 21:19:53 volumio volumio[946]: info: Reading package lists... Nov 29 21:19:53 volumio volumio[946]: Get:7 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxxf86dga1 armhf 2:1.1.4-1 [22.4 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:17 http://archive.raspberrypi.org/debian buster/main armhf xserver-xorg-legacy armhf 2:1.20.4-1+rpt4+deb10u9 [2241 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:7 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxxf86dga1 armhf 2:1.1.4-1 [22.4 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:17 http://archive.raspberrypi.org/debian buster/main armhf xserver-xorg-legacy armhf 2:1.20.4-1+rpt4+deb10u9 [2241 kB] Nov 29 21:19:53 volumio volumio[946]: info: Reading package lists... Nov 29 21:19:53 volumio volumio[946]: Get:7 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxxf86dga1 armhf 2:1.1.4-1 [22.4 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:17 http://archive.raspberrypi.org/debian buster/main armhf xserver-xorg-legacy armhf 2:1.20.4-1+rpt4+deb10u9 [2241 kB] Nov 29 21:19:53 volumio volumio[946]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 13; SM-G780F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.108 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 29 21:19:53 volumio volumio[946]: info: Get:8 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwayland-server0 armhf 1.16.0-1 [26.0 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:8 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwayland-server0 armhf 1.16.0-1 [26.0 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:8 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwayland-server0 armhf 1.16.0-1 [26.0 kB] Nov 29 21:19:53 volumio volumio[946]: info: Received Get System Info Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 21:19:53 volumio volumio[946]: info: Discovery: Getting this device information Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::volumioGetState Nov 29 21:19:53 volumio volumio[946]: info: CorePlayQueue::getTrack 0 Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::volumioGetState Nov 29 21:19:53 volumio volumio[946]: info: CorePlayQueue::getTrack 0 Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::volumioGetVisibleSources Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::volumioGetState Nov 29 21:19:53 volumio volumio[946]: info: CorePlayQueue::getTrack 0 Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::volumioGetQueue Nov 29 21:19:53 volumio volumio[946]: info: CoreStateMachine::getQueue Nov 29 21:19:53 volumio volumio[946]: info: CorePlayQueue::getQueue Nov 29 21:19:53 volumio volumio[946]: info: Listing playlists Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 29 21:19:53 volumio volumio[946]: info: Received Get System Info Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 21:19:53 volumio volumio[946]: info: Discovery: Getting this device information Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::volumioGetState Nov 29 21:19:53 volumio volumio[946]: info: CorePlayQueue::getTrack 0 Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::volumioGetState Nov 29 21:19:53 volumio volumio[946]: info: CorePlayQueue::getTrack 0 Nov 29 21:19:53 volumio volumio[946]: info: Get:9 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libepoxy0 armhf 1.5.3-0.1 [167 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:9 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libepoxy0 armhf 1.5.3-0.1 [167 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:9 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libepoxy0 armhf 1.5.3-0.1 [167 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:10 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libevdev2 armhf 1.6.0+dfsg-1 [24.9 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:10 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libevdev2 armhf 1.6.0+dfsg-1 [24.9 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:10 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libevdev2 armhf 1.6.0+dfsg-1 [24.9 kB] Nov 29 21:19:53 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. Nov 29 21:19:53 volumio volumio[946]: info: Get:11 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libfontenc1 armhf 1:1.1.3-1 [22.2 kB] Nov 29 21:19:53 volumio volumio[946]: info: Get:11 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libfontenc1 armhf 1:1.1.3-1 [22.2 kB] Nov 29 21:19:53 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 29 21:19:54 volumio volumio[946]: info: Get:12 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libgudev-1.0-0 armhf 232-2+rpi1 [11.8 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:12 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libgudev-1.0-0 armhf 232-2+rpi1 [11.8 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:12 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libgudev-1.0-0 armhf 232-2+rpi1 [11.8 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:13 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom-common all 0.32-1 [39.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:13 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom-common all 0.32-1 [39.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:13 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom-common all 0.32-1 [39.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:14 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom2 armhf 0.32-1 [16.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:14 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom2 armhf 0.32-1 [16.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:14 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom2 armhf 0.32-1 [16.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:15 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libinput-bin armhf 1.12.6-2+deb10u1 [16.5 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:15 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libinput-bin armhf 1.12.6-2+deb10u1 [16.5 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:15 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libinput-bin armhf 1.12.6-2+deb10u1 [16.5 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:18 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libmtdev1 armhf 1.1.5-1+b2 [21.2 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:18 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libmtdev1 armhf 1.1.5-1+b2 [21.2 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:18 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libmtdev1 armhf 1.1.5-1+b2 [21.2 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:19 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libinput10 armhf 1.12.6-2+deb10u1 [90.7 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:19 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libinput10 armhf 1.12.6-2+deb10u1 [90.7 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:19 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libinput10 armhf 1.12.6-2+deb10u1 [90.7 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:20 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libpciaccess0 armhf 0.14-1 [51.0 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:20 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libpciaccess0 armhf 0.14-1 [51.0 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:20 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libpciaccess0 armhf 0.14-1 [51.0 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:21 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libunwind8 armhf 1.2.1-10~deb10u1 [47.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:21 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libunwind8 armhf 1.2.1-10~deb10u1 [47.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:21 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libunwind8 armhf 1.2.1-10~deb10u1 [47.1 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:22 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libutempter0 armhf 1.1.6-3 [7736 B] Nov 29 21:19:54 volumio volumio[946]: info: Get:22 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libutempter0 armhf 1.1.6-3 [7736 B] Nov 29 21:19:54 volumio volumio[946]: info: Get:22 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libutempter0 armhf 1.1.6-3 [7736 B] Nov 29 21:19:54 volumio volumio[946]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 29 21:19:54 volumio volumio[946]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 29 21:19:54 volumio volumio[946]: info: CoreCommandRouter::volumioGetState Nov 29 21:19:54 volumio volumio[946]: info: CorePlayQueue::getTrack 0 Nov 29 21:19:54 volumio volumio[946]: info: Get:23 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom-bin armhf 0.32-1 [6528 B] Nov 29 21:19:54 volumio volumio[946]: info: Get:23 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom-bin armhf 0.32-1 [6528 B] Nov 29 21:19:54 volumio volumio[946]: info: Get:23 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libwacom-bin armhf 0.32-1 [6528 B] Nov 29 21:19:54 volumio volumio[946]: info: Get:24 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxt6 armhf 1:1.1.5-1+b3 [156 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:24 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxt6 armhf 1:1.1.5-1+b3 [156 kB] Nov 29 21:19:54 volumio volumio[946]: info: Get:24 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxt6 armhf 1:1.1.5-1+b3 [156 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:25 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxmu6 armhf 2:1.1.2-2+b3 [52.1 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:25 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxmu6 armhf 2:1.1.2-2+b3 [52.1 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:25 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxmu6 armhf 2:1.1.2-2+b3 [52.1 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:26 http://mirror.transip.net/raspbian/raspbian buster/main armhf libxpm4 armhf 1:3.5.12-1+deb10u2 [44.1 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:26 http://mirror.transip.net/raspbian/raspbian buster/main armhf libxpm4 armhf 1:3.5.12-1+deb10u2 [44.1 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:26 http://mirror.transip.net/raspbian/raspbian buster/main armhf libxpm4 armhf 1:3.5.12-1+deb10u2 [44.1 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:27 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxaw7 armhf 2:1.0.13-1+b2 [163 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:27 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxaw7 armhf 2:1.0.13-1+b2 [163 kB] Nov 29 21:19:55 volumio volumio[946]: info: Get:27 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxaw7 armhf 2:1.0.13-1+b2 [163 kB] Nov 29 21:19:55 volumio volumio[946]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:55 volumio volumio[946]: info: Folder /tmp/plugins removed Nov 29 21:19:56 volumio volumio[946]: info: Get:28 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxcomposite1 armhf 1:0.4.4-2 [16.1 kB] Nov 29 21:19:56 volumio volumio[946]: info: Get:28 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxcomposite1 armhf 1:0.4.4-2 [16.1 kB] Nov 29 21:19:56 volumio volumio[946]: info: Get:28 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxcomposite1 armhf 1:0.4.4-2 [16.1 kB] Nov 29 21:19:56 volumio volumio[946]: info: Check plugin dependencies Nov 29 21:19:56 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 29 21:19:56 volumio volumio[946]: info: Checking if plugin already exists Nov 29 21:19:56 volumio volumio[946]: info: Rename folder Nov 29 21:19:56 volumio volumio[946]: info: Folder /tmp/downloaded_plugin.zip removed Nov 29 21:19:56 volumio volumio[946]: info: Move to category Nov 29 21:19:56 volumio volumio[946]: info: Get:29 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxfont2 armhf 1:2.0.3-1 [120 kB] Nov 29 21:19:56 volumio volumio[946]: info: Get:29 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxfont2 armhf 1:2.0.3-1 [120 kB] Nov 29 21:19:56 volumio volumio[946]: info: Get:29 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxfont2 armhf 1:2.0.3-1 [120 kB] Nov 29 21:19:56 volumio volumio-remote-updater[624]: [2024-11-29 21:19:56] [connect] Successful connection Nov 29 21:19:56 volumio volumio-remote-updater[624]: [2024-11-29 21:19:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732911596 101 Nov 29 21:19:56 volumio volumio[946]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Nov 29 21:19:56 volumio volumio[946]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:19:57 volumio volumio[946]: info: Folder /tmp/plugins removed Nov 29 21:19:57 volumio volumio[946]: info: Get:30 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxft2 armhf 2.3.2-2 [49.3 kB] Nov 29 21:19:57 volumio volumio[946]: info: Get:30 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxft2 armhf 2.3.2-2 [49.3 kB] Nov 29 21:19:57 volumio volumio[946]: info: Get:30 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxft2 armhf 2.3.2-2 [49.3 kB] Nov 29 21:19:57 volumio volumio[946]: info: An error occurred installing the plugin. Rolling back config Nov 29 21:19:57 volumio volumio[946]: info: Plugin folders cleanup Nov 29 21:19:57 volumio volumio[946]: info: Scanning into folder /volumio/app/plugins/ Nov 29 21:19:57 volumio volumio[946]: info: Scanning category audio_interface Nov 29 21:19:57 volumio volumio[946]: info: Scanning category miscellanea Nov 29 21:19:57 volumio volumio[946]: info: Scanning category music_service Nov 29 21:19:57 volumio volumio[946]: info: Scanning category plugins.json Nov 29 21:19:57 volumio volumio[946]: info: Scanning category system_controller Nov 29 21:19:57 volumio volumio[946]: info: Scanning category user_interface Nov 29 21:19:57 volumio volumio[946]: info: Scanning into folder /data/plugins/ Nov 29 21:19:57 volumio volumio[946]: info: Scanning category music_service Nov 29 21:19:57 volumio volumio[946]: info: Scanning category spop Nov 29 21:19:57 volumio volumio[946]: info: Removing /data/plugins//spop/README.md Nov 29 21:19:59 volumio volumio[946]: info: Removing /data/plugins//spop/UIConfig.json Nov 29 21:19:59 volumio volumio[946]: info: Removing /data/plugins//spop/apiclient.js Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/config.json Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/config.yml.tmpl Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/gitignore Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/index.js Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/install.sh Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/package.json Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/remove.sh Nov 29 21:20:00 volumio volumio[946]: info: Removing /data/plugins//spop/spotify.png Nov 29 21:20:01 volumio volumio[946]: info: Removing /data/plugins//spop/startconnect.sh Nov 29 21:20:01 volumio volumio[946]: info: Removing /data/plugins//spop/uninstall.sh Nov 29 21:20:01 volumio volumio[946]: info: Removing /data/plugins//spop/wsclient.js Nov 29 21:20:01 volumio volumio[946]: info: Plugin folders cleanup completed Nov 29 21:20:01 volumio volumio[946]: info: Error: Error Nov 29 21:20:01 volumio volumio[946]: info: Get:31 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxkbfile1 armhf 1:1.0.9-2 [65.4 kB] Nov 29 21:20:01 volumio volumio[946]: info: Get:31 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxkbfile1 armhf 1:1.0.9-2 [65.4 kB] Nov 29 21:20:01 volumio volumio[946]: info: Get:31 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxkbfile1 armhf 1:1.0.9-2 [65.4 kB] Nov 29 21:20:01 volumio volumio[946]: info: Folder /tmp/downloaded_plugin.zip removed Nov 29 21:20:01 volumio volumio[946]: info: Folder /tmp/plugins removed Nov 29 21:20:01 volumio volumio[946]: info: Folder /tmp/downloaded_plugin.zip removed Nov 29 21:20:01 volumio volumio[946]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:20:01 volumio volumio[946]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Nov 29 21:20:01 volumio volumio[946]: info: Get:32 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxmuu1 armhf 2:1.1.2-2+b3 [23.4 kB] Nov 29 21:20:01 volumio volumio[946]: info: Get:32 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxmuu1 armhf 2:1.1.2-2+b3 [23.4 kB] Nov 29 21:20:01 volumio volumio[946]: info: Get:32 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf libxmuu1 armhf 2:1.1.2-2+b3 [23.4 kB] Nov 29 21:20:01 volumio volumio[946]: info: Folder /tmp/plugins removed Nov 29 21:20:01 volumio volumio[946]: info: Folder /tmp/plugins removed Nov 29 21:20:01 volumio volumio[946]: info: Get:33 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf x11-utils armhf 7.7+4 [176 kB] Nov 29 21:20:01 volumio volumio[946]: info: Get:33 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf x11-utils armhf 7.7+4 [176 kB] Nov 29 21:20:01 volumio volumio[946]: info: Get:33 http://mirror.nl.leaseweb.net/raspbian/raspbian buster/main armhf x11-utils armhf 7.7+4 [176 kB] Nov 29 21:20:01 volumio volumio[946]: info: An error occurred installing the plugin. Rolling back config Nov 29 21:20:01 volumio volumio[946]: info: Plugin folders cleanup Nov 29 21:20:01 volumio volumio[946]: info: Scanning into folder /volumio/app/plugins/ Nov 29 21:20:01 volumio volumio[946]: info: Scanning category audio_interface Nov 29 21:20:01 volumio volumio[946]: info: Scanning category miscellanea Nov 29 21:20:01 volumio volumio[946]: info: Scanning category music_service Nov 29 21:20:01 volumio volumio[946]: info: Scanning category plugins.json Nov 29 21:20:01 volumio volumio[946]: info: Scanning category system_controller Nov 29 21:20:01 volumio volumio[946]: info: Scanning category user_interface Nov 29 21:20:01 volumio volumio[946]: info: Scanning into folder /data/plugins/ Nov 29 21:20:01 volumio volumio[946]: info: Scanning category music_service Nov 29 21:20:01 volumio volumio[946]: info: Scanning category spop Nov 29 21:20:01 volumio volumio[946]: info: Plugin folders cleanup completed Nov 29 21:20:01 volumio volumio[946]: info: Error: Error Nov 29 21:20:01 volumio volumio[946]: info: Folder /data/temp removed Nov 29 21:20:01 volumio volumio[946]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 21:20:01 volumio volumio[946]: Error: Unable to resolve or reject the same promise twice Nov 29 21:20:01 volumio volumio[946]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Nov 29 21:20:01 volumio volumio[946]: at /volumio/app/pluginmanager.js:1087:11 Nov 29 21:20:01 volumio volumio[946]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Nov 29 21:20:01 volumio volumio[946]: at FSReqCallback.oncomplete (fs.js:171:23) Nov 29 21:20:01 volumio volumio[946]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 21:20:01 volumio sudo[4020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-29 21:19 Nov 29 21:20:01 volumio sudo[4020]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"