-- Logs begin at Tue 2026-02-24 15:01:36 CST, end at Tue 2026-02-24 15:03:56 CST. -- Feb 24 15:02:00 volumio systemd[1]: Started Music Player Daemon. Feb 24 15:02:00 volumio mpd_monitor.sh[764]: MPD Monitor Service: MPD restarted due to no mpc output. Feb 24 15:02:00 volumio ntpd[949]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 24 15:02:00 volumio wireless.js[760]: trying... Feb 24 15:02:00 volumio wpa_supplicant[1138]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=BEACON_HINT type=UNKNOWN Feb 24 15:02:00 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:00 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:00 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:00 volumio wpa_supplicant[1138]: wlan0: SME: Trying to authenticate with e8:43:68:67:95:56 (SSID='luhaocy' freq=2462 MHz) Feb 24 15:02:00 volumio kernel: wlan0: authenticate with e8:43:68:67:95:56 Feb 24 15:02:00 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Feb 24 15:02:00 volumio kernel: wlan0: send auth to e8:43:68:67:95:56 (try 1/3) Feb 24 15:02:00 volumio wpa_supplicant[1138]: wlan0: Trying to associate with e8:43:68:67:95:56 (SSID='luhaocy' freq=2462 MHz) Feb 24 15:02:00 volumio kernel: wlan0: authenticated Feb 24 15:02:00 volumio kernel: wlan0: associate with e8:43:68:67:95:56 (try 1/3) Feb 24 15:02:00 volumio wpa_supplicant[1138]: wlan0: Associated with e8:43:68:67:95:56 Feb 24 15:02:00 volumio wpa_supplicant[1138]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Feb 24 15:02:00 volumio wpa_supplicant[1138]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Feb 24 15:02:00 volumio kernel: wlan0: RX AssocResp from e8:43:68:67:95:56 (capab=0x1431 status=0 aid=12) Feb 24 15:02:00 volumio kernel: wlan0: associated Feb 24 15:02:00 volumio kernel: ath: EEPROM regdomain: 0x8348 Feb 24 15:02:00 volumio kernel: ath: EEPROM indicates we should expect a country code Feb 24 15:02:00 volumio kernel: ath: doing EEPROM country->regdmn map search Feb 24 15:02:00 volumio kernel: ath: country maps to regdmn code: 0x3a Feb 24 15:02:00 volumio kernel: ath: Country alpha2 being used: US Feb 24 15:02:00 volumio kernel: ath: Regpair used: 0x3a Feb 24 15:02:00 volumio kernel: ath: regdomain 0x8348 dynamically updated by country element Feb 24 15:02:00 volumio kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by e8:43:68:67:95:56 Feb 24 15:02:01 volumio wpa_supplicant[1138]: wlan0: WPA: Key negotiation completed with e8:43:68:67:95:56 [PTK=CCMP GTK=CCMP] Feb 24 15:02:01 volumio wpa_supplicant[1138]: wlan0: CTRL-EVENT-CONNECTED - Connection to e8:43:68:67:95:56 completed [id=0 id_str=] Feb 24 15:02:01 volumio dhcpcd[849]: wlan0: carrier acquired Feb 24 15:02:01 volumio dhcpcd[849]: wlan0: IAID 19:0e:26:87 Feb 24 15:02:01 volumio dhcpcd[849]: wlan0: adding address fe80::fd48:a5f9:2f:7a07 Feb 24 15:02:01 volumio dhcpcd[849]: ipv6_addaddr1: Permission denied Feb 24 15:02:01 volumio dhcpcd[849]: wlan0: soliciting a DHCP lease Feb 24 15:02:01 volumio ntpd[949]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 24 15:02:01 volumio wireless.js[760]: trying... Feb 24 15:02:01 volumio sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:01 volumio sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:01 volumio sudo[1161]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:02 volumio dhcpcd[849]: wlan0: soliciting an IPv6 router Feb 24 15:02:02 volumio volumio-remote-updater[752]: [2026-02-24 15:02:02] [info] asio async_connect error: system:111 (Connection refused) Feb 24 15:02:02 volumio volumio-remote-updater[752]: [2026-02-24 15:02:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 24 15:02:02 volumio volumio-remote-updater[752]: [2026-02-24 15:02:02] [error] handle_connect error: Underlying Transport Error Feb 24 15:02:02 volumio volumio-time-update[761]: volumio-time-update-util: Fetching time from Volumio... Feb 24 15:02:02 volumio volumio-time-update[761]: volumio-time-update-util: Date not found in response Feb 24 15:02:02 volumio volumio-time-update[761]: volumio-time-update-util: Retrying in 5 seconds... Feb 24 15:02:02 volumio systemd[1]: systemd-rfkill.service: Succeeded. Feb 24 15:02:02 volumio wireless.js[760]: trying... Feb 24 15:02:02 volumio sudo[1169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:02 volumio sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:02 volumio sudo[1169]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:03 volumio dhcpcd[849]: wlan0: offered 192.168.1.7 from 192.168.1.1 Feb 24 15:02:03 volumio dhcpcd[849]: wlan0: probing address 192.168.1.7/24 Feb 24 15:02:03 volumio wireless.js[760]: trying... Feb 24 15:02:03 volumio sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:03 volumio sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:03 volumio sudo[1172]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:04 volumio wireless.js[760]: trying... Feb 24 15:02:04 volumio sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:04 volumio sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:04 volumio sudo[1175]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:05 volumio wireless.js[760]: trying... Feb 24 15:02:05 volumio sudo[1178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:05 volumio sudo[1178]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:05 volumio sudo[1178]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:06 volumio wireless.js[760]: trying... Feb 24 15:02:06 volumio sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:06 volumio sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:06 volumio sudo[1181]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:07 volumio volumio-time-update[761]: volumio-time-update-util: Fetching time from Volumio... Feb 24 15:02:07 volumio volumio-time-update[761]: volumio-time-update-util: Date not found in response Feb 24 15:02:07 volumio volumio-time-update[761]: volumio-time-update-util: Retrying in 5 seconds... Feb 24 15:02:07 volumio wireless.js[760]: trying... Feb 24 15:02:07 volumio sudo[1189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:07 volumio sudo[1189]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:07 volumio sudo[1189]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:08 volumio dhcpcd[849]: wlan0: leased 192.168.1.7 for 86400 seconds Feb 24 15:02:08 volumio dhcpcd[849]: wlan0: adding route to 192.168.1.0/24 Feb 24 15:02:08 volumio avahi-daemon[747]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.7. Feb 24 15:02:08 volumio dhcpcd[849]: wlan0: adding default route via 192.168.1.1 Feb 24 15:02:08 volumio avahi-daemon[747]: New relevant interface wlan0.IPv4 for mDNS. Feb 24 15:02:08 volumio avahi-daemon[747]: Registering new address record for 192.168.1.7 on wlan0.IPv4. Feb 24 15:02:08 volumio ntpd[949]: ntpd exiting on signal 15 (Terminated) Feb 24 15:02:08 volumio systemd[1]: Stopping Network Time Service... Feb 24 15:02:08 volumio systemd[1]: ntp.service: Succeeded. Feb 24 15:02:08 volumio systemd[1]: Stopped Network Time Service. Feb 24 15:02:08 volumio systemd[1]: Starting Network Time Service... Feb 24 15:02:08 volumio ntpd[1224]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 24 15:02:08 volumio ntpd[1224]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 24 15:02:08 volumio systemd[1]: Started Network Time Service. Feb 24 15:02:08 volumio ntpd[1230]: proto: precision = 0.144 usec (-23) Feb 24 15:02:08 volumio ntpd[1230]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 24 15:02:08 volumio ntpd[1230]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 24 15:02:08 volumio ntpd[1230]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1155 days ago Feb 24 15:02:08 volumio ntpd[1230]: Listen and drop on 0 v6wildcard [::]:123 Feb 24 15:02:08 volumio ntpd[1230]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 24 15:02:08 volumio ntpd[1230]: Listen normally on 2 lo 127.0.0.1:123 Feb 24 15:02:08 volumio ntpd[1230]: Listen normally on 3 wlan0 192.168.1.7:123 Feb 24 15:02:08 volumio ntpd[1230]: Listening on routing socket on fd #20 for interface updates Feb 24 15:02:08 volumio ntpd[1230]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 24 15:02:08 volumio ntpd[1230]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 24 15:02:08 volumio nmbd[903]: [2026/02/24 15:02:08.460077, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 24 15:02:08 volumio nmbd[903]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 24 15:02:08 volumio systemd[1]: Started Samba NMB Daemon. Feb 24 15:02:08 volumio systemd[1]: Starting Samba Winbind Daemon... Feb 24 15:02:08 volumio winbindd[1232]: [2026/02/24 15:02:08.652867, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 24 15:02:08 volumio winbindd[1232]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 24 15:02:08 volumio winbindd[1232]: [2026/02/24 15:02:08.656072, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 24 15:02:08 volumio winbindd[1232]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 24 15:02:08 volumio systemd[1]: Started Samba Winbind Daemon. Feb 24 15:02:08 volumio systemd[1]: Starting Samba SMB Daemon... Feb 24 15:02:08 volumio wireless.js[760]: trying... Feb 24 15:02:08 volumio sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 24 15:02:08 volumio sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:08 volumio sudo[1239]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:08 volumio wireless.js[760]: Connected to: ----luhaocy Feb 24 15:02:08 volumio wireless.js[760]: ---- Feb 24 15:02:08 volumio sudo[1242]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 24 15:02:08 volumio sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:08 volumio sudo[1242]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:08 volumio wireless.js[760]: ... joined AP, wlan0 IPv4 is 192.168.1.7, ipV6 is undefined Feb 24 15:02:08 volumio wireless.js[760]: It's done! AP Feb 24 15:02:08 volumio iwconfig[1246]: Error for wireless request "Set Power Management" (8B2C) : Feb 24 15:02:08 volumio iwconfig[1246]: SET failed on device wlan0 ; Operation not supported. Feb 24 15:02:08 volumio systemd[1]: Started Wireless Services. Feb 24 15:02:08 volumio systemd[1]: Started Volumio Backend Module. Feb 24 15:02:08 volumio systemd[1]: Started Volumio Cpu Tweaker. Feb 24 15:02:08 volumio systemd[1]: Started Intel SST and HDA soundcard init service. Feb 24 15:02:08 volumio systemd[1]: Started Start Volumio Kiosk. Feb 24 15:02:08 volumio volumio-cpu-tweak[1249]: Setting RT Priority for mpd Feb 24 15:02:08 volumio volumio-cpu-tweak[1249]: Setting MPD Affinity Feb 24 15:02:08 volumio volumio-cpu-tweak[1249]: pid 993's current affinity mask: f Feb 24 15:02:08 volumio volumio-cpu-tweak[1249]: pid 993's new affinity mask: 3 Feb 24 15:02:08 volumio volumio-cpu-tweak[1249]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Feb 24 15:02:09 volumio smbd[1237]: [2026/02/24 15:02:09.006423, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 24 15:02:09 volumio smbd[1237]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 24 15:02:09 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Feb 24 15:02:09 volumio systemd[1]: Started Samba SMB Daemon. Feb 24 15:02:09 volumio startx[1251]: X.Org X Server 1.20.4 Feb 24 15:02:09 volumio startx[1251]: X Protocol Version 11, Revision 0 Feb 24 15:02:09 volumio startx[1251]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Feb 24 15:02:09 volumio startx[1251]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Feb 24 15:02:09 volumio startx[1251]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d35eb915-f24a-437a-a43b-4afe991304f7 bootpart=UUID=79FB-2BA3 datapart=UUID=9e0d6c64-d474-4e69-ab93-94c74dabee55 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 initrd=volumio.initrd Feb 24 15:02:09 volumio startx[1251]: Build Date: 18 December 2021 09:05:36AM Feb 24 15:02:09 volumio startx[1251]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Feb 24 15:02:09 volumio startx[1251]: Current version of pixman: 0.36.0 Feb 24 15:02:09 volumio startx[1251]: Before reporting problems, check http://wiki.x.org Feb 24 15:02:09 volumio startx[1251]: to make sure that you have the latest version. Feb 24 15:02:09 volumio startx[1251]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 24 15:02:09 volumio startx[1251]: (++) from command line, (!!) notice, (II) informational, Feb 24 15:02:09 volumio startx[1251]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 24 15:02:09 volumio startx[1251]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Feb 24 15:02:09 2026 Feb 24 15:02:09 volumio startx[1251]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 24 15:02:09 volumio startx[1251]: (II) [KMS] Kernel modesetting enabled. Feb 24 15:02:09 volumio ntpd[1230]: Soliciting pool server 119.28.206.193 Feb 24 15:02:09 volumio systemd[1]: soundcard-init.service: Succeeded. Feb 24 15:02:09 volumio volumio-remote-updater[752]: [2026-02-24 15:02:09] [info] asio async_connect error: system:111 (Connection refused) Feb 24 15:02:09 volumio volumio-remote-updater[752]: [2026-02-24 15:02:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 24 15:02:09 volumio volumio-remote-updater[752]: [2026-02-24 15:02:09] [error] handle_connect error: Underlying Transport Error Feb 24 15:02:10 volumio ntpd[1230]: Soliciting pool server 84.16.67.12 Feb 24 15:02:10 volumio ntpd[1230]: Soliciting pool server 118.25.25.89 Feb 24 15:02:10 volumio volumio[1248]: info: ------------------------------------------- Feb 24 15:02:10 volumio volumio[1248]: info: ----- Volumio3 ---- Feb 24 15:02:10 volumio volumio[1248]: info: ------------------------------------------- Feb 24 15:02:10 volumio volumio[1248]: info: ----- System startup ---- Feb 24 15:02:10 volumio volumio[1248]: info: ------------------------------------------- Feb 24 15:02:11 volumio ntpd[1230]: Soliciting pool server 193.182.111.141 Feb 24 15:02:11 volumio ntpd[1230]: Soliciting pool server 162.159.200.123 Feb 24 15:02:11 volumio volumio[1248]: info: MYVOLUMIO Environment detected Feb 24 15:02:11 volumio volumio[1248]: info: Plugin folders cleanup Feb 24 15:02:11 volumio volumio[1248]: info: Scanning into folder /volumio/app/plugins/ Feb 24 15:02:11 volumio volumio[1248]: info: Scanning category audio_interface Feb 24 15:02:11 volumio volumio[1248]: info: Scanning category miscellanea Feb 24 15:02:11 volumio volumio[1248]: info: Scanning category music_service Feb 24 15:02:11 volumio volumio[1248]: info: Scanning category plugins.json Feb 24 15:02:11 volumio volumio[1248]: info: Scanning category system_controller Feb 24 15:02:11 volumio volumio[1248]: info: Scanning category user_interface Feb 24 15:02:11 volumio volumio[1248]: info: Scanning into folder /data/plugins/ Feb 24 15:02:11 volumio volumio[1248]: info: Plugin folders cleanup completed Feb 24 15:02:11 volumio volumio[1248]: info: ------------------------------------------- Feb 24 15:02:11 volumio volumio[1248]: info: ----- Core plugins startup ---- Feb 24 15:02:11 volumio volumio[1248]: info: ------------------------------------------- Feb 24 15:02:11 volumio volumio[1248]: info: Loading plugins from folder /volumio/app/plugins/ Feb 24 15:02:11 volumio volumio[1248]: info: Adding plugin upnp to MyMusic Plugins Feb 24 15:02:11 volumio volumio[1248]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 24 15:02:11 volumio volumio[1248]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 24 15:02:11 volumio volumio[1248]: info: Loading plugins from folder /data/plugins/ Feb 24 15:02:11 volumio volumio[1248]: info: Loading plugin "system"... Feb 24 15:02:11 volumio volumio[1248]: info: Loading plugin "appearance"... Feb 24 15:02:12 volumio ntpd[1230]: Soliciting pool server 95.111.202.5 Feb 24 15:02:12 volumio ntpd[1230]: Soliciting pool server 193.182.111.12 Feb 24 15:02:12 volumio volumio-time-update[761]: volumio-time-update-util: Fetching time from Volumio... Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "network"... Feb 24 15:02:13 volumio volumio[1248]: info: Refreshing Cached IP Addresses Feb 24 15:02:13 volumio sudo[1495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 24 15:02:13 volumio sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:13 volumio sudo[1495]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:13 volumio ntpd[1230]: Soliciting pool server 210.28.130.4 Feb 24 15:02:13 volumio ntpd[1230]: Soliciting pool server 202.112.31.197 Feb 24 15:02:13 volumio sudo[1497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "services"... Feb 24 15:02:13 volumio sudo[1497]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "alsa_controller"... Feb 24 15:02:13 volumio sudo[1497]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:13 volumio sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 24 15:02:13 volumio sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:13 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "wizard"... Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "networkfs"... Feb 24 15:02:13 volumio volumio[1248]: info: Starting Udev Watcher for removable devices Feb 24 15:02:13 volumio sudo[1523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.1.8/音乐3T /mnt/NAS/音乐3T Feb 24 15:02:13 volumio sudo[1523]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:13 volumio sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.1.5/音乐3T /mnt/NAS/音乐3T Feb 24 15:02:13 volumio sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:13 volumio volumio[1248]: info: Ignoring mount for partition: boot Feb 24 15:02:13 volumio volumio[1248]: info: Ignoring mount for partition: volumio Feb 24 15:02:13 volumio volumio[1248]: info: Ignoring mount for partition: volumio_data Feb 24 15:02:13 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "volumio_command_line_client"... Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "upnp"... Feb 24 15:02:13 volumio volumio[1248]: info: [1771916533572] Starting Upmpd Daemon Feb 24 15:02:13 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "my_music"... Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "mpd"... Feb 24 15:02:13 volumio kernel: FS-Cache: Loaded Feb 24 15:02:13 volumio kernel: Key type dns_resolver registered Feb 24 15:02:13 volumio kernel: Key type cifs.spnego registered Feb 24 15:02:13 volumio kernel: Key type cifs.idmap registered Feb 24 15:02:13 volumio kernel: CIFS: Attempting to mount //192.168.1.5/音乐3T Feb 24 15:02:13 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 24 15:02:13 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Feb 24 15:02:13 volumio kernel: CIFS: Attempting to mount //192.168.1.8/音乐3T Feb 24 15:02:13 volumio sudo[1525]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:13 volumio volumio[1248]: info: Loading plugin "upnp_browser"... Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "alarm-clock"... Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "airplay_emulation"... Feb 24 15:02:14 volumio volumio[1248]: info: Starting Shairport Sync Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "last_100"... Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "webradio"... Feb 24 15:02:14 volumio ntpd[1230]: Soliciting pool server 116.203.151.74 Feb 24 15:02:14 volumio ntpd[1230]: Soliciting pool server 193.182.111.142 Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "i2s_dacs"... Feb 24 15:02:14 volumio volumio[1248]: info: I2S DAC not set, start Auto-detection Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "volumiodiscovery"... Feb 24 15:02:14 volumio volumio[1248]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 24 15:02:14 volumio volumio[1248]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 24 15:02:14 volumio volumio[1248]: *** WARNING *** For more information see Feb 24 15:02:14 volumio node[1248]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 24 15:02:14 volumio volumio[1248]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 24 15:02:14 volumio volumio[1248]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 24 15:02:14 volumio volumio[1248]: *** WARNING *** For more information see Feb 24 15:02:14 volumio node[1248]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 24 15:02:14 volumio node[1248]: *** WARNING *** For more information see Feb 24 15:02:14 volumio node[1248]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 24 15:02:14 volumio node[1248]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 24 15:02:14 volumio node[1248]: *** WARNING *** For more information see Feb 24 15:02:14 volumio volumio[1248]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 24 15:02:14 volumio volumio[1248]: info: Discovery: Started advertising with name: Volumio Feb 24 15:02:14 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "outputs"... Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "albumart"... Feb 24 15:02:14 volumio volumio[1248]: info: Plugin example_plugin is not enabled Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "inputs"... Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "updater_comm"... Feb 24 15:02:14 volumio volumio[1248]: Forking 3 albumart workers Feb 24 15:02:14 volumio volumio[1248]: info: Plugin mpdemulation is not enabled Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "rest_api"... Feb 24 15:02:14 volumio volumio[1248]: info: Loading plugin "websocket"... Feb 24 15:02:14 volumio volumio[1248]: info: Starting Socket.io Server version 2.3.0 Feb 24 15:02:14 volumio volumio[1248]: info: Loading i18n strings for locale zh Feb 24 15:02:14 volumio volumio[1248]: Updating browse sources language Feb 24 15:02:14 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 24 15:02:15 volumio volumio-time-update[761]: volumio-time-update-util: Setting system time to: 2026-02-24 15:01:36 Feb 24 15:02:15 volumio sudo[1617]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-02-24 15:01:36 Feb 24 15:02:15 volumio sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:15 volumio dbus-daemon[755]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.12' (uid=0 pid=1618 comm="timedatectl set-time 2026-02-24 15:01:36 ") Feb 24 15:02:15 volumio systemd[1]: Starting Time & Date Service... Feb 24 15:02:15 volumio volumio[1248]: Starting albumart workers Feb 24 15:02:15 volumio sudo[1505]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:15 volumio dbus-daemon[755]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 24 15:02:15 volumio systemd[1]: Started Time & Date Service. Feb 24 15:02:02 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPlay Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::play index undefined Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::startPlaybackTimer Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand stop took 1 milliseconds Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand clear took 0 milliseconds Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac" Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:03 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:03 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand add "NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac" took 2 milliseconds Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand play Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:03 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:03 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 7ms Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 6ms Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand play took 5 milliseconds Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 5ms Feb 24 15:02:03 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 3ms Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:03 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:03 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:03 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand status took 9 milliseconds Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 8ms Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 8ms Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand status took 8 milliseconds Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:03 volumio volumio[1248]: info: Feb 24 15:02:03 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:03 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand clearerror took 8 milliseconds Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand clearerror took 7 milliseconds Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand status took 3 milliseconds Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:03 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:03 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: No code Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:03 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: No code Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 60ms Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 58ms Feb 24 15:02:03 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 46 milliseconds Feb 24 15:02:03 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:03 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:03 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: No code Feb 24 15:02:03 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:03 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:03 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:03 volumio volumio[1248]: info: ------------------------------ 69ms Feb 24 15:02:03 volumio sudo[2062]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:03 volumio volumio[1248]: info: Cannot mount NAS 音乐3T at system boot, trial number 3 ,retrying in 5 seconds Feb 24 15:02:03 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 24 15:02:03 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 24 15:02:03 volumio kernel: CIFS: Attempting to mount //192.168.1.5/音乐3T Feb 24 15:02:03 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 24 15:02:03 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Feb 24 15:02:03 volumio sudo[2073]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:03 volumio volumio[1248]: info: Cannot mount NAS 音乐3T at system boot, trial number 4 ,retrying in 5 seconds Feb 24 15:02:06 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 24 15:02:06 volumio volumio[1248]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 24 15:02:06 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState Feb 24 15:02:06 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:06 volumio systemd[1]: systemd-timedated.service: Succeeded. Feb 24 15:02:07 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 24 15:02:07 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 15:02:07 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 24 15:02:08 volumio sudo[2105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.1.8/音乐3T /mnt/NAS/音乐3T Feb 24 15:02:08 volumio sudo[2105]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:08 volumio kernel: CIFS: Attempting to mount //192.168.1.8/音乐3T Feb 24 15:02:08 volumio sudo[2108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.1.5/音乐3T /mnt/NAS/音乐3T Feb 24 15:02:08 volumio sudo[2108]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 15:02:10 volumio volumio[1248]: info: Retrieving Cloud Streaming UI Feb 24 15:02:10 volumio volumio[1248]: info: Getting Tidal Cloud Configuration Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 15:02:10 volumio volumio[1248]: info: Getting Qobuz Cloud Configuration Feb 24 15:02:10 volumio volumio[1248]: info: Asking plugin for UI Config Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 15:02:10 volumio volumio[1248]: info: Getting Spotify Cloud Configuration Feb 24 15:02:10 volumio volumio[1248]: info: Asking plugin for UI Config Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 15:02:10 volumio volumio[1248]: info: Saving Spotify Acccount Feb 24 15:02:10 volumio volumio[1248]: info: Got Tidal Cloud Configuration Feb 24 15:02:10 volumio volumio[1248]: info: Got it Feb 24 15:02:10 volumio volumio[1248]: info: Got it Feb 24 15:02:10 volumio volumio[1248]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 24 15:02:10 volumio volumio[1248]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::volumioGetBrowseSources Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::volumioGetBrowseSources Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::volumioGetBrowseSources Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 24 15:02:10 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 24 15:02:11 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 15:02:11 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 15:02:11 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 24 15:02:11 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 24 15:02:11 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 24 15:02:11 volumio volumio[1248]: info: CoreCommandRouter::volumioGetBrowseSources Feb 24 15:02:11 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 24 15:02:12 volumio ntpd[1230]: Soliciting pool server 139.199.214.202 Feb 24 15:02:12 volumio volumio[1248]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 24 15:02:12 volumio volumio[1248]: info: Completed starting MyVolumio Plugin Feb 24 15:02:12 volumio volumio[1248]: [Metrics] CommandRouter: 40s 176.77ms Feb 24 15:02:12 volumio volumio[1248]: info: CoreCommandRouter::volumiosetStartupVolume Feb 24 15:02:12 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 15:02:12 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 15:02:12 volumio volumio[1248]: info: CoreCommandRouter::Close All Modals sent Feb 24 15:02:12 volumio volumio[1248]: info: CoreCommandRouter::Close All Modals sent Feb 24 15:02:13 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 24 15:02:13 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 24 15:02:13 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 24 15:02:14 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 24 15:02:14 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 24 15:02:14 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 24 15:02:15 volumio sudo[2105]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:15 volumio volumio[1248]: info: Cannot mount NAS 音乐3T at system boot, trial number 4 ,retrying in 5 seconds Feb 24 15:02:15 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 24 15:02:15 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 24 15:02:15 volumio kernel: CIFS: Attempting to mount //192.168.1.5/音乐3T Feb 24 15:02:15 volumio sudo[2108]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:15 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 24 15:02:15 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -111 Feb 24 15:02:15 volumio volumio[1248]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Feb 24 15:02:15 volumio volumio[1248]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L daphile.local. -m SMB3_11 Feb 24 15:02:18 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 24 15:02:19 volumio volumio[1248]: info: BOOT COMPLETED Feb 24 15:02:20 volumio sudo[2189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.1.8/音乐3T /mnt/NAS/音乐3T Feb 24 15:02:20 volumio sudo[2189]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:20 volumio kernel: CIFS: Attempting to mount //192.168.1.8/音乐3T Feb 24 15:02:20 volumio volumio-remote-updater[752]: [2026-02-24 15:02:20] [connect] Successful connection Feb 24 15:02:20 volumio volumio-remote-updater[752]: [2026-02-24 15:02:20] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1771916540 101 Feb 24 15:02:20 volumio volumio[1248]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Feb 24 15:02:22 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 24 15:02:25 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Feb 24 15:02:25 volumio volumio[1248]: info: Adding a new share Feb 24 15:02:25 volumio volumio[1248]: info: Checking key NasMounts.3dba8cf9-8488-432a-9ca7-d286d75d72b5 Feb 24 15:02:25 volumio volumio[1248]: info: Checking key NasMounts.71f6ec18-e51b-4574-8061-4087eb41cde9 Feb 24 15:02:25 volumio volumio[1248]: info: No correspondence found in configuration for share 音乐3T on IP 192.168.1.6 Feb 24 15:02:25 volumio volumio[1248]: info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.1.6 -N -m SMB3_11 Feb 24 15:02:26 volumio sudo[2189]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:26 volumio volumio[1248]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Feb 24 15:02:26 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 24 15:02:26 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Feb 24 15:02:26 volumio volumio[1248]: info: Negotiated SMB version with 音乐3T: SMB3_11 Feb 24 15:02:26 volumio volumio[1248]: info: Detected device 音乐3T with version SMB3_11 Feb 24 15:02:26 volumio volumio[1248]: info: Guest mount: forcing fallback SMB version 2.1 for 音乐3T Feb 24 15:02:26 volumio volumio[1248]: info: Set SMB version 3.11 in CIFS options: vers=2.1 Feb 24 15:02:26 volumio sudo[2213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.1.6/音乐3T /mnt/NAS/音乐3T Feb 24 15:02:26 volumio sudo[2213]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 15:02:26 volumio kernel: CIFS: Attempting to mount //192.168.1.6/音乐3T Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 24 15:02:26 volumio sudo[2213]: pam_unix(sudo:session): session closed for user root Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:26 volumio volumio[1248]: info: Feb 24 15:02:26 volumio volumio[1248]: ---------------------------- MPD announces state update: update Feb 24 15:02:26 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand status took 2 milliseconds Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand status took 2 milliseconds Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:26 volumio volumio[1248]: info: Command Router : Notfying DB Updatetrue Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:26 volumio volumio[1248]: info: Feb 24 15:02:26 volumio volumio[1248]: ---------------------------- MPD announces state update: update Feb 24 15:02:26 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:26 volumio volumio[1248]: info: Feb 24 15:02:26 volumio volumio[1248]: ---------------------------- MPD announces state update: update Feb 24 15:02:26 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:26 volumio volumio[1248]: info: [1771916546570] Database update started Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand status took 9 milliseconds Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand status took 8 milliseconds Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand status took 8 milliseconds Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand status took 8 milliseconds Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:26 volumio volumio[1248]: info: Command Router : Notfying DB Updatetrue Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::Close All Modals sent Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:26 volumio volumio[1248]: info: Command Router : Notfying DB Updatetrue Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::Close All Modals sent Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:26 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:26 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: No code Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: ------------------------------ 129ms Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 62 milliseconds Feb 24 15:02:26 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 40 milliseconds Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:26 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:26 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:26 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: No code Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:26 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: No code Feb 24 15:02:26 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:26 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:26 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:26 volumio volumio[1248]: info: ------------------------------ 148ms Feb 24 15:02:26 volumio volumio[1248]: info: ------------------------------ 148ms Feb 24 15:02:27 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPlay Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::play index undefined Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::startPlaybackTimer Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand stop took 1 milliseconds Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand clear took 1 milliseconds Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac" Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:32 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand add "NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac" took 1 milliseconds Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand play Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:32 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:32 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:32 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 3ms Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand play took 3 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 2ms Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 1ms Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:32 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Feb 24 15:02:32 volumio volumio[1248]: info: Ignoring MPD Status Update Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 4ms Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 2ms Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 1ms Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand status took 149 milliseconds Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand status took 150 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand status took 149 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1295,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:32 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 154ms Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:32 volumio volumio[1248]: info: Feb 24 15:02:32 volumio volumio[1248]: ---------------------------- MPD announces state update: player Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::getState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand status took 6 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand status took 2 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand status took 1 milliseconds Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseState Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":182,"duration":1295,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"871 Kbps","isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:32 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Feb 24 15:02:32 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":273,"duration":1295,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"883 Kbps","isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:32 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Feb 24 15:02:32 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 188ms Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 188ms Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 39 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 38 milliseconds Feb 24 15:02:32 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 39 milliseconds Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:32 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":1295,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"883 Kbps","isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:32 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Feb 24 15:02:32 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":1295,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"883 Kbps","isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:32 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Feb 24 15:02:32 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: ControllerMpd::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":1295,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"883 Kbps","isStreaming":false,"title":"Schelomo","artist":"Steven Isserlis","album":"In the Shadow of War","uri":"NAS/音乐3T/个人/流行/Steven Isserlis, Hugh Wolff, Gábor Takács-Nagy - In the Shadow of War (2013) FLAC (24bit-44.1kHz)/01 - Schelomo.flac","trackType":"flac"} Feb 24 15:02:32 volumio volumio[1248]: verbose: CURRENT POSITION 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Feb 24 15:02:32 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: CoreStateMachine::pushState Feb 24 15:02:32 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Feb 24 15:02:32 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 100ms Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 96ms Feb 24 15:02:32 volumio volumio[1248]: info: ------------------------------ 97ms Feb 24 15:03:56 volumio volumio[1248]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 15:03:56 volumio volumio[1248]: Error: connect ETIMEDOUT 108.160.162.115:443 Feb 24 15:03:56 volumio volumio[1248]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 24 15:03:56 volumio volumio[1248]: errno: -110, Feb 24 15:03:56 volumio volumio[1248]: code: 'ETIMEDOUT', Feb 24 15:03:56 volumio volumio[1248]: syscall: 'connect', Feb 24 15:03:56 volumio volumio[1248]: address: '108.160.162.115', Feb 24 15:03:56 volumio volumio[1248]: port: 443 Feb 24 15:03:56 volumio volumio[1248]: } Feb 24 15:03:56 volumio volumio[1248]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 15:03:56 volumio sudo[2610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-24 15:02 Feb 24 15:03:56 volumio sudo[2610]: 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"