-- 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"