-- Logs begin at Thu 2025-12-18 17:20:47 CET, end at Thu 2025-12-18 17:22:55 CET. -- Dec 18 17:21:00 volumio-tarci wpa_supplicant[1301]: wlan0: Trying to associate with SSID 'Lenovo Tab M10 HD' Dec 18 17:21:00 volumio-tarci wpa_supplicant[1301]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Dec 18 17:21:00 volumio-tarci wpa_supplicant[1301]: wlan0: Associated with fa:a2:83:f3:b3:2b Dec 18 17:21:00 volumio-tarci wpa_supplicant[1301]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 18 17:21:00 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:00 volumio-tarci sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:00 volumio-tarci sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:00 volumio-tarci sudo[1309]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:00 volumio-tarci wpa_supplicant[1301]: wlan0: WPA: Key negotiation completed with fa:a2:83:f3:b3:2b [PTK=CCMP GTK=CCMP] Dec 18 17:21:00 volumio-tarci wpa_supplicant[1301]: wlan0: CTRL-EVENT-CONNECTED - Connection to fa:a2:83:f3:b3:2b completed [id=0 id_str=] Dec 18 17:21:00 volumio-tarci dhcpcd[1039]: wlan0: carrier acquired Dec 18 17:21:00 volumio-tarci dhcpcd[1039]: wlan0: IAID 43:e0:3b:3c Dec 18 17:21:00 volumio-tarci dhcpcd[1039]: wlan0: adding address fe80::d612:43ff:fee0:3b3c Dec 18 17:21:00 volumio-tarci dhcpcd[1039]: ipv6_addaddr1: Permission denied Dec 18 17:21:01 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:01 volumio-tarci sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:01 volumio-tarci sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:01 volumio-tarci sudo[1313]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:01 volumio-tarci dhcpcd[1039]: wlan0: soliciting an IPv6 router Dec 18 17:21:01 volumio-tarci dhcpcd[1039]: wlan0: soliciting a DHCP lease Dec 18 17:21:01 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:01 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:01 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:01 volumio-tarci dhcpcd[1039]: wlan0: offered 192.168.43.128 from 192.168.43.98 Dec 18 17:21:01 volumio-tarci dhcpcd[1039]: wlan0: probing address 192.168.43.128/24 Dec 18 17:21:02 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:02 volumio-tarci sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:02 volumio-tarci sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:02 volumio-tarci sudo[1321]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:03 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:03 volumio-tarci sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:03 volumio-tarci sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:03 volumio-tarci sudo[1324]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:04 volumio-tarci volumio-remote-updater[931]: [2025-12-18 17:21:04] [info] asio async_connect error: system:111 (Connection refused) Dec 18 17:21:04 volumio-tarci volumio-remote-updater[931]: [2025-12-18 17:21:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 18 17:21:04 volumio-tarci volumio-remote-updater[931]: [2025-12-18 17:21:04] [error] handle_connect error: Underlying Transport Error Dec 18 17:21:04 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:04 volumio-tarci sudo[1327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:04 volumio-tarci sudo[1327]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:04 volumio-tarci sudo[1327]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:05 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:05 volumio-tarci sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:05 volumio-tarci sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:05 volumio-tarci sudo[1330]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:06 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:06 volumio-tarci sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:06 volumio-tarci sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:06 volumio-tarci sudo[1333]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:06 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:06 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:06 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:07 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:07 volumio-tarci sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:07 volumio-tarci sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:07 volumio-tarci sudo[1341]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:07 volumio-tarci dhcpcd[1039]: wlan0: leased 192.168.43.128 for 3599 seconds Dec 18 17:21:07 volumio-tarci avahi-daemon[932]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.43.128. Dec 18 17:21:07 volumio-tarci dhcpcd[1039]: wlan0: adding route to 192.168.43.0/24 Dec 18 17:21:07 volumio-tarci avahi-daemon[932]: New relevant interface wlan0.IPv4 for mDNS. Dec 18 17:21:07 volumio-tarci dhcpcd[1039]: wlan0: adding default route via 192.168.43.98 Dec 18 17:21:07 volumio-tarci avahi-daemon[932]: Registering new address record for 192.168.43.128 on wlan0.IPv4. Dec 18 17:21:08 volumio-tarci nmbd[1122]: [2025/12/18 17:21:08.132475, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 18 17:21:08 volumio-tarci systemd[1]: Started Samba NMB Daemon. Dec 18 17:21:08 volumio-tarci nmbd[1122]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 18 17:21:08 volumio-tarci systemd[1]: Starting Samba Winbind Daemon... Dec 18 17:21:08 volumio-tarci ntpd[1131]: ntpd exiting on signal 15 (Terminated) Dec 18 17:21:08 volumio-tarci systemd[1]: Stopping Network Time Service... Dec 18 17:21:08 volumio-tarci systemd[1]: ntp.service: Succeeded. Dec 18 17:21:08 volumio-tarci systemd[1]: Stopped Network Time Service. Dec 18 17:21:08 volumio-tarci systemd[1]: Starting Network Time Service... Dec 18 17:21:08 volumio-tarci ntpd[1378]: ntpd 4.2.8p12@1.3728-o (1): Starting Dec 18 17:21:08 volumio-tarci ntpd[1378]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Dec 18 17:21:08 volumio-tarci systemd[1]: Started Network Time Service. Dec 18 17:21:08 volumio-tarci ntpd[1384]: proto: precision = 0.238 usec (-22) Dec 18 17:21:08 volumio-tarci ntpd[1384]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 18 17:21:08 volumio-tarci ntpd[1384]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Dec 18 17:21:08 volumio-tarci ntpd[1384]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1087 days ago Dec 18 17:21:08 volumio-tarci ntpd[1384]: Listen and drop on 0 v6wildcard [::]:123 Dec 18 17:21:08 volumio-tarci ntpd[1384]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 18 17:21:08 volumio-tarci ntpd[1384]: Listen normally on 2 lo 127.0.0.1:123 Dec 18 17:21:08 volumio-tarci ntpd[1384]: Listen normally on 3 wlan0 192.168.43.128:123 Dec 18 17:21:08 volumio-tarci ntpd[1384]: Listening on routing socket on fd #20 for interface updates Dec 18 17:21:08 volumio-tarci ntpd[1384]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 18 17:21:08 volumio-tarci ntpd[1384]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 18 17:21:08 volumio-tarci winbindd[1374]: [2025/12/18 17:21:08.446200, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 18 17:21:08 volumio-tarci winbindd[1374]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 18 17:21:08 volumio-tarci winbindd[1374]: [2025/12/18 17:21:08.453283, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 18 17:21:08 volumio-tarci winbindd[1374]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 18 17:21:08 volumio-tarci systemd[1]: Started Samba Winbind Daemon. Dec 18 17:21:08 volumio-tarci systemd[1]: Starting Samba SMB Daemon... Dec 18 17:21:08 volumio-tarci wireless.js[930]: trying... Dec 18 17:21:08 volumio-tarci sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 18 17:21:08 volumio-tarci sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:08 volumio-tarci sudo[1391]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:08 volumio-tarci wireless.js[930]: Connected to: ----Lenovo Tab M10 HD Dec 18 17:21:08 volumio-tarci wireless.js[930]: ---- Dec 18 17:21:08 volumio-tarci sudo[1394]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 17:21:08 volumio-tarci sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:08 volumio-tarci sudo[1394]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:08 volumio-tarci wireless.js[930]: ... joined AP, wlan0 IPv4 is 192.168.43.128, ipV6 is undefined Dec 18 17:21:08 volumio-tarci wireless.js[930]: It's done! AP Dec 18 17:21:08 volumio-tarci systemd[1]: Started Wireless Services. Dec 18 17:21:08 volumio-tarci systemd[1]: Started Volumio Backend Module. Dec 18 17:21:08 volumio-tarci systemd[1]: Started Volumio Cpu Tweaker. Dec 18 17:21:08 volumio-tarci systemd[1]: Started Start Volumio Kiosk. Dec 18 17:21:08 volumio-tarci systemd[1]: Started Intel SST and HDA soundcard init service. Dec 18 17:21:08 volumio-tarci volumio-cpu-tweak[1400]: Setting RT Priority for mpd Dec 18 17:21:08 volumio-tarci volumio-cpu-tweak[1400]: pid 35's current scheduling policy: SCHED_FIFO Dec 18 17:21:08 volumio-tarci volumio-cpu-tweak[1400]: pid 35's current scheduling priority: 99 Dec 18 17:21:08 volumio-tarci volumio-cpu-tweak[1400]: Setting MPD Affinity Dec 18 17:21:08 volumio-tarci volumio-cpu-tweak[1400]: pid 3's current affinity mask: f Dec 18 17:21:08 volumio-tarci volumio-cpu-tweak[1400]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Dec 18 17:21:08 volumio-tarci systemd[1]: volumio_cpu_tweak.service: Succeeded. Dec 18 17:21:08 volumio-tarci smbd[1390]: [2025/12/18 17:21:08.960081, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 18 17:21:08 volumio-tarci smbd[1390]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 18 17:21:08 volumio-tarci systemd[1]: Started Samba SMB Daemon. Dec 18 17:21:09 volumio-tarci startx[1401]: X.Org X Server 1.20.4 Dec 18 17:21:09 volumio-tarci startx[1401]: X Protocol Version 11, Revision 0 Dec 18 17:21:09 volumio-tarci startx[1401]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Dec 18 17:21:09 volumio-tarci startx[1401]: Current Operating System: Linux volumio-tarci 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Dec 18 17:21:09 volumio-tarci startx[1401]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=2596df44-b922-428b-b975-d4fe20acb57b bootpart=UUID=F294-731E datapart=UUID=4b1196bf-a5af-4ee9-a520-f0b30be1dd89 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 Dec 18 17:21:09 volumio-tarci startx[1401]: Build Date: 18 December 2021 09:05:36AM Dec 18 17:21:09 volumio-tarci startx[1401]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Dec 18 17:21:09 volumio-tarci startx[1401]: Current version of pixman: 0.36.0 Dec 18 17:21:09 volumio-tarci startx[1401]: Before reporting problems, check http://wiki.x.org Dec 18 17:21:09 volumio-tarci startx[1401]: to make sure that you have the latest version. Dec 18 17:21:09 volumio-tarci startx[1401]: Markers: (--) probed, (**) from config file, (==) default setting, Dec 18 17:21:09 volumio-tarci startx[1401]: (++) from command line, (!!) notice, (II) informational, Dec 18 17:21:09 volumio-tarci startx[1401]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Dec 18 17:21:09 volumio-tarci startx[1401]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Dec 18 17:21:09 2025 Dec 18 17:21:09 volumio-tarci startx[1401]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Dec 18 17:21:09 volumio-tarci ntpd[1384]: Soliciting pool server 95.110.254.234 Dec 18 17:21:09 volumio-tarci kernel: broken atomic modeset userspace detected, disabling atomic Dec 18 17:21:09 volumio-tarci systemd[1]: soundcard-init.service: Succeeded. Dec 18 17:21:10 volumio-tarci ntpd[1384]: Soliciting pool server 89.46.74.148 Dec 18 17:21:10 volumio-tarci ntpd[1384]: Soliciting pool server 185.19.184.35 Dec 18 17:21:10 volumio-tarci startx[1401]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Dec 18 17:21:11 volumio-tarci volumio[1399]: info: ------------------------------------------- Dec 18 17:21:11 volumio-tarci volumio[1399]: info: ----- Volumio3 ---- Dec 18 17:21:11 volumio-tarci volumio[1399]: info: ------------------------------------------- Dec 18 17:21:11 volumio-tarci volumio[1399]: info: ----- System startup ---- Dec 18 17:21:11 volumio-tarci volumio[1399]: info: ------------------------------------------- Dec 18 17:21:11 volumio-tarci ntpd[1384]: Soliciting pool server 85.199.214.99 Dec 18 17:21:11 volumio-tarci ntpd[1384]: Soliciting pool server 172.232.209.103 Dec 18 17:21:11 volumio-tarci ntpd[1384]: Soliciting pool server 172.232.208.229 Dec 18 17:21:11 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:12 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:12 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:12 volumio-tarci volumio[1399]: info: MYVOLUMIO Environment detected Dec 18 17:21:12 volumio-tarci ntpd[1384]: Soliciting pool server 185.157.229.254 Dec 18 17:21:12 volumio-tarci ntpd[1384]: Soliciting pool server 212.6.50.243 Dec 18 17:21:12 volumio-tarci ntpd[1384]: Soliciting pool server 151.22.209.90 Dec 18 17:21:12 volumio-tarci ntpd[1384]: Soliciting pool server 129.152.16.145 Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Plugin folders cleanup Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning into folder /volumio/app/plugins/ Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category audio_interface Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category miscellanea Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category music_service Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category plugins.json Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category system_controller Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category user_interface Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning into folder /data/plugins/ Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category music_service Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Scanning category user_interface Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Plugin folders cleanup completed Dec 18 17:21:12 volumio-tarci volumio[1399]: info: ------------------------------------------- Dec 18 17:21:12 volumio-tarci volumio[1399]: info: ----- Core plugins startup ---- Dec 18 17:21:12 volumio-tarci volumio[1399]: info: ------------------------------------------- Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Loading plugins from folder /volumio/app/plugins/ Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Adding plugin upnp to MyMusic Plugins Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Loading plugins from folder /data/plugins/ Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Loading plugin "system"... Dec 18 17:21:12 volumio-tarci volumio[1399]: info: Loading plugin "appearance"... Dec 18 17:21:13 volumio-tarci ntpd[1384]: Soliciting pool server 195.32.70.195 Dec 18 17:21:13 volumio-tarci ntpd[1384]: Soliciting pool server 81.56.230.156 Dec 18 17:21:14 volumio-tarci ntpd[1384]: Soliciting pool server 93.94.88.51 Dec 18 17:21:14 volumio-tarci volumio-remote-updater[931]: [2025-12-18 17:21:14] [connect] Successful connection Dec 18 17:21:14 volumio-tarci volumio[1399]: info: Loading plugin "network"... Dec 18 17:21:14 volumio-tarci volumio[1399]: info: Refreshing Cached IP Addresses Dec 18 17:21:14 volumio-tarci sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 17:21:14 volumio-tarci sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:14 volumio-tarci sudo[1639]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:14 volumio-tarci sudo[1641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 17:21:14 volumio-tarci sudo[1641]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:14 volumio-tarci sudo[1641]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:14 volumio-tarci volumio[1399]: info: Loading plugin "services"... Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Loading plugin "alsa_controller"... Dec 18 17:21:15 volumio-tarci sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 18 17:21:15 volumio-tarci sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:15 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Loading plugin "wizard"... Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Loading plugin "networkfs"... Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Starting Udev Watcher for removable devices Dec 18 17:21:15 volumio-tarci ntpd[1384]: Soliciting pool server 2a03:b020:0:403::254 Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Mounting Device 2Tera Dec 18 17:21:15 volumio-tarci sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/2Tera -o noatime Dec 18 17:21:15 volumio-tarci sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:15 volumio-tarci mount.exfat[1670]: volume was not unmounted cleanly Dec 18 17:21:15 volumio-tarci sudo[1668]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:15 volumio-tarci volumio[1399]: WARN: volume was not unmounted cleanly. Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Ignoring mount for partition: boot Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Ignoring mount for partition: volumio Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Ignoring mount for partition: volumio_data Dec 18 17:21:15 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Loading plugin "volumio_command_line_client"... Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Loading plugin "upnp"... Dec 18 17:21:15 volumio-tarci volumio[1399]: info: [1766074875927] Starting Upmpd Daemon Dec 18 17:21:15 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Loading plugin "my_music"... Dec 18 17:21:15 volumio-tarci volumio[1399]: info: Loading plugin "mpd"... Dec 18 17:21:16 volumio-tarci volumio[1399]: info: Loading plugin "upnp_browser"... Dec 18 17:21:16 volumio-tarci volumio[1399]: info: Loading plugin "alarm-clock"... Dec 18 17:21:17 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "airplay_emulation"... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Starting Shairport Sync Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "last_100"... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "webradio"... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "i2s_dacs"... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: I2S DAC not set, start Auto-detection Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "volumiodiscovery"... Dec 18 17:21:17 volumio-tarci volumio[1399]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 18 17:21:17 volumio-tarci volumio[1399]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 18 17:21:17 volumio-tarci volumio[1399]: *** WARNING *** For more information see Dec 18 17:21:17 volumio-tarci volumio[1399]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 18 17:21:17 volumio-tarci volumio[1399]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 18 17:21:17 volumio-tarci volumio[1399]: *** WARNING *** For more information see Dec 18 17:21:17 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:17 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:17 volumio-tarci node[1399]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 18 17:21:17 volumio-tarci node[1399]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 18 17:21:17 volumio-tarci node[1399]: *** WARNING *** For more information see Dec 18 17:21:17 volumio-tarci node[1399]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 18 17:21:17 volumio-tarci node[1399]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 18 17:21:17 volumio-tarci node[1399]: *** WARNING *** For more information see Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Discovery: Started advertising with name: Volumio Tarci Dec 18 17:21:17 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "outputs"... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "albumart"... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Plugin example_plugin is not enabled Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "inputs"... Dec 18 17:21:17 volumio-tarci volumio[1399]: info: Loading plugin "updater_comm"... Dec 18 17:21:17 volumio-tarci volumio[1399]: Forking 3 albumart workers Dec 18 17:21:18 volumio-tarci volumio[1399]: info: Plugin mpdemulation is not enabled Dec 18 17:21:18 volumio-tarci volumio[1399]: info: Loading plugin "rest_api"... Dec 18 17:21:18 volumio-tarci volumio[1399]: info: Loading plugin "websocket"... Dec 18 17:21:18 volumio-tarci volumio[1399]: info: Starting Socket.io Server version 2.3.0 Dec 18 17:21:18 volumio-tarci volumio[1399]: info: Loading plugin "80s80s"... Dec 18 17:21:18 volumio-tarci volumio[1399]: Starting albumart workers Dec 18 17:21:18 volumio-tarci sudo[1650]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:18 volumio-tarci volumio[1399]: Starting albumart workers Dec 18 17:21:18 volumio-tarci volumio[1399]: Starting albumart workers Dec 18 17:21:19 volumio-tarci volumio[1399]: info: Applying required configuration parameters for plugin 80s80s Dec 18 17:21:19 volumio-tarci volumio[1399]: info: [1766074879151] [80s80s] API delay: 30 Dec 18 17:21:19 volumio-tarci volumio[1399]: info: Loading plugin "minidlna"... Dec 18 17:21:19 volumio-tarci volumio[1399]: info: Applying required configuration parameters for plugin minidlna Dec 18 17:21:19 volumio-tarci volumio[1399]: info: Loading plugin "motherearthradio"... Dec 18 17:21:19 volumio-tarci volumio[1399]: info: Applying required configuration parameters for plugin motherearthradio Dec 18 17:21:19 volumio-tarci volumio[1399]: info: [1766074879793] [MotherEarth] API delay: 5 Dec 18 17:21:19 volumio-tarci volumio[1399]: info: Loading plugin "podcast"... Dec 18 17:21:19 volumio-tarci volumio[1399]: info: ControllerPodcast::constructor Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Loading plugin "radio_paradise"... Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Applying required configuration parameters for plugin radio_paradise Dec 18 17:21:20 volumio-tarci volumio[1399]: info: [1766074880374] [RadioParadise] API delay: 5 Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Loading i18n strings for locale it Dec 18 17:21:20 volumio-tarci volumio[1399]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Dec 18 17:21:20 volumio-tarci volumio[1399]: Updating browse sources language Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::initPlayerControls Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: Express server listening on port 3000 Dec 18 17:21:20 volumio-tarci volumio[1399]: [Metrics] WebUI: 10s 498.86ms Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Setting Device type: x86 Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreStateMachine::resetVolumioState Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreStateMachine::getcurrentVolume Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioRetrievevolume Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreStateMachine::pushState Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioPushState Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:20 volumio-tarci volumio[1399]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Completed loading Core Plugins Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Preparing to generate the ALSA configuration file Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Volumio Network Manager: Network status updated: 2 Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 18 17:21:20 volumio-tarci systemd[1]: systemd-fsckd.service: Succeeded. Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Reloading queue from file Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreStateMachine::setRepeat false single undefined Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreStateMachine::pushState Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioPushState Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreStateMachine::setRandom true Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreStateMachine::pushState Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 17:21:20 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioPushState Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Asound.conf file unchanged, so no further update is needed Dec 18 17:21:20 volumio-tarci volumio[1399]: info: Output device has changed, restarting MPD Dec 18 17:21:21 volumio-tarci sudo[1829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 18 17:21:21 volumio-tarci sudo[1829]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Output device has changed, restarting Shairport Sync Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:21 volumio-tarci sudo[1829]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:21 volumio-tarci sudo[1831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 18 17:21:21 volumio-tarci sudo[1831]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:21 volumio-tarci systemd[1]: Listening on mpd.socket. Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 17:21:21 volumio-tarci volumio[1399]: info: ___________ START PLUGINS ___________ Dec 18 17:21:21 volumio-tarci systemd[1]: Starting Music Player Daemon... Dec 18 17:21:21 volumio-tarci volumio[1399]: info: ControllerMpd::onStart: Initializing MPD Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Creating MPD Configuration file Dec 18 17:21:21 volumio-tarci sudo[1839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 18 17:21:21 volumio-tarci sudo[1839]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:21 volumio-tarci sudo[1839]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 18 17:21:21 volumio-tarci volumio[1399]: info: [1766074881180] CoreMusicLibrary::Adding element Server multimediali Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:21 volumio-tarci sudo[1842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 18 17:21:21 volumio-tarci sudo[1842]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:21 volumio-tarci sudo[1837]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 18 17:21:21 volumio-tarci sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:21 volumio-tarci sudo[1837]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:21 volumio-tarci systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 18 17:21:21 volumio-tarci systemd[1]: mpd.service: Succeeded. Dec 18 17:21:21 volumio-tarci systemd[1]: Stopped Music Player Daemon. Dec 18 17:21:21 volumio-tarci systemd[1]: Starting Music Player Daemon... Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 18 17:21:21 volumio-tarci volumio[1399]: info: [1766074881316] CoreMusicLibrary::Adding element Last_100 Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 18 17:21:21 volumio-tarci volumio[1399]: info: [1766074881319] CoreMusicLibrary::Adding element Webradio Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Initializing BBC Radios Dec 18 17:21:21 volumio-tarci sudo[1845]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 18 17:21:21 volumio-tarci sudo[1845]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:21 volumio-tarci sudo[1845]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 18 17:21:21 volumio-tarci sudo[1845]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 18 17:21:21 volumio-tarci volumio[1399]: info: [1766074881432] CoreMusicLibrary::Adding element 80s80s Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source 80s80s Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Loading i18n strings for locale it Dec 18 17:21:21 volumio-tarci volumio[1399]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 18 17:21:21 volumio-tarci volumio[1399]: info: [1766074881478] CoreMusicLibrary::Adding element Mother Earth Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source 80s80s Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source Mother Earth Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 18 17:21:21 volumio-tarci volumio[1399]: info: [1766074881491] CoreMusicLibrary::Adding element Podcast Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source 80s80s Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source Mother Earth Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source Podcast Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 18 17:21:21 volumio-tarci volumio[1399]: info: [1766074881500] CoreMusicLibrary::Adding element Radio Paradise Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source 80s80s Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source Mother Earth Radio Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source Podcast Dec 18 17:21:21 volumio-tarci volumio[1399]: Cannot find translation for source Radio Paradise Dec 18 17:21:21 volumio-tarci volumio[1399]: info: Volumio Calling Home Dec 18 17:21:21 volumio-tarci volumio[1399]: info: MPD Permissions set Dec 18 17:21:21 volumio-tarci volumio[1399]: info: MPD Permissions set Dec 18 17:21:21 volumio-tarci volumio[1399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Dec 18 17:21:21 volumio-tarci volumio[1399]: info: minidlna: Found miniDLNA version 1.2.1 Dec 18 17:21:21 volumio-tarci volumio[1399]: info: minidlna: Starting minidlna.service Dec 18 17:21:21 volumio-tarci sh[841]: timed out Dec 18 17:21:21 volumio-tarci sh[841]: dhcpcd exited Dec 18 17:21:21 volumio-tarci dhcpcd[885]: timed out Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci dhcpcd[885]: dhcpcd exited Dec 18 17:21:21 volumio-tarci sh[841]: ifup: failed to bring up eth0 Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 18 17:21:21 volumio-tarci systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:21 volumio-tarci sudo[1869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Dec 18 17:21:21 volumio-tarci sudo[1869]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:21 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 18 17:21:21 volumio-tarci systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Dec 18 17:21:21 volumio-tarci sudo[1869]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Discovery: adding 579b8a87-6083-4c7c-80a9-a80f874ddfcd Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Discovery: Found device Volumio Tarci Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:22 volumio-tarci volumio[1399]: info: minidlna: systemctl start minidlna.service succeeded. Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Volumio called home Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Starting Shairport Sync Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Starting Shairport Sync Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Starting Shairport Sync Dec 18 17:21:22 volumio-tarci sudo[1888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 17:21:22 volumio-tarci sudo[1888]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:22 volumio-tarci sudo[1890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 17:21:22 volumio-tarci sudo[1890]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:21:22 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:22 volumio-tarci sudo[1893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 17:21:22 volumio-tarci sudo[1893]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:22 volumio-tarci systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 18 17:21:22 volumio-tarci systemd[1]: shairport-sync.service: Succeeded. Dec 18 17:21:22 volumio-tarci systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 18 17:21:22 volumio-tarci systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 18 17:21:22 volumio-tarci systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 18 17:21:22 volumio-tarci sudo[1888]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:22 volumio-tarci systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 18 17:21:22 volumio-tarci systemd[1]: shairport-sync.service: Succeeded. Dec 18 17:21:22 volumio-tarci systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 18 17:21:22 volumio-tarci sudo[1890]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:22 volumio-tarci systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Shairport-Sync Started Dec 18 17:21:22 volumio-tarci sudo[1893]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:22 volumio-tarci volumio[1399]: Error adding Membership: Error: addMembership EINVAL Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Shairport-Sync Started Dec 18 17:21:22 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:22 volumio-tarci volumio[1399]: info: Shairport-Sync Started Dec 18 17:21:22 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:22 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:23 volumio-tarci mpd[1854]: Dec 18 17:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 18 17:21:23 volumio-tarci systemd[1]: Started Music Player Daemon. Dec 18 17:21:23 volumio-tarci sudo[1831]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:23 volumio-tarci sudo[1842]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:23 volumio-tarci volumio[1399]: info: Completed starting Core Plugins Dec 18 17:21:23 volumio-tarci volumio[1399]: info: ------------------------------------------- Dec 18 17:21:23 volumio-tarci volumio[1399]: info: ----- MyVolumio plugins startup ---- Dec 18 17:21:23 volumio-tarci volumio[1399]: info: ------------------------------------------- Dec 18 17:21:23 volumio-tarci volumio[1399]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 18 17:21:23 volumio-tarci systemd[1]: minidlna.service: Succeeded. Dec 18 17:21:23 volumio-tarci volumio[1399]: error: MPD error: The expression evaluated to a falsy value: Dec 18 17:21:23 volumio-tarci volumio[1399]: assert.ok(self.idling) Dec 18 17:21:23 volumio-tarci volumio[1399]: error: The expression evaluated to a falsy value: Dec 18 17:21:23 volumio-tarci volumio[1399]: assert.ok(self.idling) Dec 18 17:21:23 volumio-tarci volumio[1399]: info: MPD running with PID1854 Dec 18 17:21:23 volumio-tarci volumio[1399]: ,establishing connection Dec 18 17:21:23 volumio-tarci volumio[1399]: error: updateQueue error: null Dec 18 17:21:23 volumio-tarci volumio[1399]: error: updateQueue error: null Dec 18 17:21:24 volumio-tarci volumio[1399]: 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: 2 Dec 18 17:21:25 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 17:21:25 volumio-tarci volumio[1399]: 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: 3 Dec 18 17:21:25 volumio-tarci sudo[1927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 17:21:25 volumio-tarci sudo[1927]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:25 volumio-tarci sudo[1927]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:25 volumio-tarci sudo[1930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 17:21:25 volumio-tarci sudo[1930]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:26 volumio-tarci sudo[1930]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:26 volumio-tarci sudo[1933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 18 17:21:26 volumio-tarci sudo[1933]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:26 volumio-tarci systemd[1]: Started UPnP Renderer front-end to MPD. Dec 18 17:21:26 volumio-tarci sudo[1933]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:26 volumio-tarci volumio[1399]: info: Upmpdcli Daemon Started Dec 18 17:21:26 volumio-tarci volumio[1935]: Generating RSA private key, 4096 bit long modulus (2 primes) Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 17:21:26 volumio-tarci sudo[1952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 17:21:26 volumio-tarci sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:26 volumio-tarci systemd[1]: Started MPD Monitor Service. Dec 18 17:21:26 volumio-tarci sudo[1952]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:26 volumio-tarci volumio[1399]: info: Successfully started MPD Monitor Dec 18 17:21:26 volumio-tarci mpd_monitor.sh[1954]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 17:21:26 volumio-tarci sudo[1956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 17:21:26 volumio-tarci sudo[1956]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:21:26 volumio-tarci volumio[1935]: ..............++++ Dec 18 17:21:26 volumio-tarci systemd[1]: Stopping MPD Monitor Service... Dec 18 17:21:26 volumio-tarci systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 18 17:21:26 volumio-tarci systemd[1]: mpd_monitor.service: Succeeded. Dec 18 17:21:26 volumio-tarci systemd[1]: Stopped MPD Monitor Service. Dec 18 17:21:26 volumio-tarci systemd[1]: Started MPD Monitor Service. Dec 18 17:21:26 volumio-tarci sudo[1956]: pam_unix(sudo:session): session closed for user root Dec 18 17:21:26 volumio-tarci mpd_monitor.sh[1961]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 17:21:26 volumio-tarci volumio[1399]: info: Successfully started MPD Monitor Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 18 17:21:26 volumio-tarci volumio[1399]: info: Received Get System Info Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 17:21:26 volumio-tarci volumio[1399]: info: Discovery: Getting this device information Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:26 volumio-tarci volumio[1399]: info: Listing playlists Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 17:21:26 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:27 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 17:21:27 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:27 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:27 volumio-tarci volumio[1399]: info: Received Get System Info Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 17:21:27 volumio-tarci volumio[1399]: info: Discovery: Getting this device information Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:21:27 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 17:21:29 volumio-tarci volumio-remote-updater[931]: [2025-12-18 17:21:29] [connect] Successful connection Dec 18 17:21:30 volumio-tarci volumio-remote-updater[931]: [2025-12-18 17:21:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766074889 101 Dec 18 17:21:30 volumio-tarci volumio[1399]: 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: 4 Dec 18 17:21:31 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 18 17:21:32 volumio-tarci volumio[1935]: ...............................................................................................................................................................................................++++ Dec 18 17:21:32 volumio-tarci volumio[1935]: e is 65537 (0x010001) Dec 18 17:21:32 volumio-tarci volumio[1935]: writing RSA key Dec 18 17:21:32 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:33 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:33 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:35 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 17:21:35 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 18 17:21:36 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 18 17:21:38 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:38 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:38 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:43 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:43 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:43 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:43 volumio-tarci volumio[1399]: error: MyVolumio Plugin failed to start in a timely fashion Dec 18 17:21:43 volumio-tarci volumio[1399]: [Metrics] CommandRouter: 32s 542.73ms Dec 18 17:21:43 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumiosetStartupVolume Dec 18 17:21:43 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 17:21:43 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:43 volumio-tarci volumio[1399]: info: CoreCommandRouter::Close All Modals sent Dec 18 17:21:43 volumio-tarci volumio[1399]: info: CoreCommandRouter::Close All Modals sent Dec 18 17:21:44 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 18 17:21:44 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 17:21:44 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 18 17:21:48 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:48 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:48 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:50 volumio-tarci volumio[1399]: info: BOOT COMPLETED Dec 18 17:21:51 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 17:21:51 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 17:21:51 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 17:21:51 volumio-tarci volumiologrotate[919]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Dec 18 17:21:51 volumio-tarci volumiologrotate[919]: ls: cannot access 'TARCI': No such file or directory Dec 18 17:21:53 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:53 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:53 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:21:58 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:21:58 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:21:58 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:03 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:03 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:03 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:08 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:09 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:09 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:14 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:14 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:14 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:19 volumio-tarci ntpd[1384]: Soliciting pool server 129.152.16.145 Dec 18 17:22:19 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:19 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:19 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:22 volumio-tarci ntpd[1384]: Soliciting pool server 2606:4700:f1::1 Dec 18 17:22:24 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:24 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:24 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:29 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:29 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:29 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:34 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:34 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:34 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:39 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:40 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:40 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:45 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:45 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:45 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:50 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:50 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:50 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:51 volumio-tarci volumiologrotate[919]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Dec 18 17:22:52 volumio-tarci volumiologrotate[919]: ls: cannot access 'TARCI': No such file or directory Dec 18 17:22:52 volumio-tarci sudo[2467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 17:22:52 volumio-tarci sudo[2467]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:22:52 volumio-tarci sudo[2467]: pam_unix(sudo:session): session closed for user root Dec 18 17:22:52 volumio-tarci sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 17:22:52 volumio-tarci sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:22:52 volumio-tarci sudo[2469]: pam_unix(sudo:session): session closed for user root Dec 18 17:22:52 volumio-tarci volumio[1399]: verbose: New Socket.io Connection to 192.168.43.128 from 192.168.43.98 UA: Mozilla/5.0 (Linux; U; Android 10; Lenovo TB-X306X Build/QP1A.190711.020; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Safari/537.36 OPR/96.1.2254.80015 Engine version: 3 Transport: polling Total Clients: 4 Dec 18 17:22:53 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 17:22:54 volumio-tarci sudo[2473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 17:22:54 volumio-tarci sudo[2473]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:22:54 volumio-tarci sudo[2473]: pam_unix(sudo:session): session closed for user root Dec 18 17:22:54 volumio-tarci sudo[2476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 17:22:54 volumio-tarci sudo[2476]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 17:22:54 volumio-tarci sudo[2476]: pam_unix(sudo:session): session closed for user root Dec 18 17:22:54 volumio-tarci volumio[1399]: verbose: New Socket.io Connection to 192.168.43.128 from 192.168.43.98 UA: Mozilla/5.0 (Linux; U; Android 10; Lenovo TB-X306X Build/QP1A.190711.020; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Safari/537.36 OPR/96.1.2254.80015 Engine version: 3 Transport: polling Total Clients: 5 Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 18 17:22:54 volumio-tarci volumio[1399]: info: Received Get System Info Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 17:22:54 volumio-tarci volumio[1399]: info: Discovery: Getting this device information Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:22:54 volumio-tarci volumio[1399]: info: Listing playlists Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 17:22:54 volumio-tarci volumio[1399]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 17:22:55 volumio-tarci volumio[1399]: info: CoreCommandRouter::volumioGetState Dec 18 17:22:55 volumio-tarci volumio[1399]: info: CorePlayQueue::getTrack 0 Dec 18 17:22:55 volumio-tarci volumio[1399]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 17:22:55 volumio-tarci volumio[1399]: Error: Unable to resolve or reject the same promise twice Dec 18 17:22:55 volumio-tarci volumio[1399]: at Promise.reject (/volumio/node_modules/kew/kew.js:189:43) Dec 18 17:22:55 volumio-tarci volumio[1399]: at /volumio/app/plugins/miscellanea/albumart/albumart.js:158:15 Dec 18 17:22:55 volumio-tarci volumio[1399]: at IncomingMessage. (/volumio/app/plugins/miscellanea/albumart/albumart.js:688:18) Dec 18 17:22:55 volumio-tarci volumio[1399]: at IncomingMessage.emit (events.js:412:35) Dec 18 17:22:55 volumio-tarci volumio[1399]: at endReadableNT (internal/streams/readable.js:1333:12) Dec 18 17:22:55 volumio-tarci volumio[1399]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Dec 18 17:22:55 volumio-tarci volumio[1399]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 17:22:55 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Fetching time from Volumio... Dec 18 17:22:55 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Date not found in response Dec 18 17:22:55 volumio-tarci volumio-time-update[922]: volumio-time-update-util: Retrying in 5 seconds... Dec 18 17:22:55 volumio-tarci sudo[2506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-18 17:21 Dec 18 17:22:55 volumio-tarci sudo[2506]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 07:31:13 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="674d725e3f749f2a23785c9f94a28aa3"