-- Logs begin at Sun 2025-05-11 09:52:55 CEST, end at Sun 2025-05-11 09:54:41 CEST. -- May 11 09:53:00 volumio51 ntpd[989]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 11 09:53:00 volumio51 sudo[1047]: pam_unix(sudo:session): session closed for user root May 11 09:53:00 volumio51 wireless.js[740]: SETTING APPROPRIATE REG DOMAIN: CH May 11 09:53:00 volumio51 sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 11 09:53:00 volumio51 sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:00 volumio51 sudo[1055]: pam_unix(sudo:session): session closed for user root May 11 09:53:00 volumio51 sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CH May 11 09:53:00 volumio51 sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:00 volumio51 sudo[1057]: pam_unix(sudo:session): session closed for user root May 11 09:53:00 volumio51 wireless.js[740]: SUCCESSFULLY SET NEW REGDOMAIN: CH May 11 09:53:00 volumio51 wireless.js[740]: Start wireless flow May 11 09:53:00 volumio51 wireless.js[740]: Stopped hotspot (if there).. May 11 09:53:00 volumio51 sudo[1062]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 11 09:53:00 volumio51 sudo[1062]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:00 volumio51 sudo[1062]: pam_unix(sudo:session): session closed for user root May 11 09:53:00 volumio51 sudo[1064]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 11 09:53:00 volumio51 sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:01 volumio51 sudo[1064]: pam_unix(sudo:session): session closed for user root May 11 09:53:01 volumio51 wireless.js[740]: DHCP IP May 11 09:53:01 volumio51 wireless.js[740]: Start ap May 11 09:53:01 volumio51 wpa_supplicant[1066]: Successfully initialized wpa_supplicant May 11 09:53:01 volumio51 sudo[1067]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 11 09:53:01 volumio51 sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:01 volumio51 dhcpcd[1068]: dev: loaded udev May 11 09:53:01 volumio51 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 11 09:53:01 volumio51 dhcpcd-run-hooks[1086]: wlan0: starting wpa_supplicant May 11 09:53:01 volumio51 ntpd[989]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 11 09:53:01 volumio51 dhcpcd-run-hooks[1091]: wlan0: failed to start wpa_supplicant May 11 09:53:01 volumio51 dhcpcd-run-hooks[1092]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma May 11 09:53:01 volumio51 dhcpcd[1068]: wlan0: connected to Access Point `' May 11 09:53:01 volumio51 dhcpcd[1068]: no interfaces have a carrier May 11 09:53:01 volumio51 dhcpcd[1068]: forked to background, child pid 1102 May 11 09:53:01 volumio51 dhcpcd[1102]: eth0: waiting for carrier May 11 09:53:01 volumio51 dhcpcd[1102]: wlan0: waiting for carrier May 11 09:53:01 volumio51 sudo[1067]: pam_unix(sudo:session): session closed for user root May 11 09:53:01 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:01] [info] asio async_connect error: system:111 (Connection refused) May 11 09:53:01 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 11 09:53:01 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:01] [error] handle_connect error: Underlying Transport Error May 11 09:53:01 volumio51 volumio-time-update[736]: volumio-time-update-util: Fetching time from Volumio... May 11 09:53:01 volumio51 volumio-time-update[736]: volumio-time-update-util: Date not found in response May 11 09:53:01 volumio51 volumio-time-update[736]: volumio-time-update-util: Retrying in 5 seconds... May 11 09:53:02 volumio51 wireless.js[740]: trying... May 11 09:53:02 volumio51 systemd[1]: systemd-rfkill.service: Succeeded. May 11 09:53:02 volumio51 sudo[1109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:02 volumio51 sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:02 volumio51 sudo[1109]: pam_unix(sudo:session): session closed for user root May 11 09:53:02 volumio51 bthelper[903]: Changing power off succeeded May 11 09:53:02 volumio51 bthelper[903]: [CHG] Controller 2C:CF:67:1F:78:39 Class: 0x0000041c May 11 09:53:02 volumio51 bthelper[903]: Changing power on succeeded May 11 09:53:03 volumio51 wireless.js[740]: trying... May 11 09:53:03 volumio51 sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:03 volumio51 sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:03 volumio51 sudo[1113]: pam_unix(sudo:session): session closed for user root May 11 09:53:04 volumio51 wireless.js[740]: trying... May 11 09:53:04 volumio51 sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:04 volumio51 sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:04 volumio51 sudo[1116]: pam_unix(sudo:session): session closed for user root May 11 09:53:05 volumio51 wireless.js[740]: trying... May 11 09:53:05 volumio51 sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:05 volumio51 sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:05 volumio51 sudo[1119]: pam_unix(sudo:session): session closed for user root May 11 09:53:06 volumio51 wireless.js[740]: trying... May 11 09:53:06 volumio51 sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:06 volumio51 sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:06 volumio51 sudo[1122]: pam_unix(sudo:session): session closed for user root May 11 09:53:06 volumio51 volumio-time-update[736]: volumio-time-update-util: Fetching time from Volumio... May 11 09:53:06 volumio51 volumio-time-update[736]: volumio-time-update-util: Date not found in response May 11 09:53:06 volumio51 volumio-time-update[736]: volumio-time-update-util: Retrying in 5 seconds... May 11 09:53:06 volumio51 wpa_supplicant[1090]: wlan0: Trying to associate with SSID 'LArgentiere' May 11 09:53:07 volumio51 wireless.js[740]: trying... May 11 09:53:07 volumio51 sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:07 volumio51 sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:07 volumio51 sudo[1130]: pam_unix(sudo:session): session closed for user root May 11 09:53:07 volumio51 wpa_supplicant[1090]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 May 11 09:53:08 volumio51 wireless.js[740]: trying... May 11 09:53:08 volumio51 sudo[1133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:08 volumio51 sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:08 volumio51 sudo[1133]: pam_unix(sudo:session): session closed for user root May 11 09:53:09 volumio51 wireless.js[740]: trying... May 11 09:53:09 volumio51 sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:09 volumio51 sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:09 volumio51 sudo[1136]: pam_unix(sudo:session): session closed for user root May 11 09:53:09 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:09] [info] asio async_connect error: system:111 (Connection refused) May 11 09:53:09 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 11 09:53:09 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:09] [error] handle_connect error: Underlying Transport Error May 11 09:53:10 volumio51 wireless.js[740]: trying... May 11 09:53:10 volumio51 sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:10 volumio51 sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:10 volumio51 sudo[1139]: pam_unix(sudo:session): session closed for user root May 11 09:53:11 volumio51 wireless.js[740]: trying... May 11 09:53:11 volumio51 sudo[1142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:11 volumio51 sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:11 volumio51 sudo[1142]: pam_unix(sudo:session): session closed for user root May 11 09:53:11 volumio51 volumio-time-update[736]: volumio-time-update-util: Fetching time from Volumio... May 11 09:53:11 volumio51 volumio-time-update[736]: volumio-time-update-util: Date not found in response May 11 09:53:11 volumio51 volumio-time-update[736]: volumio-time-update-util: Retrying in 5 seconds... May 11 09:53:12 volumio51 wireless.js[740]: trying... May 11 09:53:12 volumio51 sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:12 volumio51 sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:12 volumio51 sudo[1150]: pam_unix(sudo:session): session closed for user root May 11 09:53:13 volumio51 wireless.js[740]: trying... May 11 09:53:13 volumio51 sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:13 volumio51 sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:13 volumio51 sudo[1153]: pam_unix(sudo:session): session closed for user root May 11 09:53:13 volumio51 wpa_supplicant[1090]: wlan0: Trying to associate with SSID 'LArgentiere' May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: carrier acquired May 11 09:53:13 volumio51 wpa_supplicant[1090]: wlan0: Associated with 0c:ea:14:44:d3:7e May 11 09:53:13 volumio51 wpa_supplicant[1090]: wlan0: CTRL-EVENT-CONNECTED - Connection to 0c:ea:14:44:d3:7e completed [id=0 id_str=] May 11 09:53:13 volumio51 wpa_supplicant[1090]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: connected to Access Point `LArgentiere' May 11 09:53:13 volumio51 wpa_supplicant[1090]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CH May 11 09:53:13 volumio51 dhcpcd[1102]: DUID 00:01:00:01:2f:01:52:15:2c:cf:67:1f:78:38 May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: IAID 67:1f:78:38 May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: adding address fe80::916b:5a57:a55:fc0e May 11 09:53:13 volumio51 dhcpcd[1102]: ipv6_addaddr1: Permission denied May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: carrier lost May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: carrier acquired May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: IAID 67:1f:78:38 May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: soliciting a DHCP lease May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: offered 192.168.201.51 from 192.168.201.1 May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: probing address 192.168.201.51/24 May 11 09:53:13 volumio51 dhcpcd[1102]: wlan0: soliciting an IPv6 router May 11 09:53:14 volumio51 wireless.js[740]: trying... May 11 09:53:14 volumio51 sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:14 volumio51 sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:14 volumio51 sudo[1168]: pam_unix(sudo:session): session closed for user root May 11 09:53:15 volumio51 wireless.js[740]: trying... May 11 09:53:15 volumio51 sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:15 volumio51 sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:15 volumio51 sudo[1171]: pam_unix(sudo:session): session closed for user root May 11 09:53:16 volumio51 wireless.js[740]: trying... May 11 09:53:16 volumio51 sudo[1174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:16 volumio51 sudo[1174]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:16 volumio51 sudo[1174]: pam_unix(sudo:session): session closed for user root May 11 09:53:16 volumio51 volumio-time-update[736]: volumio-time-update-util: Fetching time from Volumio... May 11 09:53:16 volumio51 volumio-time-update[736]: volumio-time-update-util: Date not found in response May 11 09:53:16 volumio51 volumio-time-update[736]: volumio-time-update-util: Retrying in 5 seconds... May 11 09:53:17 volumio51 wireless.js[740]: trying... May 11 09:53:17 volumio51 sudo[1182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:17 volumio51 sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:17 volumio51 sudo[1182]: pam_unix(sudo:session): session closed for user root May 11 09:53:18 volumio51 wireless.js[740]: trying... May 11 09:53:18 volumio51 sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:18 volumio51 sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:18 volumio51 sudo[1188]: pam_unix(sudo:session): session closed for user root May 11 09:53:18 volumio51 dhcpcd[1102]: wlan0: leased 192.168.201.51 for 7200 seconds May 11 09:53:18 volumio51 avahi-daemon[734]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.201.51. May 11 09:53:18 volumio51 avahi-daemon[734]: New relevant interface wlan0.IPv4 for mDNS. May 11 09:53:18 volumio51 dhcpcd[1102]: wlan0: adding route to 192.168.201.0/24 May 11 09:53:18 volumio51 avahi-daemon[734]: Registering new address record for 192.168.201.51 on wlan0.IPv4. May 11 09:53:18 volumio51 dhcpcd[1102]: wlan0: adding default route via 192.168.201.1 May 11 09:53:19 volumio51 wireless.js[740]: trying... May 11 09:53:19 volumio51 sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 09:53:19 volumio51 sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:19 volumio51 sudo[1212]: pam_unix(sudo:session): session closed for user root May 11 09:53:19 volumio51 wireless.js[740]: Connected to: ----LArgentiere May 11 09:53:19 volumio51 wireless.js[740]: ---- May 11 09:53:19 volumio51 sudo[1215]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 09:53:19 volumio51 sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:19 volumio51 sudo[1215]: pam_unix(sudo:session): session closed for user root May 11 09:53:19 volumio51 wireless.js[740]: ... joined AP, wlan0 IPv4 is 192.168.201.51, ipV6 is undefined May 11 09:53:19 volumio51 wireless.js[740]: It's done! AP May 11 09:53:19 volumio51 systemd[1]: Started Wireless Services. May 11 09:53:19 volumio51 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 11 09:53:19 volumio51 systemd[1]: Started Volumio Backend Module. May 11 09:53:19 volumio51 systemd[1]: Started Volumio Cpu Tweaker. May 11 09:53:19 volumio51 volumio-cpu-tweak[1221]: Setting RT Priority for mpd May 11 09:53:19 volumio51 volumio-cpu-tweak[1221]: Setting MPD Affinity May 11 09:53:19 volumio51 volumio-cpu-tweak[1221]: pid 1006's current affinity mask: f May 11 09:53:19 volumio51 volumio-cpu-tweak[1221]: pid 1006's new affinity mask: 3 May 11 09:53:19 volumio51 volumio-cpu-tweak[1221]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 11 09:53:19 volumio51 volumio-cpu-tweak[1221]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative May 11 09:53:19 volumio51 systemd[1]: volumio_cpu_tweak.service: Succeeded. May 11 09:53:19 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:19] [info] asio async_connect error: system:111 (Connection refused) May 11 09:53:19 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:19] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 11 09:53:19 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:19] [error] handle_connect error: Underlying Transport Error May 11 09:53:19 volumio51 volumio[1220]: info: ------------------------------------------- May 11 09:53:19 volumio51 volumio[1220]: info: ----- Volumio3 ---- May 11 09:53:19 volumio51 volumio[1220]: info: ------------------------------------------- May 11 09:53:19 volumio51 volumio[1220]: info: ----- System startup ---- May 11 09:53:19 volumio51 volumio[1220]: info: ------------------------------------------- May 11 09:53:19 volumio51 volumio[1220]: info: MYVOLUMIO Environment detected May 11 09:53:19 volumio51 volumio[1220]: info: Plugin folders cleanup May 11 09:53:19 volumio51 volumio[1220]: info: Scanning into folder /volumio/app/plugins/ May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category audio_interface May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category miscellanea May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category music_service May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category plugins.json May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category system_controller May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category user_interface May 11 09:53:19 volumio51 volumio[1220]: info: Scanning into folder /data/plugins/ May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category audio_interface May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category music_service May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category system_controller May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category system_hardware May 11 09:53:19 volumio51 volumio[1220]: info: Scanning category user_interface May 11 09:53:19 volumio51 volumio[1220]: info: Plugin folders cleanup completed May 11 09:53:19 volumio51 volumio[1220]: info: ------------------------------------------- May 11 09:53:19 volumio51 volumio[1220]: info: ----- Core plugins startup ---- May 11 09:53:19 volumio51 volumio[1220]: info: ------------------------------------------- May 11 09:53:19 volumio51 volumio[1220]: info: Loading plugins from folder /volumio/app/plugins/ May 11 09:53:19 volumio51 volumio[1220]: info: Adding plugin upnp to MyMusic Plugins May 11 09:53:19 volumio51 volumio[1220]: info: Adding plugin airplay_emulation to MyMusic Plugins May 11 09:53:19 volumio51 volumio[1220]: info: Adding plugin upnp_browser to MyMusic Plugins May 11 09:53:19 volumio51 volumio[1220]: info: Loading plugins from folder /data/plugins/ May 11 09:53:19 volumio51 volumio[1220]: info: Loading plugin "system"... May 11 09:53:19 volumio51 volumio[1220]: info: Loading plugin "appearance"... May 11 09:53:20 volumio51 ntpd[989]: Listen normally on 3 wlan0 192.168.201.51:123 May 11 09:53:20 volumio51 ntpd[989]: new interface(s) found: waking up resolver May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "network"... May 11 09:53:20 volumio51 volumio[1220]: info: Refreshing Cached IP Addresses May 11 09:53:20 volumio51 sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 09:53:20 volumio51 sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:20 volumio51 sudo[1251]: pam_unix(sudo:session): session closed for user root May 11 09:53:20 volumio51 sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 09:53:20 volumio51 sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:20 volumio51 sudo[1253]: pam_unix(sudo:session): session closed for user root May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "services"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "alsa_controller"... May 11 09:53:20 volumio51 sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 11 09:53:20 volumio51 sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:20 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "wizard"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "networkfs"... May 11 09:53:20 volumio51 sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Katinkie$03,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.100/Multimedia/MusicHD /mnt/NAS/Music May 11 09:53:20 volumio51 sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:20 volumio51 volumio[1220]: info: Starting Udev Watcher for removable devices May 11 09:53:20 volumio51 sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Katinkie$03,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.100/Multimedia/AudioBooks /mnt/NAS/Audiobooks May 11 09:53:20 volumio51 sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:20 volumio51 volumio[1220]: info: Ignoring mount for partition: boot May 11 09:53:20 volumio51 volumio[1220]: info: Ignoring mount for partition: volumio May 11 09:53:20 volumio51 volumio[1220]: info: Ignoring mount for partition: volumio_data May 11 09:53:20 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "volumio_command_line_client"... May 11 09:53:20 volumio51 volumio[1220]: info: Plugin upnp is not enabled May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "my_music"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "mpd"... May 11 09:53:20 volumio51 kernel: Key type cifs.spnego registered May 11 09:53:20 volumio51 kernel: Key type cifs.idmap registered May 11 09:53:20 volumio51 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. May 11 09:53:20 volumio51 kernel: CIFS: Attempting to mount //192.168.100.100/Multimedia/MusicHD May 11 09:53:20 volumio51 volumio[1220]: info: Plugin upnp_browser is not enabled May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "alarm-clock"... May 11 09:53:20 volumio51 volumio[1220]: info: Plugin airplay_emulation is not enabled May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "last_100"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "webradio"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "i2s_dacs"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "volumiodiscovery"... May 11 09:53:20 volumio51 volumio[1220]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 11 09:53:20 volumio51 node[1220]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 11 09:53:20 volumio51 node[1220]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 09:53:20 volumio51 volumio[1220]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 09:53:20 volumio51 volumio[1220]: *** WARNING *** For more information see May 11 09:53:20 volumio51 volumio[1220]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 11 09:53:20 volumio51 volumio[1220]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 09:53:20 volumio51 volumio[1220]: *** WARNING *** For more information see May 11 09:53:20 volumio51 node[1220]: *** WARNING *** For more information see May 11 09:53:20 volumio51 node[1220]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 11 09:53:20 volumio51 node[1220]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 09:53:20 volumio51 node[1220]: *** WARNING *** For more information see May 11 09:53:20 volumio51 volumio[1220]: info: Applying required configuration parameters for plugin volumiodiscovery May 11 09:53:20 volumio51 volumio[1220]: info: Discovery: Started advertising with name: Volumio51 May 11 09:53:20 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "autostart"... May 11 09:53:20 volumio51 volumio[1220]: info: Applying required configuration parameters for plugin autostart May 11 09:53:20 volumio51 volumio[1220]: info: AutoStart - onVolumioStart - read config.json May 11 09:53:20 volumio51 volumio[1220]: info: Plugin now_playing is not enabled May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "outputs"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "albumart"... May 11 09:53:20 volumio51 volumio[1220]: info: Plugin example_plugin is not enabled May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "inputs"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "updater_comm"... May 11 09:53:20 volumio51 volumio[1220]: info: Plugin mpdemulation is not enabled May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "rest_api"... May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "websocket"... May 11 09:53:20 volumio51 volumio[1220]: info: Starting Socket.io Server version 2.3.0 May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "fusiondsp"... May 11 09:53:20 volumio51 volumio[1220]: Forking 3 albumart workers May 11 09:53:20 volumio51 volumio[1220]: info: Applying required configuration parameters for plugin fusiondsp May 11 09:53:20 volumio51 volumio[1220]: info: Loading plugin "podcast"... May 11 09:53:20 volumio51 volumio[1220]: Starting albumart workers May 11 09:53:20 volumio51 volumio[1220]: Starting albumart workers May 11 09:53:20 volumio51 volumio[1220]: Starting albumart workers May 11 09:53:21 volumio51 kernel: CIFS: Attempting to mount //192.168.100.100/Multimedia/AudioBooks May 11 09:53:21 volumio51 sudo[1279]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 sudo[1281]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 volumio[1220]: info: ControllerPodcast::constructor May 11 09:53:21 volumio51 volumio[1220]: info: Loading plugin "backup_restore"... May 11 09:53:21 volumio51 volumio[1220]: info: Applying required configuration parameters for plugin backup_restore May 11 09:53:21 volumio51 volumio[1220]: info: Plugin audiophonics_evo_sabre is not enabled May 11 09:53:21 volumio51 volumio[1220]: info: Loading plugin "mpd_oled"... May 11 09:53:21 volumio51 volumio[1220]: info: Applying required configuration parameters for plugin mpd_oled May 11 09:53:21 volumio51 volumio[1220]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json May 11 09:53:21 volumio51 volumio[1220]: info: Loading plugin "Systeminfo"... May 11 09:53:21 volumio51 volumio[1220]: info: Loading plugin "touch_display"... May 11 09:53:21 volumio51 volumio[1220]: info: Applying required configuration parameters for plugin touch_display May 11 09:53:21 volumio51 volumio[1220]: info: Loading i18n strings for locale en May 11 09:53:21 volumio51 volumio[1220]: Updating browse sources language May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::initPlayerControls May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: Express server listening on port 3000 May 11 09:53:21 volumio51 volumio[1220]: [Metrics] WebUI: 2s 40.79ms May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::resetVolumioState May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::getcurrentVolume May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioRetrievevolume May 11 09:53:21 volumio51 volumio[1220]: info: Volumio Network Manager: Network status updated: 2 May 11 09:53:21 volumio51 volumio[1220]: 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 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: Reloading queue from file May 11 09:53:21 volumio51 volumio[1220]: info: VolumeController:: Volume=15 Mute =false May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:21 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::updateTrackBlock May 11 09:53:21 volumio51 volumio[1220]: info: CorePlayQueue::getTrackBlock May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioRetrievevolume May 11 09:53:21 volumio51 volumio[1220]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 11 09:53:21 volumio51 volumio[1220]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 May 11 09:53:21 volumio51 volumio[1220]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 11 09:53:21 volumio51 volumio[1220]: info: Setting Device type: Raspberry PI May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::setRepeat false single undefined May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:21 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::setRandom false May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:21 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:21 volumio51 volumio[1220]: info: Completed loading Core Plugins May 11 09:53:21 volumio51 volumio[1220]: info: Preparing to generate the ALSA configuration file May 11 09:53:21 volumio51 volumio[1220]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 11 09:53:21 volumio51 volumio[1220]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf May 11 09:53:21 volumio51 volumio[1220]: info: Reading ALSA contributions from plugins. May 11 09:53:21 volumio51 volumio[1220]: info: VolumeController:: Volume=15 Mute =false May 11 09:53:21 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:21 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:21 volumio51 volumio[1220]: info: Asound.conf file written May 11 09:53:21 volumio51 sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 11 09:53:21 volumio51 sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1380]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 volumio[1220]: info: Output device has changed, restarting MPD May 11 09:53:21 volumio51 sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 09:53:21 volumio51 sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 volumio[1220]: info: ___________ START PLUGINS ___________ May 11 09:53:21 volumio51 sudo[1385]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 volumio[1220]: info: ControllerMpd::onStart: Initializing MPD May 11 09:53:21 volumio51 volumio[1220]: info: Creating MPD Configuration file May 11 09:53:21 volumio51 sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 09:53:21 volumio51 sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 systemd[1]: Stopping Music Player Daemon... May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 09:53:21 volumio51 volumio[1220]: info: [1746950001679] CoreMusicLibrary::Adding element Last_100 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 09:53:21 volumio51 volumio[1220]: info: [1746950001681] CoreMusicLibrary::Adding element Webradio May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:53:21 volumio51 sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 09:53:21 volumio51 volumio[1220]: info: Initializing BBC Radios May 11 09:53:21 volumio51 sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 09:53:21 volumio51 sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1391]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: AutoStart - onStart May 11 09:53:21 volumio51 systemd[1]: mpd.service: Succeeded. May 11 09:53:21 volumio51 systemd[1]: Stopped Music Player Daemon. May 11 09:53:21 volumio51 volumio[1220]: info: Loading i18n strings for locale en May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: FusionDsp - mixtype--------------------- Hardware May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 09:53:21 volumio51 volumio[1220]: info: [1746950001728] CoreMusicLibrary::Adding element Podcast May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:21 volumio51 volumio[1220]: Cannot find translation for source Podcast May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 11 09:53:21 volumio51 sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh May 11 09:53:21 volumio51 sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 volumio[1220]: info: Loading i18n strings for locale en May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:53:21 volumio51 volumio[1220]: info: Volumio Calling Home May 11 09:53:21 volumio51 sudo[1410]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 systemd[1]: Starting Music Player Daemon... May 11 09:53:21 volumio51 sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service May 11 09:53:21 volumio51 sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 volumio[1220]: info: Preparing to generate the ALSA configuration file May 11 09:53:21 volumio51 sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 11 09:53:21 volumio51 sudo[1419]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1406]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 11 09:53:21 volumio51 sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 11 09:53:21 volumio51 sudo[1406]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 sudo[1422]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 11 09:53:21 volumio51 sudo[1427]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1419]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 systemd[1]: Reloading. May 11 09:53:21 volumio51 volumio[1220]: info: Discovery: adding 9c3ef16f-9bf4-4ef6-bda8-49acdea4f335 May 11 09:53:21 volumio51 volumio[1220]: info: Discovery: Found device Volumio51 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:21 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:21 volumio51 volumio[1220]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 11 09:53:21 volumio51 volumio[1220]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf May 11 09:53:21 volumio51 volumio[1220]: info: Reading ALSA contributions from plugins. May 11 09:53:21 volumio51 volumio-time-update[736]: volumio-time-update-util: Fetching time from Volumio... May 11 09:53:21 volumio51 volumio[1220]: info: touch_display: No backlight interface detected. May 11 09:53:21 volumio51 volumio[1220]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 11 09:53:21 volumio51 volumio[1220]: info: [MPD_OLED Plugin] Set execute permissions on /tmp/mpd_oled_plugin.sh May 11 09:53:21 volumio51 volumio[1220]: info: MPD Permissions set May 11 09:53:21 volumio51 volumio[1220]: info: [MPD_OLED Plugin] tmp script created /tmp/mpd_oled_plugin.sh May 11 09:53:21 volumio51 volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 11 09:53:21 volumio51 sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 11 09:53:21 volumio51 sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 11 09:53:21 volumio51 sudo[1455]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 volumio[1220]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 11 09:53:21 volumio51 volumio[1220]: info: Asound.conf file unchanged, so no further update is needed May 11 09:53:21 volumio51 volumio[1220]: info: Output device has changed, restarting MPD May 11 09:53:21 volumio51 sudo[1458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 11 09:53:21 volumio51 sudo[1458]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1458]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 sudo[1461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 09:53:21 volumio51 sudo[1461]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1461]: pam_unix(sudo:session): session closed for user root May 11 09:53:21 volumio51 volumio[1220]: info: Preparing to generate the ALSA configuration file May 11 09:53:21 volumio51 sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 09:53:21 volumio51 sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 volumio[1220]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 11 09:53:21 volumio51 volumio[1220]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf May 11 09:53:21 volumio51 volumio[1220]: info: Reading ALSA contributions from plugins. May 11 09:53:21 volumio51 volumio[1220]: info: Volumio called home May 11 09:53:21 volumio51 volumio[1220]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. May 11 09:53:21 volumio51 volumio[1220]: info: MPD Permissions set May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:21 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: Asound.conf file unchanged, so no further update is needed May 11 09:53:21 volumio51 volumio[1220]: info: Output device has changed, restarting MPD May 11 09:53:21 volumio51 sudo[1471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 09:53:21 volumio51 sudo[1471]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:21 volumio51 sudo[1474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 09:53:21 volumio51 sudo[1474]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:21 volumio51 sudo[1471]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:22 volumio51 volumio[1220]: info: MPD Permissions set May 11 09:53:22 volumio51 systemd[1]: ifup@eth0.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 11 09:53:22 volumio51 systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 11 09:53:22 volumio51 mpd[1426]: May 11 09:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 11 09:53:22 volumio51 sudo[1422]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 11 09:53:22 volumio51 systemd[1]: Reloading. May 11 09:53:22 volumio51 volumio-time-update[736]: volumio-time-update-util: Setting system time to: 2025-05-11 09:53:22 May 11 09:53:22 volumio51 sudo[1481]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-05-11 09:53:22 May 11 09:53:22 volumio51 sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:22 volumio51 volumio[1220]: verbose: New Socket.io Connection to 192.168.201.51 from 192.168.201.16 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3 May 11 09:53:22 volumio51 dbus-daemon[723]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.12' (uid=0 pid=1482 comm="timedatectl set-time 2025-05-11 09:53:22 ") May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 09:53:22 volumio51 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetVisibleSources May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 09:53:22 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:22 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: Listing playlists May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:22 volumio51 systemd[1]: Started Music Player Daemon. May 11 09:53:22 volumio51 sudo[1427]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 sudo[1393]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 sudo[1387]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 systemd[1]: Starting Time & Date Service... May 11 09:53:22 volumio51 systemd[1]: Stopping Music Player Daemon... May 11 09:53:22 volumio51 systemd[1]: mpd.service: Succeeded. May 11 09:53:22 volumio51 systemd[1]: Stopped Music Player Daemon. May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: systemctl daemon-reload succeeded. May 11 09:53:22 volumio51 sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 11 09:53:22 volumio51 sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:22 volumio51 systemd[1]: Starting Music Player Daemon... May 11 09:53:22 volumio51 volumio[1220]: error: Cannot initialize MPD Connection: MPD is not running May 11 09:53:22 volumio51 systemd[1]: Started Volumio Kiosk. May 11 09:53:22 volumio51 sudo[1503]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: Volumio Kiosk started. May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: Completed starting Core Plugins May 11 09:53:22 volumio51 sudo[1500]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 11 09:53:22 volumio51 sudo[1500]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:22 volumio51 volumio[1220]: info: ------------------------------------------- May 11 09:53:22 volumio51 volumio[1220]: info: ----- MyVolumio plugins startup ---- May 11 09:53:22 volumio51 volumio[1220]: info: ------------------------------------------- May 11 09:53:22 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Fetching plans data.... May 11 09:53:22 volumio51 sudo[1500]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 dbus-daemon[723]: [system] Successfully activated service 'org.freedesktop.timedate1' May 11 09:53:22 volumio51 systemd[1]: Started Time & Date Service. May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: X display number found: May 11 09:53:22 volumio51 systemd-timedated[1498]: Changed local time to Sun May 11 09:53:22 2025 May 11 09:53:22 volumio51 sudo[1481]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 volumio-time-update[736]: volumio-time-update-util: System time updated successfully. May 11 09:53:22 volumio51 systemd[1]: Started Volumio Time Update Utility. May 11 09:53:22 volumio51 startx[1505]: X.Org X Server 1.20.4 May 11 09:53:22 volumio51 startx[1505]: X Protocol Version 11, Revision 0 May 11 09:53:22 volumio51 startx[1505]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian May 11 09:53:22 volumio51 startx[1505]: Current Operating System: Linux volumio51 6.6.62-v8+ #1816 SMP PREEMPT Mon Nov 18 15:35:52 GMT 2024 aarch64 May 11 09:53:22 volumio51 startx[1505]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave smsc95xx.macaddr=2C:CF:67:1F:78:37 vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=011d3c51-80d3-44ad-a55e-d3edee90a42d imgfile=/volumio_current.sqsh bootpart=UUID=4D6C-DA1F datapart=UUID=6b1028d5-8041-4054-92b1-41d19f378424 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no May 11 09:53:22 volumio51 startx[1505]: Build Date: 04 April 2023 07:50:56AM May 11 09:53:22 volumio51 startx[1505]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) May 11 09:53:22 volumio51 startx[1505]: Current version of pixman: 0.36.0 May 11 09:53:22 volumio51 startx[1505]: Before reporting problems, check http://wiki.x.org May 11 09:53:22 volumio51 startx[1505]: to make sure that you have the latest version. May 11 09:53:22 volumio51 startx[1505]: Markers: (--) probed, (**) from config file, (==) default setting, May 11 09:53:22 volumio51 startx[1505]: (++) from command line, (!!) notice, (II) informational, May 11 09:53:22 volumio51 startx[1505]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 11 09:53:22 volumio51 startx[1505]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun May 11 09:53:22 2025 May 11 09:53:22 volumio51 startx[1505]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 11 09:53:22 volumio51 startx[1505]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: X display number found: 0 May 11 09:53:22 volumio51 mpd[1521]: May 11 09:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: X display number found: 0 May 11 09:53:22 volumio51 systemd[1]: Started Music Player Daemon. May 11 09:53:22 volumio51 sudo[1464]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 sudo[1474]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 nmbd[962]: [2025/05/11 09:53:22.420942, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 11 09:53:22 volumio51 nmbd[962]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 11 09:53:22 volumio51 systemd[1]: Started MPD OLED Plugin. May 11 09:53:22 volumio51 volumio[1220]: error: MPD error: The expression evaluated to a falsy value: May 11 09:53:22 volumio51 volumio[1220]: assert.ok(self.idling) May 11 09:53:22 volumio51 volumio[1220]: error: The expression evaluated to a falsy value: May 11 09:53:22 volumio51 volumio[1220]: assert.ok(self.idling) May 11 09:53:22 volumio51 systemd[1]: Started Samba NMB Daemon. May 11 09:53:22 volumio51 volumio[1220]: error: updateQueue error: null May 11 09:53:22 volumio51 sudo[1412]: pam_unix(sudo:session): session closed for user root May 11 09:53:22 volumio51 systemd[1]: Starting Samba Winbind Daemon... May 11 09:53:22 volumio51 volumio[1220]: error: MPD error: The expression evaluated to a falsy value: May 11 09:53:22 volumio51 volumio[1220]: assert.ok(self.idling) May 11 09:53:22 volumio51 volumio[1220]: error: The expression evaluated to a falsy value: May 11 09:53:22 volumio51 volumio[1220]: assert.ok(self.idling) May 11 09:53:22 volumio51 volumio[1220]: error: updateQueue error: null May 11 09:53:22 volumio51 volumio[1220]: info: [MPD_OLED Plugin] Started mpd_oled_plugin service May 11 09:53:22 volumio51 winbindd[1544]: [2025/05/11 09:53:22.491475, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 11 09:53:22 volumio51 winbindd[1544]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 11 09:53:22 volumio51 winbindd[1544]: [2025/05/11 09:53:22.494423, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 11 09:53:22 volumio51 winbindd[1544]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 11 09:53:22 volumio51 systemd[1]: Started Samba Winbind Daemon. May 11 09:53:22 volumio51 systemd[1]: Starting Samba SMB Daemon... May 11 09:53:22 volumio51 startx[1505]: V3D 7.1 not supported by this version of Mesa. May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 smbd[1549]: [2025/05/11 09:53:22.646903, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 11 09:53:22 volumio51 smbd[1549]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 11 09:53:22 volumio51 systemd[1]: Started Samba SMB Daemon. May 11 09:53:22 volumio51 systemd[1]: Reached target Multi-User System. May 11 09:53:22 volumio51 systemd[1]: Reached target Graphical Interface. May 11 09:53:22 volumio51 systemd[1]: Starting Update UTMP about System Runlevel Changes... May 11 09:53:22 volumio51 kernel: broken atomic modeset userspace detected, disabling atomic May 11 09:53:22 volumio51 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 11 09:53:22 volumio51 systemd[1]: Started Update UTMP about System Runlevel Changes. May 11 09:53:22 volumio51 systemd[1]: Startup finished in 10.341s (kernel) + 27.659s (userspace) = 38.000s. May 11 09:53:22 volumio51 startx[1505]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:22 volumio51 volumio[1220]: info: touch_display: Setting screensaver timeout to 120 seconds. May 11 09:53:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:22 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:23 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:23 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:23 volumio51 volumio[1220]: info: camilladsp spawned new process with pid 1671, instance 1, run: true May 11 09:53:23 volumio51 volumio[1220]: info: camilladsp service started and running in background, instance 1 May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:23 volumio51 volumio[1220]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA May 11 09:53:23 volumio51 volumio[1220]: info: FusionDsp loaded May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:23 volumio51 volumio[1220]: info: FusionDsp - Reporting Fusion DSP Enabled May 11 09:53:23 volumio51 volumio[1220]: info: Adding Signal Path Element [object Object] May 11 09:53:23 volumio51 volumio[1220]: info: Adding fusiondspeq DSP Signal Path Element May 11 09:53:23 volumio51 sudo[1681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 11 09:53:23 volumio51 sudo[1681]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:23 volumio51 volumio[1220]: info: FusionDsp - ---- installed callbackRead May 11 09:53:23 volumio51 volumio[1220]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 11 09:53:23 volumio51 volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 11 09:53:23 volumio51 volumio[1220]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 11 09:53:23 volumio51 systemd[1]: Started FusionDsp Daemon. May 11 09:53:23 volumio51 sudo[1681]: pam_unix(sudo:session): session closed for user root May 11 09:53:23 volumio51 sudo[1266]: pam_unix(sudo:session): session closed for user root May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:23 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:23 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:23 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:23 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:24 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:24 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:24 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:24 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:24 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:24 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:24 volumio51 volumio[1220]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetVisibleSources May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 09:53:25 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:25 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: info: Listing playlists May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:25 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:25 volumio51 systemd[1]: systemd-fsckd.service: Succeeded. May 11 09:53:25 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:26 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:26 volumio51 volumio[1220]: verbose: New Socket.io Connection to 192.168.201.51:3000 from 192.168.201.16 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 11 09:53:26 volumio51 sh[684]: timed out May 11 09:53:26 volumio51 dhcpcd[735]: timed out May 11 09:53:26 volumio51 sh[684]: dhcpcd exited May 11 09:53:26 volumio51 dhcpcd[735]: dhcpcd exited May 11 09:53:26 volumio51 sh[684]: ifup: failed to bring up eth0 May 11 09:53:26 volumio51 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 11 09:53:26 volumio51 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:26 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:27 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:27 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:27 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:27 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:27 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:27 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:27 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 11 09:53:27 volumio51 systemd[1]: systemd-hostnamed.service: Succeeded. May 11 09:53:27 volumio51 volumio[1220]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 11 09:53:27 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 11 09:53:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:28 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:28 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:28 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:28 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:28 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:28 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:28 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:28 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:28 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:29 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 11 09:53:29 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:29] [connect] Successful connection May 11 09:53:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:29 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:29 volumio51 volumio-remote-updater[728]: [2025-05-11 09:53:29] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746950009 101 May 11 09:53:29 volumio51 volumio[1220]: 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: 8 May 11 09:53:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:29 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:29 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:29 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:29 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:30 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:30 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 11 09:53:30 volumio51 volumio[1220]: info: Adding plugin bluetooth to MyMusic Plugins May 11 09:53:30 volumio51 volumio[1220]: info: Adding plugin multiroom to MyMusic Plugins May 11 09:53:30 volumio51 volumio[1220]: info: Adding plugin metavolumio to MyMusic Plugins May 11 09:53:30 volumio51 volumio[1220]: info: Adding plugin cd_controller to MyMusic Plugins May 11 09:53:30 volumio51 volumio[1220]: info: Adding plugin qobuzconnect to MyMusic Plugins May 11 09:53:30 volumio51 volumio[1220]: info: Adding plugin smart_inputs to MyMusic Plugins May 11 09:53:30 volumio51 volumio[1220]: info: Adding plugin tidalconnect to MyMusic Plugins May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 11 09:53:30 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:30 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:30 volumio51 volumio[1220]: info: Starting MyVolumio Remote Streaming Endpoints May 11 09:53:30 volumio51 volumio[1220]: info: MyVolumio login type: Token May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 11 09:53:30 volumio51 volumio[1220]: info: Starting Streaming Service Transparent Proxy May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 11 09:53:30 volumio51 volumio[1220]: info: Streaming services startup May 11 09:53:30 volumio51 volumio[1220]: info: Starting Streaming Daemon May 11 09:53:30 volumio51 sudo[2104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 11 09:53:30 volumio51 sudo[2104]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:30 volumio51 sudo[2104]: pam_unix(sudo:session): session closed for user root May 11 09:53:30 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 11 09:53:31 volumio51 volumio[1220]: error: Cannot start Volumio Streaming Daemon May 11 09:53:31 volumio51 volumio[1220]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 11 09:53:31 volumio51 volumio[1220]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:31 volumio51 volumio[1220]: STREAMING PROXY: Starting server on port 3245 May 11 09:53:31 volumio51 volumio[1220]: Node JS runtime: 14 May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:31 volumio51 volumio[1220]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::Close All Modals sent May 11 09:53:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:31 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:32 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:32 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:32 volumio51 volumio[1220]: info: MyVolumio token set successfully May 11 09:53:32 volumio51 volumio[1220]: info: MYVOLUMIO: Adding device May 11 09:53:32 volumio51 volumio[1220]: info: MYVOLUMIO: Evaluating Server May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:32 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:32 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:32 volumio51 volumio[1220]: info: MyVolumio Plan changed: premium May 11 09:53:32 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Subscribed plan changed to premium May 11 09:53:32 volumio51 volumio[1220]: info: Removing browser output: myVolumio user plan is not superstar May 11 09:53:32 volumio51 volumio[1220]: info: Removing audio output: May 11 09:53:32 volumio51 volumio[1220]: info: MYVOLUMIO: Adding device May 11 09:53:32 volumio51 volumio[1220]: info: MYVOLUMIO: Evaluating Server May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:32 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:32 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:32 volumio51 volumio[1220]: info: Remote config written successfully May 11 09:53:32 volumio51 volumio[1220]: info: Starting Tunnel 1 May 11 09:53:32 volumio51 volumio[1220]: info: Starting Tunnel Connection Checker May 11 09:53:32 volumio51 volumio[1220]: info: Completed starting MyVolumio Plugin May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:32 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:32 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:33 volumio51 volumio[1220]: info: MYVolumio Device enabled May 11 09:53:33 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... May 11 09:53:33 volumio51 volumio[1220]: info: MyVolumio status changed May 11 09:53:33 volumio51 volumio[1220]: info: Streaming services startup May 11 09:53:33 volumio51 volumio[1220]: info: Starting Streaming Daemon May 11 09:53:33 volumio51 sudo[2185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 11 09:53:33 volumio51 sudo[2185]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:33 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:33 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid May 11 09:53:33 volumio51 volumio[1220]: error: [MyVolumio PluginManager] Cache data is invalid! May 11 09:53:33 volumio51 sudo[2185]: pam_unix(sudo:session): session closed for user root May 11 09:53:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:33 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:33 volumio51 volumio[1220]: error: Cannot start Volumio Streaming Daemon May 11 09:53:33 volumio51 volumio[1220]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 11 09:53:33 volumio51 volumio[1220]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 11 09:53:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:33 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:33 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:33 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:33 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:34 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:34 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:34 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:34 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:34 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... May 11 09:53:34 volumio51 volumio[1220]: info: [1746950014614] Starting BluetoothController May 11 09:53:34 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom May 11 09:53:35 volumio51 sudo[2218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom May 11 09:53:35 volumio51 sudo[2218]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 sudo[2218]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 volumio[1220]: info: MRS: MultiRoom plugin initialized May 11 09:53:35 volumio51 volumio[1220]: info: MRS: STOPPING SNAPCLIENT May 11 09:53:35 volumio51 volumio[1220]: info: MRS: Snap server stop May 11 09:53:35 volumio51 sudo[2234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient May 11 09:53:35 volumio51 sudo[2234]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 volumio[1220]: info: MRS: STOPPING volumioStreaming May 11 09:53:35 volumio51 sudo[2234]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 sudo[2237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver May 11 09:53:35 volumio51 sudo[2237]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 sudo[2237]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 sudo[2240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 11 09:53:35 volumio51 sudo[2240]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... May 11 09:53:35 volumio51 sudo[2240]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 sudo[2243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 11 09:53:35 volumio51 sudo[2243]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 sudo[2243]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "tidal"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... May 11 09:53:35 volumio51 volumio[1220]: info: Preparing to generate the ALSA configuration file May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid May 11 09:53:35 volumio51 volumio[1220]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 11 09:53:35 volumio51 volumio[1220]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 11 09:53:35 volumio51 volumio[1220]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf May 11 09:53:35 volumio51 volumio[1220]: info: Reading ALSA contributions from plugins. May 11 09:53:35 volumio51 volumio[1220]: info: Setting Geolocation for MyVolumio to eu10 May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: MRS: Removed streaming files May 11 09:53:35 volumio51 volumio[1220]: info: MRS: volumioStreaming STOPPED May 11 09:53:35 volumio51 volumio[1220]: info: MRS: SNAPSERVER STOPPED May 11 09:53:35 volumio51 volumio[1220]: info: MRS: SNAPCLIENT STOPPED May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:35 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:35 volumio51 volumio[1220]: info: Setting Geolocation for MyVolumio to eu10 May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:35 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:35 volumio51 volumio[1220]: info: Asound.conf file written May 11 09:53:35 volumio51 sudo[2252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 11 09:53:35 volumio51 sudo[2252]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 sudo[2252]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 volumio[1220]: info: Output device has changed, restarting MPD May 11 09:53:35 volumio51 sudo[2257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 09:53:35 volumio51 sudo[2257]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 sudo[2257]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 volumio[1220]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 sudo[2260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 09:53:35 volumio51 sudo[2260]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 systemd[1]: Stopping MPD OLED Plugin... May 11 09:53:35 volumio51 systemd[1]: mpd_oled_plugin.service: Main process exited, code=killed, status=15/TERM May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus May 11 09:53:35 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output for this device May 11 09:53:35 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output May 11 09:53:35 volumio51 sudo[2265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio51 May 11 09:53:35 volumio51 sudo[2265]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 volumio[1220]: info: Adding audio output: May 11 09:53:35 volumio51 volumio[1220]: info: Adding audio output: May 11 09:53:35 volumio51 sudo[2265]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 volumio[1220]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 systemd[1]: mpd_oled_plugin.service: Succeeded. May 11 09:53:35 volumio51 systemd[1]: Stopped MPD OLED Plugin. May 11 09:53:35 volumio51 systemd[1]: Stopping Music Player Daemon... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio May 11 09:53:35 volumio51 volumio[1220]: info: Adding METAVOLUMIO REST API Endpoints May 11 09:53:35 volumio51 volumio[1220]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 11 09:53:35 volumio51 volumio[1220]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 11 09:53:35 volumio51 volumio[1220]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 11 09:53:35 volumio51 volumio[1220]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs May 11 09:53:35 volumio51 volumio[1220]: info: Adding inputs REST Endpoints May 11 09:53:35 volumio51 volumio[1220]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 11 09:53:35 volumio51 volumio[1220]: info: Scanning Audio Inputs May 11 09:53:35 volumio51 systemd[1]: mpd.service: Succeeded. May 11 09:53:35 volumio51 systemd[1]: Stopped Music Player Daemon. May 11 09:53:35 volumio51 volumio[1220]: info: Checking against Known Cards name May 11 09:53:35 volumio51 volumio[1220]: info: Adding Server instance for streaming May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio May 11 09:53:35 volumio51 volumio[1220]: error: Hi Res Audio Failed Login: Missing Login Data May 11 09:53:35 volumio51 volumio[1220]: info: Adding HIGHRESAUDIO REST API Endpoints May 11 09:53:35 volumio51 volumio[1220]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal May 11 09:53:35 volumio51 volumio[1220]: info: Refreshing TIDAL token May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect May 11 09:53:35 volumio51 systemd[1]: Starting Music Player Daemon... May 11 09:53:35 volumio51 volumio[1220]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect May 11 09:53:35 volumio51 volumio[1220]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect May 11 09:53:35 volumio51 sudo[2274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 11 09:53:35 volumio51 sudo[2274]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: QobuzConnect: Setting Qobuz Connect card as outputdevice to 0 May 11 09:53:35 volumio51 volumio[1220]: info: QobuzConnect: Starting Qobuz Connect socket and service May 11 09:53:35 volumio51 sudo[2274]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 sudo[2271]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 11 09:53:35 volumio51 sudo[2271]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 sudo[2271]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 sudo[2283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 11 09:53:35 volumio51 sudo[2283]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:35 volumio51 volumio[1220]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections May 11 09:53:35 volumio51 volumio[1220]: info: Stopping AccessToken refresher cron for QOBUZ May 11 09:53:35 volumio51 volumio[1220]: info: AccessToken refresher cron started for QOBUZ May 11 09:53:35 volumio51 volumio[1220]: info: Adding QOBUZ REST API Endpoints May 11 09:53:35 volumio51 volumio[1220]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz May 11 09:53:35 volumio51 systemd[1]: Started Volumio Qobuz Connect Service. May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 09:53:35 volumio51 sudo[2283]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 volumio[1220]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined May 11 09:53:35 volumio51 volumio[1220]: info: Bluetooth name changed to Volumio51 May 11 09:53:35 volumio51 volumio[1220]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined May 11 09:53:35 volumio51 volumio[1220]: info: MPD Permissions set May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:35 volumio51 volumio[1220]: info: Executing endpoint qc_getconfig May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.548 [2285.2285] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 11 09:53:35 volumio51 volumio[1220]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 11 09:53:35 volumio51 volumio[1220]: info: QobuzConnect: QOBUZ Connect daemon connected May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.576 [2285.2285] INFO VolumeManager: [0x279ba50]: Setting new playback volume: 75 May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.576 [2285.2285] INFO VolumeManager: [0x279ba50]: Setting new mute state: 0 May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.576 [2285.2285] INFO QobuzConnect: [0x279c420]: Client initialized! May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.576 [2285.2285] INFO SampleApp: Starting Avahi advertising, name: Volumio51, service name: _qobuz-connect._tcp May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.579 [2285.2285] INFO LocalConfigManager: [0x279b330]: Starting Local Configuration server May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.579 [2285.2285] INFO SampleApp: Starting Local configuration server May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.579 [2285.2285] INFO SampleApp: Connected to UNIX socket client 0x2790f60 May 11 09:53:35 volumio51 qobuz-connect[2285]: 20250511 09:53:35.698 [2285.2285] INFO SampleApp: Playback volume changed: 75 May 11 09:53:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:35 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:35 volumio51 mpd[2282]: May 11 09:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 11 09:53:35 volumio51 volumio[1220]: info: Access Token successfully retrieved May 11 09:53:35 volumio51 volumio[1220]: info: Successfully Added MyVolumio device May 11 09:53:35 volumio51 volumio[1220]: info: Successfully retrieved User Session From TIDAL May 11 09:53:35 volumio51 systemd[1]: Started Music Player Daemon. May 11 09:53:35 volumio51 sudo[2260]: pam_unix(sudo:session): session closed for user root May 11 09:53:35 volumio51 volumio[1220]: error: updateQueue error: null May 11 09:53:35 volumio51 systemd[1]: Started MPD OLED Plugin. May 11 09:53:36 volumio51 volumio[1220]: info: Successfully retrieved User Subscription From TIDAL May 11 09:53:36 volumio51 volumio[1220]: info: Adding TIDAL to Browse Sources May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 09:53:36 volumio51 volumio[1220]: info: [1746950016071] CoreMusicLibrary::Adding element TIDAL May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:36 volumio51 volumio[1220]: Cannot find translation for source Podcast May 11 09:53:36 volumio51 volumio[1220]: Cannot find translation for source TIDAL May 11 09:53:36 volumio51 volumio[1220]: info: Stopping AccessToken refresher cron May 11 09:53:36 volumio51 volumio[1220]: info: AccessToken refresher cron started May 11 09:53:36 volumio51 volumio[1220]: info: Adding TIDAL REST API Endpoints May 11 09:53:36 volumio51 volumio[1220]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: Updating MyVolumio device info May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:36 volumio51 volumio[1220]: info: Updating MyVolumio device info May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: Successfully Added MyVolumio device May 11 09:53:36 volumio51 volumio[1220]: info: Successfully Updated MyVolumio device May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:36 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:36 volumio51 volumio[1220]: info: Successfully Updated MyVolumio device May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 sudo[2341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service May 11 09:53:37 volumio51 sudo[2341]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 systemd[1]: Started MyVolumio SSH Tunnel. May 11 09:53:37 volumio51 sudo[2341]: pam_unix(sudo:session): session closed for user root May 11 09:53:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:37 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:37 volumio51 volumio[1220]: info: Remote SSH Started May 11 09:53:37 volumio51 autossh[2344]: port set to 0, monitoring disabled May 11 09:53:37 volumio51 autossh[2344]: starting ssh (count 1) May 11 09:53:37 volumio51 autossh[2344]: ssh child pid is 2350 May 11 09:53:38 volumio51 volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumiossh-tunnel[2343]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts. May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 sudo[2361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service May 11 09:53:38 volumio51 sudo[2361]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:38 volumio51 systemd[1]: Started Volumio Bluetooth Module. May 11 09:53:38 volumio51 sudo[2361]: pam_unix(sudo:session): session closed for user root May 11 09:53:38 volumio51 volumio[1220]: info: Volumio BT Module successfully started May 11 09:53:38 volumio51 sudo[2364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* May 11 09:53:38 volumio51 sudo[2364]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:38 volumio51 volumiobt[2363]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory May 11 09:53:38 volumio51 sudo[2364]: pam_unix(sudo:session): session closed for user root May 11 09:53:38 volumio51 volumio[1220]: info: TidalConnect service stoped! May 11 09:53:38 volumio51 volumio[1220]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 11 09:53:38 volumio51 volumio[1220]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect May 11 09:53:38 volumio51 sudo[2376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 11 09:53:38 volumio51 sudo[2376]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:38 volumio51 systemd[1]: Started Volumio Tidal Connect Service. May 11 09:53:38 volumio51 sudo[2376]: pam_unix(sudo:session): session closed for user root May 11 09:53:38 volumio51 volumio[1220]: info: Executing endpoint tc_getconfig May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 11 09:53:38 volumio51 vtcs[2378]: STARTING TidalConnect services, version: 1.4.0.34 May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 vtcs[2378]: STARTED TidalConnect services. May 11 09:53:38 volumio51 volumio[1220]: info: Executing endpoint tc_connect May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 11 09:53:38 volumio51 volumio[1220]: info: Connecting to TidalConnect May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::servicePushState May 11 09:53:38 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:38 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output update for this device May 11 09:53:38 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::servicePushState May 11 09:53:38 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:38 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output update for this device May 11 09:53:38 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:38 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:39 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:39 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:39 volumio51 sudo[2415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio May 11 09:53:39 volumio51 sudo[2415]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:39 volumio51 volumiobt[2363]: pulseaudio: no process found May 11 09:53:39 volumio51 sudo[2415]: pam_unix(sudo:session): session closed for user root May 11 09:53:39 volumio51 dbus-daemon[723]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.26' (uid=1000 pid=2419 comm="/usr/bin/pulseaudio --high-priority=true ") May 11 09:53:39 volumio51 systemd[1]: Starting RealtimeKit Scheduling Policy Service... May 11 09:53:39 volumio51 volumio[1220]: ------------------------------------ BT MESSAGE: BT STATUS: running May 11 09:53:39 volumio51 dbus-daemon[723]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' May 11 09:53:39 volumio51 rtkit-daemon[2420]: Successfully called chroot. May 11 09:53:39 volumio51 rtkit-daemon[2420]: Successfully dropped privileges. May 11 09:53:39 volumio51 rtkit-daemon[2420]: Successfully limited resources. May 11 09:53:39 volumio51 systemd[1]: Started RealtimeKit Scheduling Policy Service. May 11 09:53:39 volumio51 rtkit-daemon[2420]: Running. May 11 09:53:39 volumio51 rtkit-daemon[2420]: Watchdog thread running. May 11 09:53:39 volumio51 rtkit-daemon[2420]: Canary thread running. May 11 09:53:39 volumio51 dbus-daemon[723]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.27' (uid=0 pid=2420 comm="/usr/lib/rtkit/rtkit-daemon ") May 11 09:53:39 volumio51 systemd[1]: Starting Authorization Manager... May 11 09:53:39 volumio51 volumio[1220]: ------------------------------------ BT MESSAGE: BT STATUS: running May 11 09:53:39 volumio51 polkitd[2424]: started daemon version 0.105 using authority implementation `local' version `0.105' May 11 09:53:39 volumio51 dbus-daemon[723]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 11 09:53:39 volumio51 systemd[1]: Started Authorization Manager. May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:39 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:39 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:39 volumio51 pulseaudio[2419]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 11 09:53:39 volumio51 pulseaudio[2419]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 11 09:53:39 volumio51 bluetoothd[1027]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSource May 11 09:53:39 volumio51 bluetoothd[1027]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSink May 11 09:53:39 volumio51 volumiobt[2363]: Applying permissions May 11 09:53:39 volumio51 volumiobt[2363]: Setting BT discoverable and pairable May 11 09:53:39 volumio51 pulseaudio[2419]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files May 11 09:53:39 volumio51 kernel: Bluetooth: RFCOMM TTY layer initialized May 11 09:53:39 volumio51 kernel: Bluetooth: RFCOMM socket layer initialized May 11 09:53:39 volumio51 kernel: Bluetooth: RFCOMM ver 1.11 May 11 09:53:39 volumio51 volumiobt[2363]: Agent registered May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [117B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [91B blob data] May 11 09:53:39 volumio51 volumiobt[2363]: [bluetooth]# -e power on May 11 09:53:39 volumio51 volumiobt[2363]: Invalid command in menu main: -e May 11 09:53:39 volumio51 volumiobt[2363]: May 11 09:53:39 volumio51 volumiobt[2363]: Use "help" for a list of available commands in a menu. May 11 09:53:39 volumio51 volumiobt[2363]: Use "menu " if you want to enter any submenu. May 11 09:53:39 volumio51 volumiobt[2363]: Use "back" if you want to return to menu main. May 11 09:53:39 volumio51 volumiobt[2363]: [bluetooth]# agent on May 11 09:53:39 volumio51 volumiobt[2363]: Agent is already registered May 11 09:53:39 volumio51 volumiobt[2363]: [bluetooth]# discoverable on May 11 09:53:39 volumio51 volumiobt[2363]: [bluetooth]# pairable on May 11 09:53:39 volumio51 volumiobt[2363]: [bluetooth]# agent NoInputNoOutput May 11 09:53:39 volumio51 volumiobt[2363]: Agent is already registered May 11 09:53:39 volumio51 volumiobt[2363]: [bluetooth]# default-agent May 11 09:53:39 volumio51 volumiobt[2363]: [bluetooth]# quit May 11 09:53:39 volumio51 volumiobt[2363]: [59B blob data] May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:39 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:39 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:39 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:39 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:40 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:40 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:40 volumio51 volumio[1220]: info: MRS: Getting audio outputs on start May 11 09:53:40 volumio51 volumio[1220]: info: MRS: Requesting all other devices output May 11 09:53:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:40 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:40 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:40 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:40 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:41 volumio51 volumio[1220]: verbose: New Socket.io Connection to 192.168.201.51:3000 from 192.168.201.16 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:41 volumio51 volumio[1220]: info: AutoStart - Plugin is starting May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetQueue May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::getQueue May 11 09:53:41 volumio51 volumio[1220]: info: CorePlayQueue::getQueue May 11 09:53:41 volumio51 volumio[1220]: info: AutoStart - start playing May 11 09:53:41 volumio51 volumio[1220]: info: AutoStart - start playing with no specific position May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPlay May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::play index 0 May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::stop May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::play index undefined May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 09:53:41 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::startPlaybackTimer May 11 09:53:41 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:41 volumio51 volumio[1220]: info: [1746950021268] ControllerTidal::clearAddPlayTrack May 11 09:53:41 volumio51 volumio[1220]: info: Getting stream with soundQuality LOSSLESS May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand stop May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand stop took 6 milliseconds May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand clear May 11 09:53:41 volumio51 volumio[1220]: info: May 11 09:53:41 volumio51 volumio[1220]: ---------------------------- MPD announces system playlist update May 11 09:53:41 volumio51 volumio[1220]: info: Ignoring MPD Status Update May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand clear took 1 milliseconds May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/316409553&soundQuality=LOSSLESS" May 11 09:53:41 volumio51 volumio[1220]: error: updateQueue error: null May 11 09:53:41 volumio51 volumio[1220]: info: May 11 09:53:41 volumio51 volumio[1220]: ---------------------------- MPD announces system playlist update May 11 09:53:41 volumio51 volumio[1220]: info: Ignoring MPD Status Update May 11 09:53:41 volumio51 volumio[1220]: info: ------------------------------ 2ms May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/316409553&soundQuality=LOSSLESS" took 1 milliseconds May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::setConsumeUpdateService mpd May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand play May 11 09:53:41 volumio51 volumio[1220]: info: ------------------------------ 1ms May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand play took 1 milliseconds May 11 09:53:41 volumio51 volumio[1220]: STREAMING PROXY: Handling url /?data=tidal://song/316409553&soundQuality=LOSSLESS May 11 09:53:41 volumio51 volumio[1220]: info: Executing endpoint getStreamUrltidal May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: TidalConnect service started! May 11 09:53:41 volumio51 volumio[1220]: [Metrics] CommandRouter: 22s 337.87ms May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumiosetStartupVolume May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:41 volumio51 volumio[1220]: info: VolumeController:: Setting startup Volume 15 May 11 09:53:41 volumio51 volumio[1220]: info: VolumeController::SetAlsaVolume15 May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::Close All Modals sent May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::Close All Modals sent May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:41 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output update for this device May 11 09:53:41 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - ---- read samplerate from file: 44100 May 11 09:53:41 volumio51 volumio[1220]: info: camilladsp stopping service pid 1671... May 11 09:53:41 volumio51 volumio[1220]: info: camilladsp service terminated, instance 1 May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 11 09:53:41 volumio51 volumio[1220]: info: camilladsp service started and running in background, instance 1 May 11 09:53:41 volumio51 volumio[1220]: info: getStreamUrl took 344 milliseconds May 11 09:53:41 volumio51 volumio[1220]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEicwYjk3N2E4NTdkNjNlNmExNTUzMjVkYmQyMmQxNWZkOV82MS5tcDQ/0.flac?token=1746953622~NTEyNDFhYWI1NTFkYTdmMWQ0Y2E0NWI4MWE5ZGRjYWRkMmYyZWNjYw== May 11 09:53:41 volumio51 volumio[1220]: info: camilladsp spawned new process with pid 2498, instance 1, run: true May 11 09:53:41 volumio51 volumio[1220]: STREAMING PROXY: Response: 200, length: 17334633 May 11 09:53:41 volumio51 volumio[1220]: info: May 11 09:53:41 volumio51 volumio[1220]: ---------------------------- MPD announces state update: player May 11 09:53:41 volumio51 volumio[1220]: info: ControllerMpd::getState May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand status May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - ---- read samplerate from file: 44100 May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - ---- read samplerate from file: 44100 May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 11 09:53:41 volumio51 volumio[1220]: info: May 11 09:53:41 volumio51 volumio[1220]: ---------------------------- MPD announces state update: player May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand status took 11 milliseconds May 11 09:53:41 volumio51 volumio[1220]: info: ControllerMpd::getState May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand status May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::parseState May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand status took 1 milliseconds May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::parseState May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::parseTrackInfo May 11 09:53:41 volumio51 volumio[1220]: info: ControllerMpd::pushState May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::servicePushState May 11 09:53:41 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:41 volumio51 volumio[1220]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"316409553&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/316409553&soundQuality=LOSSLESS","trackType":"tidal"} May 11 09:53:41 volumio51 volumio[1220]: verbose: CURRENT POSITION 0 May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::syncState stateService play May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::syncState currentStatus stop May 11 09:53:41 volumio51 volumio[1220]: info: ------------------------------ 14ms May 11 09:53:41 volumio51 volumio[1220]: info: sendMpdCommand playlistinfo took 3 milliseconds May 11 09:53:41 volumio51 volumio[1220]: verbose: ControllerMpd::parseTrackInfo May 11 09:53:41 volumio51 volumio[1220]: info: ControllerMpd::pushState May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::servicePushState May 11 09:53:41 volumio51 volumio[1220]: info: CorePlayQueue::getTrack 0 May 11 09:53:41 volumio51 volumio[1220]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1189,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"396 Kbps","isStreaming":false,"title":"316409553&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/316409553&soundQuality=LOSSLESS","trackType":"tidal"} May 11 09:53:41 volumio51 volumio[1220]: verbose: CURRENT POSITION 0 May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::syncState stateService play May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::syncState currentStatus play May 11 09:53:41 volumio51 volumio[1220]: info: Received an update from plugin. extracting info from payload May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:41 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output update for this device May 11 09:53:41 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: CoreStateMachine::pushState May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioPushState May 11 09:53:41 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output update for this device May 11 09:53:41 volumio51 volumio[1220]: info: MRS: Pushing multiroomSync output May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: ------------------------------ 21ms May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 11 09:53:41 volumio51 volumio[1220]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:41 volumio51 volumio[1220]: info: touch_display: Setting screensaver timeout to 0 seconds. May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 11 09:53:42 volumio51 volumio[1220]: info: Version has changed, forcing UI Reload May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::Reload Ui May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:42 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:42 volumio51 volumio[1220]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 May 11 09:53:43 volumio51 volumio[1220]: STREAMING PROXY: Client dropped request, destroying May 11 09:53:43 volumio51 sudo[2543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 09:53:43 volumio51 sudo[2543]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:43 volumio51 sudo[2543]: pam_unix(sudo:session): session closed for user root May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 09:53:43 volumio51 sudo[2546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 09:53:43 volumio51 sudo[2546]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:43 volumio51 sudo[2546]: pam_unix(sudo:session): session closed for user root May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: verbose: New Socket.io Connection to 192.168.201.51 from 192.168.201.16 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetVisibleSources May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 09:53:43 volumio51 volumio[1220]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 11 09:53:43 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:43 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: Listing playlists May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetVisibleSources May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 09:53:43 volumio51 volumio[1220]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 11 09:53:43 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:43 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: Listing playlists May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:43 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:44 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:44 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:44 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:44 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:45 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:45 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 09:53:45 volumio51 volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:45 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:45 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:53:45 volumio51 volumio[1220]: info: Received Get System Info May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:53:45 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:53:45 volumio51 volumio[1220]: info: Executing endpoint metavolumio May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 11 09:53:45 volumio51 volumio[1220]: info: Executing endpoint metavolumio May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 11 09:53:45 volumio51 volumio[1220]: info: Executing endpoint metavolumio May 11 09:53:45 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 11 09:53:46 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:46 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:46 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:46 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:46 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:46 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:47 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:48 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:48 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:48 volumio51 volumio[1220]: info: BOOT COMPLETED May 11 09:53:48 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:48 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:48 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:48 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:49 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:49 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:49 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:49 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:49 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:49 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetBrowseSources May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:53:50 volumio51 volumio[1220]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:50 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 09:53:51 volumio51 volumio-remote-updater[728]: No test mode May 11 09:53:51 volumio51 volumio-remote-updater[728]: No alpha test mode May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 11 09:53:51 volumio51 volumio[1220]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:51 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:52 volumio51 systemd[1]: systemd-timedated.service: Succeeded. May 11 09:53:52 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:52 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:52 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:52 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:52 volumio51 volumio[1220]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf May 11 09:53:52 volumio51 volumio[1220]: info: FusionDsp - Stopping FusionDsp service May 11 09:53:52 volumio51 volumio[1220]: info: camilladsp stopping service pid 2498... May 11 09:53:52 volumio51 volumio[1220]: info: camilladsp service terminated, instance 1 May 11 09:53:52 volumio51 sudo[2755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service May 11 09:53:52 volumio51 sudo[2755]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:52 volumio51 systemd[1]: Stopping FusionDsp Daemon... May 11 09:53:52 volumio51 volumio[1683]: Backend configuration: May 11 09:53:52 volumio51 volumio[1683]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml May 11 09:53:52 volumio51 volumio[1683]: active_config_txt: null May 11 09:53:52 volumio51 volumio[1683]: camilla_host: 127.0.0.1 May 11 09:53:52 volumio51 volumio[1683]: camilla_port: 9876 May 11 09:53:52 volumio51 volumio[1683]: coeff_dir: /data/INTERNAL/FusionDsp/filters May 11 09:53:52 volumio51 volumio[1683]: config_dir: /data/configuration/audio_interface/fusiondsp May 11 09:53:52 volumio51 volumio[1683]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml May 11 09:53:52 volumio51 volumio[1683]: log_file: /tmp/camilladsp.log May 11 09:53:52 volumio51 volumio[1683]: on_get_active_config: null May 11 09:53:52 volumio51 volumio[1683]: on_set_active_config: null May 11 09:53:52 volumio51 volumio[1683]: port: 5011 May 11 09:53:52 volumio51 volumio[1683]: supported_capture_types: null May 11 09:53:52 volumio51 volumio[1683]: supported_playback_types: null May 11 09:53:52 volumio51 volumio[1683]: update_config_symlink: false May 11 09:53:52 volumio51 volumio[1683]: update_config_txt: false May 11 09:53:52 volumio51 volumio[1683]: ======== Running on http://0.0.0.0:5011 ======== May 11 09:53:52 volumio51 volumio[1683]: (Press CTRL+C to quit) May 11 09:53:52 volumio51 volumio[1220]: ------------------------------------ BT MESSAGE: BT STATUS: running May 11 09:53:52 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:52 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:52 volumio51 systemd[1]: fusiondsp.service: Succeeded. May 11 09:53:52 volumio51 systemd[1]: Stopped FusionDsp Daemon. May 11 09:53:52 volumio51 sudo[2755]: pam_unix(sudo:session): session closed for user root May 11 09:53:52 volumio51 volumio[1220]: info: FusionDsp - Reporting Fusion DSP Disabled May 11 09:53:52 volumio51 volumio[1220]: info: Removing fusiondspeq DSP Signal Path Element May 11 09:53:52 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 09:53:52 volumio51 volumio[1220]: info: Check plugin dependencies May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:53:53 volumio51 volumio[1220]: info: Rename folder May 11 09:53:53 volumio51 volumio[1220]: info: Folder /tmp/downloaded_plugin.zip removed May 11 09:53:53 volumio51 volumio[1220]: info: Move to category May 11 09:53:53 volumio51 volumio[1220]: info: Checking if install.sh is present May 11 09:53:53 volumio51 volumio[1220]: info: Executing install.sh May 11 09:53:53 volumio51 sudo[2775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh May 11 09:53:53 volumio51 sudo[2775]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:53 volumio51 volumio[1220]: info: creating filters folder and copying demo filters May 11 09:53:53 volumio51 volumio[1220]: info: copying demo flters May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/ May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/2XEQ15/ May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/2XEQ15/.Bass-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/2XEQ15/.Classic-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/2XEQ15/.Voice-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/2XEQ15/.Rock-FusionDsp.json May 11 09:53:53 volumio51 sudo[2805]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update May 11 09:53:53 volumio51 sudo[2805]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/PEQ/ May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/convfir/ May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/convfir/kef.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/convfir/test.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/EQ15/ May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/EQ15/.Bass-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/EQ15/.Classic-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/EQ15/.Voice-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: ./presets/EQ15/.Rock-FusionDsp.json May 11 09:53:53 volumio51 volumio[1220]: info: Installing/fusiondsp dependencies May 11 09:53:53 volumio51 volumio[1220]: info: Get:1 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] May 11 09:53:53 volumio51 volumio[1220]: info: Get:2 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] May 11 09:53:53 volumio51 volumio[1220]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:53 volumio51 volumio[1220]: info: Get:4 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] May 11 09:53:53 volumio51 volumio[1220]: info: Fetched 470 kB in 0s (996 kB/s) May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:53 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:54 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:54 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:54 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:54 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:54 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:54 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:54 volumio51 volumio[1220]: info: Reading package lists... May 11 09:53:55 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:55 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:55 volumio51 volumio[1220]: info: Building dependency tree... May 11 09:53:55 volumio51 volumio[1220]: info: Reading state information... May 11 09:53:55 volumio51 volumio[1220]: info: All packages are up to date. May 11 09:53:55 volumio51 sudo[2805]: pam_unix(sudo:session): session closed for user root May 11 09:53:55 volumio51 sudo[3045]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip May 11 09:53:55 volumio51 sudo[3045]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:55 volumio51 volumio[1220]: info: Reading package lists... May 11 09:53:55 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:55 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:55 volumio51 volumio[1220]: info: Building dependency tree... May 11 09:53:55 volumio51 volumio[1220]: info: Reading state information... May 11 09:53:55 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:55 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1). May 11 09:53:56 volumio51 sudo[3045]: pam_unix(sudo:session): session closed for user root May 11 09:53:56 volumio51 volumio[1220]: info: python3-pip is already the newest version (18.1-5+rpt1). May 11 09:53:56 volumio51 volumio[1220]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. May 11 09:53:56 volumio51 sudo[3067]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / May 11 09:53:56 volumio51 sudo[3067]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:56 volumio51 sudo[3067]: pam_unix(sudo:session): session closed for user root May 11 09:53:56 volumio51 volumio[1220]: info: lib/systemd/system/fusiondsp.service May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:56 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:57 volumio51 volumio[1220]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant May 11 09:53:57 volumio51 sudo[3130]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui May 11 09:53:57 volumio51 sudo[3130]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:57 volumio51 volumio[1220]: info: more info at http://www.winimage.com/zLibDll/unzip.html May 11 09:53:57 volumio51 volumio[1220]: info: May 11 09:53:57 volumio51 volumio[1220]: info: cgui-1.0.0.zip opened May 11 09:53:57 volumio51 sudo[3130]: pam_unix(sudo:session): session closed for user root May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/LICENSE.txt May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/README.md May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/build/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/robots.txt May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/logo512.png May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/asset-manifest.json May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/index.html May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/.put_statics_here May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/favicon.ico May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/logo192.png May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/manifest.json May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/css-variables.css May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/service-worker.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/build/static/ May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/build/static/css/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map May 11 09:53:57 volumio51 sudo[3132]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui May 11 09:53:57 volumio51 sudo[3132]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/main.1503f6cd.css May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css May 11 09:53:57 volumio51 sudo[3132]: pam_unix(sudo:session): session closed for user root May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/build/static/media/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/build/static/js/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/main.71e11955.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map May 11 09:53:57 volumio51 sudo[3134]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip May 11 09:53:57 volumio51 sudo[3134]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/main.71e11955.js.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt May 11 09:53:57 volumio51 sudo[3134]: pam_unix(sudo:session): session closed for user root May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/config/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/config/camillagui.yml May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/config/gui-config.yml May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/backend/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/filters_test.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/version.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/filters.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/settings.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/views.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/filterdefaults.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__init__.py May 11 09:53:57 volumio51 volumio[1220]: info: creating directory: cgui/backend/__pycache__/ May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/routes.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/backend/filemanagement.py May 11 09:53:57 volumio51 volumio[1220]: info: extracting: cgui/main.py May 11 09:53:57 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:57 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:57 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:57 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple May 11 09:53:58 volumio51 volumio[1220]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 May 11 09:53:58 volumio51 volumio[1220]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-_lrmbmec May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:58 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:59 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:59 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:59 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:59 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:59 volumio51 volumio[1220]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp==1.0.0 from git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 in /usr/local/lib/python3.7/dist-packages May 11 09:53:59 volumio51 volumio[1220]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0.1) May 11 09:53:59 volumio51 volumio[1220]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.6.1) May 11 09:53:59 volumio51 volumio[1220]: info: Building wheels for collected packages: camilladsp May 11 09:53:59 volumio51 volumio[1220]: info: Running setup.py bdist_wheel for camilladsp: started May 11 09:53:59 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:53:59 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:00 volumio51 volumio[1220]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' May 11 09:54:00 volumio51 volumio[1220]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-0vwtja0s/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 May 11 09:54:00 volumio51 volumio[1220]: info: Successfully built camilladsp May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 09:54:00 volumio51 volumio[1220]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 11 09:54:00 volumio51 volumio[1220]: info: Received Get System Version May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:54:00 volumio51 volumio[1220]: info: Received Get System Info May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:54:00 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:00 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 09:54:01 volumio51 volumio[1220]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 11 09:54:01 volumio51 volumio[1220]: info: Received Get System Version May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 09:54:01 volumio51 volumio[1220]: info: Received Get System Info May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:54:01 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:01 volumio51 volumio[1220]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple May 11 09:54:01 volumio51 volumio[1220]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 May 11 09:54:01 volumio51 volumio[1220]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-rvg9z7di May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:01 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp-plot==1.0.2 from git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 in /usr/local/lib/python3.7/dist-packages May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: typing-extensions; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (4.7.1) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: pkgutil-resolve-name>=1.3.10; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (1.3.10) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: importlib-metadata; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (6.7.0) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: importlib-resources>=1.4.0; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (5.12.0) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (0.19.3) May 11 09:54:02 volumio51 volumio[1220]: info: Requirement already satisfied: zipp>=0.5 in /usr/local/lib/python3.7/dist-packages (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) (3.15.0) May 11 09:54:02 volumio51 volumio[1220]: info: Building wheels for collected packages: camilladsp-plot May 11 09:54:02 volumio51 volumio[1220]: info: Running setup.py bdist_wheel for camilladsp-plot: started May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:54:02 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:54:02 volumio51 volumio[1220]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' May 11 09:54:02 volumio51 volumio[1220]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-i0r8yl6j/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 May 11 09:54:02 volumio51 volumio[1220]: info: Successfully built camilladsp-plot May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:02 volumio51 volumio[1220]: info: copying hw detection script May 11 09:54:02 volumio51 volumio[1220]: info: Detected cpu architecture as aarch64 May 11 09:54:03 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:03 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:03 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:03 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:03 volumio51 ntpd[989]: Soliciting pool server 193.134.29.11 May 11 09:54:03 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:03 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:04 volumio51 sudo[3344]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params May 11 09:54:04 volumio51 sudo[3344]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:54:04 volumio51 sudo[3344]: pam_unix(sudo:session): session closed for user root May 11 09:54:04 volumio51 sudo[3346]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params May 11 09:54:04 volumio51 sudo[3346]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:54:04 volumio51 sudo[3346]: pam_unix(sudo:session): session closed for user root May 11 09:54:04 volumio51 sudo[3348]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc May 11 09:54:04 volumio51 sudo[3348]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 09:54:04 volumio51 volumio[1220]: info: Reading package lists... May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:04 volumio51 volumio[1220]: info: Building dependency tree... May 11 09:54:04 volumio51 volumio[1220]: info: Reading state information... May 11 09:54:04 volumio51 ntpd[989]: Soliciting pool server 212.51.144.44 May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:04 volumio51 volumio[1220]: info: drc is already the newest version (3.2.2~dfsg0-2). May 11 09:54:04 volumio51 sudo[3348]: pam_unix(sudo:session): session closed for user root May 11 09:54:04 volumio51 sudo[2775]: pam_unix(sudo:session): session closed for user root May 11 09:54:04 volumio51 volumio[1220]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. May 11 09:54:04 volumio51 volumio[1220]: info: Install script completed May 11 09:54:04 volumio51 volumio[1220]: info: Done installing plugin. May 11 09:54:04 volumio51 volumio[1220]: info: Enabling plugin fusiondsp May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 09:54:04 volumio51 volumio[1220]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":false},{"prettyName":"Podcast","name":"podcast","category":"music_service","version":"2.2.0","icon":"fa-podcast","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Backup & Restore Data","name":"backup_restore","category":"system_controller","version":"0.7.4","icon":"fa-floppy-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Audiophonics Evo Sabre","name":"audiophonics_evo_sabre","category":"system_hardware","version":"1.0.0","icon":"fa-hdd-o","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"MPD OLED","name":"mpd_oled","category":"system_hardware","version":"1.1.3","icon":"fa-television","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.5.1","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":true,"active":true}] May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 11 09:54:04 volumio51 volumio[1220]: info: Folder /tmp/plugins removed May 11 09:54:04 volumio51 volumio[1220]: info: Folder /tmp/downloaded_plugin.zip removed May 11 09:54:04 volumio51 volumio[1220]: Plugin install end detected on script May 11 09:54:04 volumio51 volumio[1220]: info: Folder /data/temp removed May 11 09:54:04 volumio51 volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 09:54:05 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:05 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:05 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:05 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:05 volumio51 ntpd[989]: Soliciting pool server 185.125.24.59 May 11 09:54:05 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:05 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:05 volumio51 ntpd[989]: Soliciting pool server 193.33.30.39 May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:06 volumio51 ntpd[989]: Soliciting pool server 185.122.238.196 May 11 09:54:06 volumio51 ntpd[989]: Soliciting pool server 156.106.214.48 May 11 09:54:06 volumio51 ntpd[989]: Soliciting pool server 195.141.190.190 May 11 09:54:06 volumio51 ntpd[989]: Soliciting pool server 195.186.1.100 May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:06 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:07 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:07 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:07 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:07 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:07 volumio51 ntpd[989]: Soliciting pool server 194.56.188.142 May 11 09:54:07 volumio51 ntpd[989]: Soliciting pool server 79.110.235.11 May 11 09:54:07 volumio51 ntpd[989]: Soliciting pool server 185.17.70.106 May 11 09:54:07 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:07 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:08 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:08 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:08 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:08 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:08 volumio51 ntpd[989]: Soliciting pool server 212.51.144.47 May 11 09:54:08 volumio51 ntpd[989]: Soliciting pool server 109.233.182.115 May 11 09:54:08 volumio51 ntpd[989]: Soliciting pool server 82.197.162.18 May 11 09:54:08 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:08 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:09 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:09 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:09 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:09 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:09 volumio51 ntpd[989]: Soliciting pool server 5.148.175.134 May 11 09:54:09 volumio51 ntpd[989]: Soliciting pool server 2001:470:b415:2:be24:11ff:fe10:cbc5 May 11 09:54:09 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:09 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:10 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:10 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:10 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:10 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:11 volumio51 ntpd[989]: receive: Unexpected origin timestamp 0xebcad622.ae6dc387 does not match aorg 0000000000.00000000 from server@185.17.70.106 xmt 0xebcad623.70c957ca May 11 09:54:11 volumio51 ntpd[989]: receive: Unexpected origin timestamp 0xebcad622.ae6d49e4 does not match aorg 0000000000.00000000 from server@194.56.188.142 xmt 0xebcad623.70f4cb27 May 11 09:54:11 volumio51 ntpd[989]: receive: Unexpected origin timestamp 0xebcad622.ae6ec1e6 does not match aorg 0000000000.00000000 from server@212.51.144.44 xmt 0xebcad623.7101d453 May 11 09:54:11 volumio51 ntpd[989]: receive: Unexpected origin timestamp 0xebcad622.ae6c83db does not match aorg 0000000000.00000000 from server@212.51.144.47 xmt 0xebcad623.710dfc28 May 11 09:54:11 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:11 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:11 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:11 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:12 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:12 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:12 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:12 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:12 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:12 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:13 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:13 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:13 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:13 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:13 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:13 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:14 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:14 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:14 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:14 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:14 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:14 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:15 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:15 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:15 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:15 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:15 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:15 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:16 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:16 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:16 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:16 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:16 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:16 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:16 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:17 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:17 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:17 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:17 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:17 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:17 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:17 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:18 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:18 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:18 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:18 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:18 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:18 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:19 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:19 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:19 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:19 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:19 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:19 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:20 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:20 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:20 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:20 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:20 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:20 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:21 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:22 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:23 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:24 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:25 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:26 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:27 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:28 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:29 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:30 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:31 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:32 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 09:54:33 volumio51 volumio[1220]: info: Discovery: Getting this device information May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:33 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:34 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:35 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:36 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:37 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:38 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:39 volumio51 volumio[1220]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf May 11 09:54:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:39 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:40 volumio51 volumio[1220]: info: CoreCommandRouter::volumioGetState May 11 09:54:40 volumio51 volumio[1220]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf May 11 09:54:40 volumio51 volumio[1220]: info: FusionDsp - Stopping FusionDsp service May 11 09:54:40 volumio51 volumio[1220]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 09:54:40 volumio51 volumio[1220]: TypeError: Cannot read property 'stop' of null May 11 09:54:40 volumio51 volumio[1220]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) May 11 09:54:40 volumio51 volumio[1220]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) May 11 09:54:40 volumio51 volumio[1220]: at /volumio/app/pluginmanager.js:956:12 May 11 09:54:40 volumio51 volumio[1220]: at ChildProcess.exithandler (child_process.js:299:7) May 11 09:54:40 volumio51 volumio[1220]: at ChildProcess.emit (events.js:315:20) May 11 09:54:40 volumio51 volumio[1220]: at maybeClose (internal/child_process.js:1048:16) May 11 09:54:40 volumio51 volumio[1220]: at Socket. (internal/child_process.js:439:11) May 11 09:54:40 volumio51 volumio[1220]: at Socket.emit (events.js:315:20) May 11 09:54:40 volumio51 volumio[1220]: at Pipe. (net.js:673:12) May 11 09:54:40 volumio51 volumio[1220]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 09:54:41 volumio51 sudo[4097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-11 09:53 May 11 09:54:41 volumio51 sudo[4097]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"