Dec 18 03:07:16 volumio volumio[1219]: info: Get:28 http://archive.raspberrypi.com/debian bookworm/main armhf rpi-chromium-mods armhf 20250506 [5078 B] Dec 18 03:07:16 volumio volumio[1219]: info: Get:29 http://archive.raspberrypi.com/debian bookworm/main armhf chromium-browser all 1:142.0.7444.175-1~deb12u1+rpt1 [108 kB] Dec 18 03:07:16 volumio volumio[1219]: info: Get:30 http://archive.raspberrypi.com/debian bookworm/main armhf chromium-l10n all 1:142.0.7444.175-1~deb12u1+rpt1 [19.4 MB] Dec 18 03:07:24 volumio ntpd[1003]: CLOCK: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 18 03:07:24 volumio ntpd[1003]: CLOCK: time stepped by -0.285308 Dec 18 03:07:24 volumio ntpd[1003]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 18 03:07:24 volumio ntpd[1003]: CLOCK: frequency error -939 PPM exceeds tolerance 500 PPM Dec 18 03:07:33 volumio volumio[1219]: info: Get:31 http://archive.raspberrypi.com/debian bookworm/main armhf chromium-sandbox armhf 1:142.0.7444.175-1~deb12u1+rpt1 [114 kB] Dec 18 03:07:33 volumio volumio[1219]: info: Get:32 http://archive.raspberrypi.com/debian bookworm/main armhf libwidevinecdm0 armhf 4.10.2662.3+1 [7466 kB] Dec 18 03:07:38 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.100.90 from 192.168.100.62 UA: Mozilla/5.0 (Linux; Android 12; HBN-LX9 Build/HUAWEIHBN-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/114.0.5735.196 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 18 03:07:39 volumio volumio[1219]: info: Fetched 155 MB in 1min 28s (1759 kB/s) Dec 18 03:07:40 volumio volumio[1219]: info: Selecting previously unselected package chromium-codecs-ffmpeg-extra. Dec 18 03:07:40 volumio volumio[1219]: [620B blob data] Dec 18 03:07:40 volumio volumio[1219]: info: Preparing to unpack .../00-chromium-codecs-ffmpeg-extra_126.0.6478.164-rpt1_armhf.deb ... Dec 18 03:07:40 volumio volumio[1219]: info: Unpacking chromium-codecs-ffmpeg-extra (126.0.6478.164-rpt1) ... Dec 18 03:07:40 volumio volumio[1219]: info: Selecting previously unselected package libdouble-conversion3:armhf. Dec 18 03:07:40 volumio volumio[1219]: info: Preparing to unpack .../01-libdouble-conversion3_3.2.1-1_armhf.deb ... Dec 18 03:07:40 volumio volumio[1219]: info: Unpacking libdouble-conversion3:armhf (3.2.1-1) ... Dec 18 03:07:40 volumio volumio[1219]: info: Selecting previously unselected package libharfbuzz-subset0:armhf. Dec 18 03:07:40 volumio volumio[1219]: info: Preparing to unpack .../02-libharfbuzz-subset0_6.0.0+dfsg-3_armhf.deb ... Dec 18 03:07:40 volumio volumio[1219]: info: Unpacking libharfbuzz-subset0:armhf (6.0.0+dfsg-3) ... Dec 18 03:07:40 volumio volumio[1219]: info: Selecting previously unselected package libnspr4:armhf. Dec 18 03:07:40 volumio volumio[1219]: info: Preparing to unpack .../03-libnspr4_2%3a4.35-1_armhf.deb ... Dec 18 03:07:40 volumio volumio[1219]: info: Unpacking libnspr4:armhf (2:4.35-1) ... Dec 18 03:07:41 volumio volumio[1219]: info: Selecting previously unselected package libnss3:armhf. Dec 18 03:07:41 volumio volumio[1219]: info: Preparing to unpack .../04-libnss3_2%3a3.87.1-1+deb12u1_armhf.deb ... Dec 18 03:07:41 volumio volumio[1219]: info: Unpacking libnss3:armhf (2:3.87.1-1+deb12u1) ... Dec 18 03:07:41 volumio volumio[1219]: info: Selecting previously unselected package libopenh264-7:armhf. Dec 18 03:07:41 volumio volumio[1219]: info: Preparing to unpack .../05-libopenh264-7_2.3.1+dfsg-3+deb12u2_armhf.deb ... Dec 18 03:07:41 volumio volumio[1219]: info: Unpacking libopenh264-7:armhf (2.3.1+dfsg-3+deb12u2) ... Dec 18 03:07:41 volumio volumio[1219]: info: Selecting previously unselected package libxnvctrl0:armhf. Dec 18 03:07:41 volumio volumio[1219]: info: Preparing to unpack .../06-libxnvctrl0_525.85.05-3~deb12u1_armhf.deb ... Dec 18 03:07:41 volumio volumio[1219]: info: Unpacking libxnvctrl0:armhf (525.85.05-3~deb12u1) ... Dec 18 03:07:41 volumio volumio[1219]: info: Selecting previously unselected package libxslt1.1:armhf. Dec 18 03:07:41 volumio volumio[1219]: info: Preparing to unpack .../07-libxslt1.1_1.1.35-1+deb12u3_armhf.deb ... Dec 18 03:07:41 volumio volumio[1219]: info: Unpacking libxslt1.1:armhf (1.1.35-1+deb12u3) ... Dec 18 03:07:42 volumio volumio[1219]: info: Selecting previously unselected package xdg-utils. Dec 18 03:07:42 volumio volumio[1219]: info: Preparing to unpack .../08-xdg-utils_1.1.3-4.1_all.deb ... Dec 18 03:07:42 volumio volumio[1219]: info: Unpacking xdg-utils (1.1.3-4.1) ... Dec 18 03:07:42 volumio volumio[1219]: info: Selecting previously unselected package zenoty. Dec 18 03:07:42 volumio volumio[1219]: info: Preparing to unpack .../09-zenoty_0.2_armhf.deb ... Dec 18 03:07:42 volumio volumio[1219]: info: Unpacking zenoty (0.2) ... Dec 18 03:07:42 volumio volumio[1219]: info: Selecting previously unselected package chromium-common. Dec 18 03:07:42 volumio volumio[1219]: info: Preparing to unpack .../10-chromium-common_1%3a142.0.7444.175-1~deb12u1+rpt1_armhf.deb ... Dec 18 03:07:42 volumio volumio[1219]: info: Unpacking chromium-common (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:07:42 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.100.90 from 192.168.100.62 UA: Mozilla/5.0 (Linux; Android 12; HBN-LX9 Build/HUAWEIHBN-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/114.0.5735.196 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 18 03:07:43 volumio volumio[1219]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 18 03:07:43 volumio volumio[1219]: info: Received Get System Info Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 03:07:43 volumio volumio[1219]: info: Discovery: Getting this device information Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 18 03:07:43 volumio volumio[1219]: info: Listing playlists Dec 18 03:07:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 18 03:07:46 volumio volumio[1219]: info: Selecting previously unselected package chromium. Dec 18 03:07:46 volumio volumio[1219]: info: Preparing to unpack .../11-chromium_1%3a142.0.7444.175-1~deb12u1+rpt1_armhf.deb ... Dec 18 03:07:46 volumio volumio[1219]: info: Unpacking chromium (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:07:54 volumio volumio[1219]: info: Selecting previously unselected package rpi-chromium-mods. Dec 18 03:07:54 volumio volumio[1219]: info: Preparing to unpack .../12-rpi-chromium-mods_20250506_armhf.deb ... Dec 18 03:07:54 volumio volumio[1219]: info: Unpacking rpi-chromium-mods (20250506) ... Dec 18 03:07:54 volumio volumio[1219]: info: Selecting previously unselected package chromium-browser. Dec 18 03:07:54 volumio volumio[1219]: info: Preparing to unpack .../13-chromium-browser_1%3a142.0.7444.175-1~deb12u1+rpt1_all.deb ... Dec 18 03:07:54 volumio volumio[1219]: info: Unpacking chromium-browser (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:07:54 volumio volumio[1219]: info: Selecting previously unselected package chromium-l10n. Dec 18 03:07:54 volumio volumio[1219]: info: Preparing to unpack .../14-chromium-l10n_1%3a142.0.7444.175-1~deb12u1+rpt1_all.deb ... Dec 18 03:07:54 volumio volumio[1219]: info: Unpacking chromium-l10n (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:07:58 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 03:07:58 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 18 03:08:01 volumio volumio[1219]: info: Selecting previously unselected package chromium-sandbox. Dec 18 03:08:01 volumio volumio[1219]: info: Preparing to unpack .../15-chromium-sandbox_1%3a142.0.7444.175-1~deb12u1+rpt1_armhf.deb ... Dec 18 03:08:01 volumio volumio[1219]: info: Unpacking chromium-sandbox (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:08:01 volumio volumio[1219]: info: Selecting previously unselected package fonts-liberation. Dec 18 03:08:01 volumio volumio[1219]: info: Preparing to unpack .../16-fonts-liberation_1%3a1.07.4-11_all.deb ... Dec 18 03:08:01 volumio volumio[1219]: info: Unpacking fonts-liberation (1:1.07.4-11) ... Dec 18 03:08:02 volumio volumio[1219]: info: Selecting previously unselected package libipc-system-simple-perl. Dec 18 03:08:02 volumio volumio[1219]: info: Preparing to unpack .../17-libipc-system-simple-perl_1.30-2_all.deb ... Dec 18 03:08:02 volumio volumio[1219]: info: Unpacking libipc-system-simple-perl (1.30-2) ... Dec 18 03:08:02 volumio volumio[1219]: info: Selecting previously unselected package libfile-basedir-perl. Dec 18 03:08:02 volumio volumio[1219]: info: Preparing to unpack .../18-libfile-basedir-perl_0.09-2_all.deb ... Dec 18 03:08:02 volumio volumio[1219]: info: Unpacking libfile-basedir-perl (0.09-2) ... Dec 18 03:08:02 volumio volumio[1219]: info: Selecting previously unselected package libfile-desktopentry-perl. Dec 18 03:08:02 volumio volumio[1219]: info: Preparing to unpack .../19-libfile-desktopentry-perl_0.22-3_all.deb ... Dec 18 03:08:02 volumio volumio[1219]: info: Unpacking libfile-desktopentry-perl (0.22-3) ... Dec 18 03:08:03 volumio volumio[1219]: info: Selecting previously unselected package libfile-mimeinfo-perl. Dec 18 03:08:03 volumio volumio[1219]: info: Preparing to unpack .../20-libfile-mimeinfo-perl_0.33-1_all.deb ... Dec 18 03:08:03 volumio volumio[1219]: info: Unpacking libfile-mimeinfo-perl (0.33-1) ... Dec 18 03:08:03 volumio volumio[1219]: info: Selecting previously unselected package libio-stringy-perl. Dec 18 03:08:03 volumio volumio[1219]: info: Preparing to unpack .../21-libio-stringy-perl_2.111-3_all.deb ... Dec 18 03:08:03 volumio volumio[1219]: info: Unpacking libio-stringy-perl (2.111-3) ... Dec 18 03:08:03 volumio volumio[1219]: info: Selecting previously unselected package libxml-parser-perl. Dec 18 03:08:03 volumio volumio[1219]: info: Preparing to unpack .../22-libxml-parser-perl_2.46-4_armhf.deb ... Dec 18 03:08:03 volumio volumio[1219]: info: Unpacking libxml-parser-perl (2.46-4) ... Dec 18 03:08:03 volumio volumio[1219]: info: Selecting previously unselected package libxml-twig-perl. Dec 18 03:08:03 volumio volumio[1219]: info: Preparing to unpack .../23-libxml-twig-perl_1%3a3.52-2_all.deb ... Dec 18 03:08:03 volumio volumio[1219]: info: Unpacking libxml-twig-perl (1:3.52-2) ... Dec 18 03:08:04 volumio volumio[1219]: info: Selecting previously unselected package libnet-dbus-perl. Dec 18 03:08:04 volumio volumio[1219]: info: Preparing to unpack .../24-libnet-dbus-perl_1.2.0-2_armhf.deb ... Dec 18 03:08:04 volumio volumio[1219]: info: Unpacking libnet-dbus-perl (1.2.0-2) ... Dec 18 03:08:04 volumio volumio[1219]: info: Selecting previously unselected package libtie-ixhash-perl. Dec 18 03:08:04 volumio volumio[1219]: info: Preparing to unpack .../25-libtie-ixhash-perl_1.23-4_all.deb ... Dec 18 03:08:04 volumio volumio[1219]: info: Unpacking libtie-ixhash-perl (1.23-4) ... Dec 18 03:08:04 volumio volumio[1219]: info: Selecting previously unselected package libupower-glib3:armhf. Dec 18 03:08:04 volumio volumio[1219]: info: Preparing to unpack .../26-libupower-glib3_0.99.20-2_armhf.deb ... Dec 18 03:08:04 volumio volumio[1219]: info: Unpacking libupower-glib3:armhf (0.99.20-2) ... Dec 18 03:08:04 volumio volumio[1219]: info: Selecting previously unselected package libwidevinecdm0. Dec 18 03:08:04 volumio volumio[1219]: info: Preparing to unpack .../27-libwidevinecdm0_4.10.2662.3+1_armhf.deb ... Dec 18 03:08:04 volumio volumio[1219]: info: Unpacking libwidevinecdm0 (4.10.2662.3+1) ... Dec 18 03:08:05 volumio volumio[1219]: info: Selecting previously unselected package libx11-protocol-perl. Dec 18 03:08:05 volumio volumio[1219]: info: Preparing to unpack .../28-libx11-protocol-perl_0.56-9_all.deb ... Dec 18 03:08:05 volumio volumio[1219]: info: Unpacking libx11-protocol-perl (0.56-9) ... Dec 18 03:08:06 volumio volumio[1219]: info: Selecting previously unselected package libxml-xpathengine-perl. Dec 18 03:08:06 volumio volumio[1219]: info: Preparing to unpack .../29-libxml-xpathengine-perl_0.14-2_all.deb ... Dec 18 03:08:06 volumio volumio[1219]: info: Unpacking libxml-xpathengine-perl (0.14-2) ... Dec 18 03:08:06 volumio volumio[1219]: info: Selecting previously unselected package notification-daemon. Dec 18 03:08:06 volumio volumio[1219]: info: Preparing to unpack .../30-notification-daemon_3.20.0-4_armhf.deb ... Dec 18 03:08:06 volumio volumio[1219]: info: Unpacking notification-daemon (3.20.0-4) ... Dec 18 03:08:06 volumio volumio[1219]: info: Selecting previously unselected package upower. Dec 18 03:08:06 volumio volumio[1219]: info: Preparing to unpack .../31-upower_0.99.20-2_armhf.deb ... Dec 18 03:08:06 volumio volumio[1219]: info: Unpacking upower (0.99.20-2) ... Dec 18 03:08:06 volumio dbus-daemon[780]: [system] Reloaded configuration Dec 18 03:08:06 volumio vtcs[3627]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio shairport-sync[3587]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio qobuz-connect[3586]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio dbus-daemon[780]: [system] Reloaded configuration Dec 18 03:08:06 volumio vtcs[3627]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio shairport-sync[3587]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio qobuz-connect[3586]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio dbus-daemon[780]: [system] Reloaded configuration Dec 18 03:08:06 volumio vtcs[3627]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio qobuz-connect[3586]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio shairport-sync[3587]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio dbus-daemon[780]: [system] Reloaded configuration Dec 18 03:08:06 volumio vtcs[3627]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio qobuz-connect[3586]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio shairport-sync[3587]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio dbus-daemon[780]: [system] Reloaded configuration Dec 18 03:08:06 volumio vtcs[3627]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio qobuz-connect[3586]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio shairport-sync[3587]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:06 volumio volumio[1219]: info: Setting up libxml-parser-perl (2.46-4) ... Dec 18 03:08:06 volumio volumio[1219]: info: Setting up libdouble-conversion3:armhf (3.2.1-1) ... Dec 18 03:08:06 volumio volumio[1219]: info: Setting up libtie-ixhash-perl (1.23-4) ... Dec 18 03:08:06 volumio volumio[1219]: info: Setting up chromium-codecs-ffmpeg-extra (126.0.6478.164-rpt1) ... Dec 18 03:08:06 volumio volumio[1219]: info: Setting up libio-stringy-perl (2.111-3) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libxml-twig-perl (1:3.52-2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libnet-dbus-perl (1.2.0-2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up chromium-sandbox (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up notification-daemon (3.20.0-4) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libxnvctrl0:armhf (525.85.05-3~deb12u1) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libnspr4:armhf (2:4.35-1) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libipc-system-simple-perl (1.30-2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libxml-xpathengine-perl (0.14-2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libopenh264-7:armhf (2.3.1+dfsg-3+deb12u2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libxslt1.1:armhf (1.1.35-1+deb12u3) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up fonts-liberation (1:1.07.4-11) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libupower-glib3:armhf (0.99.20-2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libharfbuzz-subset0:armhf (6.0.0+dfsg-3) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up zenoty (0.2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up xdg-utils (1.1.3-4.1) ... Dec 18 03:08:07 volumio volumio[1219]: info: update-alternatives: using /usr/bin/xdg-open to provide /usr/bin/open (open) in auto mode Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libx11-protocol-perl (0.56-9) ... Dec 18 03:08:07 volumio volumio[1219]: info: Setting up libfile-basedir-perl (0.09-2) ... Dec 18 03:08:07 volumio volumio[1219]: info: Enabling plugin touch_display Dec 18 03:08:07 volumio volumio[1219]: info: Loading plugin "touch_display"... Dec 18 03:08:07 volumio volumio[1219]: info: PLUGIN START: touch_display Dec 18 03:08:07 volumio volumio[1219]: info: Loading i18n strings for locale en Dec 18 03:08:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 03:08:07 volumio sudo[6978]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Dec 18 03:08:07 volumio sudo[6978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:07 volumio sudo[6978]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:07 volumio sudo[6980]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Dec 18 03:08:07 volumio sudo[6980]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:07 volumio sudo[6983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Dec 18 03:08:07 volumio sudo[6983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:07 volumio sudo[6986]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Dec 18 03:08:07 volumio sudo[6986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:07 volumio volumio[1219]: info: touch_display: No backlight interface detected. Dec 18 03:08:07 volumio volumio[1219]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 18 03:08:07 volumio volumio[1219]: info: Setting up upower (0.99.20-2) ... Dec 18 03:08:07 volumio sudo[6992]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Dec 18 03:08:07 volumio sudo[6992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:07 volumio sudo[6992]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:07 volumio volumio[1219]: info: touch_display: IframeKeyboardBridge extension installed successfully Dec 18 03:08:07 volumio systemd[1]: Reloading. Dec 18 03:08:07 volumio volumio[1219]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Dec 18 03:08:07 volumio sudo[6995]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Dec 18 03:08:07 volumio sudo[6995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:07 volumio sudo[6995]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:07 volumio volumio[1219]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Dec 18 03:08:08 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:08 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:08 volumio sudo[6986]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:08 volumio volumio[1219]: info: touch_display: systemctl daemon-reload succeeded. Dec 18 03:08:08 volumio sudo[7017]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Dec 18 03:08:08 volumio sudo[7017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:08 volumio systemd[1]: Reloading. Dec 18 03:08:09 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:09 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:09 volumio sudo[6983]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:09 volumio systemd[1]: Reloading. Dec 18 03:08:09 volumio volumio[1219]: info: touch_display: systemctl disable getty@tty1.service succeeded. Dec 18 03:08:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:10 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:10 volumio sudo[7017]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:10 volumio volumio[1219]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Dec 18 03:08:10 volumio volumio[1219]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Dec 18 03:08:10 volumio volumio[1219]: info: Error: Error Dec 18 03:08:10 volumio systemd[1]: Starting fstrim.service - Discard unused blocks on filesystems from /etc/fstab... Dec 18 03:08:10 volumio systemd[1]: Stopping getty@tty1.service - Getty on tty1... Dec 18 03:08:10 volumio systemd[1]: getty@tty1.service: Deactivated successfully. Dec 18 03:08:10 volumio systemd[1]: Stopped getty@tty1.service - Getty on tty1. Dec 18 03:08:10 volumio sudo[6980]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:10 volumio volumio[1219]: info: touch_display: systemctl stop getty@tty1.service succeeded. Dec 18 03:08:10 volumio volumio[1219]: info: upower.service is a disabled or a static unit, not starting it. Dec 18 03:08:10 volumio volumio[1219]: info: Setting up libnss3:armhf (2:3.87.1-1+deb12u1) ... Dec 18 03:08:10 volumio fstrim[7069]: /boot: 272.9 MiB (286146560 bytes) trimmed on /dev/mmcblk0p1 Dec 18 03:08:10 volumio systemd[1]: fstrim.service: Deactivated successfully. Dec 18 03:08:10 volumio systemd[1]: Finished fstrim.service - Discard unused blocks on filesystems from /etc/fstab. Dec 18 03:08:10 volumio volumio[1219]: info: Setting up libwidevinecdm0 (4.10.2662.3+1) ... Dec 18 03:08:10 volumio volumio[1219]: info: Setting up libfile-desktopentry-perl (0.22-3) ... Dec 18 03:08:10 volumio volumio[1219]: info: Setting up chromium-common (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:08:10 volumio volumio[1219]: info: Setting up chromium (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:08:10 volumio volumio[1219]: info: update-alternatives: using /usr/bin/chromium to provide /usr/bin/x-www-browser (x-www-browser) in auto mode Dec 18 03:08:10 volumio volumio[1219]: info: update-alternatives: using /usr/bin/chromium to provide /usr/bin/gnome-www-browser (gnome-www-browser) in auto mode Dec 18 03:08:10 volumio volumio[1219]: info: Setting up libfile-mimeinfo-perl (0.33-1) ... Dec 18 03:08:10 volumio volumio[1219]: info: Setting up rpi-chromium-mods (20250506) ... Dec 18 03:08:10 volumio volumio[1219]: info: Setting up chromium-l10n (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:08:10 volumio volumio[1219]: info: Setting up chromium-browser (1:142.0.7444.175-1~deb12u1+rpt1) ... Dec 18 03:08:11 volumio volumio[1219]: info: Processing triggers for hicolor-icon-theme (0.17-2) ... Dec 18 03:08:11 volumio volumio[1219]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Dec 18 03:08:11 volumio volumio[1219]: info: Processing triggers for man-db (2.11.2-2) ... Dec 18 03:08:11 volumio volumio[1219]: info: Processing triggers for dbus (1.14.10-1~deb12u1) ... Dec 18 03:08:11 volumio dbus-daemon[780]: [system] Reloaded configuration Dec 18 03:08:11 volumio qobuz-connect[3586]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:11 volumio vtcs[3627]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:11 volumio shairport-sync[3587]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:11 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:11 volumio volumio[1219]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Dec 18 03:08:11 volumio volumio[1219]: info: Processing triggers for udev (252.39-1~deb12u1+rpi1) ... Dec 18 03:08:13 volumio volumio[1219]: info: Processing triggers for fontconfig (2.14.1-4) ... Dec 18 03:08:14 volumio volumio[1219]: info: Installing fonts Dec 18 03:08:14 volumio volumio[1219]: info: Reading package lists... Dec 18 03:08:14 volumio volumio[1219]: info: Building dependency tree... Dec 18 03:08:14 volumio volumio[1219]: info: Reading state information... Dec 18 03:08:15 volumio volumio[1219]: info: The following additional packages will be installed: Dec 18 03:08:15 volumio volumio[1219]: info: fonts-ipafont-gothic fonts-ipafont-mincho fonts-tlwg-garuda Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-garuda-ttf fonts-tlwg-kinnari fonts-tlwg-kinnari-ttf Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-laksaman fonts-tlwg-laksaman-ttf fonts-tlwg-loma Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-loma-ttf fonts-tlwg-mono fonts-tlwg-mono-ttf fonts-tlwg-norasi Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-norasi-ttf fonts-tlwg-purisa fonts-tlwg-purisa-ttf Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-sawasdee fonts-tlwg-sawasdee-ttf fonts-tlwg-typewriter Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-typewriter-ttf fonts-tlwg-typist fonts-tlwg-typist-ttf Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-typo fonts-tlwg-typo-ttf fonts-tlwg-umpush fonts-tlwg-umpush-ttf Dec 18 03:08:15 volumio volumio[1219]: info: fonts-tlwg-waree fonts-tlwg-waree-ttf Dec 18 03:08:15 volumio volumio[1219]: info: Suggested packages: Dec 18 03:08:16 volumio volumio[1219]: info: fonts-unfonts-extra Dec 18 03:08:16 volumio volumio[1219]: info: The following NEW packages will be installed: Dec 18 03:08:16 volumio volumio[1219]: info: fonts-arphic-gbsn00lp fonts-arphic-ukai fonts-ipafont fonts-ipafont-gothic Dec 18 03:08:16 volumio volumio[1219]: info: fonts-ipafont-mincho fonts-thai-tlwg-ttf fonts-tlwg-garuda Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-garuda-ttf fonts-tlwg-kinnari fonts-tlwg-kinnari-ttf Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-laksaman fonts-tlwg-laksaman-ttf fonts-tlwg-loma Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-loma-ttf fonts-tlwg-mono fonts-tlwg-mono-ttf fonts-tlwg-norasi Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-norasi-ttf fonts-tlwg-purisa fonts-tlwg-purisa-ttf Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-sawasdee fonts-tlwg-sawasdee-ttf fonts-tlwg-typewriter Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-typewriter-ttf fonts-tlwg-typist fonts-tlwg-typist-ttf Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-typo fonts-tlwg-typo-ttf fonts-tlwg-umpush fonts-tlwg-umpush-ttf Dec 18 03:08:16 volumio volumio[1219]: info: fonts-tlwg-waree fonts-tlwg-waree-ttf fonts-unfonts-core fonts-vlgothic Dec 18 03:08:16 volumio volumio[1219]: info: 0 upgraded, 34 newly installed, 0 to remove and 13 not upgraded. Dec 18 03:08:16 volumio volumio[1219]: info: Need to get 39.3 MB of archives. Dec 18 03:08:16 volumio volumio[1219]: info: After this operation, 102 MB of additional disk space will be used. Dec 18 03:08:16 volumio volumio[1219]: info: Get:1 http://mirror.as43289.net/raspbian/raspbian bookworm/main armhf fonts-ipafont-gothic all 00303-23 [3515 kB] Dec 18 03:08:20 volumio volumio[1219]: info: Get:2 http://mirror.as43289.net/raspbian/raspbian bookworm/main armhf fonts-ipafont-mincho all 00303-23 [4726 kB] Dec 18 03:08:26 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 18 03:08:30 volumio volumio[1219]: info: Get:3 http://mirror.as43289.net/raspbian/raspbian bookworm/main armhf fonts-ipafont all 00303-23 [12.6 kB] Dec 18 03:08:30 volumio volumio[1219]: info: Get:4 http://mirror.as43289.net/raspbian/raspbian bookworm/main armhf fonts-unfonts-core all 1:1.0.2-080608-18 [14.8 MB] Dec 18 03:08:31 volumio volumio[1219]: info: Executing endpoint metavolumio Dec 18 03:08:31 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 18 03:08:31 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 03:08:31 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 18 03:08:35 volumio sudo[7149]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Dec 18 03:08:35 volumio sudo[7149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:35 volumio sudo[7149]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:35 volumio sudo[7151]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Dec 18 03:08:35 volumio sudo[7151]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:35 volumio sudo[7153]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Dec 18 03:08:36 volumio sudo[7153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:36 volumio volumio[1219]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Dec 18 03:08:36 volumio volumio[1219]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 03:08:36 volumio sudo[7157]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Dec 18 03:08:36 volumio sudo[7157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:36 volumio volumio[1219]: TypeError: Cannot read properties of undefined (reading 'split') Dec 18 03:08:36 volumio volumio[1219]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Dec 18 03:08:36 volumio volumio[1219]: at ChildProcess.exithandler (node:child_process:413:7) Dec 18 03:08:36 volumio volumio[1219]: at ChildProcess.emit (node:events:514:28) Dec 18 03:08:36 volumio volumio[1219]: at maybeClose (node:internal/child_process:1105:16) Dec 18 03:08:36 volumio volumio[1219]: at Socket. (node:internal/child_process:457:11) Dec 18 03:08:36 volumio volumio[1219]: at Socket.emit (node:events:514:28) Dec 18 03:08:36 volumio volumio[1219]: at Pipe. (node:net:337:12) Dec 18 03:08:36 volumio volumio[1219]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 03:08:36 volumio systemd[1]: Reloading. Dec 18 03:08:36 volumio sudo[7191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-18 03:07' Dec 18 03:08:36 volumio sudo[7191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 03:08:36 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:36 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 03:08:36 volumio sudo[7153]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:36 volumio sudo[7157]: pam_unix(sudo:session): session closed for user root Dec 18 03:08:36 volumio systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 18 03:08:36 volumio sudo[7151]: pam_unix(sudo:session): session closed for user root PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"