-- Logs begin at Wed 2024-07-24 19:15:52 CDT, end at Wed 2024-07-24 20:33:05 CDT. -- Jul 24 20:32:07 volumio volumio[5662]: info: Selecting previously unselected package chromium-browser-l10n. Jul 24 20:32:07 volumio volumio[5662]: info: Preparing to unpack .../05-chromium-browser-l10n_92.0.4515.98~buster-rpt2_all.deb ... Jul 24 20:32:07 volumio volumio[5662]: info: Unpacking chromium-browser-l10n (92.0.4515.98~buster-rpt2) ... Jul 24 20:32:08 volumio volumio[5662]: info: Selecting previously unselected package libipc-system-simple-perl. Jul 24 20:32:08 volumio volumio[5662]: info: Preparing to unpack .../06-libipc-system-simple-perl_1.25-4_all.deb ... Jul 24 20:32:08 volumio volumio[5662]: info: Unpacking libipc-system-simple-perl (1.25-4) ... Jul 24 20:32:08 volumio volumio[5662]: info: Selecting previously unselected package libfile-basedir-perl. Jul 24 20:32:08 volumio volumio[5662]: info: Preparing to unpack .../07-libfile-basedir-perl_0.08-1_all.deb ... Jul 24 20:32:08 volumio volumio[5662]: info: Unpacking libfile-basedir-perl (0.08-1) ... Jul 24 20:32:08 volumio volumio[5662]: info: Selecting previously unselected package libfile-desktopentry-perl. Jul 24 20:32:08 volumio volumio[5662]: info: Preparing to unpack .../08-libfile-desktopentry-perl_0.22-1_all.deb ... Jul 24 20:32:08 volumio volumio[5662]: info: Unpacking libfile-desktopentry-perl (0.22-1) ... Jul 24 20:32:08 volumio volumio[5662]: info: Selecting previously unselected package libfile-mimeinfo-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../09-libfile-mimeinfo-perl_0.29-1_all.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libfile-mimeinfo-perl (0.29-1) ... Jul 24 20:32:09 volumio volumio[5662]: info: Selecting previously unselected package libio-stringy-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../10-libio-stringy-perl_2.111-3_all.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libio-stringy-perl (2.111-3) ... Jul 24 20:32:09 volumio volumio[5662]: info: Selecting previously unselected package libxml-parser-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../11-libxml-parser-perl_2.44-4_armhf.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libxml-parser-perl (2.44-4) ... Jul 24 20:32:09 volumio volumio[5662]: info: Selecting previously unselected package libxml-twig-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../12-libxml-twig-perl_1%3a3.50-1.1_all.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libxml-twig-perl (1:3.50-1.1) ... Jul 24 20:32:09 volumio volumio[5662]: info: Selecting previously unselected package libnet-dbus-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../13-libnet-dbus-perl_1.1.0-5+b1_armhf.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libnet-dbus-perl (1.1.0-5+b1) ... Jul 24 20:32:09 volumio volumio[5662]: info: Selecting previously unselected package libtie-ixhash-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../14-libtie-ixhash-perl_1.23-2_all.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libtie-ixhash-perl (1.23-2) ... Jul 24 20:32:09 volumio volumio[5662]: info: Selecting previously unselected package libx11-protocol-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../15-libx11-protocol-perl_0.56-7_all.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libx11-protocol-perl (0.56-7) ... Jul 24 20:32:09 volumio volumio[5662]: info: Selecting previously unselected package libxml-xpathengine-perl. Jul 24 20:32:09 volumio volumio[5662]: info: Preparing to unpack .../16-libxml-xpathengine-perl_0.14-1_all.deb ... Jul 24 20:32:09 volumio volumio[5662]: info: Unpacking libxml-xpathengine-perl (0.14-1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libxml-parser-perl (2.44-4) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libtie-ixhash-perl (1.23-2) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up chromium-codecs-ffmpeg-extra (92.0.4515.98~buster-rpt2) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libio-stringy-perl (2.111-3) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libxml-twig-perl (1:3.50-1.1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libnet-dbus-perl (1.1.0-5+b1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libnspr4:armhf (2:4.20-1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libipc-system-simple-perl (1.25-4) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libxml-xpathengine-perl (0.14-1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up xdg-utils (1.1.3-1+rpt1+deb10u1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libx11-protocol-perl (0.56-7) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libfile-basedir-perl (0.08-1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libnss3:armhf (2:3.42.1-1+deb10u8) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libfile-desktopentry-perl (0.22-1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up chromium-browser (92.0.4515.98~buster-rpt2) ... Jul 24 20:32:10 volumio volumio[5662]: info: update-alternatives: using /usr/bin/chromium-browser to provide /usr/bin/x-www-browser (x-www-browser) in auto mode Jul 24 20:32:10 volumio volumio[5662]: info: update-alternatives: using /usr/bin/chromium-browser to provide /usr/bin/gnome-www-browser (gnome-www-browser) in auto mode Jul 24 20:32:10 volumio volumio[5662]: info: Setting up chromium-browser-l10n (92.0.4515.98~buster-rpt2) ... Jul 24 20:32:10 volumio volumio[5662]: info: Setting up libfile-mimeinfo-perl (0.29-1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Processing triggers for hicolor-icon-theme (0.17-2) ... Jul 24 20:32:10 volumio volumio[5662]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Jul 24 20:32:10 volumio volumio[5662]: info: Processing triggers for man-db (2.8.5-2+deb10u1) ... Jul 24 20:32:10 volumio volumio[5662]: info: Processing triggers for mime-support (3.62) ... Jul 24 20:32:10 volumio volumio[5662]: info: Installing japanese, korean, chinese and taiwanese fonts Jul 24 20:32:10 volumio volumio[5662]: info: Reading package lists... Jul 24 20:32:11 volumio volumio[5662]: info: Building dependency tree... Jul 24 20:32:11 volumio volumio[5662]: info: Reading state information... Jul 24 20:32:11 volumio volumio[5662]: info: The following NEW packages will be installed: Jul 24 20:32:11 volumio volumio[5662]: info: fonts-arphic-gbsn00lp fonts-arphic-ukai fonts-unfonts-core Jul 24 20:32:12 volumio volumio[5662]: info: 0 upgraded, 3 newly installed, 0 to remove and 7 not upgraded. Jul 24 20:32:12 volumio volumio[5662]: info: Need to get 24.9 MB of archives. Jul 24 20:32:12 volumio volumio[5662]: info: After this operation, 57.2 MB of additional disk space will be used. Jul 24 20:32:12 volumio volumio[5662]: info: Get:1 http://raspbian.mirrors.lucidnetworks.net/raspbian buster/main armhf fonts-arphic-gbsn00lp all 2.11-15 [1723 kB] Jul 24 20:32:12 volumio volumio[5662]: info: Get:2 http://raspbian.mirrors.lucidnetworks.net/raspbian buster/main armhf fonts-unfonts-core all 1:1.0.2-080608-16 [14.9 MB] Jul 24 20:32:20 volumio volumio[5662]: info: Get:3 http://raspbian.mirrors.lucidnetworks.net/raspbian buster/main armhf fonts-arphic-ukai all 0.2.20080216.2-4 [8287 kB] Jul 24 20:32:22 volumio volumio[5662]: info: Fetched 24.9 MB in 11s (2271 kB/s) Jul 24 20:32:22 volumio volumio[5662]: info: Selecting previously unselected package fonts-arphic-gbsn00lp. Jul 24 20:32:23 volumio volumio[5662]: [620B blob data] Jul 24 20:32:23 volumio volumio[5662]: info: Preparing to unpack .../fonts-arphic-gbsn00lp_2.11-15_all.deb ... Jul 24 20:32:23 volumio volumio[5662]: info: Unpacking fonts-arphic-gbsn00lp (2.11-15) ... Jul 24 20:32:23 volumio volumio[5662]: info: Selecting previously unselected package fonts-unfonts-core. Jul 24 20:32:23 volumio volumio[5662]: info: Preparing to unpack .../fonts-unfonts-core_1%3a1.0.2-080608-16_all.deb ... Jul 24 20:32:23 volumio volumio[5662]: info: Unpacking fonts-unfonts-core (1:1.0.2-080608-16) ... Jul 24 20:32:24 volumio volumio[5662]: info: Selecting previously unselected package fonts-arphic-ukai. Jul 24 20:32:24 volumio volumio[5662]: info: Preparing to unpack .../fonts-arphic-ukai_0.2.20080216.2-4_all.deb ... Jul 24 20:32:24 volumio volumio[5662]: info: Unpacking fonts-arphic-ukai (0.2.20080216.2-4) ... Jul 24 20:32:25 volumio volumio[5662]: info: Setting up fonts-unfonts-core (1:1.0.2-080608-16) ... Jul 24 20:32:25 volumio volumio[5662]: info: Setting up fonts-arphic-gbsn00lp (2.11-15) ... Jul 24 20:32:25 volumio volumio[5662]: info: Setting up fonts-arphic-ukai (0.2.20080216.2-4) ... Jul 24 20:32:25 volumio volumio[5662]: info: Processing triggers for fontconfig (2.13.1-2) ... Jul 24 20:32:25 volumio volumio[5662]: info: Creating Kiosk data dir Jul 24 20:32:25 volumio volumio[5662]: info: Creating Volumio kiosk start script Jul 24 20:32:25 volumio systemd[1]: Reloading. Jul 24 20:32:25 volumio volumio[5662]: info: Creating Systemd Unit for Kiosk Jul 24 20:32:25 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 24 20:32:26 volumio volumio[5662]: info: Disabling login prompt Jul 24 20:32:26 volumio systemd[1]: Reloading. Jul 24 20:32:26 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 24 20:32:26 volumio volumio[5662]: info: Allowing volumio to start an xsession Jul 24 20:32:26 volumio volumio[5662]: info: Removing temporary directory /tmp/touch_display-SF7fd2tx8D Jul 24 20:32:26 volumio sudo[5990]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:26 volumio volumio[5662]: info: Install script completed Jul 24 20:32:26 volumio volumio[5662]: info: Adding reference to registry Jul 24 20:32:26 volumio volumio[5662]: info: Done installing plugin. Jul 24 20:32:26 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 24 20:32:26 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 24 20:32:26 volumio volumio[5662]: info: Folder /tmp/plugins removed Jul 24 20:32:26 volumio volumio[5662]: info: Folder /tmp/downloaded_plugin.zip removed Jul 24 20:32:26 volumio volumio[5662]: Plugin install end detected on script Jul 24 20:32:26 volumio volumio[5662]: info: Folder /data/temp removed Jul 24 20:32:30 volumio volumio[5662]: info: Enabling plugin touch_display Jul 24 20:32:30 volumio volumio[5662]: info: Loading plugin "touch_display"... Jul 24 20:32:30 volumio volumio[5662]: info: PLUGIN START: touch_display Jul 24 20:32:30 volumio volumio[5662]: info: Loading i18n strings for locale en Jul 24 20:32:30 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 24 20:32:30 volumio sudo[9296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jul 24 20:32:30 volumio sudo[9296]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 24 20:32:30 volumio systemd[1]: Stopping Getty on tty1... Jul 24 20:32:30 volumio sudo[9299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jul 24 20:32:30 volumio sudo[9299]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 24 20:32:30 volumio systemd[1]: getty@tty1.service: Main process exited, code=killed, status=15/TERM Jul 24 20:32:30 volumio systemd[1]: getty@tty1.service: Succeeded. Jul 24 20:32:30 volumio systemd[1]: Stopped Getty on tty1. Jul 24 20:32:30 volumio volumio[5662]: info: touch_display: No backlight interface detected. Jul 24 20:32:30 volumio sudo[9302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 24 20:32:30 volumio sudo[9296]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:30 volumio sudo[9302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 24 20:32:30 volumio systemd[1]: Reloading. Jul 24 20:32:30 volumio volumio[5662]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 24 20:32:30 volumio volumio[5662]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jul 24 20:32:30 volumio volumio[5662]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jul 24 20:32:30 volumio sudo[9305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jul 24 20:32:30 volumio sudo[9305]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 24 20:32:30 volumio sudo[9305]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:30 volumio volumio[5662]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jul 24 20:32:30 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 24 20:32:30 volumio sudo[9299]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:30 volumio volumio[5662]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jul 24 20:32:30 volumio systemd[1]: Reloading. Jul 24 20:32:30 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 24 20:32:30 volumio sudo[9302]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:30 volumio volumio[5662]: info: touch_display: systemctl daemon-reload succeeded. Jul 24 20:32:31 volumio sudo[9334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jul 24 20:32:31 volumio sudo[9334]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 24 20:32:31 volumio systemd[1]: Started Volumio Kiosk. Jul 24 20:32:31 volumio sudo[9334]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:31 volumio volumio[5662]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jul 24 20:32:31 volumio volumio[5662]: info: touch_display: Volumio Kiosk started. Jul 24 20:32:31 volumio startx[9336]: xauth: file /home/volumio/.Xauthority does not exist Jul 24 20:32:31 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:31 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:31 volumio volumio[5662]: info: Done. Jul 24 20:32:31 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:31 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:31 volumio volumio[5662]: info: touch_display: X display number found: 0 Jul 24 20:32:31 volumio startx[9336]: X.Org X Server 1.20.4 Jul 24 20:32:31 volumio startx[9336]: X Protocol Version 11, Revision 0 Jul 24 20:32:31 volumio startx[9336]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Jul 24 20:32:31 volumio startx[9336]: Current Operating System: Linux volumio 6.1.77-v8+ #1730 SMP PREEMPT Thu Feb 8 15:26:11 GMT 2024 aarch64 Jul 24 20:32:31 volumio startx[9336]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 smsc95xx.macaddr=2C:CF:67:13:2C:5F vc_mem.mem_base=0x3fc00000 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=ttyAMA10,115200 console=tty1 imgpart=UUID=098c7cfd-ae46-4140-9835-8a735748183d imgfile=/volumio_current.sqsh bootpart=UUID=72A5-3958 datapart=UUID=b665132a-a25e-4e12-be06-e01e80487e73 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 Jul 24 20:32:31 volumio startx[9336]: Build Date: 04 April 2023 07:50:56AM Jul 24 20:32:31 volumio startx[9336]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Jul 24 20:32:31 volumio startx[9336]: Current version of pixman: 0.36.0 Jul 24 20:32:31 volumio startx[9336]: Before reporting problems, check http://wiki.x.org Jul 24 20:32:31 volumio startx[9336]: to make sure that you have the latest version. Jul 24 20:32:31 volumio startx[9336]: Markers: (--) probed, (**) from config file, (==) default setting, Jul 24 20:32:31 volumio startx[9336]: (++) from command line, (!!) notice, (II) informational, Jul 24 20:32:31 volumio startx[9336]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jul 24 20:32:31 volumio startx[9336]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed Jul 24 20:32:31 2024 Jul 24 20:32:31 volumio startx[9336]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jul 24 20:32:31 volumio startx[9336]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jul 24 20:32:31 volumio volumio[5662]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 24 20:32:31 volumio volumio[5662]: info: touch_display: X display number found: 0 Jul 24 20:32:31 volumio startx[9336]: V3D 7.1 not supported by this version of Mesa. Jul 24 20:32:31 volumio kernel: broken atomic modeset userspace detected, disabling atomic Jul 24 20:32:31 volumio startx[9336]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Jul 24 20:32:32 volumio sudo[9394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jul 24 20:32:32 volumio sudo[9394]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 24 20:32:32 volumio sudo[9394]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:32 volumio volumio[5662]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jul 24 20:32:32 volumio volumio[5662]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 24 20:32:32 volumio volumio[5662]: info: touch_display: Rotation settings written to /etc/X11/xorg.conf.d/95-touch_display-plugin.conf. Jul 24 20:32:32 volumio sudo[9409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service Jul 24 20:32:32 volumio sudo[9409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 24 20:32:32 volumio startx[9336]: xinit: connection to X server lost Jul 24 20:32:32 volumio startx[9336]: [1B blob data] Jul 24 20:32:32 volumio systemd[1]: Stopping Volumio Kiosk... Jul 24 20:32:32 volumio startx[9336]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Jul 24 20:32:33 volumio startx[9336]: xinit: unexpected signal 15 Jul 24 20:32:33 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Jul 24 20:32:33 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Jul 24 20:32:33 volumio systemd[1]: Stopped Volumio Kiosk. Jul 24 20:32:33 volumio systemd[1]: Started Volumio Kiosk. Jul 24 20:32:33 volumio sudo[9409]: pam_unix(sudo:session): session closed for user root Jul 24 20:32:33 volumio volumio[5662]: info: touch_display: systemctl restart volumio-kiosk.service succeeded. Jul 24 20:32:33 volumio volumio[5662]: info: touch_display: Volumio Kiosk restarted. Jul 24 20:32:33 volumio volumio[5662]: info: touch_display: X display number found: Jul 24 20:32:33 volumio startx[9422]: X.Org X Server 1.20.4 Jul 24 20:32:33 volumio startx[9422]: X Protocol Version 11, Revision 0 Jul 24 20:32:33 volumio startx[9422]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Jul 24 20:32:33 volumio startx[9422]: Current Operating System: Linux volumio 6.1.77-v8+ #1730 SMP PREEMPT Thu Feb 8 15:26:11 GMT 2024 aarch64 Jul 24 20:32:33 volumio startx[9422]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 smsc95xx.macaddr=2C:CF:67:13:2C:5F vc_mem.mem_base=0x3fc00000 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=ttyAMA10,115200 console=tty1 imgpart=UUID=098c7cfd-ae46-4140-9835-8a735748183d imgfile=/volumio_current.sqsh bootpart=UUID=72A5-3958 datapart=UUID=b665132a-a25e-4e12-be06-e01e80487e73 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 Jul 24 20:32:33 volumio startx[9422]: Build Date: 04 April 2023 07:50:56AM Jul 24 20:32:33 volumio startx[9422]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Jul 24 20:32:33 volumio startx[9422]: Current version of pixman: 0.36.0 Jul 24 20:32:33 volumio startx[9422]: Before reporting problems, check http://wiki.x.org Jul 24 20:32:33 volumio startx[9422]: to make sure that you have the latest version. Jul 24 20:32:33 volumio startx[9422]: Markers: (--) probed, (**) from config file, (==) default setting, Jul 24 20:32:33 volumio startx[9422]: (++) from command line, (!!) notice, (II) informational, Jul 24 20:32:33 volumio startx[9422]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jul 24 20:32:33 volumio startx[9422]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed Jul 24 20:32:33 2024 Jul 24 20:32:33 volumio startx[9422]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jul 24 20:32:33 volumio startx[9422]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jul 24 20:32:33 volumio volumio[5662]: info: touch_display: X display number found: 0 Jul 24 20:32:33 volumio volumio[5662]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 24 20:32:33 volumio volumio[5662]: info: touch_display: X display number found: 0 Jul 24 20:32:33 volumio startx[9422]: V3D 7.1 not supported by this version of Mesa. Jul 24 20:32:33 volumio kernel: broken atomic modeset userspace detected, disabling atomic Jul 24 20:32:33 volumio startx[9422]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Jul 24 20:32:34 volumio volumio[5662]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 24 20:32:35 volumio volumio[5662]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetVisibleSources Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:36 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 24 20:32:36 volumio volumio[5662]: info: Received Get System Info Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 24 20:32:36 volumio volumio[5662]: info: Discovery: Getting this device information Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:36 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:36 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:36 volumio volumio[5662]: info: Listing playlists Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 24 20:32:36 volumio volumio[5662]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetVisibleSources Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:36 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 24 20:32:36 volumio volumio[5662]: info: Received Get System Info Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 24 20:32:36 volumio volumio[5662]: info: Discovery: Getting this device information Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:36 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:36 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:36 volumio volumio[5662]: info: Listing playlists Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 24 20:32:36 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 24 20:32:37 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:37 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:38 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 24 20:32:38 volumio volumio[5662]: info: Received Get System Info Jul 24 20:32:38 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 24 20:32:38 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 24 20:32:38 volumio volumio[5662]: info: Discovery: Getting this device information Jul 24 20:32:38 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:38 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:38 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 24 20:32:38 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 24 20:32:38 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 24 20:32:41 volumio volumio[5662]: error: error Jul 24 20:32:41 volumio volumio[5662]: error: error Jul 24 20:32:41 volumio volumio[5662]: info: Enabling plugin now_playing Jul 24 20:32:41 volumio volumio[5662]: info: Loading plugin "now_playing"... Jul 24 20:32:41 volumio volumio[5662]: error: !!!! WARNING !!!! Jul 24 20:32:41 volumio volumio[5662]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Jul 24 20:32:41 volumio volumio[5662]: Require stack: Jul 24 20:32:41 volumio volumio[5662]: - /data/plugins/user_interface/now_playing/dist/index.js Jul 24 20:32:41 volumio volumio[5662]: - /volumio/app/pluginmanager.js Jul 24 20:32:41 volumio volumio[5662]: - /volumio/app/index.js Jul 24 20:32:41 volumio volumio[5662]: - /volumio/index.js Jul 24 20:32:41 volumio volumio[5662]: error: Stack trace: Error: Cannot find module 'geo-tz' Jul 24 20:32:41 volumio volumio[5662]: Require stack: Jul 24 20:32:41 volumio volumio[5662]: - /data/plugins/user_interface/now_playing/dist/index.js Jul 24 20:32:41 volumio volumio[5662]: - /volumio/app/pluginmanager.js Jul 24 20:32:41 volumio volumio[5662]: - /volumio/app/index.js Jul 24 20:32:41 volumio volumio[5662]: - /volumio/index.js Jul 24 20:32:41 volumio volumio[5662]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) Jul 24 20:32:41 volumio volumio[5662]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Jul 24 20:32:41 volumio volumio[5662]: at Module.require (internal/modules/cjs/loader.js:952:19) Jul 24 20:32:41 volumio volumio[5662]: at require (internal/modules/cjs/helpers.js:88:18) Jul 24 20:32:41 volumio volumio[5662]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Jul 24 20:32:41 volumio volumio[5662]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Jul 24 20:32:41 volumio volumio[5662]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Jul 24 20:32:41 volumio volumio[5662]: at Module.load (internal/modules/cjs/loader.js:928:32) Jul 24 20:32:41 volumio volumio[5662]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Jul 24 20:32:41 volumio volumio[5662]: at Module.require (internal/modules/cjs/loader.js:952:19) Jul 24 20:32:41 volumio volumio[5662]: at require (internal/modules/cjs/helpers.js:88:18) Jul 24 20:32:41 volumio volumio[5662]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Jul 24 20:32:41 volumio volumio[5662]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jul 24 20:32:41 volumio volumio[5662]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 24 20:32:41 volumio volumio[5662]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 24 20:32:41 volumio volumio[5662]: error: !!!! WARNING !!!! Jul 24 20:32:41 volumio volumio[5662]: info: Done. Jul 24 20:32:41 volumio volumio[5662]: error: error Jul 24 20:32:41 volumio volumio[5662]: error: error Jul 24 20:32:41 volumio volumio[5662]: error: error Jul 24 20:32:41 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:42 volumio volumio[5662]: error: error Jul 24 20:32:44 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 24 20:32:44 volumio volumio[5662]: info: Received Get System Info Jul 24 20:32:44 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 24 20:32:44 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 24 20:32:44 volumio volumio[5662]: info: Discovery: Getting this device information Jul 24 20:32:44 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:44 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:44 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 24 20:32:46 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 24 20:32:48 volumio volumio[5662]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 24 20:32:52 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 24 20:32:52 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 24 20:32:55 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 24 20:32:55 volumio volumio[5662]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 24 20:32:55 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 24 20:32:55 volumio volumio[5662]: error: Failed callmethod call: TypeError: Cannot read property 'broadcastMessage' of null Jul 24 20:32:55 volumio volumio[5662]: info: Received Get System Version Jul 24 20:32:55 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 24 20:32:55 volumio volumio[5662]: info: Received Get System Info Jul 24 20:32:55 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 24 20:32:55 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 24 20:32:55 volumio volumio[5662]: info: Discovery: Getting this device information Jul 24 20:32:55 volumio volumio[5662]: info: CoreCommandRouter::volumioGetState Jul 24 20:32:55 volumio volumio[5662]: info: CorePlayQueue::getTrack 0 Jul 24 20:32:55 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 24 20:33:00 volumio volumio[5662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 24 20:33:05 volumio volumio[5662]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/now_playing/0.7.3/volumio/buster/armhf Jul 24 20:33:05 volumio volumio[5662]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 24 20:33:05 volumio volumio[5662]: TypeError: Cannot read property 'broadcastMessage' of null Jul 24 20:33:05 volumio volumio[5662]: at /volumio/app/index.js:1515:32 Jul 24 20:33:05 volumio volumio[5662]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jul 24 20:33:05 volumio volumio[5662]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jul 24 20:33:05 volumio volumio[5662]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1513:13) Jul 24 20:33:05 volumio volumio[5662]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Jul 24 20:33:05 volumio volumio[5662]: at PluginManager.installPlugin (/volumio/app/pluginmanager.js:776:8) Jul 24 20:33:05 volumio volumio[5662]: at CoreCommandRouter.installPlugin (/volumio/app/index.js:1434:22) Jul 24 20:33:05 volumio volumio[5662]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1188:47) Jul 24 20:33:05 volumio volumio[5662]: at Socket.emit (events.js:315:20) Jul 24 20:33:05 volumio volumio[5662]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 24 20:33:05 volumio volumio[5662]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 24 20:33:05 volumio volumio[5662]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 24 20:33:05 volumio sudo[9935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-24 20:32 Jul 24 20:33:05 volumio sudo[9935]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"