Jan 25 11:38:35 volumio volumio[1254]: info: Enabling plugin touch_display Jan 25 11:38:35 volumio volumio[1254]: info: Loading plugin "touch_display"... Jan 25 11:38:36 volumio volumio[1254]: info: PLUGIN START: touch_display Jan 25 11:38:36 volumio volumio[1254]: info: Loading i18n strings for locale it Jan 25 11:38:36 volumio volumio[1254]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jan 25 11:38:36 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 25 11:38:36 volumio volumio[1254]: info: touch_display: No backlight interface detected. Jan 25 11:38:37 volumio sudo[20241]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jan 25 11:38:37 volumio sudo[20237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jan 25 11:38:37 volumio sudo[20235]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Jan 25 11:38:37 volumio sudo[20239]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jan 25 11:38:37 volumio volumio[1254]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jan 25 11:38:37 volumio sudo[20235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:38:37 volumio sudo[20241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:38:37 volumio sudo[20237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:38:37 volumio sudo[20239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:38:37 volumio sudo[20235]: pam_unix(sudo:session): session closed for user root Jan 25 11:38:37 volumio systemd[1]: Reloading. Jan 25 11:38:37 volumio volumio[1254]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jan 25 11:38:37 volumio sudo[20251]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jan 25 11:38:37 volumio sudo[20251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:38:37 volumio sudo[20251]: pam_unix(sudo:session): session closed for user root Jan 25 11:38:37 volumio volumio[1254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jan 25 11:38:37 volumio sudo[20249]: 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/ Jan 25 11:38:37 volumio sudo[20249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:38:37 volumio sudo[20249]: pam_unix(sudo:session): session closed for user root Jan 25 11:38:37 volumio volumio[1254]: info: touch_display: IframeKeyboardBridge extension installed successfully Jan 25 11:38:39 volumio volumio[1254]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 25 11:38:39 volumio volumio[1254]: info: touch_display: About to detect HDMI ports... Jan 25 11:38:39 volumio volumio[1254]: info: touch_display: X server not ready, cannot detect HDMI ports yet. Jan 25 11:38:39 volumio sudo[20241]: pam_unix(sudo:session): session closed for user root Jan 25 11:38:39 volumio volumio[1254]: info: touch_display: systemctl daemon-reload succeeded. Jan 25 11:38:39 volumio sudo[20288]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jan 25 11:38:39 volumio sudo[20288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:38:39 volumio systemd[1]: Reloading. Jan 25 11:38:41 volumio sudo[20239]: pam_unix(sudo:session): session closed for user root Jan 25 11:38:41 volumio volumio[1254]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jan 25 11:38:41 volumio systemd[1]: Stopping getty@tty1.service - Getty on tty1... Jan 25 11:38:41 volumio systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Jan 25 11:38:41 volumio sudo[20288]: pam_unix(sudo:session): session closed for user root Jan 25 11:38:41 volumio volumio[1254]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jan 25 11:38:41 volumio systemd[1]: getty@tty1.service: Deactivated successfully. Jan 25 11:38:41 volumio systemd[1]: Stopped getty@tty1.service - Getty on tty1. Jan 25 11:38:41 volumio volumio[1254]: info: touch_display: Volumio Kiosk started. Jan 25 11:38:41 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState Jan 25 11:38:41 volumio volumio[1254]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:41 volumio volumio[1254]: info: Done. Jan 25 11:38:41 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState Jan 25 11:38:41 volumio volumio[1254]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:41 volumio sudo[20237]: pam_unix(sudo:session): session closed for user root Jan 25 11:38:41 volumio volumio[1254]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jan 25 11:38:41 volumio volumio[1254]: info: touch_display: X display number found: Jan 25 11:38:41 volumio volumio[1254]: info: touch_display: X display number found: Jan 25 11:38:41 volumio startx[20328]: xauth: file /home/volumio/.Xauthority does not exist Jan 25 11:38:41 volumio volumio[1254]: info: touch_display: X display number found: 0 Jan 25 11:38:42 volumio volumio[1254]: info: touch_display: X display number found: 0 Jan 25 11:38:42 volumio startx[20335]: X.Org X Server 1.21.1.7 Jan 25 11:38:42 volumio startx[20335]: X Protocol Version 11, Revision 0 Jan 25 11:38:42 volumio startx[20335]: Current Operating System: Linux volumio 6.12.47-v7+ #1904 SMP Mon Sep 15 13:05:52 BST 2025 armv7l Jan 25 11:38:42 volumio startx[20335]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1824 bcm2708_fb.fbheight=984 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=b0b466fc-4556-43af-9f97-ebe56fe4abe4 imgfile=/volumio_current.sqsh bootpart=UUID=0428-C7E4 datapart=UUID=82051e0e-a859-4f54-aa9f-0cc23a932af8 uuidconfig=cmdline.txt rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Jan 25 11:38:42 volumio startx[20335]: xorg-server 2:21.1.7-3+rpt3+deb12u11 (https://www.debian.org/support) Jan 25 11:38:42 volumio startx[20335]: Current version of pixman: 0.44.0 Jan 25 11:38:42 volumio startx[20335]: Before reporting problems, check http://wiki.x.org Jan 25 11:38:42 volumio startx[20335]: to make sure that you have the latest version. Jan 25 11:38:42 volumio startx[20335]: Markers: (--) probed, (**) from config file, (==) default setting, Jan 25 11:38:42 volumio startx[20335]: (++) from command line, (!!) notice, (II) informational, Jan 25 11:38:42 volumio startx[20335]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jan 25 11:38:42 volumio startx[20335]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Jan 25 11:38:42 2026 Jan 25 11:38:42 volumio startx[20335]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jan 25 11:38:42 volumio startx[20335]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jan 25 11:38:42 volumio volumio[1254]: info: touch_display: X display number found: 0 Jan 25 11:38:42 volumio volumio[1254]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jan 25 11:38:42 volumio volumio[1254]: info: touch_display: X display number found: 0 Jan 25 11:38:44 volumio startx[20335]: (EE) Jan 25 11:38:44 volumio startx[20335]: Fatal server error: Jan 25 11:38:44 volumio startx[20335]: (EE) no screens found(EE) Jan 25 11:38:44 volumio startx[20335]: (EE) Jan 25 11:38:44 volumio startx[20335]: Please consult the The X.Org Foundation support Jan 25 11:38:44 volumio startx[20335]: at http://wiki.x.org Jan 25 11:38:44 volumio startx[20335]: for help. Jan 25 11:38:44 volumio startx[20335]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Jan 25 11:38:44 volumio startx[20335]: (EE) Jan 25 11:38:44 volumio volumio[1254]: error: touch_display: Error determining the video outputs: Error: Command failed: /usr/bin/xrandr -display :0 Jan 25 11:38:44 volumio volumio[1254]: Can't open display :0 Jan 25 11:38:44 volumio startx[20335]: (EE) Server terminated with error (1). Closing log file. Jan 25 11:38:48 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState Jan 25 11:38:48 volumio volumio[1254]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:49 volumio volumio[1254]: info: CoreCommandRouter::volumioNext Jan 25 11:38:49 volumio volumio[1254]: info: CoreStateMachine::next Jan 25 11:38:49 volumio volumio[1254]: info: CoreStateMachine::stop Jan 25 11:38:49 volumio volumio[1254]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 11:38:49 volumio volumio[1254]: info: CoreStateMachine::play index undefined Jan 25 11:38:49 volumio volumio[1254]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 11:38:49 volumio volumio[1254]: info: CorePlayQueue::getTrack 1 Jan 25 11:38:49 volumio volumio[1254]: info: CoreStateMachine::startPlaybackTimer Jan 25 11:38:49 volumio volumio[1254]: info: CorePlayQueue::getTrack 1 Jan 25 11:38:49 volumio volumio[1254]: verbose: ControllerMpd::clearAddPlayTracks NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-Bzf1LSMH.mp3 Jan 25 11:38:49 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 11:38:49 volumio volumio[1254]: info: CoreStateMachine::updateTrackBlock Jan 25 11:38:49 volumio volumio[1254]: info: CorePlayQueue::getTrackBlock Jan 25 11:38:49 volumio volumio[1254]: info: sendMpdCommand stop took 4 milliseconds Jan 25 11:38:49 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand clear Jan 25 11:38:49 volumio volumio[1254]: info: Jan 25 11:38:49 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:49 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:49 volumio volumio[1254]: info: sendMpdCommand clear took 3 milliseconds Jan 25 11:38:49 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-Bzf1LSMH.mp3" Jan 25 11:38:49 volumio volumio[1254]: error: updateQueue error: null Jan 25 11:38:49 volumio volumio[1254]: info: Jan 25 11:38:49 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:49 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:49 volumio volumio[1254]: info: ------------------------------ 8ms Jan 25 11:38:49 volumio volumio[1254]: info: sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-Bzf1LSMH.mp3" took 5 milliseconds Jan 25 11:38:49 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand play Jan 25 11:38:49 volumio volumio[1254]: info: ------------------------------ 7ms Jan 25 11:38:49 volumio volumio[1254]: info: sendMpdCommand play took 5 milliseconds Jan 25 11:38:49 volumio volumio[1254]: info: Jan 25 11:38:49 volumio volumio[1254]: ---------------------------- MPD announces state update: player Jan 25 11:38:49 volumio volumio[1254]: info: ControllerMpd::getState Jan 25 11:38:49 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces state update: player Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand status took 130 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::getState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 1 Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: Prefetching next song Jan 25 11:38:50 volumio volumio[1254]: info: DOING PREFETCH IN MPD Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-FiiOzicp.ogg" Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::startPlaybackTimer Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPlay Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::play index undefined Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::startPlaybackTimer Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::clearAddPlayTracks NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-FiiOzicp.ogg Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand status took 515 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:50 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces state update: player Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:50 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::getState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand playlistinfo took 521 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-FiiOzicp.ogg" took 466 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand stop took 34 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand clear Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:38:50 volumio volumio[1254]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::servicePushState Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"wave-FiiOzicp.ogg","artist":"Davide Girardi","album":null,"uri":"NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-FiiOzicp.ogg","trackType":"ogg"} Jan 25 11:38:50 volumio volumio[1254]: verbose: CURRENT POSITION 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState stateService stop Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState currentStatus stop Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: No code Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 706ms Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 586ms Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:50 volumio volumio[1254]: info: Prefetching next song Jan 25 11:38:50 volumio volumio[1254]: info: DOING PREFETCH IN MPD Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/rock-BVCJXNC-.ogg" Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:50 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:50 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 71ms Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand status took 69 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 70ms Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand consume 1 took 63 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand clear took 63 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/rock-BVCJXNC-.ogg" took 7 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-FiiOzicp.ogg" Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::servicePushState Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 25 11:38:50 volumio volumio[1254]: verbose: CURRENT POSITION 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState stateService stop Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState currentStatus stop Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: No code Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 112ms Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:50 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 66ms Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 66ms Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand add "NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-FiiOzicp.ogg" took 61 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand consume 1 took 61 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand play Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 6ms Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand play took 7 milliseconds Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces state update: player Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::getState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand status took 6 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:38:50 volumio volumio[1254]: info: Jan 25 11:38:50 volumio volumio[1254]: ---------------------------- MPD announces state update: player Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::getState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::servicePushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-BVCJXNC-.ogg","artist":"Davide Girardi","album":null,"uri":"NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/rock-BVCJXNC-.ogg","trackType":"ogg"} Jan 25 11:38:50 volumio volumio[1254]: verbose: CURRENT POSITION 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState stateService play Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState currentStatus stop Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 19ms Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand status took 6 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseState Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:38:50 volumio volumio[1254]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 25 11:38:50 volumio volumio[1254]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:38:50 volumio volumio[1254]: info: ControllerMpd::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::servicePushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-BVCJXNC-.ogg","artist":"Davide Girardi","album":null,"uri":"NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/rock-BVCJXNC-.ogg","trackType":"ogg"} Jan 25 11:38:50 volumio volumio[1254]: verbose: CURRENT POSITION 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState stateService play Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::syncState currentStatus play Jan 25 11:38:50 volumio volumio[1254]: info: Received an update from plugin. extracting info from payload Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:50 volumio volumio[1254]: info: ------------------------------ 36ms Jan 25 11:38:50 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:50 volumio volumio[1254]: info: CorePlayQueue::getTrack 2 Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:50 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:51 volumio volumio[1254]: info: CoreStateMachine::startPlaybackTimer Jan 25 11:38:51 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:51 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:51 volumio volumio[1254]: info: CorePlayQueue::getTrack 4 Jan 25 11:38:51 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:51 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:51 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:51 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:52 volumio volumio[1254]: info: Jan 25 11:38:52 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:52 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:52 volumio volumio[1254]: info: Jan 25 11:38:52 volumio volumio[1254]: ---------------------------- MPD announces state update: player Jan 25 11:38:52 volumio volumio[1254]: info: ControllerMpd::getState Jan 25 11:38:52 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:52 volumio volumio[1254]: info: ------------------------------ 4ms Jan 25 11:38:52 volumio volumio[1254]: info: sendMpdCommand status took 3 milliseconds Jan 25 11:38:52 volumio volumio[1254]: verbose: ControllerMpd::parseState Jan 25 11:38:52 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:38:52 volumio volumio[1254]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 25 11:38:52 volumio volumio[1254]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:38:52 volumio volumio[1254]: info: ControllerMpd::pushState Jan 25 11:38:52 volumio volumio[1254]: info: CoreCommandRouter::servicePushState Jan 25 11:38:52 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:52 volumio volumio[1254]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":1,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"wave-FiiOzicp.ogg","artist":"Davide Girardi","album":null,"uri":"NAS/ShareNas2/nextcloud_data/custom_apps/riotchat/3rdparty/riot/widgets/element-call/assets/wave-FiiOzicp.ogg","trackType":"ogg"} Jan 25 11:38:52 volumio volumio[1254]: verbose: CURRENT POSITION 3 Jan 25 11:38:52 volumio volumio[1254]: info: CoreStateMachine::syncState stateService play Jan 25 11:38:52 volumio volumio[1254]: info: CoreStateMachine::syncState currentStatus play Jan 25 11:38:52 volumio volumio[1254]: info: Received an update from plugin. extracting info from payload Jan 25 11:38:52 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:52 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:52 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:52 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:52 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:52 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:52 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:52 volumio volumio[1254]: info: ------------------------------ 28ms Jan 25 11:38:53 volumio volumio[1254]: info: CoreCommandRouter::volumioPause Jan 25 11:38:53 volumio volumio[1254]: info: CoreStateMachine::pause Jan 25 11:38:53 volumio volumio[1254]: info: CoreStateMachine::stPlaybackTimer Jan 25 11:38:53 volumio volumio[1254]: info: CoreStateMachine::servicePause Jan 25 11:38:53 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:53 volumio volumio[1254]: info: CoreCommandRouter::servicePause Jan 25 11:38:53 volumio volumio[1254]: info: ControllerMpd::pause Jan 25 11:38:53 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand pause Jan 25 11:38:53 volumio volumio[1254]: info: sendMpdCommand pause took 547 milliseconds Jan 25 11:38:53 volumio volumio[1254]: info: Jan 25 11:38:53 volumio volumio[1254]: ---------------------------- MPD announces system playlist update Jan 25 11:38:53 volumio volumio[1254]: info: Ignoring MPD Status Update Jan 25 11:38:53 volumio volumio[1254]: info: Jan 25 11:38:53 volumio volumio[1254]: ---------------------------- MPD announces state update: player Jan 25 11:38:53 volumio volumio[1254]: info: ControllerMpd::getState Jan 25 11:38:53 volumio volumio[1254]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:53 volumio volumio[1254]: error: updateQueue error: null Jan 25 11:38:53 volumio volumio[1254]: info: ------------------------------ 4ms Jan 25 11:38:53 volumio volumio[1254]: info: sendMpdCommand status took 2 milliseconds Jan 25 11:38:53 volumio volumio[1254]: verbose: ControllerMpd::parseState Jan 25 11:38:53 volumio volumio[1254]: info: ControllerMpd::pushState Jan 25 11:38:53 volumio volumio[1254]: info: CoreCommandRouter::servicePushState Jan 25 11:38:53 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:53 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:53 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:53 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:53 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:53 volumio volumio[1254]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 25 11:38:53 volumio volumio[1254]: verbose: CURRENT POSITION 3 Jan 25 11:38:53 volumio volumio[1254]: info: CoreStateMachine::syncState stateService stop Jan 25 11:38:53 volumio volumio[1254]: info: CoreStateMachine::syncState currentStatus pause Jan 25 11:38:53 volumio volumio[1254]: info: CoreStateMachine::pushState Jan 25 11:38:53 volumio volumio[1254]: info: CorePlayQueue::getTrack 3 Jan 25 11:38:53 volumio volumio[1254]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:53 volumio volumio[1254]: info: ------------------------------ 27ms Jan 25 11:38:53 volumio volumio[1254]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X0' Jan 25 11:38:56 volumio startx[20333]: xinit: giving up Jan 25 11:38:56 volumio startx[20333]: xinit: unable to connect to X server: Cannot assign requested address Jan 25 11:38:56 volumio startx[20333]: xinit: server error Jan 25 11:38:56 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Jan 25 11:38:56 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Jan 25 11:38:56 volumio systemd[1]: volumio-kiosk.service: Consumed 2.026s CPU time. Jan 25 11:39:00 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 25 11:39:00 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 25 11:39:02 volumio sudo[20382]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jan 25 11:39:02 volumio sudo[20382]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:39:02 volumio sudo[20382]: pam_unix(sudo:session): session closed for user root Jan 25 11:39:02 volumio sudo[20384]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Jan 25 11:39:02 volumio sudo[20384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:39:02 volumio volumio[1254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jan 25 11:39:02 volumio sudo[20386]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Jan 25 11:39:02 volumio sudo[20386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:39:02 volumio volumio[1254]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 11:39:02 volumio sudo[20390]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Jan 25 11:39:02 volumio sudo[20390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 25 11:39:02 volumio volumio[1254]: TypeError: Cannot read properties of undefined (reading 'split') Jan 25 11:39:02 volumio volumio[1254]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Jan 25 11:39:02 volumio volumio[1254]: at ChildProcess.exithandler (node:child_process:413:7) Jan 25 11:39:02 volumio volumio[1254]: at ChildProcess.emit (node:events:514:28) Jan 25 11:39:02 volumio volumio[1254]: at maybeClose (node:internal/child_process:1105:16) Jan 25 11:39:02 volumio volumio[1254]: at Socket. (node:internal/child_process:457:11) Jan 25 11:39:02 volumio volumio[1254]: at Socket.emit (node:events:514:28) Jan 25 11:39:02 volumio volumio[1254]: at Pipe. (node:net:337:12) Jan 25 11:39:02 volumio volumio[1254]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 11:39:02 volumio systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 25 11:39:02 volumio sudo[20384]: pam_unix(sudo:session): session closed for user root Jan 25 11:39:02 volumio systemd[1]: Reloading. Jan 25 11:39:04 volumio sudo[20386]: pam_unix(sudo:session): session closed for user root Jan 25 11:39:04 volumio sudo[20390]: pam_unix(sudo:session): session closed for user root Jan 25 11:39:05 volumio sudo[20425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-25 11:38' Jan 25 11:39:05 volumio sudo[20425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"