-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Wed 2024-10-16 23:18:42 CEST. -- Oct 16 23:17:00 volumio sudo[4343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 23:17:00 volumio sudo[4343]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:17:00 volumio sudo[4343]: pam_unix(sudo:session): session closed for user root Oct 16 23:17:00 volumio sudo[4349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 23:17:00 volumio sudo[4349]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:17:00 volumio sudo[4349]: pam_unix(sudo:session): session closed for user root Oct 16 23:17:01 volumio volumio[947]: verbose: New Socket.io Connection to 192.168.0.91 from 192.168.0.149 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 OPR/113.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 16 23:17:01 volumio sudo[4432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 23:17:01 volumio sudo[4432]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:17:01 volumio sudo[4432]: pam_unix(sudo:session): session closed for user root Oct 16 23:17:01 volumio sudo[4434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 23:17:01 volumio sudo[4434]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:17:01 volumio sudo[4434]: pam_unix(sudo:session): session closed for user root Oct 16 23:17:01 volumio volumio[947]: verbose: New Socket.io Connection to 192.168.0.91 from 192.168.0.149 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 OPR/113.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 16 23:17:01 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 23:17:01 volumio volumio[947]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 23:17:01 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 23:17:01 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:17:01 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:17:01 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 23:17:02 volumio volumio[947]: info: Received Get System Info Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:17:02 volumio volumio[947]: info: Discovery: Getting this device information Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:17:02 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:17:02 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:17:02 volumio volumio[947]: info: Listing playlists Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 23:17:02 volumio volumio[947]: info: Setting up libxcomposite1:armhf (1:0.4.4-2) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libxfont2:armhf (1:2.0.3-1) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libevdev2:armhf (1.6.0+dfsg-1) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libxmuu1:armhf (2:1.1.2-2+b3) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libgudev-1.0-0:armhf (232-2+rpi1) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up xbitmaps (1.1.1-2) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libwacom-common (0.32-1) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libxmu6:armhf (2:1.1.2-2+b3) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libxaw7:armhf (2:1.0.13-1+b2) ... Oct 16 23:17:02 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:17:02 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:17:02 volumio volumio[947]: info: Setting up xfonts-utils (1:7.7+6) ... Oct 16 23:17:02 volumio volumio[947]: info: Setting up libegl1-mesa:armhf (19.3.2-1~bpo10+1~rpt4) ... Oct 16 23:17:03 volumio volumio[947]: info: Setting up xfonts-base (1:1.0.5) ... Oct 16 23:17:03 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 23:17:03 volumio volumio[947]: info: Setting up xauth (1:1.0.10-1) ... Oct 16 23:17:03 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 23:17:03 volumio volumio[947]: info: Received Get System Info Oct 16 23:17:03 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:17:03 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:17:03 volumio volumio[947]: info: Discovery: Getting this device information Oct 16 23:17:03 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:17:03 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:17:03 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:17:03 volumio volumio[947]: info: Setting up x11-utils (7.7+4) ... Oct 16 23:17:04 volumio volumio[947]: info: Setting up xterm (344-1+deb10u2) ... Oct 16 23:17:04 volumio volumio[947]: info: update-alternatives: using /usr/bin/xterm to provide /usr/bin/x-terminal-emulator (x-terminal-emulator) in auto mode Oct 16 23:17:04 volumio volumio[947]: info: update-alternatives: using /usr/bin/lxterm to provide /usr/bin/x-terminal-emulator (x-terminal-emulator) in auto mode Oct 16 23:17:04 volumio volumio[947]: info: Setting up libwacom2:armhf (0.32-1) ... Oct 16 23:17:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 23:17:04 volumio volumio[947]: info: Received Get System Info Oct 16 23:17:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:17:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:17:04 volumio volumio[947]: info: Discovery: Getting this device information Oct 16 23:17:04 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:17:04 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:17:04 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:17:04 volumio volumio[947]: info: Setting up xinit (1.4.0-1) ... Oct 16 23:17:04 volumio volumio[947]: info: Setting up x11-xkb-utils (7.7+4) ... Oct 16 23:17:05 volumio volumio[947]: info: Setting up libinput-bin (1.12.6-2+deb10u1) ... Oct 16 23:17:05 volumio volumio[947]: info: Setting up libwacom-bin (0.32-1) ... Oct 16 23:17:05 volumio volumio[947]: info: Setting up xserver-common (2:1.20.4-1+rpt4+deb10u9) ... Oct 16 23:17:05 volumio volumio[947]: info: Setting up xserver-xorg-legacy (2:1.20.4-1+rpt4+deb10u9) ... Oct 16 23:17:07 volumio volumio[947]: info: Setting up libinput10:armhf (1.12.6-2+deb10u1) ... Oct 16 23:17:07 volumio volumio[947]: info: Setting up xserver-xorg-core (2:1.20.4-1+rpt4+deb10u9) ... Oct 16 23:17:08 volumio volumio[947]: info: Setting up xserver-xorg-video-radeon (1:19.0.1-1) ... Oct 16 23:17:08 volumio volumio[947]: info: Setting up xserver-xorg-input-wacom (0.34.99.1-1+b6) ... Oct 16 23:17:08 volumio volumio[947]: info: Setting up xserver-xorg-video-fbdev (1:0.5.0-1+b2) ... Oct 16 23:17:08 volumio volumio[947]: info: Setting up xserver-xorg-video-vesa (1:2.4.0-1+b1) ... Oct 16 23:17:09 volumio volumio[947]: info: Setting up xserver-xorg-video-amdgpu (18.1.99+git20190207-1) ... Oct 16 23:17:09 volumio volumio[947]: info: Setting up xserver-xorg (1:7.7+19+b8) ... Oct 16 23:17:09 volumio volumio[947]: info: Setting up xserver-xorg-video-nouveau (1:1.0.16-1) ... Oct 16 23:17:09 volumio volumio[947]: info: Setting up xserver-xorg-input-libinput (0.28.2-2) ... Oct 16 23:17:09 volumio volumio[947]: info: Setting up xserver-xorg-video-ati (1:19.0.1-1) ... Oct 16 23:17:09 volumio volumio[947]: info: Setting up xserver-xorg-video-all (1:7.7+19+b8) ... Oct 16 23:17:09 volumio volumio[947]: info: Setting up xserver-xorg-input-all (1:7.7+19+b8) ... Oct 16 23:17:09 volumio volumio[947]: info: Processing triggers for fontconfig (2.13.1-2) ... Oct 16 23:17:09 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 23:17:09 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 23:17:11 volumio volumio[947]: info: Processing triggers for mime-support (3.62) ... Oct 16 23:17:11 volumio volumio[947]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Oct 16 23:17:11 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 23:17:13 volumio systemd[1]: Starting Cleanup of Temporary Directories... Oct 16 23:17:13 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Oct 16 23:17:13 volumio systemd[1]: Started Cleanup of Temporary Directories. Oct 16 23:17:13 volumio volumio[947]: info: Reading package lists... Oct 16 23:17:14 volumio volumio[947]: info: Building dependency tree... Oct 16 23:17:14 volumio volumio[947]: info: Reading state information... Oct 16 23:17:15 volumio volumio[947]: info: The following additional packages will be installed: Oct 16 23:17:15 volumio volumio[947]: info: bsdmainutils groff-base libglu1-mesa libpipeline1 libuchardet0 man-db Oct 16 23:17:15 volumio volumio[947]: info: x11-apps x11-session-utils x11-xserver-utils xfonts-100dpi xfonts-75dpi Oct 16 23:17:15 volumio volumio[947]: info: xfonts-scalable xorg-docs-core Oct 16 23:17:15 volumio volumio[947]: info: Suggested packages: Oct 16 23:17:15 volumio volumio[947]: info: wamerican | wordlist whois vacation groff apparmor www-browser mesa-utils Oct 16 23:17:15 volumio volumio[947]: info: nickle cairo-5c xorg-docs x11-xfs-utils Oct 16 23:17:15 volumio volumio[947]: info: The following NEW packages will be installed: Oct 16 23:17:15 volumio volumio[947]: info: bsdmainutils groff-base libglu1-mesa libpipeline1 libuchardet0 man-db Oct 16 23:17:16 volumio volumio[947]: info: x11-apps x11-session-utils x11-xserver-utils xfonts-100dpi xfonts-75dpi Oct 16 23:17:16 volumio volumio[947]: info: xfonts-scalable xorg xorg-docs-core Oct 16 23:17:16 volumio volumio[947]: info: 0 upgraded, 14 newly installed, 0 to remove and 2 not upgraded. Oct 16 23:17:16 volumio volumio[947]: info: Need to get 10.8 MB of archives. Oct 16 23:17:16 volumio volumio[947]: info: After this operation, 17.8 MB of additional disk space will be used. Oct 16 23:17:16 volumio volumio[947]: info: Get:1 http://archive.raspberrypi.org/debian buster/main armhf x11-xserver-utils armhf 7.7+8+rpt1 [149 kB] Oct 16 23:17:16 volumio volumio[947]: info: Get:2 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf bsdmainutils armhf 11.1.2 [182 kB] Oct 16 23:17:16 volumio volumio[947]: info: Get:3 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf libuchardet0 armhf 0.0.6-3 [62.2 kB] Oct 16 23:17:16 volumio volumio[947]: info: Get:4 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf groff-base armhf 1.22.4-3+deb10u1 [782 kB] Oct 16 23:17:16 volumio volumio[947]: info: Get:5 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf libpipeline1 armhf 1.5.1-2 [26.6 kB] Oct 16 23:17:17 volumio volumio[947]: info: Get:6 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf man-db armhf 2.8.5-2+deb10u1 [1231 kB] Oct 16 23:17:17 volumio volumio[947]: info: Get:7 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf libglu1-mesa armhf 9.0.0-2.1 [130 kB] Oct 16 23:17:17 volumio volumio[947]: info: Get:8 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf x11-apps armhf 7.7+7 [541 kB] Oct 16 23:17:17 volumio volumio[947]: info: Get:9 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf x11-session-utils armhf 7.7+3 [61.2 kB] Oct 16 23:17:17 volumio volumio[947]: info: Get:10 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf xfonts-100dpi all 1:1.0.4+nmu1 [3822 kB] Oct 16 23:17:18 volumio volumio[947]: info: Get:11 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf xfonts-75dpi all 1:1.0.4+nmu1 [3367 kB] Oct 16 23:17:18 volumio volumio[947]: info: Get:12 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf xfonts-scalable all 1:1.0.3-1.1 [304 kB] Oct 16 23:17:18 volumio volumio[947]: info: Get:13 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf xorg-docs-core all 1:1.7.1-1.1 [84.0 kB] Oct 16 23:17:18 volumio volumio[947]: info: Get:14 http://mirror.solnet.ch/raspbian/raspbian buster/main armhf xorg armhf 1:7.7+19+b8 [38.8 kB] Oct 16 23:17:19 volumio volumio[947]: info: Fetched 10.8 MB in 2s (4586 kB/s) Oct 16 23:17:19 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 23:17:19 volumio volumio[947]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 16 23:17:19 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 16 23:17:19 volumio volumio[947]: info: Received Get System Version Oct 16 23:17:19 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 23:17:19 volumio volumio[947]: info: Received Get System Info Oct 16 23:17:19 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:17:19 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:17:19 volumio volumio[947]: info: Discovery: Getting this device information Oct 16 23:17:19 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:17:19 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:17:19 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:17:21 volumio volumio[947]: info: Selecting previously unselected package bsdmainutils. Oct 16 23:17:21 volumio volumio[947]: [620B blob data] Oct 16 23:17:21 volumio volumio[947]: info: Preparing to unpack .../00-bsdmainutils_11.1.2_armhf.deb ... Oct 16 23:17:22 volumio volumio[947]: info: Unpacking bsdmainutils (11.1.2) ... Oct 16 23:17:25 volumio volumio[947]: info: Selecting previously unselected package libuchardet0:armhf. Oct 16 23:17:26 volumio volumio[947]: info: Preparing to unpack .../01-libuchardet0_0.0.6-3_armhf.deb ... Oct 16 23:17:26 volumio volumio[947]: info: Unpacking libuchardet0:armhf (0.0.6-3) ... Oct 16 23:17:26 volumio volumio[947]: info: Selecting previously unselected package groff-base. Oct 16 23:17:26 volumio volumio[947]: info: Preparing to unpack .../02-groff-base_1.22.4-3+deb10u1_armhf.deb ... Oct 16 23:17:26 volumio volumio[947]: info: Unpacking groff-base (1.22.4-3+deb10u1) ... Oct 16 23:17:29 volumio volumio[947]: info: Selecting previously unselected package libpipeline1:armhf. Oct 16 23:17:29 volumio volumio[947]: info: Preparing to unpack .../03-libpipeline1_1.5.1-2_armhf.deb ... Oct 16 23:17:29 volumio volumio[947]: info: Unpacking libpipeline1:armhf (1.5.1-2) ... Oct 16 23:17:30 volumio volumio[947]: info: Selecting previously unselected package man-db. Oct 16 23:17:30 volumio volumio[947]: info: Preparing to unpack .../04-man-db_2.8.5-2+deb10u1_armhf.deb ... Oct 16 23:17:30 volumio volumio[947]: info: Unpacking man-db (2.8.5-2+deb10u1) ... Oct 16 23:17:32 volumio volumio[947]: info: Selecting previously unselected package libglu1-mesa:armhf. Oct 16 23:17:32 volumio volumio[947]: info: Preparing to unpack .../05-libglu1-mesa_9.0.0-2.1_armhf.deb ... Oct 16 23:17:32 volumio volumio[947]: info: Unpacking libglu1-mesa:armhf (9.0.0-2.1) ... Oct 16 23:17:34 volumio volumio[947]: info: Selecting previously unselected package x11-apps. Oct 16 23:17:34 volumio volumio[947]: info: Preparing to unpack .../06-x11-apps_7.7+7_armhf.deb ... Oct 16 23:17:34 volumio volumio[947]: info: Unpacking x11-apps (7.7+7) ... Oct 16 23:17:38 volumio volumio[947]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/lms/volumio/buster/armhf Oct 16 23:17:39 volumio volumio[947]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/lms/volumio/buster/armhf Oct 16 23:17:39 volumio volumio[947]: info: Folder /tmp/plugins removed Oct 16 23:17:39 volumio volumio[947]: info: Check plugin dependencies Oct 16 23:17:40 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 23:17:40 volumio volumio[947]: info: Checking if plugin already exists Oct 16 23:17:40 volumio volumio[947]: info: Rename folder Oct 16 23:17:40 volumio volumio[947]: info: Folder /tmp/downloaded_plugin.zip removed Oct 16 23:17:40 volumio volumio[947]: info: Move to category Oct 16 23:17:48 volumio volumio-remote-updater[605]: [2024-10-16 21:17:48] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Oct 16 23:17:53 volumio volumio-remote-updater[605]: [2024-10-16 21:17:53] [connect] Successful connection Oct 16 23:17:59 volumio volumio[947]: info: Checking if install.sh is present Oct 16 23:17:59 volumio volumio[947]: info: Executing install.sh Oct 16 23:17:59 volumio volumio[947]: verbose: New Socket.io Connection to 192.168.0.91 from 192.168.0.149 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 OPR/113.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Oct 16 23:17:59 volumio volumio[947]: verbose: New Socket.io Connection to 192.168.0.152 from 192.168.0.149 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 OPR/113.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Oct 16 23:17:59 volumio volumio[947]: verbose: New Socket.io Connection to 192.168.0.91 from 192.168.0.149 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 OPR/113.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 16 23:17:59 volumio volumio[947]: verbose: New Socket.io Connection to 192.168.0.152 from 192.168.0.149 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 OPR/113.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 16 23:17:59 volumio sudo[4670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/lms/install.sh Oct 16 23:17:59 volumio sudo[4670]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:17:59 volumio volumio[947]: info: Installing LMS and its dependencies... Oct 16 23:17:59 volumio volumio[947]: info: Installing LMS and its dependencies... Oct 16 23:18:00 volumio volumio[947]: info: Detected architecture: armv7l Oct 16 23:18:00 volumio volumio[947]: info: Detected architecture: armv7l Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:00 volumio volumio[947]: info: Received Get System Info Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:18:00 volumio volumio[947]: info: Discovery: Getting this device information Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 23:18:00 volumio volumio[947]: info: Received Get System Info Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:18:00 volumio volumio[947]: info: Discovery: Getting this device information Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:00 volumio volumio[947]: info: Listing playlists Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 23:18:00 volumio volumio[947]: info: Hit:1 http://archive.raspberrypi.org/debian buster InRelease Oct 16 23:18:00 volumio volumio[947]: info: Hit:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Oct 16 23:18:00 volumio volumio[947]: info: Oct 16 23:18:00 volumio volumio[947]: Selecting previously unselected package x11-session-utils. Oct 16 23:18:00 volumio volumio[947]: info: Hit:1 http://archive.raspberrypi.org/debian buster InRelease Oct 16 23:18:00 volumio volumio[947]: info: Hit:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Oct 16 23:18:00 volumio volumio[947]: info: Oct 16 23:18:00 volumio volumio[947]: Selecting previously unselected package x11-session-utils. Oct 16 23:18:00 volumio volumio[947]: info: Preparing to unpack .../07-x11-session-utils_7.7+3_armhf.deb ... Oct 16 23:18:00 volumio volumio[947]: info: Unpacking x11-session-utils (7.7+3) ... Oct 16 23:18:00 volumio volumio[947]: info: Preparing to unpack .../07-x11-session-utils_7.7+3_armhf.deb ... Oct 16 23:18:00 volumio volumio[947]: info: Unpacking x11-session-utils (7.7+3) ... Oct 16 23:18:00 volumio volumio[947]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 16 23:18:00 volumio volumio[947]: info: CoreCommandRouter::volumioGetState Oct 16 23:18:00 volumio volumio[947]: info: CorePlayQueue::getTrack 0 Oct 16 23:18:01 volumio volumio[947]: info: Selecting previously unselected package x11-xserver-utils. Oct 16 23:18:01 volumio volumio[947]: info: Selecting previously unselected package x11-xserver-utils. Oct 16 23:18:01 volumio volumio[947]: info: Preparing to unpack .../08-x11-xserver-utils_7.7+8+rpt1_armhf.deb ... Oct 16 23:18:01 volumio volumio[947]: info: Unpacking x11-xserver-utils (7.7+8+rpt1) ... Oct 16 23:18:01 volumio volumio[947]: info: Preparing to unpack .../08-x11-xserver-utils_7.7+8+rpt1_armhf.deb ... Oct 16 23:18:01 volumio volumio[947]: info: Unpacking x11-xserver-utils (7.7+8+rpt1) ... Oct 16 23:18:03 volumio volumio[947]: info: Selecting previously unselected package xfonts-100dpi. Oct 16 23:18:03 volumio volumio[947]: info: Selecting previously unselected package xfonts-100dpi. Oct 16 23:18:03 volumio volumio[947]: info: Preparing to unpack .../09-xfonts-100dpi_1%3a1.0.4+nmu1_all.deb ... Oct 16 23:18:03 volumio volumio[947]: info: Unpacking xfonts-100dpi (1:1.0.4+nmu1) ... Oct 16 23:18:03 volumio volumio[947]: info: Preparing to unpack .../09-xfonts-100dpi_1%3a1.0.4+nmu1_all.deb ... Oct 16 23:18:03 volumio volumio[947]: info: Unpacking xfonts-100dpi (1:1.0.4+nmu1) ... Oct 16 23:18:05 volumio volumio-remote-updater[605]: [2024-10-16 21:18:05] [connect] Successful connection Oct 16 23:18:05 volumio volumio-remote-updater[605]: [2024-10-16 21:18:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1729113485 101 Oct 16 23:18:05 volumio volumio[947]: 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: 8 Oct 16 23:18:08 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 23:18:09 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 23:18:09 volumio volumio[947]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 23:18:17 volumio volumio[947]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/pandora/volumio/buster/armhf Oct 16 23:18:19 volumio volumio[947]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/pandora/volumio/buster/armhf Oct 16 23:18:19 volumio volumio[947]: info: Folder /tmp/plugins removed Oct 16 23:18:22 volumio volumio[947]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/pandora/volumio/buster/armhf Oct 16 23:18:23 volumio volumio[947]: info: An error occurred installing the plugin. Rolling back config Oct 16 23:18:23 volumio volumio[947]: info: Plugin folders cleanup Oct 16 23:18:23 volumio volumio[947]: info: Scanning into folder /volumio/app/plugins/ Oct 16 23:18:23 volumio volumio[947]: info: Scanning category audio_interface Oct 16 23:18:23 volumio volumio[947]: info: Scanning category miscellanea Oct 16 23:18:23 volumio volumio[947]: info: Scanning category music_service Oct 16 23:18:23 volumio volumio[947]: info: Scanning category plugins.json Oct 16 23:18:23 volumio volumio[947]: info: Scanning category system_controller Oct 16 23:18:23 volumio volumio[947]: info: Scanning category user_interface Oct 16 23:18:23 volumio volumio[947]: info: Scanning into folder /data/plugins/ Oct 16 23:18:23 volumio volumio[947]: info: Scanning category music_service Oct 16 23:18:23 volumio volumio[947]: info: Scanning category system_hardware Oct 16 23:18:23 volumio volumio[947]: info: Scanning category user_interface Oct 16 23:18:23 volumio volumio[947]: info: Plugin folders cleanup completed Oct 16 23:18:23 volumio volumio[947]: info: Error: Error Oct 16 23:18:23 volumio volumio[947]: info: Folder /tmp/plugins removed Oct 16 23:18:23 volumio volumio[947]: info: Folder /tmp/downloaded_plugin.zip removed Oct 16 23:18:23 volumio volumio[947]: info: Folder /tmp/downloaded_plugin.zip removed Oct 16 23:18:24 volumio volumio[947]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/pandora/volumio/buster/armhf Oct 16 23:18:24 volumio volumio[947]: info: Folder /tmp/plugins removed Oct 16 23:18:28 volumio volumio[947]: info: Folder /data/temp removed Oct 16 23:18:28 volumio volumio[947]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 23:18:28 volumio volumio[947]: Error: Unable to resolve or reject the same promise twice Oct 16 23:18:28 volumio volumio[947]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 16 23:18:28 volumio volumio[947]: at /volumio/app/pluginmanager.js:1087:11 Oct 16 23:18:28 volumio volumio[947]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Oct 16 23:18:28 volumio volumio[947]: at FSReqCallback.oncomplete (fs.js:171:23) Oct 16 23:18:28 volumio volumio[947]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 23:18:35 volumio volumio-remote-updater[605]: [2024-10-16 21:18:35] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Oct 16 23:18:40 volumio volumio-remote-updater[605]: [2024-10-16 21:18:40] [connect] Successful connection Oct 16 23:18:42 volumio sudo[5011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-16 23:17 Oct 16 23:18:42 volumio sudo[5011]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"