Dec 23 14:46:02 napule volumio-remote-updater[731]: [2025-12-23 13:46:02] [connect] Successful connection Dec 23 14:46:15 napule volumio-remote-updater[731]: [2025-12-23 13:46:15] [connect] Successful connection Dec 23 14:46:30 napule volumio-remote-updater[731]: [2025-12-23 13:46:30] [connect] Successful connection Dec 23 14:46:35 napule volumio[1284]: error: !!!! WARNING !!!! Dec 23 14:46:35 napule volumio[1284]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Dec 23 14:46:35 napule volumio[1284]: Require stack: Dec 23 14:46:35 napule volumio[1284]: - /data/plugins/user_interface/now_playing/dist/index.js Dec 23 14:46:35 napule volumio[1284]: - /volumio/app/pluginmanager.js Dec 23 14:46:35 napule volumio[1284]: - /volumio/app/index.js Dec 23 14:46:35 napule volumio[1284]: - /volumio/index.js Dec 23 14:46:35 napule volumio[1284]: error: Stack trace: Error: Cannot find module 'geo-tz' Dec 23 14:46:35 napule volumio[1284]: Require stack: Dec 23 14:46:35 napule volumio[1284]: - /data/plugins/user_interface/now_playing/dist/index.js Dec 23 14:46:35 napule volumio[1284]: - /volumio/app/pluginmanager.js Dec 23 14:46:35 napule volumio[1284]: - /volumio/app/index.js Dec 23 14:46:35 napule volumio[1284]: - /volumio/index.js Dec 23 14:46:35 napule volumio[1284]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Dec 23 14:46:35 napule volumio[1284]: at Module._load (node:internal/modules/cjs/loader:901:27) Dec 23 14:46:35 napule volumio[1284]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 23 14:46:35 napule volumio[1284]: at require (node:internal/modules/helpers:130:18) Dec 23 14:46:35 napule volumio[1284]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Dec 23 14:46:35 napule volumio[1284]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 23 14:46:35 napule volumio[1284]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 23 14:46:35 napule volumio[1284]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 23 14:46:35 napule volumio[1284]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 23 14:46:35 napule volumio[1284]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 23 14:46:35 napule volumio[1284]: at require (node:internal/modules/helpers:130:18) Dec 23 14:46:35 napule volumio[1284]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Dec 23 14:46:35 napule volumio[1284]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Dec 23 14:46:35 napule volumio[1284]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 23 14:46:35 napule volumio[1284]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 23 14:46:35 napule volumio[1284]: error: !!!! WARNING !!!! Dec 23 14:46:35 napule volumio[1284]: info: Done. Dec 23 14:46:35 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 1 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 2 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 3 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 4 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 5 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 6 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 7 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 8 Dec 23 14:46:36 napule volumio[1284]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 23 14:46:37 napule sudo[6599]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 14:46:37 napule sudo[6599]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 14:46:37 napule sudo[6598]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 14:46:37 napule sudo[6598]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 14:46:37 napule sudo[6598]: pam_unix(sudo:session): session closed for user root Dec 23 14:46:37 napule sudo[6599]: pam_unix(sudo:session): session closed for user root Dec 23 14:46:37 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 10 Dec 23 14:46:37 napule volumio[1284]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Dec 23 14:46:37 napule volumio[1284]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::volumioGetState Dec 23 14:46:37 napule volumio[1284]: info: CorePlayQueue::getTrack 0 Dec 23 14:46:37 napule sudo[6604]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 14:46:37 napule sudo[6604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 14:46:37 napule sudo[6604]: pam_unix(sudo:session): session closed for user root Dec 23 14:46:37 napule sudo[6606]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 14:46:37 napule sudo[6606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 14:46:37 napule sudo[6606]: pam_unix(sudo:session): session closed for user root Dec 23 14:46:37 napule volumio[1284]: verbose: New Socket.io Connection to 192.168.2.145 from 192.168.2.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 13 Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::volumioGetVisibleSources Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::volumioGetState Dec 23 14:46:37 napule volumio[1284]: info: CorePlayQueue::getTrack 0 Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 23 14:46:37 napule volumio[1284]: info: Received Get System Info Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 14:46:37 napule volumio[1284]: info: Discovery: Getting this device information Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::volumioGetState Dec 23 14:46:37 napule volumio[1284]: info: CorePlayQueue::getTrack 0 Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::volumioGetState Dec 23 14:46:37 napule volumio[1284]: info: CorePlayQueue::getTrack 0 Dec 23 14:46:37 napule volumio[1284]: info: Listing playlists Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 23 14:46:37 napule volumio[1284]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 14:46:38 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 23 14:46:38 napule volumio[1284]: info: CoreCommandRouter::volumioGetState Dec 23 14:46:38 napule volumio[1284]: info: CorePlayQueue::getTrack 0 Dec 23 14:46:38 napule volumio[1284]: error: error Dec 23 14:46:38 napule volumio[1284]: error: error Dec 23 14:46:39 napule volumio[1284]: error: error Dec 23 14:46:39 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 23 14:46:39 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 14:46:39 napule volumio[1284]: info: Received Get System Info Dec 23 14:46:39 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 14:46:39 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 14:46:39 napule volumio[1284]: info: Discovery: Getting this device information Dec 23 14:46:39 napule volumio[1284]: info: CoreCommandRouter::volumioGetState Dec 23 14:46:39 napule volumio[1284]: info: CorePlayQueue::getTrack 0 Dec 23 14:46:39 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 14:46:41 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 14:46:41 napule volumio[1284]: info: Received Get System Info Dec 23 14:46:41 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 14:46:41 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 14:46:41 napule volumio[1284]: info: Discovery: Getting this device information Dec 23 14:46:41 napule volumio[1284]: info: CoreCommandRouter::volumioGetState Dec 23 14:46:41 napule volumio[1284]: info: CorePlayQueue::getTrack 0 Dec 23 14:46:41 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 14:46:41 napule volumio[1284]: error: error Dec 23 14:46:42 napule volumio[1284]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 14:46:42 napule volumio[1284]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 14:46:42 napule volumio[1284]: info: Retrieving Cloud Streaming UI Dec 23 14:46:45 napule volumio-remote-updater[731]: [2025-12-23 13:46:45] [connect] Successful connection Dec 23 14:46:47 napule su[5954]: pam_unix(su:session): session closed for user volumio Dec 23 14:46:47 napule systemd[1]: session-c1.scope: Deactivated successfully. Dec 23 14:46:47 napule systemd[1]: session-c1.scope: Consumed 1min 18.742s CPU time. Dec 23 14:46:49 napule volumio[1284]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 23 14:46:49 napule volumio[1284]: info: Dec 23 14:46:49 napule volumio[1284]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 14:46:50 napule volumio[1284]: TypeError: Cannot read properties of null (reading 'broadcastMessage') Dec 23 14:46:50 napule volumio[1284]: at /volumio/app/index.js:1534:32 Dec 23 14:46:50 napule volumio[1284]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Dec 23 14:46:50 napule volumio[1284]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Dec 23 14:46:50 napule volumio[1284]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Dec 23 14:46:50 napule volumio[1284]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Dec 23 14:46:50 napule volumio[1284]: at Tail. (/volumio/app/pluginmanager.js:860:24) Dec 23 14:46:50 napule volumio[1284]: at Tail.emit (node:events:514:28) Dec 23 14:46:50 napule volumio[1284]: at ReadStream. (/volumio/node_modules/tail/lib/tail.js:51:33) Dec 23 14:46:50 napule volumio[1284]: at ReadStream.emit (node:events:514:28) Dec 23 14:46:50 napule volumio[1284]: at addChunk (node:internal/streams/readable:343:12) Dec 23 14:46:50 napule volumio[1284]: at readableAddChunk (node:internal/streams/readable:312:11) Dec 23 14:46:50 napule volumio[1284]: at Readable.push (node:internal/streams/readable:253:10) Dec 23 14:46:50 napule volumio[1284]: at node:internal/fs/streams:275:14 Dec 23 14:46:50 napule volumio[1284]: at FSReqCallback.wrapper [as oncomplete] (node:fs:701:5) Dec 23 14:46:50 napule volumio[1284]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 14:46:58 napule sudo[5951]: pam_unix(sudo:session): session closed for user root Dec 23 14:46:59 napule systemd[1]: Stopping user@1000.service - User Manager for UID 1000... Dec 23 14:47:00 napule volumio-remote-updater[731]: [2025-12-23 13:47:00] [connect] Successful connection Dec 23 14:47:01 napule systemd[5956]: Activating special unit exit.target... Dec 23 14:47:01 napule systemd[5956]: Stopped target default.target - Main User Target. Dec 23 14:47:01 napule systemd[5956]: Stopped target basic.target - Basic System. Dec 23 14:47:01 napule systemd[5956]: Stopped target paths.target - Paths. Dec 23 14:47:01 napule systemd[5956]: Stopped target sockets.target - Sockets. Dec 23 14:47:01 napule systemd[5956]: Stopped target timers.target - Timers. Dec 23 14:47:01 napule systemd[5956]: Closed dirmngr.socket - GnuPG network certificate management daemon. Dec 23 14:47:01 napule systemd[5956]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Dec 23 14:47:01 napule systemd[5956]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Dec 23 14:47:01 napule systemd[5956]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Dec 23 14:47:01 napule systemd[5956]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Dec 23 14:47:01 napule systemd[5956]: Removed slice app.slice - User Application Slice. Dec 23 14:47:01 napule systemd[5956]: Reached target shutdown.target - Shutdown. Dec 23 14:47:01 napule systemd[5956]: Finished systemd-exit.service - Exit the Session. Dec 23 14:47:01 napule systemd[5956]: Reached target exit.target - Exit the Session. Dec 23 14:47:01 napule systemd[1]: user@1000.service: Deactivated successfully. Dec 23 14:47:01 napule systemd[1]: Stopped user@1000.service - User Manager for UID 1000. Dec 23 14:47:01 napule systemd[1]: user@1000.service: Consumed 1.468s CPU time. Dec 23 14:47:01 napule systemd[1]: Stopping user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Dec 23 14:47:02 napule systemd[1]: run-user-1000.mount: Deactivated successfully. Dec 23 14:47:02 napule systemd[1]: user-runtime-dir@1000.service: Deactivated successfully. Dec 23 14:47:02 napule systemd[1]: Stopped user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Dec 23 14:47:02 napule systemd[1]: Removed slice user-1000.slice - User Slice of UID 1000. Dec 23 14:47:02 napule systemd[1]: user-1000.slice: Consumed 1min 20.324s CPU time. Dec 23 14:47:03 napule sudo[6751]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-23 14:46' Dec 23 14:47:03 napule sudo[6751]: 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"