-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Sat 2026-02-21 15:36:09 GMT. -- Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 15:35:00 volumio-toby sudo[1345]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:00 volumio-toby sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby sudo[1345]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 21 15:35:00 volumio-toby volumio[1196]: info: Loading i18n strings for locale en Feb 21 15:35:00 volumio-toby sudo[1345]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 15:35:00 volumio-toby volumio[1196]: info: Volumio Calling Home Feb 21 15:35:00 volumio-toby sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Feb 21 15:35:00 volumio-toby sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Feb 21 15:35:00 volumio-toby sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 21 15:35:00 volumio-toby sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby systemd[1]: Reloading. Feb 21 15:35:00 volumio-toby kernel: systemd[1]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: No backlight interface detected. Feb 21 15:35:00 volumio-toby volumio[1196]: info: MPD Permissions set Feb 21 15:35:00 volumio-toby volumio[1196]: info: MPD Permissions set Feb 21 15:35:00 volumio-toby volumio[1196]: info: Volumio called home Feb 21 15:35:00 volumio-toby volumio[1196]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:00 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:00.186Z level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:00 volumio-toby 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. Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Feb 21 15:35:00 volumio-toby volumio[1196]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Feb 21 15:35:00 volumio-toby volumio[1196]: info: Starting Shairport Sync Feb 21 15:35:00 volumio-toby sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Feb 21 15:35:00 volumio-toby sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby sudo[1399]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: Starting Shairport Sync Feb 21 15:35:00 volumio-toby volumio[1196]: info: Starting Shairport Sync Feb 21 15:35:00 volumio-toby volumio[1196]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Feb 21 15:35:00 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:00 volumio-toby sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 15:35:00 volumio-toby sudo[1402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 15:35:00 volumio-toby sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:00.275Z level=INFO msg="system info for f44a1c2276fad658a0d7bf748bf3efad" deviceName=Volumio-Toby deviceVariant=volumio deviceModel= softwareVersion=3.908 Feb 21 15:35:00 volumio-toby sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Feb 21 15:35:00 volumio-toby systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Feb 21 15:35:00 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:00 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:00.329Z level=INFO msg="enabling local network discovery" Feb 21 15:35:00 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:00.360Z level=INFO msg="bootstrapping state" hasInternet=true Feb 21 15:35:00 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:00 volumio-toby sudo[1374]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: systemctl daemon-reload succeeded. Feb 21 15:35:00 volumio-toby sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Feb 21 15:35:00 volumio-toby sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:00 volumio-toby systemd[1]: Reloading. Feb 21 15:35:00 volumio-toby sudo[1368]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: systemctl stop getty@tty1.service succeeded. Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: adding c61be954-439e-45ef-b161-170238f7990c Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Found device Volumio-Toby Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: this is already registered, c61be954-439e-45ef-b161-170238f7990c Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Found device Volumio-Toby Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:00 volumio-toby 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. Feb 21 15:35:00 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:00 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:00 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:00 volumio-toby sudo[1370]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: systemctl disable getty@tty1.service succeeded. Feb 21 15:35:00 volumio-toby systemd[1]: Started Volumio Kiosk. Feb 21 15:35:00 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 15:35:00 volumio-toby systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 21 15:35:00 volumio-toby sudo[1415]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: Volumio Kiosk started. Feb 21 15:35:00 volumio-toby systemd[1]: shairport-sync.service: Succeeded. Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby sudo[1405]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 21 15:35:00 volumio-toby sudo[1402]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: Shairport-Sync Started Feb 21 15:35:00 volumio-toby sudo[1407]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: Error adding Membership: Error: addMembership EINVAL Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:00 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:00 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:00 volumio-toby volumio[1196]: info: Shairport-Sync Started Feb 21 15:35:00 volumio-toby volumio[1196]: info: Shairport-Sync Started Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: X display number found: Feb 21 15:35:00 volumio-toby startx[1430]: X.Org X Server 1.20.4 Feb 21 15:35:00 volumio-toby startx[1430]: X Protocol Version 11, Revision 0 Feb 21 15:35:00 volumio-toby startx[1430]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Feb 21 15:35:00 volumio-toby startx[1430]: Current Operating System: Linux volumio-toby 6.6.62-v8+ #1816 SMP PREEMPT Mon Nov 18 15:35:52 GMT 2024 aarch64 Feb 21 15:35:00 volumio-toby startx[1430]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 numa=fake=8 system_heap.max_order=0 smsc95xx.macaddr=D8:3A:DD:BD:7F:20 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=51ee6bb9-5695-4d0e-8a65-19850d9f5f77 imgfile=/volumio_current.sqsh bootpart=UUID=AB52-4856 datapart=UUID=d536ee74-e14f-4419-9f9a-4c8c189a5d9e 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 Feb 21 15:35:00 volumio-toby startx[1430]: Build Date: 04 April 2023 07:50:56AM Feb 21 15:35:00 volumio-toby startx[1430]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Feb 21 15:35:00 volumio-toby startx[1430]: Current version of pixman: 0.36.0 Feb 21 15:35:00 volumio-toby startx[1430]: Before reporting problems, check http://wiki.x.org Feb 21 15:35:00 volumio-toby startx[1430]: to make sure that you have the latest version. Feb 21 15:35:00 volumio-toby startx[1430]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 21 15:35:00 volumio-toby startx[1430]: (++) from command line, (!!) notice, (II) informational, Feb 21 15:35:00 volumio-toby startx[1430]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 21 15:35:00 volumio-toby startx[1430]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Feb 21 15:35:00 2026 Feb 21 15:35:00 volumio-toby startx[1430]: (==) Using config directory: "/etc/X11/xorg.conf.d" Feb 21 15:35:00 volumio-toby startx[1430]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 21 15:35:00 volumio-toby startx[1430]: (EE) Feb 21 15:35:00 volumio-toby startx[1430]: Fatal server error: Feb 21 15:35:00 volumio-toby startx[1430]: (EE) no screens found(EE) Feb 21 15:35:00 volumio-toby startx[1430]: (EE) Feb 21 15:35:00 volumio-toby startx[1430]: Please consult the The X.Org Foundation support Feb 21 15:35:00 volumio-toby startx[1430]: at http://wiki.x.org Feb 21 15:35:00 volumio-toby startx[1430]: for help. Feb 21 15:35:00 volumio-toby startx[1430]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Feb 21 15:35:00 volumio-toby startx[1430]: (EE) Feb 21 15:35:00 volumio-toby startx[1430]: (EE) Server terminated with error (1). Closing log file. Feb 21 15:35:00 volumio-toby mpd[1357]: Feb 21 15:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 21 15:35:00 volumio-toby systemd[1]: Started Music Player Daemon. Feb 21 15:35:00 volumio-toby sudo[1305]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby sudo[1334]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:00 volumio-toby volumio[1196]: info: Completed starting Core Plugins Feb 21 15:35:00 volumio-toby volumio[1196]: info: ------------------------------------------- Feb 21 15:35:00 volumio-toby volumio[1196]: info: ----- MyVolumio plugins startup ---- Feb 21 15:35:00 volumio-toby volumio[1196]: info: ------------------------------------------- Feb 21 15:35:00 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 21 15:35:00 volumio-toby volumio[1196]: error: MPD error: The expression evaluated to a falsy value: Feb 21 15:35:00 volumio-toby volumio[1196]: assert.ok(self.idling) Feb 21 15:35:00 volumio-toby volumio[1196]: error: The expression evaluated to a falsy value: Feb 21 15:35:00 volumio-toby volumio[1196]: assert.ok(self.idling) Feb 21 15:35:00 volumio-toby volumio[1196]: info: MPD running with PID1357 Feb 21 15:35:00 volumio-toby volumio[1196]: ,establishing connection Feb 21 15:35:00 volumio-toby volumio[1196]: error: updateQueue error: null Feb 21 15:35:00 volumio-toby volumio[1196]: error: updateQueue error: null Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:00 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:01 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:01 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:01 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:01 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:01 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:01 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:01 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:02 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:02 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:02 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:02 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:02 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:02 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:02 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:02 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:02 volumio-toby sudo[1239]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:02 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio-remote-updater[657]: [2026-02-21 15:35:03] [connect] Successful connection Feb 21 15:35:03 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:03 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:03 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:03 volumio-toby volumio-remote-updater[657]: [2026-02-21 15:35:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1771688103 101 Feb 21 15:35:03 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:03 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:03 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:03 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:03 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:03 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:03 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:03 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:04.287Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:60746 Feb 21 15:35:04 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:04.319Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:57216 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:04 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:04 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:04 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:04 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:04 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 15:35:04 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:04 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:04 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:05 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:06 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:07 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:08 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:09 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:09 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 21 15:35:09 volumio-toby volumio[1196]: info: Adding plugin bluetooth to MyMusic Plugins Feb 21 15:35:09 volumio-toby volumio[1196]: info: Adding plugin multiroom to MyMusic Plugins Feb 21 15:35:09 volumio-toby volumio[1196]: info: Adding plugin metavolumio to MyMusic Plugins Feb 21 15:35:09 volumio-toby volumio[1196]: info: Adding plugin cd_controller to MyMusic Plugins Feb 21 15:35:09 volumio-toby volumio[1196]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 21 15:35:09 volumio-toby volumio[1196]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 21 15:35:09 volumio-toby volumio[1196]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 21 15:35:09 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:09 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:09 volumio-toby volumio[1196]: info: Starting MyVolumio Remote Streaming Endpoints Feb 21 15:35:09 volumio-toby volumio[1196]: info: MyVolumio login type: Token Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 21 15:35:09 volumio-toby volumio[1196]: info: Starting Streaming Service Transparent Proxy Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 21 15:35:09 volumio-toby volumio[1196]: info: Streaming services startup Feb 21 15:35:09 volumio-toby volumio[1196]: info: Starting Streaming Daemon Feb 21 15:35:09 volumio-toby sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 21 15:35:09 volumio-toby sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:09 volumio-toby volumio[1196]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 21 15:35:09 volumio-toby sudo[1648]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:09 volumio-toby sudo[1656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 15:35:09 volumio-toby sudo[1656]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:09 volumio-toby sudo[1656]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:09 volumio-toby sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 15:35:09 volumio-toby sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:09 volumio-toby sudo[1659]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:09 volumio-toby volumio[1196]: error: Cannot start Volumio Streaming Daemon Feb 21 15:35:09 volumio-toby volumio[1196]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 21 15:35:09 volumio-toby volumio[1196]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 21 15:35:09 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:09 volumio-toby sudo[1664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 21 15:35:09 volumio-toby sudo[1664]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:09 volumio-toby systemd[1]: Started UPnP Renderer front-end to MPD. Feb 21 15:35:09 volumio-toby sudo[1664]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:09 volumio-toby volumio[1196]: info: Upmpdcli Daemon Started Feb 21 15:35:09 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:09 volumio-toby volumio[1666]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 21 15:35:10 volumio-toby volumio[1196]: STREAMING PROXY: Starting server on port 3245 Feb 21 15:35:10 volumio-toby volumio[1196]: Node JS runtime: 14 Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby volumio[1196]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby systemd[1]: systemd-fsckd.service: Succeeded. Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby volumio[1196]: info: MyVolumio token set successfully Feb 21 15:35:10 volumio-toby volumio[1196]: info: MYVOLUMIO: Adding device Feb 21 15:35:10 volumio-toby volumio[1196]: info: MYVOLUMIO: Evaluating Server Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby volumio[1196]: info: MyVolumio status changed Feb 21 15:35:10 volumio-toby volumio[1196]: info: Streaming services startup Feb 21 15:35:10 volumio-toby volumio[1196]: info: Starting Streaming Daemon Feb 21 15:35:10 volumio-toby volumio[1196]: info: Removing browser output: myVolumio user plan is not superstar Feb 21 15:35:10 volumio-toby volumio[1196]: info: Removing audio output: Feb 21 15:35:10 volumio-toby volumio[1196]: info: Stoppping Tunnel 1 Feb 21 15:35:10 volumio-toby sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 21 15:35:10 volumio-toby sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:10 volumio-toby sudo[1724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 21 15:35:10 volumio-toby sudo[1724]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:10 volumio-toby sudo[1721]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:10 volumio-toby sudo[1724]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:10 volumio-toby volumio[1196]: error: Cannot start Volumio Streaming Daemon Feb 21 15:35:10 volumio-toby volumio[1196]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 21 15:35:10 volumio-toby volumio[1196]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 21 15:35:10 volumio-toby volumio[1196]: info: Remote SSH Stopped Feb 21 15:35:10 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: info: Setting Geolocation for MyVolumio to eu5 Feb 21 15:35:11 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:11 volumio-toby volumio[1196]: error: touch_display: Connecting to the Xserver failed. Feb 21 15:35:11 volumio-toby volumio[1196]: info: touch_display: X display number found: 0 Feb 21 15:35:12 volumio-toby volumio[1196]: info: Updating MyVolumio device info Feb 21 15:35:12 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:12 volumio-toby volumio[1196]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 21 15:35:15 volumio-toby volumio[1196]: info: MYVOLUMIO: Adding device Feb 21 15:35:15 volumio-toby volumio[1196]: info: MYVOLUMIO: Evaluating Server Feb 21 15:35:15 volumio-toby startx[1430]: xinit: giving up Feb 21 15:35:15 volumio-toby startx[1430]: xinit: unable to connect to X server: Connection refused Feb 21 15:35:15 volumio-toby startx[1430]: xinit: server error Feb 21 15:35:15 volumio-toby systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Feb 21 15:35:15 volumio-toby systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Feb 21 15:35:16 volumio-toby volumio[1196]: info: Setting Geolocation for MyVolumio to eu2 Feb 21 15:35:16 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:16 volumio-toby volumio[1196]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 21 15:35:17 volumio-toby volumio[1196]: info: Updating MyVolumio device info Feb 21 15:35:17 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:17 volumio-toby volumio[1196]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 21 15:35:17 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:17.486Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:49672 Feb 21 15:35:17 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:17.489Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:59168 Feb 21 15:35:17 volumio-toby volumio[1666]: ................................................................................................................................................................++++ Feb 21 15:35:20 volumio-toby volumio[1666]: ..............................................................++++ Feb 21 15:35:20 volumio-toby volumio[1666]: e is 65537 (0x010001) Feb 21 15:35:20 volumio-toby volumio[1666]: writing RSA key Feb 21 15:35:21 volumio-toby systemd[1]: systemd-timedated.service: Succeeded. Feb 21 15:35:21 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:21 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:21 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:21 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:21 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:21 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:21 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 15:35:21 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:21 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:24 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 15:35:24 volumio-toby volumio[1196]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 21 15:35:24 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:24 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:27 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:27.983Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:48576 Feb 21 15:35:27 volumio-toby volumio5-onboarding[1344]: time=2026-02-21T15:35:27.984Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:45324 Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetBrowseSources Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 15:35:29 volumio-toby volumio[1196]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 21 15:35:29 volumio-toby volumio[1196]: info: Completed starting MyVolumio Plugin Feb 21 15:35:29 volumio-toby volumio[1196]: [Metrics] CommandRouter: 31s 285.77ms Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::volumiosetStartupVolume Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::Close All Modals sent Feb 21 15:35:29 volumio-toby volumio[1196]: info: CoreCommandRouter::Close All Modals sent Feb 21 15:35:29 volumio-toby volumio[1196]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Feb 21 15:35:29 volumio-toby volumio[1196]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Feb 21 15:35:29 volumio-toby volumio[1196]: aplay: main:828: audio open error: No such device Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 15:35:30 volumio-toby volumio-remote-updater[657]: No test mode Feb 21 15:35:30 volumio-toby volumio-remote-updater[657]: No alpha test mode Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 21 15:35:30 volumio-toby volumio[1196]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 15:35:30 volumio-toby volumio5-onboarding[1344]: failed to bootstrap state: failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded Feb 21 15:35:30 volumio-toby systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 21 15:35:30 volumio-toby systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 21 15:35:30 volumio-toby systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Feb 21 15:35:30 volumio-toby systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Feb 21 15:35:30 volumio-toby systemd[1]: Stopped Volumio5 Onboarding Server. Feb 21 15:35:30 volumio-toby systemd[1]: Started Volumio5 Onboarding Server. Feb 21 15:35:30 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:30.717Z level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 21 15:35:30 volumio-toby volumio[1196]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 15:35:30 volumio-toby volumio[1196]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Feb 21 15:35:30 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:30 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:30 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:30 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:30.728Z level=INFO msg="system info for f44a1c2276fad658a0d7bf748bf3efad" deviceName=Volumio-Toby deviceVariant=volumio deviceModel= softwareVersion=3.908 Feb 21 15:35:30 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:30 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:30 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:30 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:30.755Z level=INFO msg="enabling local network discovery" Feb 21 15:35:30 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:30.782Z level=INFO msg="bootstrapping state" hasInternet=true Feb 21 15:35:30 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:30 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:30 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:30 volumio-toby volumio-remote-updater[657]: No test mode Feb 21 15:35:30 volumio-toby volumio-remote-updater[657]: No alpha test mode Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 15:35:30 volumio-toby volumio[1196]: aplay: device_list:272: no soundcards found... Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 21 15:35:30 volumio-toby volumio[1196]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:30 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 15:35:31 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:31.381Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:45346 Feb 21 15:35:31 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:31.400Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.148:48604 Feb 21 15:35:32 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:32.127Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Feb 21 15:35:32 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:32.128Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Feb 21 15:35:32 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:32.128Z level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Feb 21 15:35:32 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:32.128Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Feb 21 15:35:32 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:32 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:32 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 15:35:32 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:32 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 15:35:33 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:33.928Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=FFjpb97no6Qpu2JY8d5DEaKMLF63 tokenExpiry=2026-02-21T16:35:33.928Z Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:35 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:35 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:35 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:35 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:35 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:35 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:35 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:36 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:36 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:36 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:36 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:36 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:36 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:36 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:36 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:36 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:36 volumio-toby volumio[1196]: info: BOOT COMPLETED Feb 21 15:35:37 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:37 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:37 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:37 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:37 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:37 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:37 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:37 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:37 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:38 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:38 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:38 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:38 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:38 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:38 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:38 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 21 15:35:38 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:38 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.978Z level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" latency=-140.399978ms platform=PLATFORM_ANDROID version=5.260115.0 Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.980Z level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" latency=-142.450793ms timeout=10s Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.980Z level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" Feb 21 15:35:46 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:46 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:46 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.982Z level=INFO msg="emitting device name changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" name=Volumio-Toby Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.984Z level=INFO msg="emitting device language changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" language=en Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.985Z level=INFO msg="emitting device timezone changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" timezone=Europe/London Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.986Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" available=true connected=true macAddress=d8:3a:dd:bd:7f:20 ip4Address=192.168.0.173/24 ip6Address= Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.989Z level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" available=true connected=true macAddress=d8:3a:dd:bd:7f:21 ip4Address=192.168.0.175/24 ip6Address= ssid=VM4262719 Feb 21 15:35:46 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:46.989Z level=INFO msg="emitting device setup status changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" setupComplete=true Feb 21 15:35:46 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 21 15:35:47 volumio-toby volumio[1196]: aplay: device_list:272: no soundcards found... Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 21 15:35:47 volumio-toby volumio[1196]: amixer -c 0 info | grep "vc4-hdmi-0" Feb 21 15:35:47 volumio-toby volumio[1196]: Invalid card number. Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.017Z level=WARN msg="active output device not found in available devices" component=volumio/socket activeDeviceId=0 Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.017Z level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" selectedOutputId=0 Feb 21 15:35:47 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:47 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:47 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.044Z level=INFO msg="emitting software info changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" currentVersion=3.908 latestVersion=3.908 Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.044Z level=INFO msg="emitting software update progress event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" status=UPDATE_STATUS_NONE progress=0 Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.044Z level=INFO msg="emitting user changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" userId=FFjpb97no6Qpu2JY8d5DEaKMLF63 Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.044Z level=INFO msg="emitting music providers changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" providers=9 Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.044Z level=INFO msg="emitting plugins changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" plugins=54 Feb 21 15:35:47 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:47 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.047Z level=INFO msg="emitting player state changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" state=STATUS_STOPPED positionMs=0 volume=100 Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.047Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" id= title= Feb 21 15:35:47 volumio-toby volumio5-onboarding[1817]: time=2026-02-21T15:35:47.080Z level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.148:48604,192.168.0.148:45346 @ 0x1800b10" latency=-150.806127ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 21 15:35:47 volumio-toby sudo[1895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 15:35:47 volumio-toby sudo[1895]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:47 volumio-toby sudo[1895]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:47 volumio-toby sudo[1898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 15:35:47 volumio-toby sudo[1898]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:47 volumio-toby sudo[1898]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:47 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173 from 192.168.0.148 UA: Mozilla/5.0 (Linux; Android 15; CPH2493 Build/AP3A.240617.008; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.79 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 15:35:48 volumio-toby ntpd[863]: Soliciting pool server 131.111.8.60 Feb 21 15:35:48 volumio-toby sudo[1901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 15:35:48 volumio-toby sudo[1901]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:48 volumio-toby sudo[1901]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:48 volumio-toby sudo[1904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 15:35:48 volumio-toby sudo[1904]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:35:48 volumio-toby sudo[1904]: pam_unix(sudo:session): session closed for user root Feb 21 15:35:48 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.173 from 192.168.0.148 UA: Mozilla/5.0 (Linux; Android 15; CPH2493 Build/AP3A.240617.008; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.79 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetVisibleSources Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:48 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 21 15:35:48 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:48 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:48 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:48 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:48 volumio-toby volumio[1196]: info: Listing playlists Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 15:35:48 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 21 15:35:49 volumio-toby ntpd[863]: Soliciting pool server 178.79.184.152 Feb 21 15:35:49 volumio-toby ntpd[863]: Soliciting pool server 195.171.43.10 Feb 21 15:35:49 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 21 15:35:50 volumio-toby ntpd[863]: Soliciting pool server 88.80.189.24 Feb 21 15:35:50 volumio-toby ntpd[863]: Soliciting pool server 131.111.8.63 Feb 21 15:35:50 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:50 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:50 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:50 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:50 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:50 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:50 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:50 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:50 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 15:35:51 volumio-toby ntpd[863]: Soliciting pool server 83.217.166.45 Feb 21 15:35:51 volumio-toby ntpd[863]: Soliciting pool server 185.103.119.60 Feb 21 15:35:51 volumio-toby ntpd[863]: Soliciting pool server 212.71.233.40 Feb 21 15:35:51 volumio-toby ntpd[863]: Soliciting pool server 194.213.3.203 Feb 21 15:35:52 volumio-toby ntpd[863]: Soliciting pool server 176.58.109.184 Feb 21 15:35:52 volumio-toby ntpd[863]: Soliciting pool server 213.219.38.86 Feb 21 15:35:52 volumio-toby ntpd[863]: Soliciting pool server 109.74.192.36 Feb 21 15:35:53 volumio-toby ntpd[863]: Soliciting pool server 178.215.228.24 Feb 21 15:35:53 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:53 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:35:53 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:53 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:53 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:53 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:53 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:53 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:54 volumio-toby ntpd[863]: Soliciting pool server 109.74.197.50 Feb 21 15:35:55 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 15:35:55 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 15:35:57 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:35:57 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:35:57 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:35:57 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:35:57 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:35:57 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:35:57 volumio-toby volumio[1196]: verbose: New Socket.io Connection to 192.168.0.175:3000 from 192.168.0.148 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Feb 21 15:35:57 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 15:35:57 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 15:35:58 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 21 15:35:59 volumio-toby volumio[1196]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 15:36:06 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 21 15:36:06 volumio-toby volumio[1196]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 21 15:36:06 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 21 15:36:06 volumio-toby volumio[1196]: info: Received Get System Version Feb 21 15:36:06 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 15:36:06 volumio-toby volumio[1196]: info: Received Get System Info Feb 21 15:36:06 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 15:36:06 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 15:36:06 volumio-toby volumio[1196]: info: Discovery: Getting this device information Feb 21 15:36:06 volumio-toby volumio[1196]: info: CoreCommandRouter::volumioGetState Feb 21 15:36:06 volumio-toby volumio[1196]: info: CorePlayQueue::getTrack 0 Feb 21 15:36:06 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 15:36:08 volumio-toby volumio[1196]: info: CALLMETHOD: user_interface touch_display saveOrientationConf [object Object] Feb 21 15:36:08 volumio-toby volumio[1196]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveOrientationConf Feb 21 15:36:08 volumio-toby sudo[1935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Feb 21 15:36:08 volumio-toby sudo[1935]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 15:36:08 volumio-toby sudo[1935]: pam_unix(sudo:session): session closed for user root Feb 21 15:36:08 volumio-toby volumio[1196]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Feb 21 15:36:08 volumio-toby volumio[1196]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 15:36:08 volumio-toby volumio[1196]: TypeError: Cannot read property 'split' of undefined Feb 21 15:36:08 volumio-toby volumio[1196]: at /data/plugins/user_interface/touch_display/index.js:1258:37 Feb 21 15:36:08 volumio-toby volumio[1196]: at ChildProcess.exithandler (child_process.js:299:7) Feb 21 15:36:08 volumio-toby volumio[1196]: at ChildProcess.emit (events.js:315:20) Feb 21 15:36:08 volumio-toby volumio[1196]: at maybeClose (internal/child_process.js:1048:16) Feb 21 15:36:08 volumio-toby volumio[1196]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) Feb 21 15:36:08 volumio-toby volumio[1196]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 15:36:09 volumio-toby sudo[1946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 15:35 Feb 21 15:36:09 volumio-toby sudo[1946]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"