Dec 20 16:21:00 usbridge volumio[1021]: Unhandled rejection Error: No sockets available, cannot start. Dec 20 16:21:00 usbridge volumio[1021]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Dec 20 16:21:00 usbridge volumio[1021]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Dec 20 16:21:00 usbridge volumio[1021]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Dec 20 16:21:00 usbridge volumio[1021]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Dec 20 16:21:00 usbridge volumio[1021]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Dec 20 16:21:00 usbridge volumio[1021]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Dec 20 16:21:00 usbridge volumio[1021]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Dec 20 16:21:00 usbridge volumio[1021]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Dec 20 16:21:00 usbridge volumio[1021]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Dec 20 16:21:00 usbridge volumio[1021]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Dec 20 16:21:00 usbridge volumio[1021]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Dec 20 16:21:00 usbridge volumio[1021]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Dec 20 16:21:00 usbridge volumio[1021]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Dec 20 16:21:00 usbridge volumio[1021]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Dec 20 16:21:00 usbridge volumio[1021]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Dec 20 16:21:00 usbridge volumio[1021]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 20 16:21:00 usbridge sudo[1285]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 16:21:00 usbridge sudo[1285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:00 usbridge sudo[1285]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:00 usbridge volumio[1021]: info: touch_display: No backlight interface detected. Dec 20 16:21:01 usbridge sudo[1288]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 16:21:01 usbridge sudo[1288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:01 usbridge volumio[1021]: info: touch_display: systemctl disable getty@tty1.service succeeded. Dec 20 16:21:01 usbridge volumio[1021]: info: MPD Permissions set Dec 20 16:21:01 usbridge volumio[1021]: info: MPD Permissions set Dec 20 16:21:01 usbridge sudo[1232]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:01 usbridge sudo[1288]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:01 usbridge sudo[1228]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:01 usbridge volumio[1021]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 20 16:21:01 usbridge volumio[1021]: info: touch_display: systemctl stop getty@tty1.service succeeded. Dec 20 16:21:01 usbridge volumio[1021]: info: touch_display: systemctl daemon-reload succeeded. Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge sudo[1297]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Dec 20 16:21:01 usbridge sudo[1297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 16:21:01 usbridge volumio[1134]: Starting albumart workers Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge sudo[1293]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Dec 20 16:21:01 usbridge sudo[1293]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge sudo[1293]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 16:21:01 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:01 usbridge systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Dec 20 16:21:02 usbridge sudo[1297]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:02 usbridge volumio[1133]: Starting albumart workers Dec 20 16:21:02 usbridge volumio[1132]: Starting albumart workers Dec 20 16:21:02 usbridge volumio[1021]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Dec 20 16:21:02 usbridge volumio[1021]: info: touch_display: Volumio Kiosk started. Dec 20 16:21:02 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:02 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:02 usbridge volumio[1021]: info: touch_display: IframeKeyboardBridge extension installed successfully Dec 20 16:21:02 usbridge startx[1334]: X.Org X Server 1.21.1.7 Dec 20 16:21:02 usbridge startx[1334]: X Protocol Version 11, Revision 0 Dec 20 16:21:02 usbridge startx[1334]: Current Operating System: Linux usbridge 6.12.47-v7+ #1904 SMP Mon Sep 15 13:05:52 BST 2025 armv7l Dec 20 16:21:02 usbridge startx[1334]: Kernel command line: coherent_pool=1M snd_bcm2835.enable_headphones=0 cgroup_disable=memory snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1024 bcm2708_fb.fbheight=600 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:F2:58:B0 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=ttyAMA0,115200 console=tty1 imgpart=UUID=dafa3844-b779-48cd-9b4c-01ecfd09e0f4 imgfile=/volumio_current.sqsh bootpart=UUID=3B89-0B23 datapart=UUID=752d19ad-b702-471d-847a-f79ae83515d0 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 Dec 20 16:21:02 usbridge startx[1334]: xorg-server 2:21.1.7-3+rpt3+deb12u11 (https://www.debian.org/support) Dec 20 16:21:02 usbridge startx[1334]: Current version of pixman: 0.44.0 Dec 20 16:21:02 usbridge startx[1334]: Before reporting problems, check http://wiki.x.org Dec 20 16:21:02 usbridge startx[1334]: to make sure that you have the latest version. Dec 20 16:21:02 usbridge startx[1334]: Markers: (--) probed, (**) from config file, (==) default setting, Dec 20 16:21:02 usbridge startx[1334]: (++) from command line, (!!) notice, (II) informational, Dec 20 16:21:02 usbridge startx[1334]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Dec 20 16:21:02 usbridge startx[1334]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Dec 20 16:21:02 2025 Dec 20 16:21:02 usbridge startx[1334]: (==) Using config directory: "/etc/X11/xorg.conf.d" Dec 20 16:21:02 usbridge startx[1334]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Dec 20 16:21:02 usbridge volumio[1021]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Dec 20 16:21:02 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:02 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:02 usbridge volumio[1021]: info: Starting Shairport Sync Dec 20 16:21:02 usbridge sudo[1338]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Dec 20 16:21:02 usbridge volumio[1021]: info: Starting Shairport Sync Dec 20 16:21:02 usbridge sudo[1338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:02 usbridge sudo[1338]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:02 usbridge volumio[1021]: info: Starting Shairport Sync Dec 20 16:21:02 usbridge sudo[1340]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 16:21:02 usbridge sudo[1340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:02 usbridge sudo[1343]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 16:21:02 usbridge sudo[1343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:02 usbridge systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 20 16:21:02 usbridge systemd[1]: shairport-sync.service: Deactivated successfully. Dec 20 16:21:02 usbridge systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 20 16:21:02 usbridge systemd[1]: shairport-sync.service: Consumed 1.731s CPU time. Dec 20 16:21:03 usbridge sudo[1347]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 16:21:03 usbridge sudo[1347]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:03 usbridge systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 20 16:21:03 usbridge sudo[1343]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:03 usbridge sudo[1340]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:03 usbridge volumio[1021]: info: touch_display: X display number found: 0 Dec 20 16:21:03 usbridge systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 20 16:21:03 usbridge systemd[1]: shairport-sync.service: Deactivated successfully. Dec 20 16:21:03 usbridge systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 20 16:21:03 usbridge systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 20 16:21:03 usbridge sudo[1347]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:03 usbridge volumio[1021]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Dec 20 16:21:03 usbridge volumio[1021]: info: Shairport-Sync Started Dec 20 16:21:03 usbridge volumio[1021]: Error adding Membership: Error: addMembership EINVAL Dec 20 16:21:03 usbridge sudo[1368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 20 16:21:03 usbridge sudo[1368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:03 usbridge volumio[1021]: info: Shairport-Sync Started Dec 20 16:21:03 usbridge volumio[1021]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Dec 20 16:21:04 usbridge volumio[1021]: info: touch_display: X display number found: 0 Dec 20 16:21:04 usbridge volumio[1021]: info: Shairport-Sync Started Dec 20 16:21:04 usbridge startx[1334]: (EE) Dec 20 16:21:04 usbridge startx[1334]: Fatal server error: Dec 20 16:21:04 usbridge startx[1334]: (EE) no screens found(EE) Dec 20 16:21:04 usbridge startx[1334]: (EE) Dec 20 16:21:04 usbridge startx[1334]: Please consult the The X.Org Foundation support Dec 20 16:21:04 usbridge startx[1334]: at http://wiki.x.org Dec 20 16:21:04 usbridge startx[1334]: for help. Dec 20 16:21:04 usbridge startx[1334]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Dec 20 16:21:04 usbridge startx[1334]: (EE) Dec 20 16:21:04 usbridge startx[1334]: (EE) Server terminated with error (1). Closing log file. Dec 20 16:21:04 usbridge volumio[1021]: error: touch_display: Error determining the video outputs: Error: Command failed: /usr/bin/xrandr -display :0 Dec 20 16:21:04 usbridge volumio[1021]: Can't open display :0 Dec 20 16:21:04 usbridge systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 20 16:21:04 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:04 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:05 usbridge mpd[1206]: 2025-12-20T16:21:05 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 20 16:21:05 usbridge systemd[1]: Started mpd.service - Music Player Daemon. Dec 20 16:21:05 usbridge sudo[1179]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:05 usbridge sudo[1190]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:05 usbridge volumio[1021]: info: Completed starting Core Plugins Dec 20 16:21:05 usbridge volumio[1021]: info: ------------------------------------------- Dec 20 16:21:05 usbridge volumio[1021]: info: ----- MyVolumio plugins startup ---- Dec 20 16:21:05 usbridge volumio[1021]: info: ------------------------------------------- Dec 20 16:21:05 usbridge volumio[1021]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 20 16:21:05 usbridge volumio[1021]: info: MPD running with PID1206 Dec 20 16:21:05 usbridge volumio[1021]: ,establishing connection Dec 20 16:21:05 usbridge volumio[1021]: error: MPD error: The expression evaluated to a falsy value: Dec 20 16:21:05 usbridge volumio[1021]: assert.ok(self.idling) Dec 20 16:21:05 usbridge volumio[1021]: error: The expression evaluated to a falsy value: Dec 20 16:21:05 usbridge volumio[1021]: assert.ok(self.idling) Dec 20 16:21:05 usbridge volumio[1021]: error: MPD error: The expression evaluated to a falsy value: Dec 20 16:21:05 usbridge volumio[1021]: assert.ok(self.idling) Dec 20 16:21:05 usbridge volumio[1021]: error: The expression evaluated to a falsy value: Dec 20 16:21:05 usbridge volumio[1021]: assert.ok(self.idling) Dec 20 16:21:05 usbridge volumio[1021]: error: updateQueue error: null Dec 20 16:21:07 usbridge dhcpcd[736]: timed out Dec 20 16:21:07 usbridge sh[720]: timed out Dec 20 16:21:07 usbridge sh[645]: ifup: failed to bring up eth0 Dec 20 16:21:07 usbridge systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 20 16:21:07 usbridge systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 20 16:21:08 usbridge sudo[1410]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 20 16:21:08 usbridge sudo[1410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:08 usbridge systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 20 16:21:08 usbridge sudo[1414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 20 16:21:08 usbridge sudo[1414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:21:08 usbridge mpd_monitor.sh[1413]: MPD Monitor Service: Starting MPD Monitor Service Dec 20 16:21:08 usbridge sudo[1410]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:08 usbridge volumio[1021]: info: Successfully started MPD Monitor Dec 20 16:21:08 usbridge systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Dec 20 16:21:08 usbridge systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 20 16:21:08 usbridge systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 20 16:21:08 usbridge sudo[1368]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:08 usbridge systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 20 16:21:08 usbridge systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 20 16:21:08 usbridge systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 20 16:21:08 usbridge systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 20 16:21:08 usbridge sudo[1414]: pam_unix(sudo:session): session closed for user root Dec 20 16:21:08 usbridge mpd_monitor.sh[1420]: MPD Monitor Service: Starting MPD Monitor Service Dec 20 16:21:08 usbridge volumio[1021]: info: Upmpdcli Daemon Started Dec 20 16:21:08 usbridge volumio[1021]: info: Successfully started MPD Monitor Dec 20 16:21:10 usbridge volumio[1021]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 20 16:21:11 usbridge volumio[1021]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.073&uuid=efcda4eecce4a6354245a72180e1907e" http://updates.volumio.org/downloader-v1/track-device Dec 20 16:21:11 usbridge volumio[1021]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 20 16:21:11 usbridge volumio[1021]: Dload Upload Total Spent Left Speed Dec 20 16:21:11 usbridge volumio[1021]: [132B blob data] Dec 20 16:21:11 usbridge volumio[1021]: retrying in 5 seconds, trial 0 Dec 20 16:21:11 usbridge volumio[1021]: info: Volumio Calling Home Dec 20 16:21:17 usbridge startx[1333]: xinit: giving up Dec 20 16:21:17 usbridge startx[1333]: xinit: unable to connect to X server: Connection refused Dec 20 16:21:17 usbridge startx[1333]: xinit: server error Dec 20 16:21:17 usbridge systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Dec 20 16:21:17 usbridge systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Dec 20 16:21:17 usbridge systemd[1]: volumio-kiosk.service: Consumed 1.072s CPU time. Dec 20 16:21:17 usbridge systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 20 16:21:19 usbridge dhcpcd[779]: eth0: carrier acquired Dec 20 16:21:19 usbridge kernel: ax88179_178a 1-1.3:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0xC1E1 Dec 20 16:21:19 usbridge dhcpcd[779]: eth0: IAID f7:00:a8:81 Dec 20 16:21:19 usbridge dhcpcd[779]: eth0: soliciting a DHCP lease Dec 20 16:21:20 usbridge dhcpcd[779]: eth0: offered 192.168.0.83 from 192.168.0.1 Dec 20 16:21:20 usbridge dhcpcd[779]: eth0: probing address 192.168.0.83/24 Dec 20 16:21:20 usbridge ifplugd(eth0)[949]: Link beat detected. Dec 20 16:21:20 usbridge dhcpcd[779]: eth0: soliciting an IPv6 router Dec 20 16:21:20 usbridge ifplugd(eth0)[949]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Dec 20 16:21:20 usbridge ifplugd(eth0)[949]: client: command failed: No such device (-19) Dec 20 16:21:20 usbridge dhcpcd[779]: control command: dhcpcd eth0 Dec 20 16:21:20 usbridge ifplugd(eth0)[949]: client: sending commands to dhcpcd process Dec 20 16:21:20 usbridge dhcpcd[779]: control_free: No such file or directory Dec 20 16:21:21 usbridge ifplugd(eth0)[949]: Program executed successfully. Dec 20 16:21:21 usbridge volumio[1021]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.073&uuid=efcda4eecce4a6354245a72180e1907e" http://updates.volumio.org/downloader-v1/track-device Dec 20 16:21:21 usbridge volumio[1021]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 20 16:21:21 usbridge volumio[1021]: Dload Upload Total Spent Left Speed Dec 20 16:21:21 usbridge volumio[1021]: [132B blob data] Dec 20 16:21:21 usbridge volumio[1021]: retrying in 5 seconds, trial 1 Dec 20 16:21:21 usbridge volumio[1021]: info: Volumio Calling Home Dec 20 16:21:23 usbridge bash[1451]: setdatetime-helper: all HTTPS Date fallbacks failed Dec 20 16:21:23 usbridge systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 20 16:21:23 usbridge systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 20 16:21:24 usbridge dhcpcd[779]: eth0: leased 192.168.0.83 for 7200 seconds Dec 20 16:21:24 usbridge avahi-daemon[648]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.83. Dec 20 16:21:24 usbridge avahi-daemon[648]: New relevant interface eth0.IPv4 for mDNS. Dec 20 16:21:24 usbridge dhcpcd[779]: eth0: adding route to 192.168.0.0/24 Dec 20 16:21:24 usbridge avahi-daemon[648]: Registering new address record for 192.168.0.83 on eth0.IPv4. Dec 20 16:21:24 usbridge dhcpcd[779]: eth0: adding default route via 192.168.0.1 Dec 20 16:21:24 usbridge volumio[1021]: verbose: New Socket.io Connection to 192.168.0.83 from 192.168.0.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 20 16:21:24 usbridge systemd[1]: welcome.service: Deactivated successfully. Dec 20 16:21:24 usbridge systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 20 16:21:24 usbridge systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 20 16:21:24 usbridge volumio[1021]: verbose: New Socket.io Connection to 192.168.0.83 from 192.168.0.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 20 16:21:24 usbridge volumio[1021]: verbose: New Socket.io Connection to 192.168.0.83 from 192.168.0.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 20 16:21:24 usbridge systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 20 16:21:24 usbridge welcome[1585]: Resolved ip:[1] 192.168.0.83 Dec 20 16:21:24 usbridge systemd[1]: Started nmbd.service - Samba NMB Daemon. Dec 20 16:21:24 usbridge systemd[1]: Starting winbind.service - Samba Winbind Daemon... Dec 20 16:21:24 usbridge systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 20 16:21:24 usbridge systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 20 16:21:25 usbridge volumio[1021]: error: MyVolumio Plugin failed to start in a timely fashion Dec 20 16:21:25 usbridge volumio[1021]: [Metrics] CommandRouter: 39s 859.83ms Dec 20 16:21:25 usbridge volumio[1021]: info: CoreCommandRouter::volumiosetStartupVolume Dec 20 16:21:25 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 16:21:25 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 16:21:25 usbridge winbindd[1595]: [2025/12/20 16:21:25.439882, 0] ../../source3/winbindd/winbindd.c:1440(main) Dec 20 16:21:25 usbridge winbindd[1595]: winbindd version 4.17.8-Raspbian started. Dec 20 16:21:25 usbridge winbindd[1595]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 20 16:21:25 usbridge volumio[1021]: info: CoreCommandRouter::Close All Modals sent Dec 20 16:21:25 usbridge volumio[1021]: info: CoreCommandRouter::Close All Modals sent Dec 20 16:21:25 usbridge winbindd[1595]: [2025/12/20 16:21:25.462617, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) Dec 20 16:21:25 usbridge winbindd[1595]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 20 16:21:25 usbridge systemd[1]: Started winbind.service - Samba Winbind Daemon. Dec 20 16:21:25 usbridge volumio[1021]: info: Discovery: this is already registered, 071a2344-7cf4-41f8-b797-a1e9c7f52fc8 Dec 20 16:21:25 usbridge volumio[1021]: info: Discovery: Found device Usbridge Dec 20 16:21:25 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:25 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:25 usbridge systemd[1]: Starting smbd.service - Samba SMB Daemon... Dec 20 16:21:25 usbridge ntpd[930]: IO: Listen normally on 3 eth0 192.168.0.83:123 Dec 20 16:21:25 usbridge ntpd[930]: IO: new interface(s) found: waking up resolver Dec 20 16:21:25 usbridge ntpd[930]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 16:21:25 usbridge ntpd[930]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Dec 20 16:21:25 usbridge ntpd[930]: DNS: Pool taking: 175.210.18.47 Dec 20 16:21:25 usbridge ntpd[930]: DNS: Pool taking: 158.247.202.103 Dec 20 16:21:25 usbridge ntpd[930]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Dec 20 16:21:26 usbridge smbd[1614]: [2025/12/20 16:21:26.225928, 0] ../../source3/smbd/server.c:1741(main) Dec 20 16:21:26 usbridge smbd[1614]: smbd version 4.17.8-Raspbian started. Dec 20 16:21:26 usbridge smbd[1614]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 20 16:21:26 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 20 16:21:26 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 20 16:21:26 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 20 16:21:26 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 16:21:26 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 16:21:26 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 16:21:26 usbridge ntpd[930]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 16:21:26 usbridge ntpd[930]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Dec 20 16:21:26 usbridge ntpd[930]: DNS: Pool taking: 221.151.118.78 Dec 20 16:21:26 usbridge ntpd[930]: DNS: Pool taking: 3.39.176.65 Dec 20 16:21:26 usbridge ntpd[930]: DNS: Pool taking: 2001:678:8::123 Dec 20 16:21:26 usbridge ntpd[930]: DNS: Pool taking: 240b:400d:3:3300:aeda:71da:9779:d4f1 Dec 20 16:21:26 usbridge ntpd[930]: DNS: Pool taking: 2401:c080:1c00:24a1:5400:5ff:fe04:720 Dec 20 16:21:26 usbridge ntpd[930]: DNS: Pool taking: 240b:400d:3:3300:aeda:71da:9779:d8f1 Dec 20 16:21:26 usbridge ntpd[930]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Dec 20 16:21:27 usbridge volumio[1021]: verbose: New Socket.io Connection to 192.168.0.83 from 192.168.0.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:27 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:21:27 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 16:21:27 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:21:27 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:27 usbridge volumio[1021]: info: Listing playlists Dec 20 16:21:27 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetQueue Dec 20 16:21:27 usbridge volumio[1021]: info: CoreStateMachine::getQueue Dec 20 16:21:27 usbridge volumio[1021]: info: CorePlayQueue::getQueue Dec 20 16:21:27 usbridge systemd[1]: Started smbd.service - Samba SMB Daemon. Dec 20 16:21:27 usbridge systemd[1]: Reached target multi-user.target - Multi-User System. Dec 20 16:21:27 usbridge systemd[1]: Reached target graphical.target - Graphical Interface. Dec 20 16:21:27 usbridge systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Dec 20 16:21:27 usbridge systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 20 16:21:27 usbridge ntpd[930]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 16:21:27 usbridge ntpd[930]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 20 16:21:27 usbridge ntpd[930]: DNS: Pool taking: 194.0.5.123 Dec 20 16:21:27 usbridge systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Dec 20 16:21:27 usbridge ntpd[930]: DNS: Pool taking: 121.174.142.82 Dec 20 16:21:27 usbridge ntpd[930]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 20 16:21:27 usbridge systemd[1]: Startup finished in 15.688s (kernel) + 56.625s (userspace) = 1min 12.314s. Dec 20 16:21:28 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:21:28 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:28 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:28 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:28 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:28 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 16:21:28 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:21:28 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:28 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:28 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:28 usbridge volumio[1021]: info: Listing playlists Dec 20 16:21:28 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetQueue Dec 20 16:21:28 usbridge volumio[1021]: info: CoreStateMachine::getQueue Dec 20 16:21:28 usbridge volumio[1021]: info: CorePlayQueue::getQueue Dec 20 16:21:28 usbridge ntpd[930]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 16:21:28 usbridge ntpd[930]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 20 16:21:28 usbridge ntpd[930]: DNS: Pool taking: 175.195.167.194 Dec 20 16:21:28 usbridge ntpd[930]: DNS: Pool taking: 27.102.137.217 Dec 20 16:21:28 usbridge ntpd[930]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 20 16:21:29 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:21:29 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 16:21:29 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:21:29 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:29 usbridge volumio[1021]: info: Listing playlists Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetQueue Dec 20 16:21:29 usbridge volumio[1021]: info: CoreStateMachine::getQueue Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getQueue Dec 20 16:21:29 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:21:29 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:21:29 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:21:29 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:21:30 usbridge volumio[1021]: info: Volumio Network Manager: Network status updated: 1 Dec 20 16:21:30 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 16:21:32 usbridge volumio[1021]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.073&uuid=efcda4eecce4a6354245a72180e1907e" http://updates.volumio.org/downloader-v1/track-device Dec 20 16:21:32 usbridge volumio[1021]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 20 16:21:32 usbridge volumio[1021]: Dload Upload Total Spent Left Speed Dec 20 16:21:32 usbridge volumio[1021]: [132B blob data] Dec 20 16:21:32 usbridge volumio[1021]: retrying in 5 seconds, trial 2 Dec 20 16:21:32 usbridge volumio[1021]: info: Volumio Calling Home Dec 20 16:21:32 usbridge volumio[1021]: info: BOOT COMPLETED Dec 20 16:21:58 usbridge ntpd[930]: CLOCK: time stepped by 25.630986 Dec 20 16:21:58 usbridge ntpd[930]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 20 16:22:00 usbridge volumio[1021]: info: Volumio called home Dec 20 16:22:00 usbridge sudo[1666]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 16:22:00 usbridge sudo[1666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:00 usbridge sudo[1666]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:00 usbridge sudo[1669]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 16:22:00 usbridge sudo[1669]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:00 usbridge sudo[1669]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:00 usbridge volumio[1021]: verbose: New Socket.io Connection to 192.168.0.83 from 192.168.0.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 20 16:22:00 usbridge volumio[1021]: info: Adding plugin bluetooth to MyMusic Plugins Dec 20 16:22:00 usbridge volumio[1021]: info: Adding plugin multiroom to MyMusic Plugins Dec 20 16:22:00 usbridge volumio[1021]: info: Adding plugin metavolumio to MyMusic Plugins Dec 20 16:22:00 usbridge volumio[1021]: info: Adding plugin cd_controller to MyMusic Plugins Dec 20 16:22:00 usbridge volumio[1021]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 20 16:22:00 usbridge volumio[1021]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 20 16:22:00 usbridge volumio[1021]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 20 16:22:00 usbridge volumio[1021]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 20 16:22:04 usbridge volumio[1021]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 20 16:22:04 usbridge volumio[1021]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 20 16:22:04 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 16:22:04 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 16:22:04 usbridge volumio[1021]: info: Starting MyVolumio Remote Streaming Endpoints Dec 20 16:22:04 usbridge volumio[1021]: info: MyVolumio login type: Token Dec 20 16:22:04 usbridge volumio[1021]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 20 16:22:04 usbridge volumio[1021]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 20 16:22:08 usbridge volumio[1021]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 20 16:22:08 usbridge volumio[1021]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 20 16:22:08 usbridge volumio[1021]: info: Streaming services startup Dec 20 16:22:08 usbridge volumio[1021]: info: Starting Streaming Daemon Dec 20 16:22:08 usbridge sudo[1688]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 20 16:22:08 usbridge sudo[1688]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:08 usbridge volumio[1021]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 20 16:22:08 usbridge sudo[1688]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:09 usbridge volumio[1021]: error: Cannot start Volumio Streaming Daemon Dec 20 16:22:09 usbridge volumio[1021]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 20 16:22:09 usbridge volumio[1021]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 20 16:22:09 usbridge sudo[1695]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 16:22:09 usbridge sudo[1695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:09 usbridge sudo[1695]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:09 usbridge sudo[1697]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 16:22:09 usbridge sudo[1697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:09 usbridge sudo[1697]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:09 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:22:09 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:09 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:22:09 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 16:22:09 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:22:09 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:22:09 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:09 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:10 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:10 usbridge volumio[1021]: info: Listing playlists Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetQueue Dec 20 16:22:10 usbridge volumio[1021]: info: CoreStateMachine::getQueue Dec 20 16:22:10 usbridge volumio[1021]: info: CorePlayQueue::getQueue Dec 20 16:22:10 usbridge volumio[1021]: info: Received Get System Info Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 16:22:10 usbridge volumio[1021]: info: Discovery: Getting this device information Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:10 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 16:22:10 usbridge volumio[1021]: info: CoreCommandRouter::volumioGetState Dec 20 16:22:10 usbridge volumio[1021]: info: CorePlayQueue::getTrack 0 Dec 20 16:22:10 usbridge sudo[1703]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Dec 20 16:22:10 usbridge sudo[1703]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:10 usbridge sudo[1703]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:10 usbridge sudo[1705]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Dec 20 16:22:10 usbridge sudo[1705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:10 usbridge sudo[1709]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Dec 20 16:22:10 usbridge sudo[1709]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:10 usbridge sudo[1710]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Dec 20 16:22:10 usbridge sudo[1710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 16:22:11 usbridge systemd[1]: Reloading. Dec 20 16:22:11 usbridge volumio[1021]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 20 16:22:11 usbridge volumio[1021]: verbose: New Socket.io Connection to 192.168.0.83 from 192.168.0.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 20 16:22:11 usbridge volumio[1021]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Dec 20 16:22:11 usbridge volumio[1021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 16:22:12 usbridge volumio[1021]: TypeError: Cannot read properties of undefined (reading 'split') Dec 20 16:22:12 usbridge volumio[1021]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Dec 20 16:22:12 usbridge volumio[1021]: at ChildProcess.exithandler (node:child_process:413:7) Dec 20 16:22:12 usbridge volumio[1021]: at ChildProcess.emit (node:events:514:28) Dec 20 16:22:12 usbridge volumio[1021]: at maybeClose (node:internal/child_process:1105:16) Dec 20 16:22:12 usbridge volumio[1021]: at Socket. (node:internal/child_process:457:11) Dec 20 16:22:12 usbridge volumio[1021]: at Socket.emit (node:events:514:28) Dec 20 16:22:12 usbridge volumio[1021]: at Pipe. (node:net:337:12) Dec 20 16:22:12 usbridge volumio[1021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 16:22:12 usbridge sudo[1709]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:12 usbridge systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 20 16:22:12 usbridge systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 20 16:22:12 usbridge sudo[1705]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:12 usbridge sudo[1710]: pam_unix(sudo:session): session closed for user root Dec 20 16:22:16 usbridge sudo[1763]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-20 16:21' Dec 20 16:22:16 usbridge sudo[1763]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"