Jun 21 13:34:02 volumiopi4 sshd[2834]: Accepted password for volumio from 192.168.0.185 port 49350 ssh2 Jun 21 13:34:02 volumiopi4 sshd[2834]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Jun 21 13:34:04 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 21 13:34:05 volumiopi4 volumio[1212]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 21 13:34:22 volumiopi4 volumio[1212]: info: Received Get System Version Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 21 13:34:22 volumiopi4 volumio[1212]: info: Received Get System Info Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 21 13:34:22 volumiopi4 volumio[1212]: info: Discovery: Getting this device information Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CoreCommandRouter::volumioGetState Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CorePlayQueue::getTrack 0 Jun 21 13:34:22 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 21 13:34:24 volumiopi4 volumio[1212]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Jun 21 13:34:24 volumiopi4 volumio[1212]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:95:19) Jun 21 13:34:24 volumiopi4 volumio[1212]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:116:37) Jun 21 13:34:24 volumiopi4 volumio[1212]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:51:13 Jun 21 13:34:24 volumiopi4 volumio[1212]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jun 21 13:34:24 volumiopi4 volumio[1212]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13) Jun 21 13:34:24 volumiopi4 volumio[1212]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3) Jun 21 13:34:24 volumiopi4 volumio[1212]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jun 21 13:34:24 volumiopi4 volumio[1212]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Jun 21 13:34:24 volumiopi4 volumio[1212]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Jun 21 13:34:24 volumiopi4 volumio[1212]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Jun 21 13:34:24 volumiopi4 volumio[1212]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Jun 21 13:34:24 volumiopi4 volumio[1212]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3) Jun 21 13:34:24 volumiopi4 volumio[1212]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10) Jun 21 13:34:24 volumiopi4 volumio[1212]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3) Jun 21 13:34:24 volumiopi4 volumio[1212]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12) Jun 21 13:34:24 volumiopi4 volumio[1212]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jun 21 13:34:35 volumiopi4 systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 21 13:34:35 volumiopi4 systemd-logind[676]: New session 1 of user volumio. Jun 21 13:34:35 volumiopi4 systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Jun 21 13:34:35 volumiopi4 systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Jun 21 13:34:35 volumiopi4 volumio[1212]: info: CoreCommandRouter::volumioGetState Jun 21 13:34:35 volumiopi4 volumio[1212]: info: CorePlayQueue::getTrack 0 Jun 21 13:34:37 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 21 13:34:37 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 21 13:34:38 volumiopi4 systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Jun 21 13:34:38 volumiopi4 systemd[1]: Starting user@1000.service - User Manager for UID 1000... Jun 21 13:34:55 volumiopi4 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 21 13:34:55 volumiopi4 dbus-daemon[668]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.48' (uid=0 pid=3269 comm="timedatectl show --property=NTPSynchronized --valu") Jun 21 13:34:58 volumiopi4 sudo[3229]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sed -i s/localhost:4004/localhost:3000/g /opt/volumiokiosk.sh Jun 21 13:34:58 volumiopi4 sudo[3229]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:34:58 volumiopi4 sudo[3229]: pam_unix(sudo:session): session closed for user root Jun 21 13:34:58 volumiopi4 systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 21 13:34:58 volumiopi4 volumio[1212]: [sudo] password for volumio: info: [now-playing] Executing /usr/bin/sudo /bin/systemctl status volumio-kiosk Jun 21 13:34:58 volumiopi4 sudo[3275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status volumio-kiosk Jun 21 13:34:58 volumiopi4 sudo[3275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:34:58 volumiopi4 sudo[3283]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jun 21 13:34:58 volumiopi4 sudo[3285]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Jun 21 13:34:58 volumiopi4 sudo[3283]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:34:58 volumiopi4 sudo[3285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:34:58 volumiopi4 volumio[1212]: info: CoreCommandRouter::volumioGetState Jun 21 13:34:58 volumiopi4 sudo[3275]: pam_unix(sudo:session): session closed for user root Jun 21 13:34:58 volumiopi4 volumio[1212]: info: CorePlayQueue::getTrack 0 Jun 21 13:34:58 volumiopi4 sudo[3287]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Jun 21 13:34:58 volumiopi4 sudo[3287]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:34:58 volumiopi4 sudo[3283]: pam_unix(sudo:session): session closed for user root Jun 21 13:34:58 volumiopi4 sudo[3291]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Jun 21 13:34:58 volumiopi4 sudo[3291]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:34:58 volumiopi4 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jun 21 13:34:58 volumiopi4 volumio[1212]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jun 21 13:34:58 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jun 21 13:34:58 volumiopi4 volumio[1212]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jun 21 13:34:58 volumiopi4 volumio[1212]: info: [now-playing] Executing /usr/bin/sudo /bin/systemctl restart volumio-kiosk Jun 21 13:34:58 volumiopi4 sudo[3296]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk Jun 21 13:34:58 volumiopi4 sudo[3296]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:34:58 volumiopi4 systemd[1]: Started getty@tty1.service - Getty on tty1. Jun 21 13:34:58 volumiopi4 sudo[3285]: pam_unix(sudo:session): session closed for user root Jun 21 13:34:58 volumiopi4 volumio[1212]: info: touch_display: Rotation settings written to /etc/X11/xorg.conf.d/95-touch_display-plugin.conf. Jun 21 13:34:58 volumiopi4 dbus-daemon[668]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 21 13:34:58 volumiopi4 setdatetime-helper.sh[3266]: Time is not synchronized. Attempting to sync... Jun 21 13:35:03 volumiopi4 sudo[3306]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Sat, 21 Jun 2025 11:34:58 GMT#015' Jun 21 13:35:03 volumiopi4 sudo[3306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 13:34:58 volumiopi4 setdatetime-helper.sh[3329]: Sat Jun 21 13:34:58 SAST 2025 Jun 21 13:34:58 volumiopi4 sudo[3306]: pam_unix(sudo:session): session closed for user root Jun 21 13:34:58 volumiopi4 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 21 13:34:58 volumiopi4 setdatetime-helper.sh[3266]: Time synchronized successfully. Jun 21 13:34:58 volumiopi4 systemd-journald[340]: Time jumped backwards, rotating. Jun 21 13:34:58 volumiopi4 (systemd)[3225]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Jun 21 13:34:58 volumiopi4 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 21 13:34:58 volumiopi4 systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 21 13:34:58 volumiopi4 systemd[1]: Reloading. Jun 21 13:35:01 volumiopi4 sshd[3313]: Accepted password for volumio from 192.168.0.185 port 49748 ssh2 Jun 21 13:35:01 volumiopi4 sshd[3313]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Jun 21 13:35:07 volumiopi4 volumio[1212]: info: touch_display: systemctl start getty@tty1.service succeeded. Jun 21 13:35:08 volumiopi4 sudo[3287]: pam_unix(sudo:session): session closed for user root Jun 21 13:35:08 volumiopi4 volumio[1212]: info: touch_display: systemctl enable getty@tty1.service succeeded. Jun 21 13:35:08 volumiopi4 systemd[1]: Reloading. Jun 21 13:35:08 volumiopi4 sudo[3291]: pam_unix(sudo:session): session closed for user root Jun 21 13:35:08 volumiopi4 volumio[1212]: error: touch_display: Failed to stop volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl stop volumio-kiosk.service Jun 21 13:35:08 volumiopi4 volumio[1212]: Job for volumio-kiosk.service canceled. Jun 21 13:35:08 volumiopi4 volumio[1212]: info: Disabling plugin touch_display Jun 21 13:35:08 volumiopi4 volumio[1212]: info: Done. Jun 21 13:35:09 volumiopi4 startx[1604]: xinit: connection to X server lost Jun 21 13:35:09 volumiopi4 systemd[1]: Stopping volumio-kiosk.service - Volumio Kiosk... Jun 21 13:35:09 volumiopi4 ntpd[975]: CLOCK: time stepped by 0.427109 Jun 21 13:35:09 volumiopi4 ntpd[975]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Jun 21 13:35:09 volumiopi4 startx[1604]: Jun 21 13:35:09 volumiopi4 systemd-logind[676]: New session 3 of user volumio. Jun 21 13:35:09 volumiopi4 systemd[1]: Reloading. Jun 21 13:35:10 volumiopi4 startx[1604]: waiting for X server to shut down Jun 21 13:35:10 volumiopi4 startx[1606]: (II) Server terminated successfully (0). Closing log file. Jun 21 13:35:15 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 21 13:35:15 volumiopi4 volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 21 13:35:18 volumiopi4 volumio[1212]: info: Enabling plugin now_playing Jun 21 13:35:18 volumiopi4 volumio[1212]: info: Loading plugin "now_playing"... Jun 21 13:35:18 volumiopi4 volumio[1212]: info: PLUGIN START: now_playing Jun 21 13:35:18 volumiopi4 volumio[1212]: info: [now-playing] ConfigUpdater: config is up to date. Jun 21 13:35:18 volumiopi4 volumio[1212]: info: [now-playing] App is listening on port 4004. Jun 21 13:35:20 volumiopi4 startx[1604]: .......... Jun 21 13:35:20 volumiopi4 startx[1604]: xinit: X server slow to shut down, sending KILL signal Jun 21 13:35:20 volumiopi4 startx[1604]: Jun 21 13:35:21 volumiopi4 volumio[1212]: info: [now-playing] Backing up /opt/volumiokiosk.sh to /home/volumio/.now_playing/volumiokiosk.sh.bak Jun 21 13:35:21 volumiopi4 sudo[3442]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sed -i s/localhost:3000/localhost:4004/g /opt/volumiokiosk.sh Jun 21 13:35:21 volumiopi4 sudo[3442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:35:21 volumiopi4 sudo[3442]: pam_unix(sudo:session): session closed for user root Jun 21 13:35:21 volumiopi4 volumio[1212]: info: [now-playing] Executing /usr/bin/sudo /bin/systemctl status volumio-kiosk Jun 21 13:35:21 volumiopi4 sudo[3456]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status volumio-kiosk Jun 21 13:35:21 volumiopi4 sudo[3456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 13:35:22 volumiopi4 systemd[1]: Reloading. Jun 21 13:35:22 volumiopi4 sudo[3456]: pam_unix(sudo:session): session closed for user root Jun 21 13:35:22 volumiopi4 volumio[1212]: error: [now-playing] Failed to execute systemctl command status on volumio-kiosk: Error: Command failed: /usr/bin/sudo /bin/systemctl status volumio-kiosk Jun 21 13:35:22 volumiopi4 volumio[1212]: at ChildProcess.exithandler (node:child_process:421:12) Jun 21 13:35:22 volumiopi4 volumio[1212]: at ChildProcess.emit (node:events:514:28) Jun 21 13:35:22 volumiopi4 volumio[1212]: at maybeClose (node:internal/child_process:1105:16) Jun 21 13:35:22 volumiopi4 volumio[1212]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Jun 21 13:35:22 volumiopi4 volumio[1212]: info: Error: Error: Command failed: /usr/bin/sudo /bin/systemctl status volumio-kiosk Jun 21 13:35:22 volumiopi4 systemd[3225]: Queued start job for default target default.target. Jun 21 13:35:22 volumiopi4 systemd[3225]: Created slice app.slice - User Application Slice. Jun 21 13:35:22 volumiopi4 systemd[3225]: Reached target paths.target - Paths. Jun 21 13:35:22 volumiopi4 systemd[3225]: Reached target timers.target - Timers. Jun 21 13:35:22 volumiopi4 systemd[3225]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 21 13:35:22 volumiopi4 systemd[3225]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Jun 21 13:35:22 volumiopi4 systemd[3225]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Jun 21 13:35:22 volumiopi4 systemd[3225]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Jun 21 13:35:22 volumiopi4 systemd[3225]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Jun 21 13:35:22 volumiopi4 systemd[3225]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Jun 21 13:35:22 volumiopi4 systemd[3225]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 21 13:35:22 volumiopi4 systemd[3225]: Reached target sockets.target - Sockets. Jun 21 13:35:22 volumiopi4 systemd[3225]: Reached target basic.target - Basic System. Jun 21 13:35:22 volumiopi4 systemd[3225]: Reached target default.target - Main User Target. Jun 21 13:35:22 volumiopi4 systemd[3225]: Startup finished in 14.347s. Jun 21 13:35:23 volumiopi4 volumio[1212]: info: CoreCommandRouter::volumioGetState Jun 21 13:35:23 volumiopi4 volumio[1212]: info: CorePlayQueue::getTrack 0 Jun 21 13:35:23 volumiopi4 sudo[2793]: pam_unix(sudo:session): session closed for user root Jun 21 13:35:23 volumiopi4 systemd[1]: Started user@1000.service - User Manager for UID 1000. Jun 21 13:35:23 volumiopi4 systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 21 13:35:23 volumiopi4 volumio[1212]: info: enable SSH service success Jun 21 13:35:23 volumiopi4 systemd[1]: Started session-1.scope - Session 1 of User volumio. Jun 21 13:35:23 volumiopi4 systemd[1]: Started session-3.scope - Session 3 of User volumio. Jun 21 13:35:23 volumiopi4 sshd[2834]: pam_env(sshd:session): deprecated reading of user environment enabled Jun 21 13:35:23 volumiopi4 sshd[3313]: pam_env(sshd:session): deprecated reading of user environment enabled Jun 21 13:35:23 volumiopi4 sshd[2834]: pam_unix(sshd:session): session closed for user volumio Jun 21 13:35:23 volumiopi4 systemd[1]: session-1.scope: Deactivated successfully. Jun 21 13:35:23 volumiopi4 systemd-logind[676]: Session 1 logged out. Waiting for processes to exit. Jun 21 13:35:23 volumiopi4 systemd-logind[676]: Removed session 1. Jun 21 13:35:23 volumiopi4 startx[1604]: waiting for server to die .. Jun 21 13:35:23 volumiopi4 startx[1604]: xinit: unexpected signal 15 Jun 21 13:35:23 volumiopi4 systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:35:23 volumiopi4 systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Jun 21 13:35:23 volumiopi4 systemd[1]: Stopped volumio-kiosk.service - Volumio Kiosk. Jun 21 13:35:23 volumiopi4 systemd[1]: volumio-kiosk.service: Consumed 28.296s CPU time. Jun 21 13:35:23 volumiopi4 systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Jun 21 13:35:23 volumiopi4 sudo[3296]: pam_unix(sudo:session): session closed for user root Jun 21 13:35:23 volumiopi4 volumio[1212]: warn: [now-playing] MyBackgroundMonitor stopped Jun 21 13:35:23 volumiopi4 volumio[1212]: info: Disabling plugin now_playing Jun 21 13:35:23 volumiopi4 volumio[1212]: info: Done. Jun 21 13:35:24 volumiopi4 startx[3546]: X.Org X Server 1.21.1.7 Jun 21 13:35:24 volumiopi4 startx[3546]: X Protocol Version 11, Revision 0 Jun 21 13:35:24 volumiopi4 startx[3546]: Current Operating System: Linux volumiopi4 6.12.27-v7l+ #1876 SMP Tue May 6 15:10:05 BST 2025 armv7l Jun 21 13:35:24 volumiopi4 startx[3546]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 numa=fake=1 system_heap.max_order=0 smsc95xx.macaddr=E4:5F:01:CF:18:B1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=0ca921d0-ed29-48f1-bc74-550f2ad8e370 imgfile=/volumio_current.sqsh bootpart=UUID=E54B-2C41 datapart=UUID=9cfbeebe-d04d-4377-b93c-47b70d48adf5 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Jun 21 13:35:24 volumiopi4 startx[3546]: xorg-server 2:21.1.7-3+rpt3+deb12u9 (https://www.debian.org/support) Jun 21 13:35:24 volumiopi4 startx[3546]: Current version of pixman: 0.44.0 Jun 21 13:35:24 volumiopi4 startx[3546]: Before reporting problems, check http://wiki.x.org Jun 21 13:35:24 volumiopi4 startx[3546]: to make sure that you have the latest version. Jun 21 13:35:24 volumiopi4 startx[3546]: Markers: (--) probed, (**) from config file, (==) default setting, Jun 21 13:35:24 volumiopi4 startx[3546]: (++) from command line, (!!) notice, (II) informational, Jun 21 13:35:24 volumiopi4 startx[3546]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jun 21 13:35:24 volumiopi4 startx[3546]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Jun 21 13:35:23 2025 Jun 21 13:35:24 volumiopi4 startx[3546]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jun 21 13:35:24 volumiopi4 startx[3546]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jun 21 13:35:28 volumiopi4 volumio[1212]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 13:35:28 volumiopi4 volumio[1212]: TypeError: Cannot read properties of null (reading 'logger') Jun 21 13:35:28 volumiopi4 volumio[1212]: at NowPlayingContext.getLogger (/data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js:72:83) Jun 21 13:35:28 volumiopi4 volumio[1212]: at stdLogError (/data/plugins/user_interface/now_playing/dist/app/Router.js:34:33) Jun 21 13:35:28 volumiopi4 volumio[1212]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:37:46 Jun 21 13:35:28 volumiopi4 volumio[1212]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 21 13:35:28 volumiopi4 volumio[1212]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 13:35:29 volumiopi4 sudo[3766]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-21 13:34' Jun 21 13:35:29 volumiopi4 sudo[3766]: 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="ecd46641d85b721d58d1c7edd71dd0a358c8514c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jun 7 04:21:21 UTC 2025" VOLUMIO_VERSION="4.011" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="97f38114d6fd5ff4ce2816f49b632994"