-- Logs begin at Thu 2025-10-16 20:28:57 CST, end at Thu 2025-10-16 20:30:00 CST. -- Oct 16 20:29:00 volumio loadcpufreq[831]: Loading cpufreq kernel modules...done (acpi-cpufreq). Oct 16 20:29:00 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 16 20:29:00 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 16 20:29:00 volumio cpufrequtils[951]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Oct 16 20:29:00 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 16 20:29:00 volumio nmbd[908]: [2025/10/16 20:29:00.202976, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 16 20:29:00 volumio nmbd[908]: started asyncdns process 959 Oct 16 20:29:00 volumio nmbd[908]: [2025/10/16 20:29:00.203837, 0] ../lib/util/become_daemon.c:149(daemon_status) Oct 16 20:29:00 volumio nmbd[908]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Oct 16 20:29:00 volumio nmbd[908]: [2025/10/16 20:29:00.203897, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Oct 16 20:29:00 volumio nmbd[908]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Oct 16 20:29:00 volumio wireless.js[782]: Cleaning previous... Oct 16 20:29:00 volumio sudo[967]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 16 20:29:00 volumio sudo[967]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:00 volumio sudo[967]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:00 volumio sudo[969]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 16 20:29:00 volumio sudo[969]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:00 volumio sudo[969]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:00 volumio wireless.js[782]: Stopped aP Oct 16 20:29:00 volumio sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 16 20:29:00 volumio sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:00 volumio sudo[976]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:00 volumio sudo[978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Oct 16 20:29:00 volumio sudo[978]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:00 volumio sudo[978]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:00 volumio sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 16 20:29:00 volumio sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:00 volumio sudo[985]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:00 volumio sudo[987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Oct 16 20:29:00 volumio sudo[987]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:00 volumio ntpd[904]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 16 20:29:01 volumio ntpd[904]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 16 20:29:02 volumio sudo[987]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:02 volumio wireless.js[782]: Start wireless flow Oct 16 20:29:02 volumio wireless.js[782]: Stopped hotspot (if there).. Oct 16 20:29:02 volumio sudo[992]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 16 20:29:02 volumio sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:02 volumio sudo[992]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:02 volumio sudo[994]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 16 20:29:02 volumio sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:02 volumio sudo[994]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:02 volumio wireless.js[782]: DHCP IP Oct 16 20:29:02 volumio wireless.js[782]: Start ap Oct 16 20:29:02 volumio wpa_supplicant[996]: Successfully initialized wpa_supplicant Oct 16 20:29:02 volumio sudo[997]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Oct 16 20:29:02 volumio sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:02 volumio dhcpcd[998]: sending commands to master dhcpcd process Oct 16 20:29:02 volumio dhcpcd[892]: control command: /sbin/dhcpcd Oct 16 20:29:02 volumio sudo[997]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:02 volumio ntpd[904]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 16 20:29:03 volumio wireless.js[782]: trying... Oct 16 20:29:03 volumio sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:03 volumio sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:03 volumio sudo[1003]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:03 volumio ntpd[904]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 16 20:29:04 volumio systemd[1]: systemd-rfkill.service: Succeeded. Oct 16 20:29:04 volumio wireless.js[782]: trying... Oct 16 20:29:04 volumio volumio-remote-updater[785]: [2025-10-16 20:29:04] [info] asio async_connect error: system:111 (Connection refused) Oct 16 20:29:04 volumio volumio-remote-updater[785]: [2025-10-16 20:29:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 16 20:29:04 volumio volumio-remote-updater[785]: [2025-10-16 20:29:04] [error] handle_connect error: Underlying Transport Error Oct 16 20:29:04 volumio sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:04 volumio sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:04 volumio sudo[1006]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:05 volumio wpa_supplicant[1001]: wlan0: SME: Trying to authenticate with 80:ea:07:b5:5d:c4 (SSID='TP-LINK_2.4G_5DC4' freq=2462 MHz) Oct 16 20:29:05 volumio kernel: wlan0: authenticate with 80:ea:07:b5:5d:c4 Oct 16 20:29:05 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Oct 16 20:29:05 volumio kernel: wlan0: send auth to 80:ea:07:b5:5d:c4 (try 1/3) Oct 16 20:29:05 volumio wpa_supplicant[1001]: wlan0: Trying to associate with 80:ea:07:b5:5d:c4 (SSID='TP-LINK_2.4G_5DC4' freq=2462 MHz) Oct 16 20:29:05 volumio kernel: wlan0: authenticated Oct 16 20:29:05 volumio kernel: wlan0: associate with 80:ea:07:b5:5d:c4 (try 1/3) Oct 16 20:29:05 volumio kernel: wlan0: RX AssocResp from 80:ea:07:b5:5d:c4 (capab=0x11 status=0 aid=2) Oct 16 20:29:05 volumio wpa_supplicant[1001]: wlan0: Associated with 80:ea:07:b5:5d:c4 Oct 16 20:29:05 volumio wpa_supplicant[1001]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 16 20:29:05 volumio wpa_supplicant[1001]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Oct 16 20:29:05 volumio kernel: wlan0: associated Oct 16 20:29:05 volumio wpa_supplicant[1001]: wlan0: WPA: Key negotiation completed with 80:ea:07:b5:5d:c4 [PTK=CCMP GTK=CCMP] Oct 16 20:29:05 volumio wpa_supplicant[1001]: wlan0: CTRL-EVENT-CONNECTED - Connection to 80:ea:07:b5:5d:c4 completed [id=0 id_str=] Oct 16 20:29:05 volumio dhcpcd[892]: wlan0: carrier acquired Oct 16 20:29:05 volumio dhcpcd[892]: wlan0: IAID 91:92:59:14 Oct 16 20:29:05 volumio dhcpcd[892]: wlan0: soliciting an IPv6 router Oct 16 20:29:05 volumio wireless.js[782]: trying... Oct 16 20:29:05 volumio sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:05 volumio sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:05 volumio sudo[1025]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:06 volumio dhcpcd[892]: wlan0: soliciting a DHCP lease Oct 16 20:29:06 volumio wireless.js[782]: trying... Oct 16 20:29:06 volumio sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:06 volumio sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:06 volumio sudo[1028]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:06 volumio dhcpcd[892]: wlan0: offered 192.168.13.105 from 192.168.13.1 Oct 16 20:29:06 volumio dhcpcd[892]: wlan0: probing address 192.168.13.105/24 Oct 16 20:29:07 volumio wireless.js[782]: trying... Oct 16 20:29:07 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:07 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:07 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:08 volumio wireless.js[782]: trying... Oct 16 20:29:08 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:08 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:08 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:09 volumio screensaver.sh[754]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused Oct 16 20:29:09 volumio wireless.js[782]: trying... Oct 16 20:29:09 volumio sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:09 volumio sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:09 volumio sudo[1044]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:10 volumio wireless.js[782]: trying... Oct 16 20:29:10 volumio sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:10 volumio sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:10 volumio sudo[1047]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:11 volumio wireless.js[782]: trying... Oct 16 20:29:11 volumio sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:11 volumio sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:11 volumio sudo[1050]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:12 volumio volumio-remote-updater[785]: [2025-10-16 20:29:12] [info] asio async_connect error: system:111 (Connection refused) Oct 16 20:29:12 volumio volumio-remote-updater[785]: [2025-10-16 20:29:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 16 20:29:12 volumio volumio-remote-updater[785]: [2025-10-16 20:29:12] [error] handle_connect error: Underlying Transport Error Oct 16 20:29:12 volumio dhcpcd[892]: wlan0: leased 192.168.13.105 for 7200 seconds Oct 16 20:29:12 volumio avahi-daemon[781]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.13.105. Oct 16 20:29:12 volumio avahi-daemon[781]: New relevant interface wlan0.IPv4 for mDNS. Oct 16 20:29:12 volumio dhcpcd[892]: wlan0: adding route to 192.168.13.0/24 Oct 16 20:29:12 volumio avahi-daemon[781]: Registering new address record for 192.168.13.105 on wlan0.IPv4. Oct 16 20:29:12 volumio dhcpcd[892]: wlan0: adding default route via 192.168.13.1 Oct 16 20:29:12 volumio ntpd[904]: ntpd exiting on signal 15 (Terminated) Oct 16 20:29:12 volumio systemd[1]: Stopping Network Time Service... Oct 16 20:29:12 volumio systemd[1]: ntp.service: Succeeded. Oct 16 20:29:12 volumio systemd[1]: Stopped Network Time Service. Oct 16 20:29:12 volumio systemd[1]: Starting Network Time Service... Oct 16 20:29:12 volumio ntpd[1085]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 16 20:29:12 volumio ntpd[1085]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 16 20:29:12 volumio systemd[1]: Started Network Time Service. Oct 16 20:29:12 volumio ntpd[1091]: proto: precision = 0.140 usec (-23) Oct 16 20:29:12 volumio ntpd[1091]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 16 20:29:12 volumio ntpd[1091]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 16 20:29:12 volumio ntpd[1091]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1024 days ago Oct 16 20:29:12 volumio ntpd[1091]: Listen and drop on 0 v6wildcard [::]:123 Oct 16 20:29:12 volumio ntpd[1091]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 16 20:29:12 volumio ntpd[1091]: Listen normally on 2 lo 127.0.0.1:123 Oct 16 20:29:12 volumio ntpd[1091]: Listen normally on 3 wlan0 192.168.13.105:123 Oct 16 20:29:12 volumio ntpd[1091]: Listening on routing socket on fd #20 for interface updates Oct 16 20:29:12 volumio ntpd[1091]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 16 20:29:12 volumio ntpd[1091]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 16 20:29:12 volumio wireless.js[782]: trying... Oct 16 20:29:12 volumio sudo[1094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 20:29:12 volumio sudo[1094]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:12 volumio sudo[1094]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:12 volumio wireless.js[782]: Connected to: ----TP-LINK_2.4G_5DC4 Oct 16 20:29:12 volumio wireless.js[782]: ---- Oct 16 20:29:12 volumio sudo[1097]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 20:29:12 volumio sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:12 volumio sudo[1097]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:12 volumio wireless.js[782]: ... joined AP, wlan0 IPv4 is 192.168.13.105, ipV6 is undefined Oct 16 20:29:12 volumio wireless.js[782]: It's done! AP Oct 16 20:29:12 volumio systemd[1]: Started Wireless Services. Oct 16 20:29:12 volumio systemd[1]: Started Volumio Backend Module. Oct 16 20:29:12 volumio systemd[1]: Started Intel SST and HDA soundcard init service. Oct 16 20:29:12 volumio systemd[1]: Started Start Volumio Kiosk. Oct 16 20:29:12 volumio systemd[1]: Started Volumio Cpu Tweaker. Oct 16 20:29:12 volumio volumio-cpu-tweak[1105]: Setting RT Priority for mpd Oct 16 20:29:12 volumio volumio-cpu-tweak[1105]: pid 35's current scheduling policy: SCHED_FIFO Oct 16 20:29:12 volumio volumio-cpu-tweak[1105]: pid 35's current scheduling priority: 99 Oct 16 20:29:12 volumio volumio-cpu-tweak[1105]: Setting MPD Affinity Oct 16 20:29:12 volumio volumio-cpu-tweak[1105]: pid 3's current affinity mask: f Oct 16 20:29:12 volumio volumio-cpu-tweak[1105]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 16 20:29:12 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 16 20:29:12 volumio startx[1104]: X.Org X Server 1.20.4 Oct 16 20:29:12 volumio startx[1104]: X Protocol Version 11, Revision 0 Oct 16 20:29:12 volumio startx[1104]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Oct 16 20:29:12 volumio startx[1104]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Oct 16 20:29:12 volumio startx[1104]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d0822069-d48a-490f-b8bc-9970c0b6e384 bootpart=UUID=1496-1547 datapart=UUID=a0bf3376-7b72-4c09-9fc2-d0970ff7651c 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 Oct 16 20:29:12 volumio startx[1104]: Build Date: 18 December 2021 09:05:36AM Oct 16 20:29:12 volumio startx[1104]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Oct 16 20:29:12 volumio startx[1104]: Current version of pixman: 0.36.0 Oct 16 20:29:12 volumio startx[1104]: Before reporting problems, check http://wiki.x.org Oct 16 20:29:12 volumio startx[1104]: to make sure that you have the latest version. Oct 16 20:29:12 volumio startx[1104]: Markers: (--) probed, (**) from config file, (==) default setting, Oct 16 20:29:12 volumio startx[1104]: (++) from command line, (!!) notice, (II) informational, Oct 16 20:29:12 volumio startx[1104]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Oct 16 20:29:12 volumio startx[1104]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Oct 16 20:29:12 2025 Oct 16 20:29:12 volumio startx[1104]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Oct 16 20:29:13 volumio kernel: broken atomic modeset userspace detected, disabling atomic Oct 16 20:29:13 volumio systemd[1]: soundcard-init.service: Succeeded. Oct 16 20:29:13 volumio startx[1104]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Oct 16 20:29:13 volumio ntpd[1091]: Soliciting pool server 139.199.214.202 Oct 16 20:29:13 volumio volumio[1102]: info: ------------------------------------------- Oct 16 20:29:13 volumio volumio[1102]: info: ----- Volumio3 ---- Oct 16 20:29:13 volumio volumio[1102]: info: ------------------------------------------- Oct 16 20:29:13 volumio volumio[1102]: info: ----- System startup ---- Oct 16 20:29:13 volumio volumio[1102]: info: ------------------------------------------- Oct 16 20:29:14 volumio ntpd[1091]: Soliciting pool server 119.28.183.184 Oct 16 20:29:14 volumio ntpd[1091]: Soliciting pool server 139.199.215.251 Oct 16 20:29:14 volumio volumio[1102]: info: MYVOLUMIO Environment detected Oct 16 20:29:14 volumio volumio[1102]: info: Plugin folders cleanup Oct 16 20:29:14 volumio volumio[1102]: info: Scanning into folder /volumio/app/plugins/ Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category audio_interface Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category miscellanea Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category music_service Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category plugins.json Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category system_controller Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category user_interface Oct 16 20:29:14 volumio volumio[1102]: info: Scanning into folder /data/plugins/ Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category music_service Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category system_controller Oct 16 20:29:14 volumio volumio[1102]: info: Scanning category user_interface Oct 16 20:29:14 volumio volumio[1102]: info: Plugin folders cleanup completed Oct 16 20:29:14 volumio volumio[1102]: info: ------------------------------------------- Oct 16 20:29:14 volumio volumio[1102]: info: ----- Core plugins startup ---- Oct 16 20:29:14 volumio volumio[1102]: info: ------------------------------------------- Oct 16 20:29:14 volumio volumio[1102]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 20:29:14 volumio volumio[1102]: info: Adding plugin upnp to MyMusic Plugins Oct 16 20:29:14 volumio volumio[1102]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 20:29:14 volumio volumio[1102]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 20:29:14 volumio volumio[1102]: info: Loading plugins from folder /data/plugins/ Oct 16 20:29:14 volumio volumio[1102]: info: Loading plugin "system"... Oct 16 20:29:14 volumio volumio[1102]: info: Loading plugin "appearance"... Oct 16 20:29:15 volumio nmbd[908]: [2025/10/16 20:29:15.207360, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 16 20:29:15 volumio systemd[1]: Started Samba NMB Daemon. Oct 16 20:29:15 volumio nmbd[908]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 16 20:29:15 volumio systemd[1]: Starting Samba Winbind Daemon... Oct 16 20:29:15 volumio ntpd[1091]: Soliciting pool server 162.159.200.123 Oct 16 20:29:15 volumio ntpd[1091]: Soliciting pool server 193.182.111.143 Oct 16 20:29:15 volumio ntpd[1091]: Soliciting pool server 111.230.189.174 Oct 16 20:29:15 volumio nmbd[908]: [2025/10/16 20:29:15.426342, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 16 20:29:15 volumio nmbd[908]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.13.105 for name WORKGROUP<1d>. Oct 16 20:29:15 volumio nmbd[908]: This response was from IP 192.168.13.66, reporting an IP address of 192.168.13.66. Oct 16 20:29:15 volumio winbindd[1318]: [2025/10/16 20:29:15.472665, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 16 20:29:15 volumio winbindd[1318]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 16 20:29:15 volumio winbindd[1318]: [2025/10/16 20:29:15.476124, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 16 20:29:15 volumio systemd[1]: Started Samba Winbind Daemon. Oct 16 20:29:15 volumio winbindd[1318]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 16 20:29:15 volumio systemd[1]: Starting Samba SMB Daemon... Oct 16 20:29:15 volumio smbd[1323]: [2025/10/16 20:29:15.782712, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 16 20:29:15 volumio systemd[1]: Started Samba SMB Daemon. Oct 16 20:29:15 volumio smbd[1323]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 16 20:29:15 volumio systemd[1]: Reached target Multi-User System. Oct 16 20:29:15 volumio systemd[1]: Reached target Graphical Interface. Oct 16 20:29:15 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 16 20:29:15 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 16 20:29:15 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 16 20:29:15 volumio systemd[1]: Startup finished in 9.488s (firmware) + 3.934s (loader) + 9.021s (kernel) + 18.309s (userspace) = 40.753s. Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "network"... Oct 16 20:29:16 volumio volumio[1102]: info: Refreshing Cached IP Addresses Oct 16 20:29:16 volumio sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 20:29:16 volumio sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "services"... Oct 16 20:29:16 volumio sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 20:29:16 volumio sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:16 volumio sudo[1335]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:16 volumio sudo[1333]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "alsa_controller"... Oct 16 20:29:16 volumio sudo[1339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 16 20:29:16 volumio sudo[1339]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "wizard"... Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "networkfs"... Oct 16 20:29:16 volumio volumio[1102]: info: Starting Udev Watcher for removable devices Oct 16 20:29:16 volumio volumio[1102]: info: Ignoring mount for partition: boot Oct 16 20:29:16 volumio volumio[1102]: info: Ignoring mount for partition: volumio Oct 16 20:29:16 volumio volumio[1102]: info: Ignoring mount for partition: volumio_data Oct 16 20:29:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "volumio_command_line_client"... Oct 16 20:29:16 volumio sudo[1348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.13.66:fs/1000/nfs /mnt/NAS/Fn Oct 16 20:29:16 volumio sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "upnp"... Oct 16 20:29:16 volumio volumio[1102]: info: [1760617756206] Starting Upmpd Daemon Oct 16 20:29:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "my_music"... Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "mpd"... Oct 16 20:29:16 volumio kernel: FS-Cache: Loaded Oct 16 20:29:16 volumio ntpd[1091]: Soliciting pool server 162.159.200.1 Oct 16 20:29:16 volumio ntpd[1091]: Soliciting pool server 193.182.111.12 Oct 16 20:29:16 volumio ntpd[1091]: Soliciting pool server 5.79.108.34 Oct 16 20:29:16 volumio kernel: Key type dns_resolver registered Oct 16 20:29:16 volumio ntpd[1091]: Soliciting pool server 116.203.151.74 Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "upnp_browser"... Oct 16 20:29:16 volumio kernel: NFS: Registering the id_resolver key type Oct 16 20:29:16 volumio kernel: Key type id_resolver registered Oct 16 20:29:16 volumio kernel: Key type id_legacy registered Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "alarm-clock"... Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "airplay_emulation"... Oct 16 20:29:16 volumio volumio[1102]: info: Starting Shairport Sync Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "last_100"... Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "webradio"... Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "i2s_dacs"... Oct 16 20:29:16 volumio volumio[1102]: info: I2S DAC not set, start Auto-detection Oct 16 20:29:16 volumio volumio[1102]: info: Loading plugin "volumiodiscovery"... Oct 16 20:29:16 volumio volumio[1102]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 20:29:16 volumio volumio[1102]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 20:29:16 volumio volumio[1102]: *** WARNING *** For more information see Oct 16 20:29:16 volumio volumio[1102]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 20:29:16 volumio volumio[1102]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 20:29:16 volumio volumio[1102]: *** WARNING *** For more information see Oct 16 20:29:16 volumio node[1102]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 20:29:16 volumio node[1102]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 20:29:16 volumio node[1102]: *** WARNING *** For more information see Oct 16 20:29:16 volumio node[1102]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 20:29:16 volumio node[1102]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 20:29:16 volumio node[1102]: *** WARNING *** For more information see Oct 16 20:29:16 volumio volumio[1102]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 20:29:16 volumio volumio[1102]: info: Discovery: Started advertising with name: Volumio Oct 16 20:29:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "jellyfin"... Oct 16 20:29:17 volumio ntpd[1091]: Soliciting pool server 202.112.29.82 Oct 16 20:29:17 volumio ntpd[1091]: Soliciting pool server 202.118.1.130 Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "jellyfin_server"... Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "autostart"... Oct 16 20:29:17 volumio volumio[1102]: info: Applying required configuration parameters for plugin autostart Oct 16 20:29:17 volumio volumio[1102]: info: AutoStart - onVolumioStart - read config.json Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "peppy_screensaver"... Oct 16 20:29:17 volumio volumio[1102]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "outputs"... Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "albumart"... Oct 16 20:29:17 volumio volumio[1102]: info: Plugin example_plugin is not enabled Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "inputs"... Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "updater_comm"... Oct 16 20:29:17 volumio volumio[1102]: Forking 3 albumart workers Oct 16 20:29:17 volumio volumio[1102]: info: Plugin mpdemulation is not enabled Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "rest_api"... Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "websocket"... Oct 16 20:29:17 volumio volumio[1102]: info: Starting Socket.io Server version 2.3.0 Oct 16 20:29:17 volumio volumio[1102]: info: Loading plugin "RoonBridge"... Oct 16 20:29:18 volumio volumio[1102]: info: Applying required configuration parameters for plugin RoonBridge Oct 16 20:29:18 volumio volumio[1102]: info: Loading plugin "lms"... Oct 16 20:29:18 volumio volumio[1102]: Starting albumart workers Oct 16 20:29:18 volumio volumio[1102]: Starting albumart workers Oct 16 20:29:18 volumio volumio[1102]: Starting albumart workers Oct 16 20:29:18 volumio volumio[1102]: info: Loading plugin "minidlna"... Oct 16 20:29:18 volumio volumio[1102]: info: Applying required configuration parameters for plugin minidlna Oct 16 20:29:18 volumio ntpd[1091]: Soliciting pool server 84.16.67.12 Oct 16 20:29:18 volumio volumio[1102]: info: Loading i18n strings for locale zh Oct 16 20:29:18 volumio volumio[1102]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Oct 16 20:29:18 volumio volumio[1102]: Updating browse sources language Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:18 volumio ntpd[1091]: Soliciting pool server 119.28.206.193 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::initPlayerControls Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: Express server listening on port 3000 Oct 16 20:29:18 volumio volumio[1102]: [Metrics] WebUI: 4s 962.09ms Oct 16 20:29:18 volumio volumio[1102]: info: Setting Device type: x86 Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::resetVolumioState Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::getcurrentVolume Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 20:29:18 volumio volumio[1102]: info: Completed loading Core Plugins Oct 16 20:29:18 volumio volumio[1102]: info: Preparing to generate the ALSA configuration file Oct 16 20:29:18 volumio volumio[1102]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 16 20:29:18 volumio volumio[1102]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 16 20:29:18 volumio volumio[1102]: info: Reading ALSA contributions from plugins. Oct 16 20:29:18 volumio volumio[1102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 16 20:29:18 volumio volumio[1102]: info: Reloading queue from file Oct 16 20:29:18 volumio volumio[1102]: info: VolumeController:: Volume=49 Mute =false Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::updateTrackBlock Oct 16 20:29:18 volumio volumio[1102]: info: CorePlayQueue::getTrackBlock Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::setRepeat null single undefined Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::setRandom null Oct 16 20:29:18 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:18 volumio volumio[1102]: info: Asound.conf file unchanged, so no further update is needed Oct 16 20:29:18 volumio volumio[1102]: info: Output device has changed, restarting MPD Oct 16 20:29:18 volumio volumio[1102]: info: Output device has changed, restarting Shairport Sync Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 20:29:18 volumio sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:18 volumio sudo[1512]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:18 volumio sudo[1514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 20:29:18 volumio sudo[1514]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:18 volumio volumio[1102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 20:29:18 volumio volumio[1102]: info: ___________ START PLUGINS ___________ Oct 16 20:29:18 volumio systemd[1]: Listening on mpd.socket. Oct 16 20:29:18 volumio volumio[1102]: info: ControllerMpd::onStart: Initializing MPD Oct 16 20:29:18 volumio volumio[1102]: info: Creating MPD Configuration file Oct 16 20:29:18 volumio sudo[1522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 20:29:18 volumio sudo[1522]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 20:29:18 volumio volumio[1102]: info: [1760617758684] CoreMusicLibrary::Adding element 媒体服务器 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:18 volumio systemd[1]: Starting Music Player Daemon... Oct 16 20:29:18 volumio sudo[1522]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:18 volumio sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 20:29:18 volumio sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 16 20:29:18 volumio systemd[1]: mpd.service: Succeeded. Oct 16 20:29:18 volumio systemd[1]: Stopped Music Player Daemon. Oct 16 20:29:18 volumio systemd[1]: Starting Music Player Daemon... Oct 16 20:29:18 volumio volumio[1102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 20:29:18 volumio volumio[1102]: info: [1760617758744] CoreMusicLibrary::Adding element Last_100 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 20:29:18 volumio volumio[1102]: info: [1760617758746] CoreMusicLibrary::Adding element Webradio Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:18 volumio sudo[1530]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 20:29:18 volumio sudo[1530]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 20:29:18 volumio volumio[1102]: info: Initializing BBC Radios Oct 16 20:29:18 volumio sudo[1530]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 16 20:29:18 volumio sudo[1530]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:18 volumio volumio[1102]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 20:29:18 volumio volumio[1102]: info: Discovery: Getting this device information Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 20:29:18 volumio volumio[1102]: info: [1760617758792] CoreMusicLibrary::Adding element Jellyfin Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:18 volumio volumio[1102]: Cannot find translation for source Jellyfin Oct 16 20:29:18 volumio volumio[1102]: info: [jellyfin] Initialized plugin with device info: {"id":"6576be8c-9ca3-4f6e-ad09-3e064e726785","host":"http://192.168.13.105","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":49,"mute":false,"artist":"赵鹏","track":"乌兰巴托的夜晚","albumart":"http://192.168.13.105/albumart?cacheid=609&web=%E8%B5%B5%E9%B9%8F/%E4%B8%AD%E5%9B%BD%E6%9C%80%E5%A5%BD%E5%A3%B0%E9%9F%B3%3A%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E4%B8%93%E7%94%A8%E5%A4%A7%E7%A2%9F/extralarge&path=%2FUSB&metadata=false"}} Oct 16 20:29:18 volumio volumio[1102]: info: [jellyfin_server] Executing /usr/bin/sudo /bin/systemctl start jellyfin || true Oct 16 20:29:18 volumio volumio[1102]: info: AutoStart - onStart Oct 16 20:29:18 volumio volumio[1102]: info: Loading i18n strings for locale zh Oct 16 20:29:18 volumio volumio[1102]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Oct 16 20:29:18 volumio sudo[1547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start jellyfin Oct 16 20:29:18 volumio sudo[1547]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:18 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 16 20:29:18 volumio volumio[1102]: info: /tmp/myfifo created Oct 16 20:29:18 volumio volumio[1102]: info: /tmp/myfifosa created Oct 16 20:29:18 volumio sudo[1555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 16 20:29:18 volumio sudo[1555]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:18 volumio volumio[1102]: info: snd-dummy loaded Oct 16 20:29:18 volumio systemd[1]: Starting Jellyfin... Oct 16 20:29:18 volumio sudo[1339]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:18 volumio sudo[1555]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio systemd[1]: Started Jellyfin. Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio sudo[1547]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:18 volumio sudo[1348]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:18 volumio volumio[1102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 20:29:18 volumio sudo[1576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Oct 16 20:29:19 volumio sudo[1576]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio volumio[1102]: info: Loading i18n strings for locale zh Oct 16 20:29:19 volumio volumio[1102]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Oct 16 20:29:19 volumio sudo[1580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver Oct 16 20:29:19 volumio sudo[1580]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio volumio[1102]: info: Volumio Calling Home Oct 16 20:29:19 volumio systemd[1]: Started RoonBridge. Oct 16 20:29:19 volumio sudo[1576]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio systemd[1]: /data/plugins/music_service/lms/unit/logitechmediaserver.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/logitechmediaserver.pid → /run/logitechmediaserver.pid; please update the unit file accordingly. Oct 16 20:29:19 volumio systemd[1]: Starting Logitech Media Server Daemon... Oct 16 20:29:19 volumio systemd[1]: Started Logitech Media Server Daemon. Oct 16 20:29:19 volumio sudo[1580]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio systemd[1598]: logitechmediaserver.service: Failed to execute command: No such file or directory Oct 16 20:29:19 volumio systemd[1598]: logitechmediaserver.service: Failed at step EXEC spawning /usr/sbin/squeezeboxserver: No such file or directory Oct 16 20:29:19 volumio systemd[1]: logitechmediaserver.service: Main process exited, code=exited, status=203/EXEC Oct 16 20:29:19 volumio systemd[1]: logitechmediaserver.service: Failed with result 'exit-code'. Oct 16 20:29:19 volumio volumio[1102]: info: Discovery: adding 6576be8c-9ca3-4f6e-ad09-3e064e726785 Oct 16 20:29:19 volumio volumio[1102]: info: Discovery: Found device Volumio Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:19 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:19 volumio volumio[1102]: info: logitechmediaserver started Oct 16 20:29:19 volumio volumio[1102]: info: MPD Permissions set Oct 16 20:29:19 volumio volumio[1102]: info: MPD Permissions set Oct 16 20:29:19 volumio volumio[1102]: info: VolumeController:: Volume=49 Mute =false Oct 16 20:29:19 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:19 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:19 volumio volumio[1102]: info: minidlna: Found miniDLNA version 1.2.1 Oct 16 20:29:19 volumio volumio[1102]: info: minidlna: Starting minidlna.service Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:19 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:19 volumio volumio[1102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 16 20:29:19 volumio sudo[1602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Oct 16 20:29:19 volumio sudo[1602]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio sudo[1602]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio ntpd[1091]: Soliciting pool server 2a03:8600::aa Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio sudo[1623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 16 20:29:19 volumio sudo[1623]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio sudo[1623]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio volumio[1102]: info: minidlna: systemctl start minidlna.service succeeded. Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 16 20:29:19 volumio volumio[1102]: info: Starting Shairport Sync Oct 16 20:29:19 volumio volumio[1102]: info: Starting Shairport Sync Oct 16 20:29:19 volumio sudo[1630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 20:29:19 volumio sudo[1630]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio volumio[1102]: info: Starting Shairport Sync Oct 16 20:29:19 volumio sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 20:29:19 volumio sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio sudo[1630]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio volumio[1102]: info: Starting Shairport Sync Oct 16 20:29:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 16 20:29:19 volumio sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 20:29:19 volumio sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 16 20:29:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 16 20:29:19 volumio sudo[1638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 20:29:19 volumio sudo[1638]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:19 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:19 volumio sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 20:29:19 volumio sudo[1632]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 16 20:29:19 volumio sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 16 20:29:19 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 16 20:29:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 16 20:29:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 16 20:29:19 volumio sudo[1638]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio sudo[1635]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio volumio[1102]: info: MPD Permissions set Oct 16 20:29:19 volumio volumio[1102]: info: Shairport-Sync Started Oct 16 20:29:19 volumio volumio[1102]: Error adding Membership: Error: addMembership EINVAL Oct 16 20:29:19 volumio volumio[1102]: info: Shairport-Sync Started Oct 16 20:29:19 volumio volumio[1102]: info: Shairport-Sync Started Oct 16 20:29:19 volumio volumio[1102]: info: Volumio called home Oct 16 20:29:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 16 20:29:19 volumio shairport-sync[1645]: shairport-sync: thread-watch.c:149: avahi_threaded_poll_stop: Assertion `!pthread_equal(pthread_self(), p->thread_id)' failed. Oct 16 20:29:19 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=6/ABRT Oct 16 20:29:19 volumio systemd[1]: shairport-sync.service: Failed with result 'signal'. Oct 16 20:29:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 20:29:19 volumio sudo[1643]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:19 volumio volumio[1102]: info: [jellyfin_server] Executing /usr/bin/sudo /bin/systemctl status jellyfin || true Oct 16 20:29:19 volumio volumio[1102]: info: Shairport-Sync Started Oct 16 20:29:19 volumio sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status jellyfin Oct 16 20:29:19 volumio sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:19 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 16 20:29:19 volumio sudo[1659]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:19 volumio RoonBridge[1585]: 00:00:00.005 Warn: get lock file path: /tmp/.rnbgem0- Oct 16 20:29:19 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 16 20:29:20 volumio sudo[1663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 20:29:20 volumio sudo[1663]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.229 Trace: [childprocess] using unix child process Oct 16 20:29:20 volumio mpd[1535]: Oct 16 20:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 16 20:29:20 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 16 20:29:20 volumio systemd[1]: mpd.service: Succeeded. Oct 16 20:29:20 volumio systemd[1]: Stopped Music Player Daemon. Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.268 Debug: PathForResource, filename: ../.update Oct 16 20:29:20 volumio systemd[1]: Starting Music Player Daemon... Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.297 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.302 Debug: PathForResource, filename: RAATServer Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.302 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.302 Debug: PathForResource, filename: RoonBridgeHelper Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.302 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Oct 16 20:29:20 volumio RoonBridge[1585]: Initializing Oct 16 20:29:20 volumio volumio[1102]: 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 Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.337 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Oct 16 20:29:20 volumio sudo[1665]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 20:29:20 volumio sudo[1665]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:20 volumio sudo[1665]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.377 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Oct 16 20:29:20 volumio RoonBridge[1585]: Not Running (.o) Oct 16 20:29:20 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:20 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:20 volumio screensaver.sh[754]: 1563 Oct 16 20:29:20 volumio volumio[1102]: info: [jellyfin_server] Executing /usr/bin/sudo /bin/systemctl status jellyfin || true Oct 16 20:29:20 volumio volumio[1102]: warn: peppy_screensaver: An error occurred on pygame check Command failed: python3 -c "import pygame" Oct 16 20:29:20 volumio volumio[1102]: Terminated Oct 16 20:29:20 volumio volumio[1102]: {"killed":false,"code":143,"signal":null,"cmd":"python3 -c \"import pygame\"","stack":"Error: Command failed: python3 -c \"import pygame\"\nTerminated\n\n at ChildProcess.exithandler (child_process.js:383:12)\n at ChildProcess.emit (events.js:400:28)\n at maybeClose (internal/child_process.js:1088:16)\n at Socket. (internal/child_process.js:446:11)\n at Socket.emit (events.js:400:28)\n at Pipe. (net.js:686:12)"} Oct 16 20:29:20 volumio sudo[1692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status jellyfin Oct 16 20:29:20 volumio sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:20 volumio sudo[1692]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:20 volumio RoonBridge[1585]: Running Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Jellyfin version: 10.9.6 Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Environment Variables: ["[JELLYFIN_LOG_DIR, /opt/jellyfin/log]"] Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Arguments: ["/opt/jellyfin/jellyfin_10.9.6/jellyfin.dll", "-d", "/opt/jellyfin/data", "-C", "/opt/jellyfin/cache", "-c", "/opt/jellyfin/config", "-l", "/opt/jellyfin/log", "--ffmpeg", "/usr/lib/jellyfin-ffmpeg/ffmpeg"] Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Operating system: Debian GNU/Linux 10 (buster) Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Architecture: X64 Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: 64-Bit Process: True Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: User Interactive: True Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Processor count: 4 Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Program data path: /opt/jellyfin/data Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Log directory path: /opt/jellyfin/log Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Config directory path: /opt/jellyfin/config Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Cache path: /opt/jellyfin/cache Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Web resources path: /opt/jellyfin/jellyfin_10.9.6/jellyfin-web Oct 16 20:29:20 volumio jellyfin[1553]: [20:29:20] [INF] [1] Main: Application directory: /opt/jellyfin/jellyfin_10.9.6/ Oct 16 20:29:20 volumio RoonBridge[1585]: 00:00:00.028 Warn: get lock file path: /tmp/.rnbhgem0- Oct 16 20:29:20 volumio mpd[1675]: Oct 16 20:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 16 20:29:20 volumio systemd[1]: Started Music Player Daemon. Oct 16 20:29:20 volumio sudo[1525]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:20 volumio sudo[1514]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:20 volumio sudo[1663]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:20 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 20:29:20 volumio volumio[1102]: error: MPD error: The expression evaluated to a falsy value: Oct 16 20:29:20 volumio volumio[1102]: assert.ok(self.idling) Oct 16 20:29:20 volumio volumio[1102]: error: The expression evaluated to a falsy value: Oct 16 20:29:20 volumio volumio[1102]: assert.ok(self.idling) Oct 16 20:29:20 volumio volumio[1102]: error: MPD error: The expression evaluated to a falsy value: Oct 16 20:29:20 volumio volumio[1102]: assert.ok(self.idling) Oct 16 20:29:20 volumio volumio[1102]: error: The expression evaluated to a falsy value: Oct 16 20:29:20 volumio volumio[1102]: assert.ok(self.idling) Oct 16 20:29:20 volumio volumio[1102]: info: MPD running with PID1675 Oct 16 20:29:20 volumio volumio[1102]: ,establishing connection Oct 16 20:29:20 volumio volumio[1102]: error: updateQueue error: null Oct 16 20:29:20 volumio volumio[1102]: info: [jellyfin_server] Executing /usr/bin/sudo /bin/systemctl status jellyfin || true Oct 16 20:29:20 volumio volumio[1102]: error: updateQueue error: null Oct 16 20:29:20 volumio sudo[1713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status jellyfin Oct 16 20:29:20 volumio sudo[1713]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:20 volumio sudo[1713]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:21 volumio jellyfin[1553]: [20:29:21] [INF] [1] Jellyfin.Server.Migrations.MigrationRunner: Marking following migrations as applied because this is a fresh install: ["CreateNetworkConfiguration", "MigrateMusicBrainzTimeout", "MigrateNetworkConfiguration"] Oct 16 20:29:21 volumio jellyfin[1553]: [20:29:21] [INF] [1] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /opt/jellyfin/cache Oct 16 20:29:21 volumio jellyfin[1553]: [20:29:21] [INF] [1] Emby.Server.Implementations.ApplicationHost: Loading assemblies Oct 16 20:29:21 volumio volumio[1102]: info: [jellyfin_server] Executing /usr/bin/sudo /bin/systemctl status jellyfin || true Oct 16 20:29:21 volumio ntpd[1091]: receive: Unexpected origin timestamp 0xec9b63a1.4fae431f does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xec9b63a1.c3a0c446 Oct 16 20:29:21 volumio sudo[1742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status jellyfin Oct 16 20:29:21 volumio sudo[1742]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:21 volumio sudo[1742]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:21 volumio ntpd[1091]: receive: Unexpected origin timestamp 0xec9b63a1.4faf090e does not match aorg 0000000000.00000000 from server@193.182.111.143 xmt 0xec9b63a1.d22948f5 Oct 16 20:29:21 volumio ntpd[1091]: receive: Unexpected origin timestamp 0xec9b63a1.4fad551e does not match aorg 0000000000.00000000 from server@193.182.111.12 xmt 0xec9b63a1.d780beec Oct 16 20:29:21 volumio ntpd[1091]: receive: Unexpected origin timestamp 0xec9b63a1.4fa8a5c1 does not match aorg 0000000000.00000000 from server@84.16.67.12 xmt 0xec9b63a1.da2c907b Oct 16 20:29:22 volumio jellyfin[1553]: [20:29:22] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN subnets: ["127.0.0.1/8", "10.0.0.0/8", "172.16.0.0/12", "192.168.0.0/16"] Oct 16 20:29:22 volumio jellyfin[1553]: [20:29:22] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions: [] Oct 16 20:29:22 volumio jellyfin[1553]: [20:29:22] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Used LAN subnets: ["127.0.0.1/8", "10.0.0.0/8", "172.16.0.0/12", "192.168.0.0/16"] Oct 16 20:29:22 volumio jellyfin[1553]: [20:29:22] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Filtered interface addresses: ["127.0.0.1", "192.168.13.105"] Oct 16 20:29:22 volumio jellyfin[1553]: [20:29:22] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Bind Addresses ["0.0.0.0"] Oct 16 20:29:22 volumio jellyfin[1553]: [20:29:22] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Remote IP filter is Allowlist Oct 16 20:29:22 volumio jellyfin[1553]: [20:29:22] [INF] [1] Jellyfin.Networking.Manager.NetworkManager: Filtered subnets: [] Oct 16 20:29:22 volumio volumio[1102]: 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: 4 Oct 16 20:29:22 volumio volumio[1102]: info: [jellyfin_server] Executing /usr/bin/sudo /bin/systemctl status jellyfin || true Oct 16 20:29:22 volumio sudo[1912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status jellyfin Oct 16 20:29:22 volumio sudo[1912]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:22 volumio sudo[1912]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:22 volumio volumio[1102]: info: Completed starting Core Plugins Oct 16 20:29:22 volumio volumio[1102]: info: ------------------------------------------- Oct 16 20:29:22 volumio volumio[1102]: info: ----- MyVolumio plugins startup ---- Oct 16 20:29:22 volumio volumio[1102]: info: ------------------------------------------- Oct 16 20:29:22 volumio volumio[1102]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 16 20:29:22 volumio volumio-remote-updater[785]: [2025-10-16 20:29:22] [connect] Successful connection Oct 16 20:29:22 volumio volumio-remote-updater[785]: [2025-10-16 20:29:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760617762 101 Oct 16 20:29:22 volumio volumio[1102]: 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: 5 Oct 16 20:29:23 volumio volumio[1102]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 20:29:23 volumio volumio[1102]: info: Received Get System Info Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 20:29:23 volumio volumio[1102]: info: Discovery: Getting this device information Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: Listing playlists Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 20:29:23 volumio volumio[1102]: info: Received Get System Info Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 20:29:23 volumio volumio[1102]: info: Discovery: Getting this device information Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 20:29:23 volumio volumio[1102]: info: Received Get System Info Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 20:29:23 volumio volumio[1102]: info: Discovery: Getting this device information Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 20:29:23 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:23 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:23 volumio volumio[1102]: info: Listing playlists Oct 16 20:29:25 volumio jellyfin[1553]: [20:29:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: TMDb 10.9.6.0 Oct 16 20:29:25 volumio jellyfin[1553]: [20:29:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: Studio Images 10.9.6.0 Oct 16 20:29:25 volumio jellyfin[1553]: [20:29:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: OMDb 10.9.6.0 Oct 16 20:29:25 volumio jellyfin[1553]: [20:29:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: MusicBrainz 10.9.6.0 Oct 16 20:29:25 volumio jellyfin[1553]: [20:29:25] [INF] [1] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: AudioDB 10.9.6.0 Oct 16 20:29:25 volumio jellyfin[1553]: [20:29:25] [INF] [1] Jellyfin.Server.Migrations.MigrationRunner: Marking following migrations as applied because this is a fresh install: ["DisableTranscodingThrottling", "CreateLoggingConfigHeirarchy", "MigrateActivityLogDatabase", "RemoveDuplicateExtras", "MigrateUserDatabase", "MigrateDisplayPreferencesDatabase", "RemoveDownloadImagesInAdvance", "MigrateAuthenticationDatabase", "FixPlaylistOwner", "MigrateRatingLevels", "FixAudioData"] Oct 16 20:29:25 volumio jellyfin[1553]: [20:29:25] [INF] [1] Main: Kestrel is listening on 0.0.0.0 Oct 16 20:29:25 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 20:29:26 volumio jellyfin[1553]: [20:29:26] [WRN] [1] Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware: The WebRootPath was not found: /wwwroot. Static files may be unavailable. Oct 16 20:29:26 volumio jellyfin[1553]: [20:29:26] [INF] [1] Emby.Server.Implementations.ApplicationHost: Running startup tasks Oct 16 20:29:26 volumio jellyfin[1553]: [20:29:26] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for Generate Trickplay Images set to fire at 2025-10-17 03:00:00.000 +08:00, which is 06:30:33.4250189 from now. Oct 16 20:29:26 volumio jellyfin[1553]: [20:29:26] [INF] [1] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for Extract Chapter Images set to fire at 2025-10-17 02:00:00.000 +08:00, which is 05:30:33.4202594 from now. Oct 16 20:29:26 volumio sudo[1934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 20:29:26 volumio sudo[1934]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:26 volumio sudo[1936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 20:29:26 volumio sudo[1936]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:26 volumio sudo[1936]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:26 volumio sudo[1934]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:26 volumio sudo[1942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 16 20:29:26 volumio sudo[1942]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:26 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 16 20:29:26 volumio sudo[1942]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:26 volumio volumio[1102]: info: Upmpdcli Daemon Started Oct 16 20:29:26 volumio volumio[1944]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 16 20:29:26 volumio jellyfin[1553]: [20:29:26] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Found ffmpeg version 6.0.1 Oct 16 20:29:26 volumio jellyfin[1553]: [20:29:26] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available decoders: ["libdav1d", "av1", "av1_cuvid", "av1_qsv", "h264", "h264_qsv", "h264_cuvid", "hevc", "hevc_qsv", "hevc_cuvid", "mpeg2video", "mpeg2_qsv", "mpeg2_cuvid", "mpeg4", "mpeg4_cuvid", "msmpeg4", "vc1_qsv", "vc1_cuvid", "vp8", "libvpx", "vp8_cuvid", "vp8_qsv", "vp9", "libvpx-vp9", "vp9_cuvid", "vp9_qsv", "aac", "ac3", "dca", "flac", "mp3", "truehd"] Oct 16 20:29:26 volumio jellyfin[1553]: [20:29:26] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available encoders: ["libsvtav1", "av1_nvenc", "av1_qsv", "av1_amf", "av1_vaapi", "libx264", "h264_amf", "h264_nvenc", "h264_qsv", "h264_v4l2m2m", "h264_vaapi", "libx265", "hevc_amf", "hevc_nvenc", "hevc_qsv", "hevc_vaapi", "mjpeg_qsv", "mjpeg_vaapi", "mpeg4", "msmpeg4", "libvpx", "libvpx-vp9", "aac", "libfdk_aac", "ac3", "alac", "dca", "flac", "libmp3lame", "libopus", "truehd", "libvorbis", "srt"] Oct 16 20:29:27 volumio jellyfin[1553]: [20:29:27] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available filters: ["deinterlace_qsv", "deinterlace_vaapi", "hwupload_cuda", "hwupload_vaapi", "libplacebo", "overlay_opencl", "overlay_qsv", "overlay_vaapi", "overlay_vulkan", "overlay_cuda", "procamp_vaapi", "scale_cuda", "scale_opencl", "scale_qsv", "scale_vaapi", "scale_vulkan", "tonemap_cuda", "tonemap_opencl", "tonemap_vaapi", "vpp_qsv", "yadif_cuda", "zscale", "alphasrc"] Oct 16 20:29:27 volumio volumio[1944]: .........................................................++++ Oct 16 20:29:27 volumio jellyfin[1553]: [20:29:27] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Available hwaccel types: ["cuda", "vaapi", "qsv", "drm", "opencl", "vulkan"] Oct 16 20:29:27 volumio volumio[1944]: ....................++++ Oct 16 20:29:27 volumio volumio[1944]: e is 65537 (0x010001) Oct 16 20:29:27 volumio volumio[1944]: writing RSA key Oct 16 20:29:27 volumio jellyfin[1553]: [20:29:27] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: FFmpeg: /usr/lib/jellyfin-ffmpeg/ffmpeg Oct 16 20:29:27 volumio jellyfin[1553]: [20:29:27] [INF] [1] Emby.Server.Implementations.ApplicationHost: ServerId: b1cfc0d663974d88a7e5ad9e731e53ae Oct 16 20:29:27 volumio jellyfin[1553]: [20:29:27] [INF] [1] Emby.Server.Implementations.ApplicationHost: Core startup complete Oct 16 20:29:27 volumio jellyfin[1553]: [20:29:27] [INF] [1] Main: Startup complete 0:00:07.7898125 Oct 16 20:29:29 volumio systemd[1]: systemd-fsckd.service: Succeeded. Oct 16 20:29:29 volumio jellyfin[1553]: [20:29:29] [INF] [11] Emby.Server.Implementations.ScheduledTasks.TaskManager: Clean up collections and playlists Completed after 0 minute(s) and 0 seconds Oct 16 20:29:30 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 16 20:29:31 volumio volumio[1102]: info: Adding plugin bluetooth to MyMusic Plugins Oct 16 20:29:31 volumio volumio[1102]: info: Adding plugin multiroom to MyMusic Plugins Oct 16 20:29:31 volumio volumio[1102]: info: Adding plugin metavolumio to MyMusic Plugins Oct 16 20:29:31 volumio volumio[1102]: info: Adding plugin cd_controller to MyMusic Plugins Oct 16 20:29:31 volumio volumio[1102]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 16 20:29:31 volumio volumio[1102]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 16 20:29:31 volumio jellyfin[1553]: [20:29:31] [INF] [8] Emby.Server.Implementations.ScheduledTasks.TaskManager: Update Plugins Completed after 0 minute(s) and 1 seconds Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 16 20:29:31 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:31 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:31 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:31 volumio volumio[1102]: info: Starting MyVolumio Remote Streaming Endpoints Oct 16 20:29:31 volumio volumio[1102]: info: MyVolumio login type: Token Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 16 20:29:31 volumio volumio[1102]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 16 20:29:32 volumio volumio[1102]: info: Starting Streaming Service Transparent Proxy Oct 16 20:29:32 volumio volumio[1102]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 16 20:29:32 volumio volumio[1102]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 16 20:29:32 volumio volumio[1102]: info: Streaming services startup Oct 16 20:29:32 volumio volumio[1102]: info: Starting Streaming Daemon Oct 16 20:29:32 volumio sudo[2014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 20:29:32 volumio sudo[2014]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:32 volumio volumio[1102]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 16 20:29:32 volumio sudo[2014]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:32 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 20:29:32 volumio volumio[1102]: error: Cannot start Volumio Streaming Daemon Oct 16 20:29:32 volumio volumio[1102]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 16 20:29:32 volumio volumio[1102]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 16 20:29:32 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:32 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:32 volumio volumio[1102]: STREAMING PROXY: Starting server on port 3245 Oct 16 20:29:32 volumio volumio[1102]: Node JS runtime: 14 Oct 16 20:29:39 volumio volumio[1102]: info: AutoStart - Plugin is starting Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioGetQueue Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::getQueue Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getQueue Oct 16 20:29:39 volumio volumio[1102]: info: AutoStart - start playing Oct 16 20:29:39 volumio volumio[1102]: info: AutoStart - start playing with no specific position Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPlay Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::play index 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::stop Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::play index undefined Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::startPlaybackTimer Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::clearAddPlayTracks USB/赵鹏 - 乌兰巴托的夜晚.flac Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand stop took 1 milliseconds Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand clear took 1 milliseconds Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand add "USB/赵鹏 - 乌兰巴托的夜晚.flac" Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: error: updateQueue error: null Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 4ms Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand add "USB/赵鹏 - 乌兰巴托的夜晚.flac" took 3 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 2ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 2ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 1ms Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand play Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Oct 16 20:29:39 volumio volumio[1102]: info: Ignoring MPD Status Update Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 4ms Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand play took 2 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 2ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 2ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 1ms Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 60 milliseconds Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 62 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 61 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 60 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus stop Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 67ms Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: Oct 16 20:29:39 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 7 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 3 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 2 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand status took 1 milliseconds Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":318,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"691 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus play Oct 16 20:29:39 volumio volumio[1102]: info: Received an update from plugin. extracting info from payload Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus play Oct 16 20:29:39 volumio volumio[1102]: info: Received an update from plugin. extracting info from payload Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus play Oct 16 20:29:39 volumio volumio[1102]: info: Received an update from plugin. extracting info from payload Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 87ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 87ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 87ms Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 16 20:29:39 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus play Oct 16 20:29:39 volumio volumio[1102]: info: Received an update from plugin. extracting info from payload Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus play Oct 16 20:29:39 volumio volumio[1102]: info: Received an update from plugin. extracting info from payload Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus play Oct 16 20:29:39 volumio volumio[1102]: info: Received an update from plugin. extracting info from payload Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:29:39 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState stateService play Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus play Oct 16 20:29:39 volumio volumio[1102]: info: Received an update from plugin. extracting info from payload Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:29:39 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:39 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 54ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 49ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 49ms Oct 16 20:29:39 volumio volumio[1102]: info: ------------------------------ 49ms Oct 16 20:29:39 volumio kernel: snd_hda_intel 0000:00:1b.0: IRQ timing workaround is activated for card #1. Suggest a bigger bdl_pos_adj. Oct 16 20:29:43 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:43 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:43 volumio sudo[2048]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 16 20:29:43 volumio sudo[2048]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:44 volumio volumio[1102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 16 20:29:44 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:44 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:45 volumio volumio[1102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 16 20:29:45 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:45 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:46 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 20:29:46 volumio volumio[1102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 16 20:29:46 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:46 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:49 volumio volumio[1102]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Oct 16 20:29:49 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:49 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 20:29:49 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:49 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 20:29:49 volumio volumio-remote-updater[785]: No test mode Oct 16 20:29:49 volumio volumio-remote-updater[785]: No alpha test mode Oct 16 20:29:49 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 20:29:51 volumio volumio[1102]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n
    \n
  • Fix plugin installations due to apt repository
    • \n
  • Fix chromecast playback
    • \n
\n

NEW ADDITIONS

\n
    \n
  • Add link for downloading CORRD in the side-menu
    • \n
\n","title":"Update v3.832","updateavailable":true} Oct 16 20:29:51 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 16 20:29:52 volumio volumio[1102]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 16 20:29:52 volumio volumio[1102]: info: Completed starting MyVolumio Plugin Oct 16 20:29:52 volumio volumio[1102]: info: BOOT COMPLETED Oct 16 20:29:52 volumio volumio[1102]: [Metrics] CommandRouter: 38s 92.51ms Oct 16 20:29:52 volumio volumio[1102]: info: CoreCommandRouter::volumiosetStartupVolume Oct 16 20:29:52 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 20:29:52 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 20:29:52 volumio volumio[1102]: info: CoreCommandRouter::Close All Modals sent Oct 16 20:29:52 volumio volumio[1102]: info: CoreCommandRouter::Close All Modals sent Oct 16 20:29:52 volumio volumio[1102]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Oct 16 20:29:52 volumio volumio[1102]: aplay: main:828: audio open error: Device or resource busy Oct 16 20:29:53 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 16 20:29:53 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 16 20:29:53 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 16 20:29:56 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 20:29:56 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 20:29:56 volumio volumio[1102]: info: Discovery: Getting this device information Oct 16 20:29:56 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:56 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:56 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 20:29:56 volumio volumio[1102]: verbose: New Socket.io Connection to 192.168.13.105 from 192.168.13.109 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 8 Oct 16 20:29:56 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:56 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:56 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 20:29:56 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 20:29:59 volumio sudo[2140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 20:29:59 volumio sudo[2140]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:59 volumio sudo[2143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 20:29:59 volumio sudo[2140]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:59 volumio sudo[2143]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 20:29:59 volumio sudo[2143]: pam_unix(sudo:session): session closed for user root Oct 16 20:29:59 volumio volumio[1102]: verbose: New Socket.io Connection to 192.168.13.105 from 192.168.13.109 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:59 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 20:29:59 volumio volumio[1102]: info: Received Get System Info Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 20:29:59 volumio volumio[1102]: info: Discovery: Getting this device information Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:59 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Oct 16 20:29:59 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:29:59 volumio volumio[1102]: info: Listing playlists Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 20:29:59 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::volumioPause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::stPlaybackTimer Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::servicePause Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::servicePause Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::pause Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand pause Oct 16 20:30:00 volumio volumio[1102]: info: Oct 16 20:30:00 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand pause took 1 milliseconds Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:30:00 volumio volumio[1102]: info: Oct 16 20:30:00 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:30:00 volumio volumio[1102]: info: Oct 16 20:30:00 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:30:00 volumio volumio[1102]: info: Oct 16 20:30:00 volumio volumio[1102]: ---------------------------- MPD announces state update: player Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::getState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand status Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand status took 3 milliseconds Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand status took 2 milliseconds Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand status took 1 milliseconds Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand status took 1 milliseconds Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseState Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 20:30:00 volumio volumio[1102]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:30:00 volumio volumio[1102]: verbose: ControllerMpd::parseTrackInfo Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":21878,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"730 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:30:00 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState stateService pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::stPlaybackTimer Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":21878,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"730 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:30:00 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState stateService pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::stPlaybackTimer Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":21878,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"730 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:30:00 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState stateService pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::stPlaybackTimer Oct 16 20:30:00 volumio volumio[1102]: info: ControllerMpd::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::servicePushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":21878,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"730 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 16 20:30:00 volumio volumio[1102]: verbose: CURRENT POSITION 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState stateService pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::syncState currentStatus pause Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::pushState Oct 16 20:30:00 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Oct 16 20:30:00 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Oct 16 20:30:00 volumio volumio[1102]: info: CoreStateMachine::stPlaybackTimer Oct 16 20:30:00 volumio volumio[1102]: info: ------------------------------ 29ms Oct 16 20:30:00 volumio volumio[1102]: info: ------------------------------ 28ms Oct 16 20:30:00 volumio volumio[1102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 20:30:00 volumio volumio[1102]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 16 20:30:00 volumio volumio[1102]: at Object.readdirSync (fs.js:1048:3) Oct 16 20:30:00 volumio volumio[1102]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 16 20:30:00 volumio volumio[1102]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 16 20:30:00 volumio volumio[1102]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 16 20:30:00 volumio volumio[1102]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 16 20:30:00 volumio volumio[1102]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 16 20:30:00 volumio volumio[1102]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 16 20:30:00 volumio volumio[1102]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 16 20:30:00 volumio volumio[1102]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 16 20:30:00 volumio volumio[1102]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 16 20:30:00 volumio volumio[1102]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 16 20:30:00 volumio volumio[1102]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 16 20:30:00 volumio volumio[1102]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 16 20:30:00 volumio volumio[1102]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 16 20:30:00 volumio volumio[1102]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 16 20:30:00 volumio volumio[1102]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 16 20:30:00 volumio volumio[1102]: errno: -20, Oct 16 20:30:00 volumio volumio[1102]: syscall: 'scandir', Oct 16 20:30:00 volumio volumio[1102]: code: 'ENOTDIR', Oct 16 20:30:00 volumio volumio[1102]: path: '/tmp/peppyrunning' Oct 16 20:30:00 volumio volumio[1102]: } Oct 16 20:30:00 volumio volumio[1102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 20:30:00 volumio sudo[2225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-16 20:29 Oct 16 20:30:00 volumio sudo[2225]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"