Dec 30 00:30:03 volumio4 volumio[1249]: info: Reading package lists... Dec 30 00:30:05 volumio4 volumio[1249]: info: Building dependency tree... Dec 30 00:30:05 volumio4 volumio[1249]: info: Reading state information... Dec 30 00:30:05 volumio4 volumio[1249]: info: 13 packages can be upgraded. Run 'apt list --upgradable' to see them. Dec 30 00:30:05 volumio4 sudo[2746]: pam_unix(sudo:session): session closed for user root Dec 30 00:30:05 volumio4 sudo[3003]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt install -y sysbench Dec 30 00:30:05 volumio4 sudo[3003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 30 00:30:07 volumio4 volumio[1249]: info: Reading package lists... Dec 30 00:30:10 volumio4 volumio[1249]: info: Building dependency tree... Dec 30 00:30:10 volumio4 volumio[1249]: info: Reading state information... Dec 30 00:30:14 volumio4 volumio[1249]: info: The following additional packages will be installed: Dec 30 00:30:14 volumio4 volumio[1249]: info: libaio1 libluajit2-5.1-2 libluajit2-5.1-common libmariadb3 libpq5 Dec 30 00:30:14 volumio4 volumio[1249]: info: mariadb-common mysql-common Dec 30 00:30:14 volumio4 volumio[1249]: info: The following NEW packages will be installed: Dec 30 00:30:14 volumio4 volumio[1249]: info: libaio1 libluajit2-5.1-2 libluajit2-5.1-common libmariadb3 libpq5 Dec 30 00:30:14 volumio4 volumio[1249]: info: mariadb-common mysql-common sysbench Dec 30 00:30:14 volumio4 volumio[1249]: info: 0 upgraded, 8 newly installed, 0 to remove and 13 not upgraded. Dec 30 00:30:14 volumio4 volumio[1249]: info: Need to get 727 kB of archives. Dec 30 00:30:14 volumio4 volumio[1249]: info: After this operation, 2609 kB of additional disk space will be used. Dec 30 00:30:14 volumio4 volumio[1249]: info: Get:1 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libaio1 armhf 0.3.113-4+rpi1 [13.3 kB] Dec 30 00:30:14 volumio4 volumio[1249]: info: Get:2 http://www.mirrorservice.org/sites/archive.raspbian.org/raspbian bookworm/main armhf libluajit2-5.1-common all 2.1-20230119-1 [46.6 kB] Dec 30 00:30:14 volumio4 volumio[1249]: info: Get:3 http://www.mirrorservice.org/sites/archive.raspbian.org/raspbian bookworm/main armhf libluajit2-5.1-2 armhf 2.1-20230119-1 [211 kB] Dec 30 00:30:14 volumio4 volumio[1249]: info: Get:4 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf mysql-common all 5.8+1.1.0 [6636 B] Dec 30 00:30:15 volumio4 volumio[1249]: info: Get:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf mariadb-common all 1:10.11.3-1+rpi1 [24.1 kB] Dec 30 00:30:15 volumio4 volumio[1249]: info: Get:6 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libmariadb3 armhf 1:10.11.3-1+rpi1 [154 kB] Dec 30 00:30:15 volumio4 volumio[1249]: info: Get:8 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf sysbench armhf 1.0.20+ds-5 [104 kB] Dec 30 00:30:15 volumio4 volumio[1249]: info: Get:7 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libpq5 armhf 15.14-0+deb12u1 [166 kB] Dec 30 00:30:16 volumio4 volumio[1249]: info: Fetched 727 kB in 1s (557 kB/s) Dec 30 00:30:16 volumio4 volumio[1249]: info: Selecting previously unselected package libaio1:armhf. Dec 30 00:30:17 volumio4 volumio[1249]: [620B blob data] Dec 30 00:30:17 volumio4 volumio[1249]: info: Preparing to unpack .../0-libaio1_0.3.113-4+rpi1_armhf.deb ... Dec 30 00:30:17 volumio4 volumio[1249]: info: Unpacking libaio1:armhf (0.3.113-4+rpi1) ... Dec 30 00:30:17 volumio4 volumio[1249]: info: Selecting previously unselected package libluajit2-5.1-common. Dec 30 00:30:17 volumio4 volumio[1249]: info: Preparing to unpack .../1-libluajit2-5.1-common_2.1-20230119-1_all.deb ... Dec 30 00:30:17 volumio4 volumio[1249]: info: Unpacking libluajit2-5.1-common (2.1-20230119-1) ... Dec 30 00:30:17 volumio4 volumio[1249]: info: Selecting previously unselected package libluajit2-5.1-2:armhf. Dec 30 00:30:17 volumio4 volumio[1249]: info: Preparing to unpack .../2-libluajit2-5.1-2_2.1-20230119-1_armhf.deb ... Dec 30 00:30:17 volumio4 volumio[1249]: info: Unpacking libluajit2-5.1-2:armhf (2.1-20230119-1) ... Dec 30 00:30:17 volumio4 volumio[1249]: info: Selecting previously unselected package mysql-common. Dec 30 00:30:17 volumio4 volumio[1249]: info: Preparing to unpack .../3-mysql-common_5.8+1.1.0_all.deb ... Dec 30 00:30:17 volumio4 volumio[1249]: info: Unpacking mysql-common (5.8+1.1.0) ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Selecting previously unselected package mariadb-common. Dec 30 00:30:18 volumio4 volumio[1249]: info: Preparing to unpack .../4-mariadb-common_1%3a10.11.3-1+rpi1_all.deb ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Unpacking mariadb-common (1:10.11.3-1+rpi1) ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Selecting previously unselected package libmariadb3:armhf. Dec 30 00:30:18 volumio4 volumio[1249]: info: Preparing to unpack .../5-libmariadb3_1%3a10.11.3-1+rpi1_armhf.deb ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Unpacking libmariadb3:armhf (1:10.11.3-1+rpi1) ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Selecting previously unselected package libpq5:armhf. Dec 30 00:30:18 volumio4 volumio[1249]: info: Preparing to unpack .../6-libpq5_15.14-0+deb12u1_armhf.deb ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Unpacking libpq5:armhf (15.14-0+deb12u1) ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Selecting previously unselected package sysbench. Dec 30 00:30:18 volumio4 volumio[1249]: info: Preparing to unpack .../7-sysbench_1.0.20+ds-5_armhf.deb ... Dec 30 00:30:18 volumio4 volumio[1249]: info: Unpacking sysbench (1.0.20+ds-5) ... Dec 30 00:30:19 volumio4 volumio[1249]: info: Setting up mysql-common (5.8+1.1.0) ... Dec 30 00:30:19 volumio4 volumio[1249]: info: update-alternatives: using /etc/mysql/my.cnf.fallback to provide /etc/mysql/my.cnf (my.cnf) in auto mode Dec 30 00:30:19 volumio4 volumio[1249]: info: Setting up libpq5:armhf (15.14-0+deb12u1) ... Dec 30 00:30:19 volumio4 volumio[1249]: info: Setting up libluajit2-5.1-common (2.1-20230119-1) ... Dec 30 00:30:19 volumio4 volumio[1249]: info: Setting up mariadb-common (1:10.11.3-1+rpi1) ... Dec 30 00:30:19 volumio4 volumio[1249]: info: update-alternatives: using /etc/mysql/mariadb.cnf to provide /etc/mysql/my.cnf (my.cnf) in auto mode Dec 30 00:30:19 volumio4 volumio[1249]: info: Setting up libmariadb3:armhf (1:10.11.3-1+rpi1) ... Dec 30 00:30:19 volumio4 volumio[1249]: info: Setting up libaio1:armhf (0.3.113-4+rpi1) ... Dec 30 00:30:19 volumio4 volumio[1249]: info: Setting up libluajit2-5.1-2:armhf (2.1-20230119-1) ... Dec 30 00:30:20 volumio4 volumio[1249]: info: Setting up sysbench (1.0.20+ds-5) ... Dec 30 00:30:20 volumio4 volumio[1249]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Dec 30 00:30:21 volumio4 sudo[3003]: pam_unix(sudo:session): session closed for user root Dec 30 00:30:21 volumio4 volumio[1249]: info: Configuration file doesn't exist, nothing to do Dec 30 00:30:21 volumio4 volumio[1249]: info: Detected cpu architecture as armv7l Dec 30 00:30:21 volumio4 sudo[3176]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/user_interface/Systeminfo/c/hw_params_arm /data/plugins/user_interface/Systeminfo/hw_params Dec 30 00:30:21 volumio4 sudo[3176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 30 00:30:21 volumio4 sudo[3176]: pam_unix(sudo:session): session closed for user root Dec 30 00:30:21 volumio4 sudo[3178]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/user_interface/Systeminfo/hw_params Dec 30 00:30:21 volumio4 sudo[3178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 30 00:30:21 volumio4 sudo[3178]: pam_unix(sudo:session): session closed for user root Dec 30 00:30:21 volumio4 sudo[2744]: pam_unix(sudo:session): session closed for user root Dec 30 00:30:21 volumio4 volumio[1249]: Plugin install end detected on script Dec 30 00:30:21 volumio4 volumio[1249]: info: Install script completed Dec 30 00:30:21 volumio4 volumio[1249]: info: Adding reference to registry Dec 30 00:30:21 volumio4 volumio[1249]: info: Done installing plugin. Dec 30 00:30:21 volumio4 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 00:30:21 volumio4 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 30 00:30:21 volumio4 volumio[1249]: info: Folder /tmp/plugins removed Dec 30 00:30:21 volumio4 volumio[1249]: info: Folder /tmp/downloaded_plugin.zip removed Dec 30 00:30:21 volumio4 volumio[1249]: info: Folder /data/temp removed Dec 30 00:30:39 volumio4 volumio[1249]: info: Enabling plugin Systeminfo Dec 30 00:30:39 volumio4 volumio[1249]: info: Loading plugin "Systeminfo"... Dec 30 00:30:39 volumio4 volumio[1249]: info: PLUGIN START: Systeminfo Dec 30 00:30:39 volumio4 volumio[1249]: info: Done. Dec 30 00:31:01 volumio4 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 30 00:31:02 volumio4 volumio[1249]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Dec 30 00:31:04 volumio4 volumio[1249]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Dec 30 00:31:04 volumio4 volumio[1249]: info: Folder /tmp/plugins removed Dec 30 00:31:05 volumio4 volumio[1249]: info: Check plugin dependencies Dec 30 00:31:05 volumio4 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 00:31:05 volumio4 volumio[1249]: info: Checking if plugin already exists Dec 30 00:31:05 volumio4 volumio[1249]: info: Rename folder Dec 30 00:31:05 volumio4 volumio[1249]: info: Folder /tmp/downloaded_plugin.zip removed Dec 30 00:31:05 volumio4 volumio[1249]: info: Move to category Dec 30 00:31:08 volumio4 volumio[1249]: info: Checking if install.sh is present Dec 30 00:31:08 volumio4 volumio[1249]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/now_playing/1.0.3/volumio/bookworm/armhf Dec 30 00:31:08 volumio4 volumio[1249]: info: Executing install.sh Dec 30 00:31:08 volumio4 sudo[3270]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/now_playing/install.sh Dec 30 00:31:08 volumio4 sudo[3270]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 00:31:08 volumio4 volumio[1249]: info: Installing geo-tz node dependency Dec 30 00:31:08 volumio4 su[3273]: (to volumio) root on none Dec 30 00:31:08 volumio4 su[3273]: pam_unix(su:session): session opened for user volumio(uid=1000) by (uid=0) Dec 30 00:31:08 volumio4 systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Dec 30 00:31:08 volumio4 systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Dec 30 00:31:08 volumio4 systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Dec 30 00:31:08 volumio4 systemd[1]: Starting user@1000.service - User Manager for UID 1000... Dec 30 00:31:08 volumio4 (systemd)[3275]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Dec 30 00:31:09 volumio4 systemd[3275]: Queued start job for default target default.target. Dec 30 00:31:09 volumio4 systemd[3275]: Created slice app.slice - User Application Slice. Dec 30 00:31:09 volumio4 systemd[3275]: Reached target paths.target - Paths. Dec 30 00:31:09 volumio4 systemd[3275]: Reached target timers.target - Timers. Dec 30 00:31:09 volumio4 systemd[3275]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Dec 30 00:31:09 volumio4 systemd[3275]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Dec 30 00:31:09 volumio4 systemd[3275]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Dec 30 00:31:09 volumio4 systemd[3275]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Dec 30 00:31:09 volumio4 systemd[3275]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Dec 30 00:31:09 volumio4 systemd[3275]: Reached target sockets.target - Sockets. Dec 30 00:31:09 volumio4 systemd[3275]: Reached target basic.target - Basic System. Dec 30 00:31:09 volumio4 systemd[1]: Started user@1000.service - User Manager for UID 1000. Dec 30 00:31:09 volumio4 systemd[3275]: Started mpris-proxy.service - Bluetooth mpris proxy. Dec 30 00:31:09 volumio4 systemd[3275]: Reached target default.target - Main User Target. Dec 30 00:31:09 volumio4 systemd[3275]: Startup finished in 386ms. Dec 30 00:31:09 volumio4 systemd[1]: Started session-c1.scope - Session c1 of User volumio. Dec 30 00:31:09 volumio4 mpris-proxy[3304]: Can't get on session bus Dec 30 00:31:09 volumio4 systemd[3275]: mpris-proxy.service: Main process exited, code=exited, status=1/FAILURE Dec 30 00:31:09 volumio4 systemd[3275]: mpris-proxy.service: Failed with result 'exit-code'. Dec 30 00:31:10 volumio4 volumio[1249]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/now_playing/1.0.3/volumio/bookworm/armhf Dec 30 00:31:10 volumio4 volumio[1249]: info: Folder /tmp/plugins removed Dec 30 00:31:11 volumio4 volumio[1249]: info: Check plugin dependencies Dec 30 00:31:11 volumio4 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 00:31:11 volumio4 volumio[1249]: info: Checking if plugin already exists Dec 30 00:31:11 volumio4 volumio[1249]: info: Rename folder Dec 30 00:31:11 volumio4 volumio[1249]: info: Folder /tmp/downloaded_plugin.zip removed Dec 30 00:31:11 volumio4 volumio[1249]: info: Move to category Dec 30 00:31:15 volumio4 ntpd[988]: CLOCK: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 30 00:31:15 volumio4 volumio[1249]: info: Checking if install.sh is present Dec 30 00:31:15 volumio4 volumio[1249]: info: Executing install.sh Dec 30 00:31:15 volumio4 sudo[3372]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/now_playing/install.sh Dec 30 00:31:15 volumio4 sudo[3372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 00:31:15 volumio4 volumio[1249]: info: Installing geo-tz node dependency Dec 30 00:31:15 volumio4 volumio[1249]: info: Installing geo-tz node dependency Dec 30 00:31:15 volumio4 su[3375]: (to volumio) root on none Dec 30 00:31:15 volumio4 su[3375]: pam_unix(su:session): session opened for user volumio(uid=1000) by (uid=0) Dec 30 00:31:15 volumio4 systemd[1]: Started session-c2.scope - Session c2 of User volumio. Dec 30 00:31:31 volumio4 volumio[1249]: info: Dec 30 00:31:31 volumio4 volumio[1249]: info: added 30 packages, removed 144 packages, and audited 31 packages in 21s Dec 30 00:31:31 volumio4 volumio[1249]: info: Dec 30 00:31:32 volumio4 volumio[1249]: info: added 30 packages, removed 144 packages, and audited 31 packages in 21s Dec 30 00:31:32 volumio4 volumio[1249]: info: Dec 30 00:31:32 volumio4 volumio[1249]: info: Dec 30 00:31:32 volumio4 su[3273]: pam_unix(su:session): session closed for user volumio Dec 30 00:31:32 volumio4 volumio[1249]: info: 6 packages are looking for funding Dec 30 00:31:32 volumio4 volumio[1249]: info: 6 packages are looking for funding Dec 30 00:31:32 volumio4 systemd[1]: session-c1.scope: Deactivated successfully. Dec 30 00:31:32 volumio4 systemd[1]: session-c1.scope: Consumed 30.805s CPU time. Dec 30 00:31:32 volumio4 volumio[1249]: info: run `npm fund` for details Dec 30 00:31:32 volumio4 volumio[1249]: info: run `npm fund` for details Dec 30 00:31:32 volumio4 volumio[1249]: info: Dec 30 00:31:32 volumio4 volumio[1249]: info: found 0 vulnerabilities Dec 30 00:31:32 volumio4 volumio[1249]: info: Dec 30 00:31:32 volumio4 volumio[1249]: info: found 0 vulnerabilities Dec 30 00:31:32 volumio4 sudo[3270]: pam_unix(sudo:session): session closed for user root Dec 30 00:31:32 volumio4 volumio[1249]: info: Install script completed Dec 30 00:31:32 volumio4 volumio[1249]: info: Adding reference to registry Dec 30 00:31:32 volumio4 volumio[1249]: info: Done installing plugin. Dec 30 00:31:32 volumio4 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 00:31:32 volumio4 volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 30 00:31:32 volumio4 volumio[1249]: info: Creating user directories (if not exist) Dec 30 00:31:32 volumio4 volumio[1249]: info: Creating user directories (if not exist) Dec 30 00:31:32 volumio4 volumio[1249]: info: Folder /tmp/plugins removed Dec 30 00:31:32 volumio4 volumio[1249]: info: Folder /tmp/downloaded_plugin.zip removed Dec 30 00:31:32 volumio4 volumio[1249]: info: Folder /data/temp removed Dec 30 00:31:32 volumio4 volumio[1249]: info: Now Playing plugin installed Dec 30 00:31:32 volumio4 volumio[1249]: Plugin install end detected on script Dec 30 00:31:32 volumio4 volumio[1249]: info: Now Playing plugin installed Dec 30 00:31:32 volumio4 volumio[1249]: Plugin install end detected on script Dec 30 00:31:35 volumio4 volumio[1249]: info: Enabling plugin now_playing Dec 30 00:31:35 volumio4 volumio[1249]: info: Loading plugin "now_playing"... Dec 30 00:31:35 volumio4 volumio[1249]: error: !!!! WARNING !!!! Dec 30 00:31:35 volumio4 volumio[1249]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'now-playing-common' Dec 30 00:31:35 volumio4 volumio[1249]: Require stack: Dec 30 00:31:35 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/config/PluginConfig.js Dec 30 00:31:35 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js Dec 30 00:31:35 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/index.js Dec 30 00:31:35 volumio4 volumio[1249]: - /volumio/app/pluginmanager.js Dec 30 00:31:35 volumio4 volumio[1249]: - /volumio/app/index.js Dec 30 00:31:35 volumio4 volumio[1249]: - /volumio/index.js Dec 30 00:31:35 volumio4 volumio[1249]: error: Stack trace: Error: Cannot find module 'now-playing-common' Dec 30 00:31:35 volumio4 volumio[1249]: Require stack: Dec 30 00:31:35 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/config/PluginConfig.js Dec 30 00:31:35 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js Dec 30 00:31:35 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/index.js Dec 30 00:31:35 volumio4 volumio[1249]: - /volumio/app/pluginmanager.js Dec 30 00:31:35 volumio4 volumio[1249]: - /volumio/app/index.js Dec 30 00:31:35 volumio4 volumio[1249]: - /volumio/index.js Dec 30 00:31:35 volumio4 volumio[1249]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Dec 30 00:31:35 volumio4 volumio[1249]: at Module._load (node:internal/modules/cjs/loader:901:27) Dec 30 00:31:35 volumio4 volumio[1249]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 30 00:31:35 volumio4 volumio[1249]: at require (node:internal/modules/helpers:130:18) Dec 30 00:31:35 volumio4 volumio[1249]: at Object. (/data/plugins/user_interface/now_playing/dist/lib/config/PluginConfig.js:8:30) Dec 30 00:31:35 volumio4 volumio[1249]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 30 00:31:35 volumio4 volumio[1249]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 30 00:31:35 volumio4 volumio[1249]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 30 00:31:35 volumio4 volumio[1249]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 30 00:31:35 volumio4 volumio[1249]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 30 00:31:35 volumio4 volumio[1249]: at require (node:internal/modules/helpers:130:18) Dec 30 00:31:35 volumio4 volumio[1249]: at Object. (/data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js:20:24) Dec 30 00:31:35 volumio4 volumio[1249]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 30 00:31:35 volumio4 volumio[1249]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 30 00:31:35 volumio4 volumio[1249]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 30 00:31:35 volumio4 volumio[1249]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 30 00:31:35 volumio4 volumio[1249]: error: !!!! WARNING !!!! Dec 30 00:31:35 volumio4 volumio[1249]: info: Done. Dec 30 00:31:42 volumio4 volumio[1249]: info: Enabling plugin now_playing Dec 30 00:31:42 volumio4 volumio[1249]: info: Loading plugin "now_playing"... Dec 30 00:31:42 volumio4 volumio[1249]: error: !!!! WARNING !!!! Dec 30 00:31:42 volumio4 volumio[1249]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'now-playing-common' Dec 30 00:31:42 volumio4 volumio[1249]: Require stack: Dec 30 00:31:42 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/config/PluginConfig.js Dec 30 00:31:42 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js Dec 30 00:31:42 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/index.js Dec 30 00:31:42 volumio4 volumio[1249]: - /volumio/app/pluginmanager.js Dec 30 00:31:42 volumio4 volumio[1249]: - /volumio/app/index.js Dec 30 00:31:42 volumio4 volumio[1249]: - /volumio/index.js Dec 30 00:31:42 volumio4 volumio[1249]: error: Stack trace: Error: Cannot find module 'now-playing-common' Dec 30 00:31:42 volumio4 volumio[1249]: Require stack: Dec 30 00:31:42 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/config/PluginConfig.js Dec 30 00:31:42 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js Dec 30 00:31:42 volumio4 volumio[1249]: - /data/plugins/user_interface/now_playing/dist/index.js Dec 30 00:31:42 volumio4 volumio[1249]: - /volumio/app/pluginmanager.js Dec 30 00:31:42 volumio4 volumio[1249]: - /volumio/app/index.js Dec 30 00:31:42 volumio4 volumio[1249]: - /volumio/index.js Dec 30 00:31:42 volumio4 volumio[1249]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Dec 30 00:31:42 volumio4 volumio[1249]: at Module._load (node:internal/modules/cjs/loader:901:27) Dec 30 00:31:42 volumio4 volumio[1249]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 30 00:31:42 volumio4 volumio[1249]: at require (node:internal/modules/helpers:130:18) Dec 30 00:31:42 volumio4 volumio[1249]: at Object. (/data/plugins/user_interface/now_playing/dist/lib/config/PluginConfig.js:8:30) Dec 30 00:31:42 volumio4 volumio[1249]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 30 00:31:42 volumio4 volumio[1249]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 30 00:31:42 volumio4 volumio[1249]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 30 00:31:42 volumio4 volumio[1249]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 30 00:31:42 volumio4 volumio[1249]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 30 00:31:42 volumio4 volumio[1249]: at require (node:internal/modules/helpers:130:18) Dec 30 00:31:42 volumio4 volumio[1249]: at Object. (/data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js:20:24) Dec 30 00:31:42 volumio4 volumio[1249]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 30 00:31:42 volumio4 volumio[1249]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 30 00:31:42 volumio4 volumio[1249]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 30 00:31:42 volumio4 volumio[1249]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 30 00:31:42 volumio4 volumio[1249]: error: !!!! WARNING !!!! Dec 30 00:31:42 volumio4 volumio[1249]: info: Error: TypeError: Cannot read properties of null (reading 'printToastMessage') Dec 30 00:31:57 volumio4 volumio[1249]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/peppymeterbasic/volumio/bookworm/armhf Dec 30 00:31:57 volumio4 volumio[1249]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 00:31:57 volumio4 volumio[1249]: TypeError: Cannot read properties of null (reading 'broadcastMessage') Dec 30 00:31:57 volumio4 volumio[1249]: at /volumio/app/index.js:1534:32 Dec 30 00:31:57 volumio4 volumio[1249]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Dec 30 00:31:57 volumio4 volumio[1249]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Dec 30 00:31:57 volumio4 volumio[1249]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Dec 30 00:31:57 volumio4 volumio[1249]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Dec 30 00:31:57 volumio4 volumio[1249]: at PluginManager.installPlugin (/volumio/app/pluginmanager.js:776:8) Dec 30 00:31:57 volumio4 volumio[1249]: at CoreCommandRouter.installPlugin (/volumio/app/index.js:1453:22) Dec 30 00:31:57 volumio4 volumio[1249]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1220:47) Dec 30 00:31:57 volumio4 volumio[1249]: at Socket.emit (node:events:514:28) Dec 30 00:31:57 volumio4 volumio[1249]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 30 00:31:57 volumio4 volumio[1249]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 30 00:31:57 volumio4 volumio[1249]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 00:31:58 volumio4 sudo[3586]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-30 00:30' Dec 30 00:31:58 volumio4 sudo[3586]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"