-- Logs begin at Fri 2025-05-16 23:03:56 UTC, end at Fri 2025-05-16 23:05:04 UTC. -- May 16 23:04:00 volumio dhcpcd[937]: eth0: waiting for carrier May 16 23:04:00 volumio sh[772]: eth0: waiting for carrier May 16 23:04:00 volumio dhcpcd[819]: eth0: waiting for carrier May 16 23:04:00 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 16 23:04:00 volumio dhcpcd[937]: wlan0: waiting for carrier May 16 23:04:00 volumio dhcpcd[937]: wlan0: carrier acquired May 16 23:04:00 volumio avahi-daemon[857]: Network interface enumeration completed. May 16 23:04:01 volumio avahi-daemon[857]: Server startup complete. Host name is volumio.local. Local service cookie is 1691770587. May 16 23:04:01 volumio dhcpcd[937]: DUID 00:04:4c:f1:0d:f5:91:1a:72:57:bd:11:75:13:62:02:52:60 May 16 23:04:01 volumio dhcpcd[937]: wlan0: IAID 37:14:31:b9 May 16 23:04:01 volumio dhcpcd[937]: wlan0: adding address fe80::3ba1:308:a75f:d395 May 16 23:04:01 volumio dhcpcd[937]: ipv6_addaddr1: Permission denied May 16 23:04:01 volumio dhcpcd[937]: wlan0: carrier lost May 16 23:04:02 volumio bluetoothd[846]: Loading LTKs timed out for hci0 May 16 23:04:02 volumio systemd[1]: iptables.service: Succeeded. May 16 23:04:02 volumio systemd[1]: Started Raise network interfaces. May 16 23:04:02 volumio systemd[1]: Reached target Network. May 16 23:04:02 volumio systemd[1]: Starting Permit User Sessions... May 16 23:04:02 volumio systemd[1]: Starting Network Time Service... May 16 23:04:02 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 16 23:04:02 volumio systemd[1]: Starting Music Player Daemon... May 16 23:04:02 volumio systemd[1]: Reached target Network is Online. May 16 23:04:02 volumio systemd[1]: Starting Samba NMB Daemon... May 16 23:04:02 volumio systemd[1]: Starting /etc/rc.local Compatibility... May 16 23:04:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 16 23:04:02 volumio systemd[1]: Starting LSB: Brings up/down network automatically... May 16 23:04:02 volumio systemd[1]: Starting Hostname Service... May 16 23:04:02 volumio systemd[1]: Started Permit User Sessions. May 16 23:04:02 volumio systemd[1]: Started /etc/rc.local Compatibility. May 16 23:04:02 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... May 16 23:04:02 volumio systemd[1]: Starting Hold until boot process finishes up... May 16 23:04:02 volumio systemd[1]: Received SIGRTMIN+21 from PID 379 (plymouthd). May 16 23:04:02 volumio dbus-daemon[843]: [system] Successfully activated service 'org.freedesktop.hostname1' May 16 23:04:02 volumio systemd[1]: Started Hostname Service. May 16 23:04:02 volumio systemd[1]: Received SIGRTMIN+21 from PID 379 (plymouthd). May 16 23:04:02 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. May 16 23:04:02 volumio systemd[1]: Started Hold until boot process finishes up. May 16 23:04:02 volumio systemd[1]: plymouth-quit.service: Succeeded. May 16 23:04:02 volumio systemd[1]: Started Terminate Plymouth Boot Screen. May 16 23:04:02 volumio systemd[1]: Started Getty on tty1. May 16 23:04:02 volumio systemd[1]: Reached target Login Prompts. May 16 23:04:02 volumio ifplugd(eth0)[1029]: ifplugd 0.28 initializing. May 16 23:04:02 volumio ifplugd(eth0)[1029]: Using interface eth0/3C:07:54:10:79:57 with driver (version: 6.6.32-volumio) May 16 23:04:02 volumio ifplugd(eth0)[1029]: Using detection mode: SIOCETHTOOL May 16 23:04:02 volumio ifplugd(eth0)[1029]: Initialization complete, link beat not detected. May 16 23:04:02 volumio loadcpufreq[945]: Loading cpufreq kernel modules...done (acpi-cpufreq). May 16 23:04:02 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 16 23:04:03 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 16 23:04:03 volumio systemd[1]: systemd-rfkill.service: Succeeded. May 16 23:04:03 volumio ifplugd[996]: Network Interface Plugging Daemon...start eth0...done. May 16 23:04:03 volumio systemd[1]: Started LSB: Brings up/down network automatically. May 16 23:04:03 volumio ntpd[991]: ntpd 4.2.8p12@1.3728-o (1): Starting May 16 23:04:03 volumio systemd[1]: Started Network Time Service. May 16 23:04:03 volumio ntpd[991]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 16 23:04:03 volumio ntpd[1054]: proto: precision = 0.128 usec (-23) May 16 23:04:03 volumio cpufrequtils[1049]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. May 16 23:04:03 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. May 16 23:04:03 volumio ntpd[1054]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 16 23:04:03 volumio ntpd[1054]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 16 23:04:03 volumio ntpd[1054]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 871 days ago May 16 23:04:03 volumio ntpd[1054]: Listen and drop on 0 v6wildcard [::]:123 May 16 23:04:03 volumio ntpd[1054]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 16 23:04:03 volumio ntpd[1054]: Listen normally on 2 lo 127.0.0.1:123 May 16 23:04:03 volumio ntpd[1054]: Listening on routing socket on fd #19 for interface updates May 16 23:04:03 volumio ntpd[1054]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 16 23:04:03 volumio ntpd[1054]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 16 23:04:03 volumio sudo[992]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 16 23:04:03 volumio sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:03 volumio sudo[992]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 16 23:04:03 volumio sudo[992]: pam_unix(sudo:session): session closed for user root May 16 23:04:03 volumio nmbd[999]: [2025/05/16 23:04:03.640155, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 16 23:04:03 volumio nmbd[999]: started asyncdns process 1065 May 16 23:04:03 volumio nmbd[999]: [2025/05/16 23:04:03.640886, 0] ../lib/util/become_daemon.c:149(daemon_status) May 16 23:04:03 volumio nmbd[999]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 16 23:04:03 volumio nmbd[999]: [2025/05/16 23:04:03.640941, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 16 23:04:03 volumio nmbd[999]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 16 23:04:03 volumio wireless.js[852]: Cleaning previous... May 16 23:04:04 volumio ntpd[1054]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 16 23:04:04 volumio volumio-time-update[844]: volumio-time-update-util: Fetching time from Volumio... May 16 23:04:04 volumio volumio-time-update[844]: volumio-time-update-util: Date not found in response May 16 23:04:04 volumio volumio-time-update[844]: volumio-time-update-util: Retrying in 5 seconds... May 16 23:04:04 volumio volumio-remote-updater[849]: [2025-05-16 23:04:04] [info] asio async_connect error: system:111 (Connection refused) May 16 23:04:04 volumio volumio-remote-updater[849]: [2025-05-16 23:04:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 16 23:04:04 volumio volumio-remote-updater[849]: [2025-05-16 23:04:04] [error] handle_connect error: Underlying Transport Error May 16 23:04:04 volumio sudo[1078]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 16 23:04:04 volumio sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:04 volumio sudo[1078]: pam_unix(sudo:session): session closed for user root May 16 23:04:04 volumio sudo[1080]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 16 23:04:04 volumio sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:04 volumio sudo[1080]: pam_unix(sudo:session): session closed for user root May 16 23:04:04 volumio wireless.js[852]: Stopped aP May 16 23:04:05 volumio sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 16 23:04:05 volumio sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:05 volumio ntpd[1054]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 16 23:04:05 volumio kernel: b43-phy0: Loading firmware version 666.2 (2011-02-23 01:15:07) May 16 23:04:05 volumio sudo[1087]: pam_unix(sudo:session): session closed for user root May 16 23:04:05 volumio sudo[1090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 16 23:04:05 volumio sudo[1090]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:05 volumio sudo[1090]: pam_unix(sudo:session): session closed for user root May 16 23:04:06 volumio sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 16 23:04:06 volumio sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:06 volumio sudo[1097]: pam_unix(sudo:session): session closed for user root May 16 23:04:06 volumio sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 16 23:04:06 volumio sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:06 volumio ntpd[1054]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 16 23:04:07 volumio ntpd[1054]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 16 23:04:07 volumio sudo[1099]: pam_unix(sudo:session): session closed for user root May 16 23:04:07 volumio wireless.js[852]: Start wireless flow May 16 23:04:07 volumio wireless.js[852]: Stopped hotspot (if there).. May 16 23:04:07 volumio sudo[1104]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 16 23:04:07 volumio sudo[1104]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:07 volumio sudo[1104]: pam_unix(sudo:session): session closed for user root May 16 23:04:07 volumio sudo[1106]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 16 23:04:07 volumio sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:07 volumio sudo[1106]: pam_unix(sudo:session): session closed for user root May 16 23:04:07 volumio wireless.js[852]: DHCP IP May 16 23:04:07 volumio wireless.js[852]: Start ap May 16 23:04:07 volumio wpa_supplicant[1108]: Successfully initialized wpa_supplicant May 16 23:04:07 volumio sudo[1109]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 16 23:04:07 volumio sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:07 volumio dhcpcd[1110]: sending commands to master dhcpcd process May 16 23:04:07 volumio dhcpcd[937]: control command: /sbin/dhcpcd May 16 23:04:07 volumio sudo[1109]: pam_unix(sudo:session): session closed for user root May 16 23:04:07 volumio kernel: b43-phy0: Loading firmware version 666.2 (2011-02-23 01:15:07) May 16 23:04:08 volumio wireless.js[852]: trying... May 16 23:04:08 volumio sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:08 volumio sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:08 volumio sudo[1114]: pam_unix(sudo:session): session closed for user root May 16 23:04:09 volumio mpd[1064]: May 16 23:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 16 23:04:09 volumio systemd[1]: Started Music Player Daemon. May 16 23:04:09 volumio mpd_monitor.sh[853]: MPD Monitor Service: MPD restarted due to no mpc output. May 16 23:04:09 volumio volumio-time-update[844]: volumio-time-update-util: Fetching time from Volumio... May 16 23:04:09 volumio volumio-time-update[844]: volumio-time-update-util: Date not found in response May 16 23:04:09 volumio volumio-time-update[844]: volumio-time-update-util: Retrying in 5 seconds... May 16 23:04:09 volumio wireless.js[852]: trying... May 16 23:04:09 volumio sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:09 volumio sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:09 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root May 16 23:04:09 volumio wpa_supplicant[1112]: wlan0: SME: Trying to authenticate with 74:06:35:99:b9:6d (SSID='VTR-7023671' freq=2437 MHz) May 16 23:04:09 volumio kernel: wlan0: authenticate with 74:06:35:99:b9:6d May 16 23:04:09 volumio kernel: wlan0: 80 MHz not supported, disabling VHT May 16 23:04:09 volumio wpa_supplicant[1112]: wlan0: Trying to associate with 74:06:35:99:b9:6d (SSID='VTR-7023671' freq=2437 MHz) May 16 23:04:09 volumio kernel: wlan0: send auth to 74:06:35:99:b9:6d (try 1/3) May 16 23:04:09 volumio kernel: wlan0: authenticated May 16 23:04:09 volumio kernel: wlan0: associate with 74:06:35:99:b9:6d (try 1/3) May 16 23:04:09 volumio wpa_supplicant[1112]: wlan0: Associated with 74:06:35:99:b9:6d May 16 23:04:09 volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 16 23:04:09 volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CL May 16 23:04:09 volumio kernel: wlan0: RX AssocResp from 74:06:35:99:b9:6d (capab=0x1011 status=0 aid=4) May 16 23:04:09 volumio kernel: wlan0: associated May 16 23:04:09 volumio kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by 74:06:35:99:b9:6d May 16 23:04:10 volumio wpa_supplicant[1112]: wlan0: WPA: Key negotiation completed with 74:06:35:99:b9:6d [PTK=CCMP GTK=CCMP] May 16 23:04:10 volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-CONNECTED - Connection to 74:06:35:99:b9:6d completed [id=0 id_str=] May 16 23:04:10 volumio dhcpcd[937]: wlan0: carrier acquired May 16 23:04:10 volumio dhcpcd[937]: wlan0: IAID 37:14:31:b9 May 16 23:04:10 volumio dhcpcd[937]: wlan0: rebinding lease of 192.168.0.17 May 16 23:04:10 volumio wireless.js[852]: trying... May 16 23:04:10 volumio sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:10 volumio sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:10 volumio sudo[1144]: pam_unix(sudo:session): session closed for user root May 16 23:04:10 volumio dhcpcd[937]: wlan0: soliciting an IPv6 router May 16 23:04:11 volumio dhcpcd[937]: wlan0: probing address 192.168.0.17/24 May 16 23:04:11 volumio wireless.js[852]: trying... May 16 23:04:11 volumio sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:11 volumio sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:11 volumio sudo[1147]: pam_unix(sudo:session): session closed for user root May 16 23:04:12 volumio volumio-remote-updater[849]: [2025-05-16 23:04:12] [info] asio async_connect error: system:111 (Connection refused) May 16 23:04:12 volumio volumio-remote-updater[849]: [2025-05-16 23:04:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 16 23:04:12 volumio volumio-remote-updater[849]: [2025-05-16 23:04:12] [error] handle_connect error: Underlying Transport Error May 16 23:04:12 volumio wireless.js[852]: trying... May 16 23:04:12 volumio sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:12 volumio sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:12 volumio sudo[1150]: pam_unix(sudo:session): session closed for user root May 16 23:04:13 volumio wireless.js[852]: trying... May 16 23:04:13 volumio sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:13 volumio sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:13 volumio sudo[1153]: pam_unix(sudo:session): session closed for user root May 16 23:04:14 volumio volumio-time-update[844]: volumio-time-update-util: Fetching time from Volumio... May 16 23:04:14 volumio volumio-time-update[844]: volumio-time-update-util: Date not found in response May 16 23:04:14 volumio volumio-time-update[844]: volumio-time-update-util: Retrying in 5 seconds... May 16 23:04:14 volumio wireless.js[852]: trying... May 16 23:04:14 volumio sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:14 volumio sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:14 volumio sudo[1161]: pam_unix(sudo:session): session closed for user root May 16 23:04:15 volumio wireless.js[852]: trying... May 16 23:04:15 volumio sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:15 volumio sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:15 volumio sudo[1164]: pam_unix(sudo:session): session closed for user root May 16 23:04:16 volumio dhcpcd[937]: wlan0: leased 192.168.0.17 for 604800 seconds May 16 23:04:16 volumio avahi-daemon[857]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.17. May 16 23:04:16 volumio avahi-daemon[857]: New relevant interface wlan0.IPv4 for mDNS. May 16 23:04:16 volumio dhcpcd[937]: wlan0: adding route to 192.168.0.0/24 May 16 23:04:16 volumio avahi-daemon[857]: Registering new address record for 192.168.0.17 on wlan0.IPv4. May 16 23:04:16 volumio dhcpcd[937]: wlan0: adding default route via 192.168.0.1 May 16 23:04:16 volumio wireless.js[852]: trying... May 16 23:04:16 volumio sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 16 23:04:16 volumio sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:16 volumio sudo[1184]: pam_unix(sudo:session): session closed for user root May 16 23:04:16 volumio wireless.js[852]: Connected to: ----VTR-7023671 May 16 23:04:16 volumio wireless.js[852]: ---- May 16 23:04:16 volumio sudo[1191]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 16 23:04:16 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:16 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root May 16 23:04:16 volumio wireless.js[852]: ... joined AP, wlan0 IPv4 is 192.168.0.17, ipV6 is undefined May 16 23:04:16 volumio wireless.js[852]: It's done! AP May 16 23:04:16 volumio ntpd[1054]: ntpd exiting on signal 15 (Terminated) May 16 23:04:16 volumio systemd[1]: Stopping Network Time Service... May 16 23:04:16 volumio systemd[1]: ntp.service: Succeeded. May 16 23:04:16 volumio systemd[1]: Stopped Network Time Service. May 16 23:04:16 volumio systemd[1]: Starting Network Time Service... May 16 23:04:16 volumio ntpd[1206]: ntpd 4.2.8p12@1.3728-o (1): Starting May 16 23:04:16 volumio ntpd[1206]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 16 23:04:16 volumio systemd[1]: Started Network Time Service. May 16 23:04:16 volumio ntpd[1212]: proto: precision = 0.061 usec (-24) May 16 23:04:16 volumio ntpd[1212]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 16 23:04:16 volumio ntpd[1212]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 16 23:04:16 volumio ntpd[1212]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 871 days ago May 16 23:04:16 volumio ntpd[1212]: Listen and drop on 0 v6wildcard [::]:123 May 16 23:04:16 volumio ntpd[1212]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 16 23:04:16 volumio ntpd[1212]: Listen normally on 2 lo 127.0.0.1:123 May 16 23:04:16 volumio ntpd[1212]: Listen normally on 3 wlan0 192.168.0.17:123 May 16 23:04:16 volumio ntpd[1212]: Listening on routing socket on fd #20 for interface updates May 16 23:04:16 volumio ntpd[1212]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 16 23:04:16 volumio ntpd[1212]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 16 23:04:17 volumio iwconfig[1215]: Error for wireless request "Set Power Management" (8B2C) : May 16 23:04:17 volumio iwconfig[1215]: SET failed on device wlan0 ; Operation not supported. May 16 23:04:17 volumio systemd[1]: Started Wireless Services. May 16 23:04:17 volumio systemd[1]: Started Volumio Backend Module. May 16 23:04:17 volumio systemd[1]: Started Start Volumio Kiosk. May 16 23:04:17 volumio systemd[1]: Started Intel SST and HDA soundcard init service. May 16 23:04:17 volumio systemd[1]: Started Volumio Cpu Tweaker. May 16 23:04:17 volumio ntpd[1212]: Soliciting pool server 64.176.13.132 May 16 23:04:18 volumio ntpd[1212]: Soliciting pool server 162.159.200.123 May 16 23:04:19 volumio volumio-time-update[844]: volumio-time-update-util: Fetching time from Volumio... May 16 23:04:19 volumio nmbd[999]: [2025/05/16 23:04:19.661984, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 16 23:04:19 volumio systemd[1]: Started Samba NMB Daemon. May 16 23:04:19 volumio nmbd[999]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 16 23:04:19 volumio systemd[1]: Starting Samba Winbind Daemon... May 16 23:04:19 volumio volumio-cpu-tweak[1219]: Setting RT Priority for mpd May 16 23:04:19 volumio volumio-cpu-tweak[1219]: Setting MPD Affinity May 16 23:04:19 volumio volumio-cpu-tweak[1219]: pid 1064's current affinity mask: f May 16 23:04:19 volumio volumio-cpu-tweak[1219]: pid 1064's new affinity mask: 3 May 16 23:04:19 volumio volumio-cpu-tweak[1219]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 16 23:04:19 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. May 16 23:04:19 volumio startx[1217]: X.Org X Server 1.20.4 May 16 23:04:19 volumio startx[1217]: X Protocol Version 11, Revision 0 May 16 23:04:19 volumio startx[1217]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian May 16 23:04:19 volumio startx[1217]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 May 16 23:04:19 volumio startx[1217]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=1f9d2b05-dd9a-4ae0-9071-3f477194c4bf bootpart=UUID=A474-C705 datapart=UUID=33bd9221-1888-4308-a302-01479145b622 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 May 16 23:04:19 volumio startx[1217]: Build Date: 18 December 2021 09:05:36AM May 16 23:04:19 volumio startx[1217]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) May 16 23:04:19 volumio startx[1217]: Current version of pixman: 0.36.0 May 16 23:04:19 volumio startx[1217]: Before reporting problems, check http://wiki.x.org May 16 23:04:19 volumio startx[1217]: to make sure that you have the latest version. May 16 23:04:19 volumio startx[1217]: Markers: (--) probed, (**) from config file, (==) default setting, May 16 23:04:19 volumio startx[1217]: (++) from command line, (!!) notice, (II) informational, May 16 23:04:19 volumio startx[1217]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 16 23:04:19 volumio startx[1217]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri May 16 23:04:19 2025 May 16 23:04:19 volumio startx[1217]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 16 23:04:19 volumio winbindd[1240]: [2025/05/16 23:04:19.886569, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 16 23:04:19 volumio winbindd[1240]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 16 23:04:20 volumio volumio-time-update[844]: volumio-time-update-util: Setting system time to: 2025-05-16 23:04:19 May 16 23:04:20 volumio sudo[1302]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-05-16 23:04:19 May 16 23:04:20 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:21 volumio winbindd[1240]: [2025/05/16 23:04:21.972275, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 16 23:04:21 volumio winbindd[1240]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 16 23:04:21 volumio systemd[1]: Started Samba Winbind Daemon. May 16 23:04:21 volumio dbus-daemon[843]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.8' (uid=0 pid=1303 comm="timedatectl set-time 2025-05-16 23:04:19 ") May 16 23:04:21 volumio systemd[1]: Starting Samba SMB Daemon... May 16 23:04:22 volumio volumio-remote-updater[849]: [2025-05-16 23:04:22] [info] asio async_connect error: system:111 (Connection refused) May 16 23:04:22 volumio volumio-remote-updater[849]: [2025-05-16 23:04:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 16 23:04:22 volumio volumio-remote-updater[849]: [2025-05-16 23:04:22] [error] handle_connect error: Underlying Transport Error May 16 23:04:22 volumio systemd[1]: Starting Time & Date Service... May 16 23:04:22 volumio dbus-daemon[843]: [system] Successfully activated service 'org.freedesktop.timedate1' May 16 23:04:22 volumio systemd[1]: Started Time & Date Service. May 16 23:04:19 volumio systemd-timedated[1331]: Changed local time to Fri May 16 23:04:19 2025 May 16 23:04:19 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root May 16 23:04:19 volumio volumio-time-update[844]: volumio-time-update-util: System time updated successfully. May 16 23:04:19 volumio systemd[1]: Started Volumio Time Update Utility. May 16 23:04:19 volumio systemd[1]: soundcard-init.service: Succeeded. May 16 23:04:19 volumio ntpd[1212]: Soliciting pool server 194.0.5.123 May 16 23:04:19 volumio ntpd[1212]: Soliciting pool server 64.176.4.213 May 16 23:04:20 volumio smbd[1324]: [2025/05/16 23:04:20.482365, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 16 23:04:20 volumio systemd[1]: Started Samba SMB Daemon. May 16 23:04:20 volumio smbd[1324]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 16 23:04:20 volumio systemd[1]: Reached target Multi-User System. May 16 23:04:20 volumio systemd[1]: Reached target Graphical Interface. May 16 23:04:20 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 16 23:04:20 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 16 23:04:20 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 16 23:04:20 volumio systemd[1]: Startup finished in 9.325s (kernel) + 28.966s (userspace) = 38.291s. May 16 23:04:20 volumio kernel: broken atomic modeset userspace detected, disabling atomic May 16 23:04:20 volumio ntpd[1212]: Soliciting pool server 64.176.3.116 May 16 23:04:20 volumio ntpd[1212]: Soliciting pool server 200.1.19.16 May 16 23:04:21 volumio ntpd[1212]: Soliciting pool server 2600:1901:4010:7af:: May 16 23:04:23 volumio startx[1217]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. May 16 23:04:24 volumio systemd[1]: systemd-fsckd.service: Succeeded. May 16 23:04:24 volumio volumio[1216]: info: ------------------------------------------- May 16 23:04:24 volumio volumio[1216]: info: ----- Volumio3 ---- May 16 23:04:24 volumio volumio[1216]: info: ------------------------------------------- May 16 23:04:24 volumio volumio[1216]: info: ----- System startup ---- May 16 23:04:24 volumio volumio[1216]: info: ------------------------------------------- May 16 23:04:25 volumio sh[772]: timed out May 16 23:04:25 volumio sh[772]: dhcpcd exited May 16 23:04:25 volumio dhcpcd[819]: timed out May 16 23:04:25 volumio dhcpcd[819]: dhcpcd exited May 16 23:04:25 volumio sh[772]: ifup: failed to bring up eth0 May 16 23:04:25 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 16 23:04:25 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 16 23:04:28 volumio volumio[1216]: info: MYVOLUMIO Environment detected May 16 23:04:32 volumio ntpd[1212]: receive: Unexpected origin timestamp 0xebd242fc.b29801fc does not match aorg 0000000000.00000000 from server@194.0.5.123 xmt 0xebd24300.96b77e16 May 16 23:04:32 volumio systemd[1]: systemd-hostnamed.service: Succeeded. May 16 23:04:34 volumio volumio[1216]: info: Plugin folders cleanup May 16 23:04:34 volumio volumio[1216]: info: Scanning into folder /volumio/app/plugins/ May 16 23:04:34 volumio volumio[1216]: info: Scanning category audio_interface May 16 23:04:34 volumio volumio[1216]: info: Scanning category miscellanea May 16 23:04:34 volumio volumio[1216]: info: Scanning category music_service May 16 23:04:34 volumio volumio[1216]: info: Scanning category plugins.json May 16 23:04:34 volumio volumio[1216]: info: Scanning category system_controller May 16 23:04:34 volumio volumio[1216]: info: Scanning category user_interface May 16 23:04:34 volumio volumio[1216]: info: Scanning into folder /data/plugins/ May 16 23:04:34 volumio volumio[1216]: info: Scanning category audio_interface May 16 23:04:34 volumio volumio[1216]: info: Scanning category music_service May 16 23:04:34 volumio volumio[1216]: info: Plugin folders cleanup completed May 16 23:04:34 volumio volumio[1216]: info: ------------------------------------------- May 16 23:04:34 volumio volumio[1216]: info: ----- Core plugins startup ---- May 16 23:04:34 volumio volumio[1216]: info: ------------------------------------------- May 16 23:04:34 volumio volumio[1216]: info: Loading plugins from folder /volumio/app/plugins/ May 16 23:04:34 volumio volumio[1216]: info: Adding plugin upnp to MyMusic Plugins May 16 23:04:34 volumio volumio[1216]: info: Adding plugin airplay_emulation to MyMusic Plugins May 16 23:04:34 volumio volumio[1216]: info: Adding plugin upnp_browser to MyMusic Plugins May 16 23:04:34 volumio volumio[1216]: info: Loading plugins from folder /data/plugins/ May 16 23:04:34 volumio volumio[1216]: info: Loading plugin "system"... May 16 23:04:34 volumio volumio[1216]: info: Loading plugin "appearance"... May 16 23:04:35 volumio volumio-remote-updater[849]: [2025-05-16 23:04:35] [connect] Successful connection May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "network"... May 16 23:04:37 volumio volumio[1216]: info: Refreshing Cached IP Addresses May 16 23:04:37 volumio sudo[1461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 16 23:04:37 volumio sudo[1461]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:37 volumio sudo[1461]: pam_unix(sudo:session): session closed for user root May 16 23:04:37 volumio sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 16 23:04:37 volumio sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:37 volumio sudo[1463]: pam_unix(sudo:session): session closed for user root May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "services"... May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "alsa_controller"... May 16 23:04:37 volumio sudo[1476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 16 23:04:37 volumio sudo[1476]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:37 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "wizard"... May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "networkfs"... May 16 23:04:37 volumio volumio[1216]: info: Starting Udev Watcher for removable devices May 16 23:04:37 volumio volumio[1216]: info: Ignoring mount for partition: boot May 16 23:04:37 volumio volumio[1216]: info: Ignoring mount for partition: volumio May 16 23:04:37 volumio volumio[1216]: info: Ignoring mount for partition: volumio_data May 16 23:04:37 volumio volumio[1216]: info: Ignoring mount for partition: EFI May 16 23:04:37 volumio volumio[1216]: info: Ignoring mount for partition: 2c5c38fc-7c62-402c-a5a0-5e46f24baf79 May 16 23:04:37 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "volumio_command_line_client"... May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "upnp"... May 16 23:04:37 volumio volumio[1216]: info: [1747436677737] Starting Upmpd Daemon May 16 23:04:37 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "my_music"... May 16 23:04:37 volumio volumio[1216]: info: Loading plugin "mpd"... May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "upnp_browser"... May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "alarm-clock"... May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "airplay_emulation"... May 16 23:04:38 volumio volumio[1216]: info: Starting Shairport Sync May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "last_100"... May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "webradio"... May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "i2s_dacs"... May 16 23:04:38 volumio volumio[1216]: info: I2S DAC not set, start Auto-detection May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "volumiodiscovery"... May 16 23:04:38 volumio volumio[1216]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 16 23:04:38 volumio volumio[1216]: *** WARNING *** Please fix your application to use the native API of Avahi! May 16 23:04:38 volumio volumio[1216]: *** WARNING *** For more information see May 16 23:04:38 volumio node[1216]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 16 23:04:38 volumio volumio[1216]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 16 23:04:38 volumio volumio[1216]: *** WARNING *** Please fix your application to use the native API of Avahi! May 16 23:04:38 volumio volumio[1216]: *** WARNING *** For more information see May 16 23:04:38 volumio node[1216]: *** WARNING *** Please fix your application to use the native API of Avahi! May 16 23:04:38 volumio node[1216]: *** WARNING *** For more information see May 16 23:04:38 volumio node[1216]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 16 23:04:38 volumio node[1216]: *** WARNING *** Please fix your application to use the native API of Avahi! May 16 23:04:38 volumio node[1216]: *** WARNING *** For more information see May 16 23:04:38 volumio volumio[1216]: info: Applying required configuration parameters for plugin volumiodiscovery May 16 23:04:38 volumio volumio[1216]: info: Discovery: Started advertising with name: Volumio May 16 23:04:38 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 16 23:04:38 volumio volumio[1216]: info: Loading plugin "spop"... May 16 23:04:42 volumio sudo[1476]: pam_unix(sudo:session): session closed for user root May 16 23:04:50 volumio volumio-remote-updater[849]: [2025-05-16 23:04:50] [connect] Successful connection May 16 23:04:52 volumio systemd[1]: systemd-timedated.service: Succeeded. May 16 23:04:56 volumio volumio[1216]: info: Plugin ytcr is not enabled May 16 23:04:56 volumio volumio[1216]: info: Loading plugin "outputs"... May 16 23:04:56 volumio volumio[1216]: info: Loading plugin "albumart"... May 16 23:04:56 volumio volumio[1216]: info: Plugin example_plugin is not enabled May 16 23:04:56 volumio volumio[1216]: info: Loading plugin "inputs"... May 16 23:04:56 volumio volumio[1216]: info: Loading plugin "updater_comm"... May 16 23:04:56 volumio volumio[1216]: Forking 3 albumart workers May 16 23:04:56 volumio volumio[1216]: info: Plugin mpdemulation is not enabled May 16 23:04:56 volumio volumio[1216]: info: Loading plugin "rest_api"... May 16 23:04:56 volumio volumio[1216]: info: Loading plugin "websocket"... May 16 23:04:56 volumio volumio[1216]: info: Starting Socket.io Server version 2.3.0 May 16 23:04:56 volumio volumio[1216]: info: Loading plugin "fusiondsp"... May 16 23:04:56 volumio volumio[1216]: Starting albumart workers May 16 23:04:56 volumio volumio[1216]: Starting albumart workers May 16 23:04:56 volumio volumio[1216]: Starting albumart workers May 16 23:04:56 volumio volumio[1216]: info: Applying required configuration parameters for plugin fusiondsp May 16 23:04:56 volumio volumio[1216]: info: Loading i18n strings for locale es May 16 23:04:56 volumio volumio[1216]: Updating browse sources language May 16 23:04:56 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::initPlayerControls May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 16 23:04:57 volumio volumio[1216]: Express server listening on port 3000 May 16 23:04:57 volumio volumio[1216]: [Metrics] WebUI: 32s 419.85ms May 16 23:04:57 volumio volumio[1216]: info: Setting Device type: x86 May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::resetVolumioState May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::getcurrentVolume May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioRetrievevolume May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio sudo[1658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 16 23:04:57 volumio sudo[1658]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio sudo[1658]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio volumio[1216]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 16 23:04:57 volumio volumio[1216]: info: Completed loading Core Plugins May 16 23:04:57 volumio sudo[1660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 16 23:04:57 volumio volumio[1216]: info: Preparing to generate the ALSA configuration file May 16 23:04:57 volumio sudo[1660]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio sudo[1660]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio volumio[1216]: info: Cannot read play queue from file May 16 23:04:57 volumio volumio[1216]: info: Volumio Network Manager: Network status updated: 2 May 16 23:04:57 volumio volumio[1216]: Unable to parse: May 16 23:04:57 volumio volumio[1216]: Simple mixer control 'PCM',0 May 16 23:04:57 volumio volumio[1216]: Capabilities: pswitch pswitch-joined May 16 23:04:57 volumio volumio[1216]: Playback channels: Mono May 16 23:04:57 volumio volumio[1216]: Mono: Playback [on] May 16 23:04:57 volumio volumio[1216]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output May 16 23:04:57 volumio volumio[1216]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 16 23:04:57 volumio volumio[1216]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 16 23:04:57 volumio volumio[1216]: info: Reading ALSA contributions from plugins. May 16 23:04:57 volumio volumio[1216]: Unable to parse: May 16 23:04:57 volumio volumio[1216]: Simple mixer control 'PCM',0 May 16 23:04:57 volumio volumio[1216]: Capabilities: pswitch pswitch-joined May 16 23:04:57 volumio volumio[1216]: Playback channels: Mono May 16 23:04:57 volumio volumio[1216]: Mono: Playback [on] May 16 23:04:57 volumio volumio[1216]: info: VolumeController:: Volume=undefined Mute =false May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::pushState May 16 23:04:57 volumio volumio[1216]: info: CorePlayQueue::getTrack 0 May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioPushState May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::updateTrackBlock May 16 23:04:57 volumio volumio[1216]: info: CorePlayQueue::getTrackBlock May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioRetrievevolume May 16 23:04:57 volumio volumio[1216]: Unable to parse: May 16 23:04:57 volumio volumio[1216]: Simple mixer control 'PCM',0 May 16 23:04:57 volumio volumio[1216]: Capabilities: pswitch pswitch-joined May 16 23:04:57 volumio volumio[1216]: Playback channels: Mono May 16 23:04:57 volumio volumio[1216]: Mono: Playback [on] May 16 23:04:57 volumio volumio[1216]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::setRepeat null single undefined May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::pushState May 16 23:04:57 volumio volumio[1216]: info: CorePlayQueue::getTrack 0 May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioPushState May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::setRandom null May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::pushState May 16 23:04:57 volumio volumio[1216]: info: CorePlayQueue::getTrack 0 May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioPushState May 16 23:04:57 volumio volumio[1216]: Unable to parse: May 16 23:04:57 volumio volumio[1216]: Simple mixer control 'PCM',0 May 16 23:04:57 volumio volumio[1216]: Capabilities: pswitch pswitch-joined May 16 23:04:57 volumio volumio[1216]: Playback channels: Mono May 16 23:04:57 volumio volumio[1216]: Mono: Playback [on] May 16 23:04:57 volumio volumio[1216]: info: VolumeController:: Volume=undefined Mute =false May 16 23:04:57 volumio volumio[1216]: info: CoreStateMachine::pushState May 16 23:04:57 volumio volumio[1216]: info: CorePlayQueue::getTrack 0 May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioPushState May 16 23:04:57 volumio volumio[1216]: info: Asound.conf file unchanged, so no further update is needed May 16 23:04:57 volumio volumio[1216]: info: Output device has changed, restarting MPD May 16 23:04:57 volumio sudo[1672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 16 23:04:57 volumio sudo[1672]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio volumio[1216]: info: Output device has changed, restarting Shairport Sync May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 16 23:04:57 volumio sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio sudo[1675]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio sudo[1678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 16 23:04:57 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 16 23:04:57 volumio sudo[1678]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio sudo[1672]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio volumio[1216]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 16 23:04:57 volumio systemd[1]: Stopping Music Player Daemon... May 16 23:04:57 volumio volumio[1216]: info: ___________ START PLUGINS ___________ May 16 23:04:57 volumio volumio[1216]: info: ControllerMpd::onStart: Initializing MPD May 16 23:04:57 volumio volumio[1216]: info: Creating MPD Configuration file May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 16 23:04:57 volumio volumio[1216]: info: [1747436697293] CoreMusicLibrary::Adding element Media Servers May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 16 23:04:57 volumio sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 16 23:04:57 volumio sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio sudo[1685]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio systemd[1]: mpd.service: Succeeded. May 16 23:04:57 volumio sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 16 23:04:57 volumio sudo[1687]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio systemd[1]: Stopped Music Player Daemon. May 16 23:04:57 volumio systemd[1]: Starting Music Player Daemon... May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM May 16 23:04:57 volumio systemd[1]: mpd.service: Succeeded. May 16 23:04:57 volumio systemd[1]: Stopped Music Player Daemon. May 16 23:04:57 volumio systemd[1]: Starting Music Player Daemon... May 16 23:04:57 volumio volumio[1216]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 16 23:04:57 volumio sudo[1692]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 16 23:04:57 volumio sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio volumio[1216]: info: [1747436697336] CoreMusicLibrary::Adding element Last_100 May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 16 23:04:57 volumio volumio[1216]: info: [1747436697337] CoreMusicLibrary::Adding element Webradio May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 16 23:04:57 volumio sudo[1692]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio volumio[1216]: info: Initializing BBC Radios May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: Creating Spotify config file May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: Loading i18n strings for locale es May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: FusionDsp - mixtype--------------------- Hardware May 16 23:04:57 volumio volumio[1216]: info: Volumio Calling Home May 16 23:04:57 volumio volumio[1216]: info: Preparing to generate the ALSA configuration file May 16 23:04:57 volumio volumio[1216]: info: Discovery: adding c4e97557-6296-4695-acd5-33fcbe9383ea May 16 23:04:57 volumio volumio[1216]: info: Discovery: Found device Volumio May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioGetState May 16 23:04:57 volumio volumio[1216]: info: CorePlayQueue::getTrack 0 May 16 23:04:57 volumio volumio[1216]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 16 23:04:57 volumio volumio[1216]: info: Reading ALSA contributions from plugins. May 16 23:04:57 volumio volumio[1216]: info: MPD Permissions set May 16 23:04:57 volumio volumio[1216]: info: MPD Permissions set May 16 23:04:57 volumio volumio[1216]: info: Upmpdcli Daemon Started May 16 23:04:57 volumio volumio[1216]: info: Spotify config file written May 16 23:04:57 volumio sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service May 16 23:04:57 volumio sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio volumio[1216]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 May 16 23:04:57 volumio volumio[1216]: info: No need to fix Spotify hosts May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio systemd[1]: Started go-librespot Daemon. May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 16 23:04:57 volumio go-librespot[1731]: go-librespot daemon starting... May 16 23:04:57 volumio sudo[1721]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: Starting Shairport Sync May 16 23:04:57 volumio volumio[1216]: info: Starting Shairport Sync May 16 23:04:57 volumio sudo[1746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 16 23:04:57 volumio sudo[1746]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio volumio[1216]: info: Starting Shairport Sync May 16 23:04:57 volumio sudo[1749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 16 23:04:57 volumio sudo[1749]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::volumioGetState May 16 23:04:57 volumio volumio[1216]: info: CorePlayQueue::getTrack 0 May 16 23:04:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 16 23:04:57 volumio systemd[1]: shairport-sync.service: Succeeded. May 16 23:04:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 16 23:04:57 volumio sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 16 23:04:57 volumio sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 16 23:04:57 volumio volumio[1216]: info: Asound.conf file unchanged, so no further update is needed May 16 23:04:57 volumio volumio[1216]: info: Output device has changed, restarting MPD May 16 23:04:57 volumio volumio[1216]: info: Output device has changed, restarting Shairport Sync May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio sudo[1756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 16 23:04:57 volumio sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio sudo[1759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 16 23:04:57 volumio sudo[1749]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio sudo[1759]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 16 23:04:57 volumio sudo[1746]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM May 16 23:04:57 volumio systemd[1]: shairport-sync.service: Succeeded. May 16 23:04:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 16 23:04:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 16 23:04:57 volumio sudo[1756]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio sudo[1752]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio volumio[1216]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 16 23:04:57 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 16 23:04:57 volumio systemd[1]: mpd.service: Succeeded. May 16 23:04:57 volumio systemd[1]: Stopped Music Player Daemon. May 16 23:04:57 volumio systemd[1]: Starting Music Player Daemon... May 16 23:04:57 volumio volumio[1216]: info: MPD Permissions set May 16 23:04:57 volumio volumio[1216]: info: Shairport-Sync Started May 16 23:04:57 volumio volumio[1216]: Error adding Membership: Error: addMembership EINVAL May 16 23:04:57 volumio volumio[1216]: info: Shairport-Sync Started May 16 23:04:57 volumio volumio[1216]: info: Shairport-Sync Started May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 16 23:04:57 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:04:57 volumio volumio[1216]: info: Starting Shairport Sync May 16 23:04:57 volumio sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 16 23:04:57 volumio sudo[1771]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 16 23:04:57 volumio sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio sudo[1771]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:04:57 volumio sudo[1771]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 16 23:04:57 volumio systemd[1]: shairport-sync.service: Succeeded. May 16 23:04:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 16 23:04:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 16 23:04:57 volumio volumio[1216]: info: Volumio called home May 16 23:04:57 volumio sudo[1780]: pam_unix(sudo:session): session closed for user root May 16 23:04:57 volumio volumio[1216]: info: Shairport-Sync Started May 16 23:04:58 volumio go-librespot[1731]: time="2025-05-16T23:04:58Z" level=info msg="running go-librespot 0.2.0" May 16 23:04:58 volumio mpd[1783]: May 16 23:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 16 23:04:58 volumio systemd[1]: Started Music Player Daemon. May 16 23:04:58 volumio sudo[1687]: pam_unix(sudo:session): session closed for user root May 16 23:04:58 volumio sudo[1678]: pam_unix(sudo:session): session closed for user root May 16 23:04:58 volumio sudo[1759]: pam_unix(sudo:session): session closed for user root May 16 23:04:58 volumio go-librespot[1731]: time="2025-05-16T23:04:58Z" level=debug msg="app state loaded" May 16 23:04:58 volumio go-librespot[1731]: time="2025-05-16T23:04:58Z" level=debug msg="stored credentials not found" May 16 23:04:59 volumio volumio[1216]: info: Completed starting Core Plugins May 16 23:04:59 volumio volumio[1216]: info: ------------------------------------------- May 16 23:04:59 volumio volumio[1216]: info: ----- MyVolumio plugins startup ---- May 16 23:04:59 volumio volumio[1216]: info: ------------------------------------------- May 16 23:04:59 volumio volumio[1216]: info: [MyVolumio PluginManager] Fetching plans data.... May 16 23:04:59 volumio go-librespot[1731]: time="2025-05-16T23:04:59Z" level=info msg="api server listening on 127.0.0.1:9879" May 16 23:05:02 volumio volumio[1216]: info: camilladsp service started and running in background, instance 1 May 16 23:05:02 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 16 23:05:03 volumio volumio[1216]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 16 23:05:03 volumio volumio[1216]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 16 23:05:03 volumio volumio[1216]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 16 23:05:03 volumio volumio[1216]: info: FusionDsp loaded May 16 23:05:03 volumio volumio[1216]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 16 23:05:03 volumio volumio[1216]: info: FusionDsp - Reporting Fusion DSP Enabled May 16 23:05:03 volumio volumio[1216]: info: Adding Signal Path Element [object Object] May 16 23:05:03 volumio volumio[1216]: info: Adding fusiondspeq DSP Signal Path Element May 16 23:05:03 volumio volumio[1216]: info: FusionDsp - ---- installed callbackRead May 16 23:05:03 volumio volumio[1216]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 16 23:05:03 volumio volumio[1216]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT May 16 23:05:03 volumio volumio[1216]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) May 16 23:05:03 volumio volumio[1216]: at onErrorNT (internal/child_process.js:472:16) May 16 23:05:03 volumio volumio[1216]: at processTicksAndRejections (internal/process/task_queues.js:82:21) May 16 23:05:03 volumio volumio[1216]: at runNextTicks (internal/process/task_queues.js:64:3) May 16 23:05:03 volumio volumio[1216]: at listOnTimeout (internal/timers.js:526:9) May 16 23:05:03 volumio volumio[1216]: at processTimers (internal/timers.js:500:7) { May 16 23:05:03 volumio volumio[1216]: errno: -2, May 16 23:05:03 volumio volumio[1216]: code: 'ENOENT', May 16 23:05:03 volumio volumio[1216]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 16 23:05:03 volumio volumio[1216]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 16 23:05:03 volumio volumio[1216]: spawnargs: [ May 16 23:05:03 volumio volumio[1216]: '-p', May 16 23:05:03 volumio volumio[1216]: 9876, May 16 23:05:03 volumio volumio[1216]: '-o', May 16 23:05:03 volumio volumio[1216]: '/tmp/camilladsp.log', May 16 23:05:03 volumio volumio[1216]: '-l', May 16 23:05:03 volumio volumio[1216]: 'warn', May 16 23:05:03 volumio volumio[1216]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 16 23:05:03 volumio volumio[1216]: ] May 16 23:05:03 volumio volumio[1216]: } May 16 23:05:03 volumio volumio[1216]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 16 23:05:04 volumio sudo[1847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 16 23:05:04 volumio sudo[1847]: pam_unix(sudo:session): session opened for user root by (uid=0) May 16 23:05:04 volumio sudo[1858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-16 23:04 May 16 23:05:04 volumio sudo[1858]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"