-- Logs begin at Mon 2025-11-03 18:38:49 CST, end at Mon 2025-11-03 18:40:32 CST. -- Nov 03 18:39:00 volumio dhcpcd[707]: wlan0: soliciting a DHCP lease Nov 03 18:39:00 volumio dhcpcd[707]: wlan0: soliciting a DHCP lease Nov 03 18:39:00 volumio dhcpcd[707]: wlan0: offered 192.168.100.116 from 192.168.100.1 Nov 03 18:39:00 volumio dhcpcd[707]: wlan0: offered 192.168.100.116 from 192.168.100.1 Nov 03 18:39:00 volumio dhcpcd[707]: wlan0: probing address 192.168.100.116/24 Nov 03 18:39:00 volumio dhcpcd[707]: wlan0: probing address 192.168.100.116/24 Nov 03 18:39:00 volumio kernel: platform USBC000:00: deferred probe pending Nov 03 18:39:00 volumio wireless.js[710]: trying... Nov 03 18:39:00 volumio sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 03 18:39:00 volumio sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:00 volumio sudo[1026]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:01 volumio volumio-time-update[704]: volumio-time-update-util: Fetching time from Volumio... Nov 03 18:39:01 volumio volumio-time-update[704]: volumio-time-update-util: Date not found in response Nov 03 18:39:01 volumio volumio-time-update[704]: volumio-time-update-util: Retrying in 5 seconds... Nov 03 18:39:01 volumio wireless.js[710]: trying... Nov 03 18:39:01 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 03 18:39:01 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:01 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:02 volumio wireless.js[710]: trying... Nov 03 18:39:02 volumio sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 03 18:39:02 volumio sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:02 volumio sudo[1037]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:03 volumio wireless.js[710]: trying... Nov 03 18:39:03 volumio sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 03 18:39:03 volumio sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:03 volumio sudo[1040]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:04 volumio volumio-remote-updater[699]: [2025-11-03 18:39:04] [info] asio async_connect error: system:111 (Connection refused) Nov 03 18:39:04 volumio volumio-remote-updater[699]: [2025-11-03 18:39:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 03 18:39:04 volumio volumio-remote-updater[699]: [2025-11-03 18:39:04] [error] handle_connect error: Underlying Transport Error Nov 03 18:39:04 volumio wireless.js[710]: trying... Nov 03 18:39:04 volumio dhcpcd[707]: wlan0: leased 192.168.100.116 for 43200 seconds Nov 03 18:39:04 volumio dhcpcd[707]: wlan0: leased 192.168.100.116 for 43200 seconds Nov 03 18:39:04 volumio sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 03 18:39:04 volumio sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:04 volumio sudo[1043]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:04 volumio avahi-daemon[712]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.116. Nov 03 18:39:04 volumio dhcpcd[707]: wlan0: adding route to 192.168.100.0/24 Nov 03 18:39:04 volumio dhcpcd[707]: wlan0: adding route to 192.168.100.0/24 Nov 03 18:39:04 volumio dhcpcd[707]: wlan0: adding default route via 192.168.100.1 Nov 03 18:39:04 volumio dhcpcd[707]: wlan0: adding default route via 192.168.100.1 Nov 03 18:39:04 volumio avahi-daemon[712]: New relevant interface wlan0.IPv4 for mDNS. Nov 03 18:39:04 volumio avahi-daemon[712]: Registering new address record for 192.168.100.116 on wlan0.IPv4. Nov 03 18:39:04 volumio ntpd[841]: ntpd exiting on signal 15 (Terminated) Nov 03 18:39:04 volumio systemd[1]: Stopping Network Time Service... Nov 03 18:39:04 volumio systemd[1]: ntp.service: Succeeded. Nov 03 18:39:04 volumio systemd[1]: Stopped Network Time Service. Nov 03 18:39:05 volumio systemd[1]: Starting Network Time Service... Nov 03 18:39:05 volumio ntpd[1079]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 03 18:39:05 volumio ntpd[1079]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Nov 03 18:39:05 volumio systemd[1]: Started Network Time Service. Nov 03 18:39:05 volumio ntpd[1085]: proto: precision = 0.063 usec (-24) Nov 03 18:39:05 volumio ntpd[1085]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 03 18:39:05 volumio ntpd[1085]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 03 18:39:05 volumio ntpd[1085]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1042 days ago Nov 03 18:39:05 volumio ntpd[1085]: Listen and drop on 0 v6wildcard [::]:123 Nov 03 18:39:05 volumio ntpd[1085]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 03 18:39:05 volumio ntpd[1085]: Listen normally on 2 lo 127.0.0.1:123 Nov 03 18:39:05 volumio ntpd[1085]: Listen normally on 3 wlan0 192.168.100.116:123 Nov 03 18:39:05 volumio ntpd[1085]: Listening on routing socket on fd #20 for interface updates Nov 03 18:39:05 volumio ntpd[1085]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 03 18:39:05 volumio ntpd[1085]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 03 18:39:05 volumio dhcpcd[707]: forked to background, child pid 1087 Nov 03 18:39:05 volumio dhcpcd[707]: forked to background, child pid 1087 Nov 03 18:39:05 volumio systemd[1]: Started DHCP Client Daemon. Nov 03 18:39:05 volumio wireless.js[710]: trying... Nov 03 18:39:05 volumio sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 03 18:39:05 volumio sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:05 volumio sudo[1089]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:05 volumio wireless.js[710]: Connected to: ----Xiaomi_lf28_5G Nov 03 18:39:05 volumio wireless.js[710]: ---- Nov 03 18:39:05 volumio sudo[1092]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 18:39:05 volumio sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:05 volumio sudo[1092]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:05 volumio wireless.js[710]: ... joined AP, wlan0 IPv4 is 192.168.100.116, ipV6 is undefined Nov 03 18:39:05 volumio wireless.js[710]: It's done! AP Nov 03 18:39:05 volumio systemd[1]: Started Wireless Services. Nov 03 18:39:05 volumio systemd[1]: Started Volumio Backend Module. Nov 03 18:39:05 volumio systemd[1]: Started Volumio Cpu Tweaker. Nov 03 18:39:05 volumio systemd[1]: Started Start Volumio Kiosk. Nov 03 18:39:05 volumio systemd[1]: Started Intel SST and HDA soundcard init service. Nov 03 18:39:06 volumio volumio-cpu-tweak[1098]: Setting RT Priority for mpd Nov 03 18:39:06 volumio volumio-cpu-tweak[1098]: Not enough cores to set MPD affinity Nov 03 18:39:06 volumio volumio-cpu-tweak[1098]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 03 18:39:06 volumio ntpd[1085]: Soliciting pool server 193.182.111.12 Nov 03 18:39:06 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 03 18:39:06 volumio startx[1099]: X.Org X Server 1.20.4 Nov 03 18:39:06 volumio startx[1099]: X Protocol Version 11, Revision 0 Nov 03 18:39:06 volumio startx[1099]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Nov 03 18:39:06 volumio startx[1099]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Nov 03 18:39:06 volumio startx[1099]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=47887e29-9707-47e6-b0dd-43e3e80bada7 bootpart=UUID=C2C3-4C63 datapart=UUID=28747106-f667-4326-abe4-5435a33543d6 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Nov 03 18:39:06 volumio startx[1099]: Build Date: 18 December 2021 09:05:36AM Nov 03 18:39:06 volumio startx[1099]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Nov 03 18:39:06 volumio startx[1099]: Current version of pixman: 0.36.0 Nov 03 18:39:06 volumio startx[1099]: Before reporting problems, check http://wiki.x.org Nov 03 18:39:06 volumio startx[1099]: to make sure that you have the latest version. Nov 03 18:39:06 volumio startx[1099]: Markers: (--) probed, (**) from config file, (==) default setting, Nov 03 18:39:06 volumio startx[1099]: (++) from command line, (!!) notice, (II) informational, Nov 03 18:39:06 volumio startx[1099]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Nov 03 18:39:06 volumio startx[1099]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Nov 3 18:39:06 2025 Nov 03 18:39:06 volumio startx[1099]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Nov 03 18:39:06 volumio systemd[1]: soundcard-init.service: Succeeded. Nov 03 18:39:06 volumio kernel: broken atomic modeset userspace detected, disabling atomic Nov 03 18:39:06 volumio volumio-time-update[704]: volumio-time-update-util: Fetching time from Volumio... Nov 03 18:39:06 volumio startx[1099]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Nov 03 18:39:06 volumio volumio[1097]: info: ------------------------------------------- Nov 03 18:39:06 volumio volumio[1097]: info: ----- Volumio3 ---- Nov 03 18:39:06 volumio volumio[1097]: info: ------------------------------------------- Nov 03 18:39:06 volumio volumio[1097]: info: ----- System startup ---- Nov 03 18:39:06 volumio volumio[1097]: info: ------------------------------------------- Nov 03 18:39:07 volumio ntpd[1085]: Soliciting pool server 119.28.206.193 Nov 03 18:39:07 volumio ntpd[1085]: Soliciting pool server 193.182.111.142 Nov 03 18:39:07 volumio nmbd[819]: [2025/11/03 18:39:07.130510, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 03 18:39:07 volumio systemd[1]: Started Samba NMB Daemon. Nov 03 18:39:07 volumio nmbd[819]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 03 18:39:07 volumio systemd[1]: Starting Samba Winbind Daemon... Nov 03 18:39:07 volumio winbindd[1242]: [2025/11/03 18:39:07.294443, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 03 18:39:07 volumio winbindd[1242]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 03 18:39:07 volumio systemd[1]: Started Samba Winbind Daemon. Nov 03 18:39:07 volumio winbindd[1242]: [2025/11/03 18:39:07.302200, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 03 18:39:07 volumio winbindd[1242]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 03 18:39:07 volumio systemd[1]: Starting Samba SMB Daemon... Nov 03 18:39:07 volumio volumio-time-update[704]: volumio-time-update-util: Setting system time to: 2025-11-03 18:39:07 Nov 03 18:39:07 volumio sudo[1266]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-11-03 18:39:07 Nov 03 18:39:07 volumio sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:07 volumio dbus-daemon[698]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.8' (uid=0 pid=1267 comm="timedatectl set-time 2025-11-03 18:39:07 ") Nov 03 18:39:07 volumio systemd[1]: Starting Time & Date Service... Nov 03 18:39:07 volumio dbus-daemon[698]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 03 18:39:07 volumio systemd[1]: Started Time & Date Service. Nov 03 18:39:07 volumio systemd-timedated[1268]: Changed local time to Mon Nov 3 18:39:07 2025 Nov 03 18:39:07 volumio sudo[1266]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:07 volumio volumio-time-update[704]: volumio-time-update-util: System time updated successfully. Nov 03 18:39:07 volumio systemd[1]: Started Volumio Time Update Utility. Nov 03 18:39:07 volumio volumio[1097]: info: MYVOLUMIO Environment detected Nov 03 18:39:07 volumio systemd[1]: Started Samba SMB Daemon. Nov 03 18:39:07 volumio smbd[1264]: [2025/11/03 18:39:07.088024, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 03 18:39:07 volumio systemd[1]: Reached target Multi-User System. Nov 03 18:39:07 volumio smbd[1264]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 03 18:39:07 volumio systemd[1]: Reached target Graphical Interface. Nov 03 18:39:07 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 03 18:39:07 volumio volumio[1097]: info: Plugin folders cleanup Nov 03 18:39:07 volumio volumio[1097]: info: Scanning into folder /volumio/app/plugins/ Nov 03 18:39:07 volumio volumio[1097]: info: Scanning category audio_interface Nov 03 18:39:07 volumio volumio[1097]: info: Scanning category miscellanea Nov 03 18:39:07 volumio volumio[1097]: info: Scanning category music_service Nov 03 18:39:07 volumio volumio[1097]: info: Scanning category plugins.json Nov 03 18:39:07 volumio volumio[1097]: info: Scanning category system_controller Nov 03 18:39:07 volumio volumio[1097]: info: Scanning category user_interface Nov 03 18:39:07 volumio volumio[1097]: info: Scanning into folder /data/plugins/ Nov 03 18:39:07 volumio volumio[1097]: info: Plugin folders cleanup completed Nov 03 18:39:07 volumio volumio[1097]: info: ------------------------------------------- Nov 03 18:39:07 volumio volumio[1097]: info: ----- Core plugins startup ---- Nov 03 18:39:07 volumio volumio[1097]: info: ------------------------------------------- Nov 03 18:39:07 volumio volumio[1097]: info: Loading plugins from folder /volumio/app/plugins/ Nov 03 18:39:07 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 03 18:39:07 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 03 18:39:07 volumio systemd[1]: Startup finished in 6.748s (firmware) + 9.459s (loader) + 6.846s (kernel) + 18.995s (userspace) = 42.049s. Nov 03 18:39:07 volumio volumio[1097]: info: Adding plugin upnp to MyMusic Plugins Nov 03 18:39:07 volumio volumio[1097]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 03 18:39:07 volumio volumio[1097]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 03 18:39:07 volumio volumio[1097]: info: Loading plugins from folder /data/plugins/ Nov 03 18:39:07 volumio volumio[1097]: info: Loading plugin "system"... Nov 03 18:39:07 volumio volumio[1097]: info: Loading plugin "appearance"... Nov 03 18:39:07 volumio ntpd[1085]: Soliciting pool server 139.199.214.202 Nov 03 18:39:07 volumio ntpd[1085]: Soliciting pool server 111.230.189.174 Nov 03 18:39:07 volumio ntpd[1085]: Soliciting pool server 193.182.111.143 Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "network"... Nov 03 18:39:08 volumio volumio[1097]: info: Refreshing Cached IP Addresses Nov 03 18:39:08 volumio sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "services"... Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "alsa_controller"... Nov 03 18:39:08 volumio sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:08 volumio sudo[1327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 18:39:08 volumio sudo[1325]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:08 volumio sudo[1327]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:08 volumio sudo[1327]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:08 volumio sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 03 18:39:08 volumio sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:08 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "wizard"... Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "networkfs"... Nov 03 18:39:08 volumio volumio[1097]: info: Starting Udev Watcher for removable devices Nov 03 18:39:08 volumio volumio[1097]: info: Ignoring mount for partition: boot Nov 03 18:39:08 volumio volumio[1097]: info: Ignoring mount for partition: volumio Nov 03 18:39:08 volumio volumio[1097]: info: Ignoring mount for partition: volumio_data Nov 03 18:39:08 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "volumio_command_line_client"... Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "upnp"... Nov 03 18:39:08 volumio volumio[1097]: info: [1762166348330] Starting Upmpd Daemon Nov 03 18:39:08 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "my_music"... Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "mpd"... Nov 03 18:39:08 volumio ntpd[1085]: Soliciting pool server 210.28.130.4 Nov 03 18:39:08 volumio ntpd[1085]: Soliciting pool server 101.43.66.2 Nov 03 18:39:08 volumio ntpd[1085]: Soliciting pool server 84.16.73.33 Nov 03 18:39:08 volumio ntpd[1085]: Soliciting pool server 84.16.67.12 Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "upnp_browser"... Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "alarm-clock"... Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "airplay_emulation"... Nov 03 18:39:08 volumio volumio[1097]: info: Starting Shairport Sync Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "last_100"... Nov 03 18:39:08 volumio volumio[1097]: info: Loading plugin "webradio"... Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "i2s_dacs"... Nov 03 18:39:09 volumio volumio[1097]: info: I2S DAC not set, start Auto-detection Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "volumiodiscovery"... Nov 03 18:39:09 volumio volumio[1097]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 03 18:39:09 volumio node[1097]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 03 18:39:09 volumio volumio[1097]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 18:39:09 volumio volumio[1097]: *** WARNING *** For more information see Nov 03 18:39:09 volumio volumio[1097]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 03 18:39:09 volumio volumio[1097]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 18:39:09 volumio volumio[1097]: *** WARNING *** For more information see Nov 03 18:39:09 volumio node[1097]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 18:39:09 volumio node[1097]: *** WARNING *** For more information see Nov 03 18:39:09 volumio node[1097]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 03 18:39:09 volumio node[1097]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 18:39:09 volumio node[1097]: *** WARNING *** For more information see Nov 03 18:39:09 volumio volumio[1097]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 03 18:39:09 volumio volumio[1097]: info: Discovery: Started advertising with name: Volumio Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "outputs"... Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "albumart"... Nov 03 18:39:09 volumio volumio[1097]: info: Plugin example_plugin is not enabled Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "inputs"... Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "updater_comm"... Nov 03 18:39:09 volumio volumio[1097]: Forking 1 albumart workers Nov 03 18:39:09 volumio volumio[1097]: info: Plugin mpdemulation is not enabled Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "rest_api"... Nov 03 18:39:09 volumio ntpd[1085]: Soliciting pool server 119.28.183.184 Nov 03 18:39:09 volumio ntpd[1085]: Soliciting pool server 185.209.85.222 Nov 03 18:39:09 volumio volumio[1097]: info: Loading plugin "websocket"... Nov 03 18:39:09 volumio volumio[1097]: info: Starting Socket.io Server version 2.3.0 Nov 03 18:39:09 volumio volumio[1097]: info: Loading i18n strings for locale zh Nov 03 18:39:09 volumio volumio[1097]: Updating browse sources language Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 18:39:09 volumio volumio[1097]: Starting albumart workers Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::initPlayerControls Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 18:39:09 volumio volumio[1097]: Express server listening on port 3000 Nov 03 18:39:09 volumio volumio[1097]: [Metrics] WebUI: 3s 568.86ms Nov 03 18:39:09 volumio volumio[1097]: info: Setting Device type: x86 Nov 03 18:39:09 volumio volumio[1097]: info: CoreStateMachine::resetVolumioState Nov 03 18:39:09 volumio volumio[1097]: info: CoreStateMachine::getcurrentVolume Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:09 volumio volumio[1097]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 03 18:39:09 volumio volumio[1097]: info: Completed loading Core Plugins Nov 03 18:39:09 volumio volumio[1097]: info: Preparing to generate the ALSA configuration file Nov 03 18:39:09 volumio volumio[1097]: info: Cannot read play queue from file Nov 03 18:39:09 volumio volumio[1097]: info: Volumio Network Manager: Network status updated: 2 Nov 03 18:39:09 volumio volumio[1097]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Nov 03 18:39:09 volumio volumio[1097]: info: Asound.conf file unchanged, so no further update is needed Nov 03 18:39:09 volumio volumio[1097]: info: Output device has changed, restarting MPD Nov 03 18:39:09 volumio volumio[1097]: info: Output device has changed, restarting Shairport Sync Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:09 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:09 volumio sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 18:39:09 volumio sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:09 volumio sudo[1420]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:09 volumio sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 18:39:09 volumio sudo[1422]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:10 volumio systemd[1]: Stopping Music Player Daemon... Nov 03 18:39:10 volumio volumio[1097]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 18:39:10 volumio volumio[1097]: info: ___________ START PLUGINS ___________ Nov 03 18:39:10 volumio volumio[1097]: info: ControllerMpd::onStart: Initializing MPD Nov 03 18:39:10 volumio volumio[1097]: info: Creating MPD Configuration file Nov 03 18:39:10 volumio systemd[1]: mpd.service: Succeeded. Nov 03 18:39:10 volumio systemd[1]: Stopped Music Player Daemon. Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 18:39:10 volumio volumio[1097]: info: [1762166350058] CoreMusicLibrary::Adding element 媒体服务器 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 18:39:10 volumio systemd[1]: Starting Music Player Daemon... Nov 03 18:39:10 volumio sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 18:39:10 volumio sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:10 volumio sudo[1436]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:10 volumio sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 18:39:10 volumio sudo[1447]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:10 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 03 18:39:10 volumio systemd[1]: mpd.service: Succeeded. Nov 03 18:39:10 volumio systemd[1]: Stopped Music Player Daemon. Nov 03 18:39:10 volumio systemd[1]: Starting Music Player Daemon... Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:10 volumio sudo[1450]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 18:39:10 volumio sudo[1450]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:10 volumio sudo[1450]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:10 volumio volumio[1097]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 18:39:10 volumio volumio[1097]: info: [1762166350194] CoreMusicLibrary::Adding element Last_100 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 18:39:10 volumio volumio[1097]: info: [1762166350195] CoreMusicLibrary::Adding element Webradio Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 18:39:10 volumio volumio[1097]: info: Initializing BBC Radios Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: Volumio Calling Home Nov 03 18:39:10 volumio volumio[1097]: info: CoreStateMachine::setRepeat null single undefined Nov 03 18:39:10 volumio volumio[1097]: info: CoreStateMachine::pushState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioPushState Nov 03 18:39:10 volumio volumio[1097]: info: CoreStateMachine::setRandom null Nov 03 18:39:10 volumio volumio[1097]: info: CoreStateMachine::pushState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioPushState Nov 03 18:39:10 volumio volumio[1097]: info: VolumeController:: Volume=41 Mute =false Nov 03 18:39:10 volumio volumio[1097]: info: CoreStateMachine::pushState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioPushState Nov 03 18:39:10 volumio volumio[1097]: info: CoreStateMachine::updateTrackBlock Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrackBlock Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 18:39:10 volumio ntpd[1085]: Soliciting pool server 162.159.200.1 Nov 03 18:39:10 volumio volumio[1097]: info: MPD Permissions set Nov 03 18:39:10 volumio volumio[1097]: info: MPD Permissions set Nov 03 18:39:10 volumio volumio[1097]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:10 volumio volumio[1097]: info: Discovery: adding db905a27-3a29-4611-8301-46bb0d76efd1 Nov 03 18:39:10 volumio volumio[1097]: info: Discovery: Found device Volumio Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: VolumeController:: Volume=41 Mute =false Nov 03 18:39:10 volumio volumio[1097]: info: CoreStateMachine::pushState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioPushState Nov 03 18:39:10 volumio volumio[1097]: info: Starting Shairport Sync Nov 03 18:39:10 volumio volumio[1097]: info: Starting Shairport Sync Nov 03 18:39:10 volumio sudo[1510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 18:39:10 volumio sudo[1510]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:10 volumio volumio[1097]: info: Starting Shairport Sync Nov 03 18:39:10 volumio sudo[1513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 18:39:10 volumio sudo[1513]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 18:39:10 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 18:39:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 18:39:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 18:39:10 volumio sudo[1510]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:10 volumio sudo[1513]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio sudo[1517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 18:39:10 volumio sudo[1517]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 18:39:10 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 18:39:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 18:39:10 volumio mpd[1458]: Nov 03 18:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 18:39:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 18:39:10 volumio systemd[1]: Started Music Player Daemon. Nov 03 18:39:10 volumio sudo[1422]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:10 volumio sudo[1447]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:10 volumio sudo[1517]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:10 volumio volumio[1097]: info: Shairport-Sync Started Nov 03 18:39:10 volumio volumio[1097]: Error adding Membership: Error: addMembership EINVAL Nov 03 18:39:10 volumio volumio[1097]: info: Shairport-Sync Started Nov 03 18:39:10 volumio volumio[1097]: verbose: New Socket.io Connection to 192.168.100.116:3000 from 192.168.100.139 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Nov 03 18:39:10 volumio volumio[1097]: verbose: New Socket.io Connection to 192.168.100.116 from 192.168.100.139 UA: Mozilla/5.0 (Linux; Android 16; 25113PN0EC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 03 18:39:10 volumio volumio[1097]: info: Shairport-Sync Started Nov 03 18:39:10 volumio volumio[1097]: info: Completed starting Core Plugins Nov 03 18:39:10 volumio volumio[1097]: info: ------------------------------------------- Nov 03 18:39:10 volumio volumio[1097]: info: ----- MyVolumio plugins startup ---- Nov 03 18:39:10 volumio volumio[1097]: info: ------------------------------------------- Nov 03 18:39:10 volumio volumio[1097]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 03 18:39:10 volumio volumio[1097]: error: MPD error: The expression evaluated to a falsy value: Nov 03 18:39:10 volumio volumio[1097]: assert.ok(self.idling) Nov 03 18:39:10 volumio volumio[1097]: error: The expression evaluated to a falsy value: Nov 03 18:39:10 volumio volumio[1097]: assert.ok(self.idling) Nov 03 18:39:10 volumio volumio[1097]: info: MPD running with PID1458 Nov 03 18:39:10 volumio volumio[1097]: ,establishing connection Nov 03 18:39:10 volumio volumio[1097]: error: updateQueue error: null Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 18:39:10 volumio volumio[1097]: error: updateQueue error: null Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 18:39:10 volumio volumio[1097]: info: Received Get System Info Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 18:39:10 volumio volumio[1097]: info: Discovery: Getting this device information Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 18:39:10 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:10 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:10 volumio volumio[1097]: info: Listing playlists Nov 03 18:39:11 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 18:39:11 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 18:39:11 volumio volumio[1097]: info: Discovery: Getting this device information Nov 03 18:39:11 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:11 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:11 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 18:39:11 volumio volumio[1097]: verbose: New Socket.io Connection to 192.168.100.116:3000 from 192.168.100.139 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Nov 03 18:39:11 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:11 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:11 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 03 18:39:11 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 03 18:39:11 volumio volumio[1097]: info: Volumio called home Nov 03 18:39:11 volumio ntpd[1085]: Soliciting pool server 139.199.215.251 Nov 03 18:39:11 volumio volumio[1097]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 03 18:39:12 volumio volumio[1097]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:12 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 18:39:12 volumio volumio[1097]: info: Received Get System Info Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 18:39:12 volumio volumio[1097]: info: Discovery: Getting this device information Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:12 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 18:39:12 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:12 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:12 volumio volumio[1097]: info: Listing playlists Nov 03 18:39:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 03 18:39:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 18:39:13 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:13 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:13 volumio sudo[1331]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:14 volumio ntpd[1085]: receive: Unexpected origin timestamp 0xecb304d1.75d90837 does not match aorg 0000000000.00000000 from server@84.16.67.12 xmt 0xecb304d2.a1cba8a2 Nov 03 18:39:14 volumio ntpd[1085]: receive: Unexpected origin timestamp 0xecb304d1.75dff673 does not match aorg 0000000000.00000000 from server@193.182.111.143 xmt 0xecb304d2.a313a5ca Nov 03 18:39:14 volumio ntpd[1085]: receive: Unexpected origin timestamp 0xecb304d1.75db4c44 does not match aorg 0000000000.00000000 from server@84.16.73.33 xmt 0xecb304d2.a356fda3 Nov 03 18:39:15 volumio volumio-remote-updater[699]: [2025-11-03 18:39:15] [connect] Successful connection Nov 03 18:39:15 volumio volumio-remote-updater[699]: [2025-11-03 18:39:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762166355 101 Nov 03 18:39:15 volumio volumio[1097]: 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: 7 Nov 03 18:39:15 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 18:39:15 volumio volumio[1097]: info: Received Get System Info Nov 03 18:39:15 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 18:39:15 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 18:39:15 volumio volumio[1097]: info: Discovery: Getting this device information Nov 03 18:39:15 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:15 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:15 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 18:39:15 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 03 18:39:16 volumio volumio[1097]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 03 18:39:19 volumio sudo[1566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 18:39:19 volumio sudo[1566]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:19 volumio sudo[1566]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:19 volumio sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 18:39:19 volumio sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:19 volumio sudo[1568]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:19 volumio sudo[1572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 03 18:39:19 volumio sudo[1572]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:19 volumio sudo[1572]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:19 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 03 18:39:19 volumio volumio[1097]: info: Upmpdcli Daemon Started Nov 03 18:39:19 volumio volumio[1574]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 03 18:39:19 volumio volumio[1574]: .......................++++ Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 03 18:39:20 volumio volumio[1097]: info: Adding plugin bluetooth to MyMusic Plugins Nov 03 18:39:20 volumio volumio[1097]: info: Adding plugin multiroom to MyMusic Plugins Nov 03 18:39:20 volumio volumio[1097]: info: Adding plugin metavolumio to MyMusic Plugins Nov 03 18:39:20 volumio volumio[1097]: info: Adding plugin cd_controller to MyMusic Plugins Nov 03 18:39:20 volumio volumio[1097]: info: Adding plugin qobuzconnect to MyMusic Plugins Nov 03 18:39:20 volumio volumio[1097]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 03 18:39:20 volumio volumio[1097]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 03 18:39:20 volumio volumio[1097]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 03 18:39:21 volumio volumio[1097]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 03 18:39:21 volumio volumio[1097]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 03 18:39:21 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:21 volumio volumio[1097]: info: Starting MyVolumio Remote Streaming Endpoints Nov 03 18:39:21 volumio volumio[1097]: info: MyVolumio not started Nov 03 18:39:21 volumio volumio[1097]: info: Initializing device activation check Nov 03 18:39:21 volumio volumio[1097]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 03 18:39:21 volumio volumio[1097]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 03 18:39:21 volumio systemd[1]: systemd-fsckd.service: Succeeded. Nov 03 18:39:21 volumio sh[631]: timed out Nov 03 18:39:21 volumio dhcpcd[674]: timed out Nov 03 18:39:21 volumio sh[631]: dhcpcd exited Nov 03 18:39:21 volumio dhcpcd[674]: dhcpcd exited Nov 03 18:39:21 volumio sh[631]: ifup: failed to bring up eth0 Nov 03 18:39:21 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 03 18:39:21 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 03 18:39:21 volumio volumio[1097]: info: Starting Streaming Service Transparent Proxy Nov 03 18:39:21 volumio volumio[1097]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 03 18:39:21 volumio volumio[1097]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 03 18:39:21 volumio volumio[1097]: info: Streaming services startup Nov 03 18:39:21 volumio volumio[1097]: info: Starting Streaming Daemon Nov 03 18:39:21 volumio sudo[1768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 18:39:21 volumio sudo[1768]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:21 volumio sudo[1768]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:21 volumio volumio[1097]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 03 18:39:21 volumio volumio[1097]: error: Cannot start Volumio Streaming Daemon Nov 03 18:39:21 volumio volumio[1097]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 18:39:21 volumio volumio[1097]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 18:39:22 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Nov 03 18:39:22 volumio volumio[1097]: STREAMING PROXY: Starting server on port 3245 Nov 03 18:39:22 volumio volumio[1097]: Node JS runtime: 14 Nov 03 18:39:23 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 18:39:23 volumio volumio[1574]: ..................................................................................................................................................................................................................................................................................................................................................................................................................................++++ Nov 03 18:39:23 volumio volumio[1574]: e is 65537 (0x010001) Nov 03 18:39:23 volumio volumio[1574]: writing RSA key Nov 03 18:39:24 volumio volumio[1097]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 18:39:24 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 03 18:39:24 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Nov 03 18:39:24 volumio sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Nov 03 18:39:24 volumio sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:24 volumio sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 03 18:39:24 volumio sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:24 volumio sudo[1800]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:24 volumio sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 03 18:39:24 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:24 volumio sudo[1811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 03 18:39:24 volumio sudo[1811]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:24 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:24 volumio sudo[1795]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:24 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 03 18:39:24 volumio sudo[1811]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:24 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 03 18:39:24 volumio sudo[1822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 18:39:24 volumio sudo[1822]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:24 volumio sudo[1821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 18:39:24 volumio sudo[1821]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:24 volumio sudo[1822]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:24 volumio sudo[1821]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:24 volumio sudo[1827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 03 18:39:24 volumio sudo[1827]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 18:39:29 volumio sudo[1827]: pam_unix(sudo:session): session closed for user root Nov 03 18:39:32 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 18:39:32 volumio volumio[1097]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 03 18:39:32 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 03 18:39:32 volumio volumio[1097]: info: Received Get System Version Nov 03 18:39:32 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 18:39:32 volumio volumio[1097]: info: Received Get System Info Nov 03 18:39:32 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 18:39:32 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 18:39:32 volumio volumio[1097]: info: Discovery: Getting this device information Nov 03 18:39:32 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:32 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:32 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 18:39:36 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 18:39:36 volumio volumio[1097]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 03 18:39:36 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:36 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:37 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 18:39:37 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 18:39:37 volumio volumio[1097]: info: Discovery: Getting this device information Nov 03 18:39:37 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:39:37 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:39:37 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 18:39:37 volumio systemd[1]: systemd-timedated.service: Succeeded. Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 18:39:41 volumio volumio-remote-updater[699]: No test mode Nov 03 18:39:41 volumio volumio-remote-updater[699]: No alpha test mode Nov 03 18:39:41 volumio volumio[1097]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 03 18:39:41 volumio volumio[1097]: info: Completed starting MyVolumio Plugin Nov 03 18:39:41 volumio volumio[1097]: [Metrics] CommandRouter: 34s 547.58ms Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::Close All Modals sent Nov 03 18:39:41 volumio volumio[1097]: info: CoreCommandRouter::Close All Modals sent Nov 03 18:39:42 volumio volumio[1097]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 18:39:42 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 18:39:42 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 18:39:42 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 18:39:42 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 18:39:48 volumio volumio[1097]: info: BOOT COMPLETED Nov 03 18:40:13 volumio volumio[1097]: verbose: New Socket.io Connection to 192.168.100.116:3000 from 192.168.100.139 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Nov 03 18:40:13 volumio volumio[1097]: verbose: New Socket.io Connection to 192.168.100.116:3000 from 192.168.100.139 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Nov 03 18:40:13 volumio volumio[1097]: verbose: New Socket.io Connection to 192.168.100.116 from 192.168.100.139 UA: Mozilla/5.0 (Linux; Android 16; 25113PN0EC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:40:13 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 18:40:13 volumio volumio[1097]: info: Received Get System Info Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 18:40:13 volumio volumio[1097]: info: Discovery: Getting this device information Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:40:13 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::volumioGetState Nov 03 18:40:13 volumio volumio[1097]: info: CorePlayQueue::getTrack 0 Nov 03 18:40:13 volumio volumio[1097]: info: Listing playlists Nov 03 18:40:13 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 18:40:25 volumio volumio[1097]: info: Retrieving Cloud Streaming UI Nov 03 18:40:25 volumio volumio[1097]: info: Getting Tidal Cloud Configuration Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 18:40:25 volumio volumio[1097]: info: Getting Qobuz Cloud Configuration Nov 03 18:40:25 volumio volumio[1097]: info: Asking plugin for UI Config Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 18:40:25 volumio volumio[1097]: info: Getting Spotify Cloud Configuration Nov 03 18:40:25 volumio volumio[1097]: info: Asking plugin for UI Config Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 18:40:25 volumio volumio[1097]: info: Saving Spotify Acccount Nov 03 18:40:25 volumio volumio[1097]: info: Got Tidal Cloud Configuration Nov 03 18:40:25 volumio volumio[1097]: info: Got it Nov 03 18:40:25 volumio volumio[1097]: info: Got it Nov 03 18:40:25 volumio volumio[1097]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 18:40:25 volumio volumio[1097]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 03 18:40:25 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 03 18:40:27 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 03 18:40:27 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 03 18:40:28 volumio volumio[1097]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fnOS-LF-2.local. -m SMB3_11 Nov 03 18:40:29 volumio volumio[1097]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 03 18:40:32 volumio volumio[1097]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 18:40:32 volumio volumio[1097]: Error: dns service error: unknown Nov 03 18:40:32 volumio volumio[1097]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Nov 03 18:40:32 volumio volumio[1097]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Nov 03 18:40:32 volumio volumio[1097]: errorCode: -65537 Nov 03 18:40:32 volumio volumio[1097]: } Nov 03 18:40:32 volumio volumio[1097]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 18:40:32 volumio sudo[2042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-03 18:39 Nov 03 18:40:32 volumio sudo[2042]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"