-- Logs begin at Wed 2024-08-28 08:42:34 UTC, end at Fri 2024-08-30 02:32:11 UTC. -- Aug 30 02:31:31 musical-fidelity systemd[1]: Time has been changed Aug 30 02:31:31 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:31 musical-fidelity sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:31 musical-fidelity sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:31 musical-fidelity sudo[1113]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:31 musical-fidelity kernel: RTL871X: send eapol packet Aug 30 02:31:31 musical-fidelity kernel: RTL871X: rtw_aes_decrypt(wlan0) no_gkey_bc_cnt:13, no_gkey_mc_cnt:1 Aug 30 02:31:32 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:32 musical-fidelity sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:32 musical-fidelity sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:32 musical-fidelity sudo[1123]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:32 musical-fidelity kernel: RTL871X: send eapol packet Aug 30 02:31:33 musical-fidelity kernel: RTL871X: rtw_aes_decrypt(wlan0) no_gkey_bc_cnt:9, no_gkey_mc_cnt:0 Aug 30 02:31:33 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:33 musical-fidelity sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:33 musical-fidelity kernel: RTL871X: send eapol packet Aug 30 02:31:33 musical-fidelity sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:33 musical-fidelity sudo[1132]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:34 musical-fidelity kernel: RTL871X: rtw_aes_decrypt(wlan0) no_gkey_bc_cnt:1, no_gkey_mc_cnt:47 Aug 30 02:31:34 musical-fidelity kernel: RTL871X: sta recv deauth reason code(2) sta:d4:5d:64:c5:dd:b8, ignore = 0 Aug 30 02:31:34 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-DISCONNECTED bssid=d4:5d:64:c5:dd:b8 reason=0 locally_generated=1 Aug 30 02:31:34 musical-fidelity wpa_supplicant[1051]: wlan0: WPA: 4-Way Handshake failed - pre-shared key may be incorrect Aug 30 02:31:34 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Alpha Audio" auth_failures=1 duration=10 reason=WRONG_KEY Aug 30 02:31:34 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Aug 30 02:31:34 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:34 musical-fidelity sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:34 musical-fidelity sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:34 musical-fidelity sudo[1143]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:35 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:35 musical-fidelity sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:35 musical-fidelity sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:35 musical-fidelity sudo[1152]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:36 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:36 musical-fidelity sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:36 musical-fidelity sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:36 musical-fidelity sudo[1161]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:37 musical-fidelity volumio-remote-updater[721]: [2024-08-30 02:31:37] [info] asio async_connect error: system:111 (Connection refused) Aug 30 02:31:37 musical-fidelity volumio-remote-updater[721]: [2024-08-30 02:31:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 30 02:31:37 musical-fidelity volumio-remote-updater[721]: [2024-08-30 02:31:37] [error] handle_connect error: Underlying Transport Error Aug 30 02:31:37 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:38 musical-fidelity sudo[1170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:38 musical-fidelity sudo[1170]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:38 musical-fidelity sudo[1170]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:39 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:39 musical-fidelity sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:39 musical-fidelity sudo[1179]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:39 musical-fidelity sudo[1179]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:40 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:40 musical-fidelity sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:40 musical-fidelity sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:40 musical-fidelity sudo[1188]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:41 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:41 musical-fidelity sudo[1197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:41 musical-fidelity sudo[1197]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:41 musical-fidelity sudo[1197]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:42 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:42 musical-fidelity sudo[1206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:42 musical-fidelity sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:42 musical-fidelity sudo[1206]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:43 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:43 musical-fidelity sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:43 musical-fidelity sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:43 musical-fidelity sudo[1215]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:44 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:44 musical-fidelity sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:44 musical-fidelity sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:44 musical-fidelity sudo[1224]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:45 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:45 musical-fidelity sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:45 musical-fidelity sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:45 musical-fidelity sudo[1233]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:46 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:46 musical-fidelity sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:46 musical-fidelity sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:46 musical-fidelity sudo[1242]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:47 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:47 musical-fidelity sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:47 musical-fidelity sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:47 musical-fidelity sudo[1251]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:47 musical-fidelity volumio-remote-updater[721]: [2024-08-30 02:31:47] [info] asio async_connect error: system:111 (Connection refused) Aug 30 02:31:47 musical-fidelity volumio-remote-updater[721]: [2024-08-30 02:31:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 30 02:31:47 musical-fidelity volumio-remote-updater[721]: [2024-08-30 02:31:47] [error] handle_connect error: Underlying Transport Error Aug 30 02:31:48 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:48 musical-fidelity sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:48 musical-fidelity sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:48 musical-fidelity sudo[1260]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:49 musical-fidelity wireless.js[897]: trying... Aug 30 02:31:49 musical-fidelity sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 02:31:49 musical-fidelity sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:49 musical-fidelity sudo[1269]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Alpha Audio" Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: Trying to associate with d4:5d:64:c5:dd:b8 (SSID='Alpha Audio' freq=2452 MHz) Aug 30 02:31:50 musical-fidelity kernel: RTL871X: rtw_set_802_11_connect(wlan0) fw_state=0x00000008 Aug 30 02:31:50 musical-fidelity kernel: RTL871X: start auth Aug 30 02:31:50 musical-fidelity kernel: RTL871X: auth success, start assoc Aug 30 02:31:50 musical-fidelity kernel: RTL871X: rtw_cfg80211_indicate_connect(wlan0) BSS not found !! Aug 30 02:31:50 musical-fidelity kernel: RTL871X: assoc success Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: Associated with d4:5d:64:c5:dd:b8 Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Aug 30 02:31:50 musical-fidelity kernel: RTL871X: send eapol packet Aug 30 02:31:50 musical-fidelity wireless.js[897]: Overtime, starting plan B Aug 30 02:31:50 musical-fidelity wireless.js[897]: STARTING HOTSPOT Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-DISCONNECTED bssid=d4:5d:64:c5:dd:b8 reason=3 locally_generated=1 Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: WPA: 4-Way Handshake failed - pre-shared key may be incorrect Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Alpha Audio" auth_failures=2 duration=23 reason=WRONG_KEY Aug 30 02:31:50 musical-fidelity dhcpcd[1077]: wlan0: carrier acquired Aug 30 02:31:50 musical-fidelity wpa_supplicant[1051]: wlan0: CTRL-EVENT-TERMINATING Aug 30 02:31:50 musical-fidelity dhcpcd[1077]: wlan0: soliciting a DHCP lease Aug 30 02:31:51 musical-fidelity dhcpcd[1077]: wlan0: carrier lost Aug 30 02:31:51 musical-fidelity dhcpcd[1077]: eth0: adding route to 192.168.50.0/24 Aug 30 02:31:51 musical-fidelity dhcpcd[1077]: eth0: adding default route via 192.168.50.1 Aug 30 02:31:51 musical-fidelity dhcpcd[1077]: eth0: removing route to 192.168.50.0/24 Aug 30 02:31:51 musical-fidelity dhcpcd[1077]: eth0: removing default route via 192.168.50.1 Aug 30 02:31:53 musical-fidelity systemd[1]: Stopped hotspot.service. Aug 30 02:31:53 musical-fidelity sudo[1320]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 30 02:31:53 musical-fidelity sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:53 musical-fidelity sudo[1320]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:53 musical-fidelity sudo[1328]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 30 02:31:53 musical-fidelity sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:31:53 musical-fidelity sudo[1328]: pam_unix(sudo:session): session closed for user root Aug 30 02:31:53 musical-fidelity avahi-daemon[746]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Aug 30 02:31:53 musical-fidelity avahi-daemon[746]: New relevant interface wlan0.IPv4 for mDNS. Aug 30 02:31:53 musical-fidelity avahi-daemon[746]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting hotspot.service... Aug 30 02:31:53 musical-fidelity systemd[1]: Started hotspot.service. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting dhcpd.service... Aug 30 02:31:53 musical-fidelity systemd[1]: Starting dnsmasq.service... Aug 30 02:31:53 musical-fidelity systemd[1]: Started Wireless Services. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting Volumio Backend Module... Aug 30 02:31:53 musical-fidelity systemd[1]: Started Volumio Backend Module. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting Start Volumio Kiosk... Aug 30 02:31:53 musical-fidelity systemd[1]: Started Start Volumio Kiosk. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting Volumio Streaming Daemon... Aug 30 02:31:53 musical-fidelity systemd[1]: Started Volumio Streaming Daemon. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting Multi-User System. Aug 30 02:31:53 musical-fidelity systemd[1]: Reached target Multi-User System. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting Graphical Interface. Aug 30 02:31:53 musical-fidelity systemd[1]: Reached target Graphical Interface. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 30 02:31:53 musical-fidelity systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 30 02:31:53 musical-fidelity dnsmasq[1358]: started, version 2.72 cachesize 150 Aug 30 02:31:53 musical-fidelity dnsmasq[1358]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Aug 30 02:31:53 musical-fidelity dnsmasq[1358]: reading /etc/resolv.conf Aug 30 02:31:53 musical-fidelity dnsmasq[1358]: using nameserver 192.168.50.1#53 Aug 30 02:31:53 musical-fidelity dnsmasq[1358]: using nameserver 208.67.222.222#53 Aug 30 02:31:53 musical-fidelity dnsmasq[1358]: using nameserver 208.67.220.220#53 Aug 30 02:31:53 musical-fidelity dnsmasq[1358]: read /etc/hosts - 2 addresses Aug 30 02:31:53 musical-fidelity systemd[1]: Started dnsmasq.service. Aug 30 02:31:53 musical-fidelity systemd[1]: Starting Host and Network Name Lookups. Aug 30 02:31:53 musical-fidelity systemd[1]: Reached target Host and Network Name Lookups. Aug 30 02:31:53 musical-fidelity dhcpd[1342]: Internet Systems Consortium DHCP Server 4.3.1 Aug 30 02:31:53 musical-fidelity dhcpd[1342]: Copyright 2004-2014 Internet Systems Consortium. Aug 30 02:31:53 musical-fidelity dhcpd[1342]: All rights reserved. Aug 30 02:31:53 musical-fidelity dhcpd[1342]: For info, please visit https://www.isc.org/software/dhcp/ Aug 30 02:31:53 musical-fidelity dhcpd[1342]: Config file: /etc/dhcp/dhcpd.conf Aug 30 02:31:53 musical-fidelity dhcpd[1342]: Database file: /var/lib/dhcp/dhcpd.leases Aug 30 02:31:53 musical-fidelity dhcpd[1342]: PID file: /var/run/dhcpd.pid Aug 30 02:31:53 musical-fidelity hotspot[1342]: Internet Systems Consortium DHCP Server 4.3.1 Aug 30 02:31:53 musical-fidelity hotspot[1342]: Copyright 2004-2014 Internet Systems Consortium. Aug 30 02:31:53 musical-fidelity hotspot[1342]: All rights reserved. Aug 30 02:31:53 musical-fidelity hotspot[1342]: For info, please visit https://www.isc.org/software/dhcp/ Aug 30 02:31:53 musical-fidelity hotspot[1342]: Config file: /etc/dhcp/dhcpd.conf Aug 30 02:31:53 musical-fidelity hotspot[1342]: Database file: /var/lib/dhcp/dhcpd.leases Aug 30 02:31:53 musical-fidelity hotspot[1342]: PID file: /var/run/dhcpd.pid Aug 30 02:31:53 musical-fidelity dhcpd[1342]: Internet Systems Consortium DHCP Server 4.3.1 Aug 30 02:31:53 musical-fidelity dhcpd[1342]: Copyright 2004-2014 Internet Systems Consortium. Aug 30 02:31:53 musical-fidelity dhcpd[1342]: All rights reserved. Aug 30 02:31:53 musical-fidelity dhcpd[1342]: For info, please visit https://www.isc.org/software/dhcp/ Aug 30 02:31:53 musical-fidelity dhcpd[1342]: Wrote 15 leases to leases file. Aug 30 02:31:53 musical-fidelity hotspot[1342]: Wrote 15 leases to leases file. Aug 30 02:31:54 musical-fidelity dhcpd[1342]: Listening on LPF/wlan0/5c:f3:70:bc:52:92/192.168.211.0/24 Aug 30 02:31:54 musical-fidelity dhcpd[1342]: Sending on LPF/wlan0/5c:f3:70:bc:52:92/192.168.211.0/24 Aug 30 02:31:54 musical-fidelity dhcpd[1342]: Aug 30 02:31:54 musical-fidelity dhcpd[1342]: No subnet declaration for eth0 (192.168.50.52). Aug 30 02:31:54 musical-fidelity dhcpd[1342]: ** Ignoring requests on eth0. If this is not what Aug 30 02:31:54 musical-fidelity dhcpd[1342]: you want, please write a subnet declaration Aug 30 02:31:54 musical-fidelity dhcpd[1342]: in your dhcpd.conf file for the network segment Aug 30 02:31:54 musical-fidelity dhcpd[1342]: to which interface eth0 is attached. ** Aug 30 02:31:54 musical-fidelity dhcpd[1342]: Aug 30 02:31:54 musical-fidelity dhcpd[1342]: Sending on Socket/fallback/fallback-net Aug 30 02:31:54 musical-fidelity dhcpd[1382]: Server starting service. Aug 30 02:31:54 musical-fidelity systemd[1]: Started dhcpd.service. Aug 30 02:31:54 musical-fidelity systemd[1]: Startup finished in 8.896s (kernel) + 39.378s (userspace) = 48.275s. Aug 30 02:31:54 musical-fidelity hotspot[1342]: Listening on LPF/wlan0/5c:f3:70:bc:52:92/192.168.211.0/24 Aug 30 02:31:54 musical-fidelity hotspot[1342]: Sending on LPF/wlan0/5c:f3:70:bc:52:92/192.168.211.0/24 Aug 30 02:31:54 musical-fidelity hotspot[1342]: No subnet declaration for eth0 (192.168.50.52). Aug 30 02:31:54 musical-fidelity hotspot[1342]: ** Ignoring requests on eth0. If this is not what Aug 30 02:31:54 musical-fidelity hotspot[1342]: you want, please write a subnet declaration Aug 30 02:31:54 musical-fidelity hotspot[1342]: in your dhcpd.conf file for the network segment Aug 30 02:31:54 musical-fidelity hotspot[1342]: to which interface eth0 is attached. ** Aug 30 02:31:54 musical-fidelity hotspot[1342]: Sending on Socket/fallback/fallback-net Aug 30 02:31:54 musical-fidelity hotspot[1341]: Launching Ordinary Hostapd Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: ############################ Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: # Volumio Streaming Daemon # Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: # Running on port 7777 # Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: ############################ Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: Checking variant in static cache Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: Enabled services: Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: 1) tidal Aug 30 02:31:54 musical-fidelity volumio-streaming-daemon[1346]: 2) qobuz Aug 30 02:31:54 musical-fidelity startx[1345]: X.Org X Server 1.18.4 Aug 30 02:31:54 musical-fidelity startx[1345]: Release Date: 2016-07-19 Aug 30 02:31:54 musical-fidelity startx[1345]: X Protocol Version 11, Revision 0 Aug 30 02:31:54 musical-fidelity startx[1345]: Build Operating System: Linux 4.4.26-v7+ armv7l Raspbian Aug 30 02:31:54 musical-fidelity startx[1345]: Current Operating System: Linux musical-fidelity 4.9.65-v7+ #1 SMP Thu Jul 19 18:43:14 UTC 2018 armv7l Aug 30 02:31:54 musical-fidelity startx[1345]: Kernel command line: bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:61:C4:5B vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash quiet 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=2 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh elevator=noop rootwait smsc95xx.turbo_mode=N bootdelay=5 logo.nologo vt.global_cursor_default=0 loglevel=0 consoleblank=0 Aug 30 02:31:54 musical-fidelity startx[1345]: Build Date: 11 November 2016 11:59:59AM Aug 30 02:31:54 musical-fidelity startx[1345]: xorg-server 2:1.18.4-2+rpi1 (https://www.debian.org/support) Aug 30 02:31:54 musical-fidelity startx[1345]: Current version of pixman: 0.32.6 Aug 30 02:31:54 musical-fidelity startx[1345]: Before reporting problems, check http://wiki.x.org Aug 30 02:31:54 musical-fidelity startx[1345]: to make sure that you have the latest version. Aug 30 02:31:54 musical-fidelity startx[1345]: Markers: (--) probed, (**) from config file, (==) default setting, Aug 30 02:31:54 musical-fidelity startx[1345]: (++) from command line, (!!) notice, (II) informational, Aug 30 02:31:54 musical-fidelity startx[1345]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Aug 30 02:31:54 musical-fidelity startx[1345]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Aug 30 02:31:54 2024 Aug 30 02:31:54 musical-fidelity startx[1345]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Aug 30 02:31:54 musical-fidelity dhcpcd[1077]: wlan0: carrier acquired Aug 30 02:31:54 musical-fidelity kernel: RTL871X: assoc success Aug 30 02:31:54 musical-fidelity startx[1345]: modprobe: FATAL: Module g2d_23 not found. Aug 30 02:31:54 musical-fidelity dhcpcd[1077]: wlan0: soliciting a DHCP lease Aug 30 02:31:54 musical-fidelity dhcpd[1382]: DHCPDISCOVER from 5c:f3:70:bc:52:92 via wlan0 Aug 30 02:31:55 musical-fidelity dhcpd[1382]: DHCPOFFER on 192.168.211.18 to 5c:f3:70:bc:52:92 (musical-fidelity) via wlan0 Aug 30 02:31:56 musical-fidelity ntpd[840]: Listen normally on 4 wlan0 192.168.211.1 UDP 123 Aug 30 02:31:56 musical-fidelity ntpd[840]: peers refreshed Aug 30 02:31:57 musical-fidelity volumio[1344]: info: ------------------------------------------- Aug 30 02:31:57 musical-fidelity volumio[1344]: info: ----- Volumio2 ---- Aug 30 02:31:57 musical-fidelity volumio[1344]: info: ------------------------------------------- Aug 30 02:31:57 musical-fidelity volumio[1344]: info: ----- System startup ---- Aug 30 02:31:57 musical-fidelity volumio[1344]: info: ------------------------------------------- Aug 30 02:31:57 musical-fidelity volumio-remote-updater[721]: [2024-08-30 02:31:57] [connect] Successful connection Aug 30 02:31:58 musical-fidelity dhcpd[1382]: DHCPDISCOVER from 5c:f3:70:bc:52:92 (musical-fidelity) via wlan0 Aug 30 02:31:58 musical-fidelity dhcpd[1382]: DHCPOFFER on 192.168.211.18 to 5c:f3:70:bc:52:92 (musical-fidelity) via wlan0 Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Plugin folders cleanup Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning into folder /volumio/app/plugins/ Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning category audio_interface Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning category miscellanea Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning category music_service Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning category plugins.json Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning category system_controller Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning category user_interface Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Scanning into folder /data/plugins/ Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Plugin folders cleanup completed Aug 30 02:31:58 musical-fidelity volumio[1344]: info: ------------------------------------------- Aug 30 02:31:58 musical-fidelity volumio[1344]: info: ----- Core plugins startup ---- Aug 30 02:31:58 musical-fidelity volumio[1344]: info: ------------------------------------------- Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Adding plugin upnp to MyMusic Plugins Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Adding plugin metavolumio to MyMusic Plugins Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Adding plugin cd_controller to MyMusic Plugins Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Adding plugin raat to MyMusic Plugins Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Loading plugins from folder /data/plugins/ Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Loading plugin "system"... Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Applying required configuration parameters for plugin system Aug 30 02:31:58 musical-fidelity volumio[1344]: No id defined. Creating one Aug 30 02:31:58 musical-fidelity volumio[1344]: info: Loading plugin "appearance"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "network"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Refreshing Cached IP Addresses Aug 30 02:32:00 musical-fidelity sudo[1466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "services"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "alsa_controller"... Aug 30 02:32:00 musical-fidelity sudo[1466]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:00 musical-fidelity sudo[1469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 02:32:00 musical-fidelity sudo[1466]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:00 musical-fidelity sudo[1469]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:00 musical-fidelity sudo[1469]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Applying required configuration parameters for plugin alsa_controller Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "wizard"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "volumio_command_line_client"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "upnp"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: [1724985120229] Starting Upmpd Daemon Aug 30 02:32:00 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "my_music"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "mpd"... Aug 30 02:32:00 musical-fidelity volumio[1344]: info: Loading plugin "upnp_browser"... Aug 30 02:32:01 musical-fidelity volumio[1344]: info: Loading plugin "networkfs"... Aug 30 02:32:01 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 02:32:01 musical-fidelity volumio[1344]: info: Loading plugin "bluetooth"... Aug 30 02:32:01 musical-fidelity volumio[1344]: info: [1724985121848] Starting BluetoothController Aug 30 02:32:01 musical-fidelity volumio[1344]: info: Loading plugin "multiroom"... Aug 30 02:32:01 musical-fidelity volumio[1344]: info: Loading plugin "alarm-clock"... Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Loading plugin "metavolumio"... Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Loading plugin "airplay_emulation"... Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Starting Shairport Sync Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Loading plugin "cd_controller"... Aug 30 02:32:02 musical-fidelity sudo[1501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Aug 30 02:32:02 musical-fidelity sudo[1501]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:02 musical-fidelity systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 02:32:02 musical-fidelity sudo[1501]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Plugin last_100 is not enabled Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Loading plugin "raat"... Aug 30 02:32:02 musical-fidelity volumio[1344]: info: RAAT Plugin loaded Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Adding restartRAATSocket REST API Endpoint Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Loading plugin "streaming_services"... Aug 30 02:32:02 musical-fidelity volumio[1344]: info: Loading plugin "webradio"... Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Loading plugin "i2s_dacs"... Aug 30 02:32:03 musical-fidelity volumio[1344]: info: I2S DAC not set, start Auto-detection Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Loading plugin "volumiodiscovery"... Aug 30 02:32:03 musical-fidelity volumio[1344]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 02:32:03 musical-fidelity node[1344]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 02:32:03 musical-fidelity node[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 02:32:03 musical-fidelity node[1344]: *** WARNING *** For more information see Aug 30 02:32:03 musical-fidelity node[1344]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 02:32:03 musical-fidelity node[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 02:32:03 musical-fidelity node[1344]: *** WARNING *** For more information see Aug 30 02:32:03 musical-fidelity volumio[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 02:32:03 musical-fidelity volumio[1344]: *** WARNING *** For more information see Aug 30 02:32:03 musical-fidelity volumio[1344]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 02:32:03 musical-fidelity volumio[1344]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 02:32:03 musical-fidelity volumio[1344]: *** WARNING *** For more information see Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 02:32:03 musical-fidelity volumio[1344]: Discovery: StartAdv! undefined Aug 30 02:32:03 musical-fidelity volumio[1344]: Discovery: Started advertising... undefined - undefined Aug 30 02:32:03 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Plugin outputs is not enabled Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Loading plugin "albumart"... Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Plugin example_plugin is not enabled Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Loading plugin "hi_res_audio"... Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Applying required configuration parameters for plugin hi_res_audio Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Loading plugin "inputs"... Aug 30 02:32:03 musical-fidelity volumio[1344]: Forking 3 albumart workers Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Adding inputs REST Endpoints Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/inputs Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Scanning Audio Inputs Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Checking against Known Cards name Aug 30 02:32:03 musical-fidelity volumio[1344]: info: Loading plugin "qobuz"... Aug 30 02:32:04 musical-fidelity volumio[1344]: Starting albumart workers Aug 30 02:32:04 musical-fidelity volumio[1344]: Starting albumart workers Aug 30 02:32:04 musical-fidelity volumio[1344]: Starting albumart workers Aug 30 02:32:06 musical-fidelity dhcpd[1382]: DHCPDISCOVER from 5c:f3:70:bc:52:92 (musical-fidelity) via wlan0 Aug 30 02:32:06 musical-fidelity dhcpd[1382]: DHCPOFFER on 192.168.211.18 to 5c:f3:70:bc:52:92 (musical-fidelity) via wlan0 Aug 30 02:32:06 musical-fidelity volumio[1344]: info: Loading plugin "spop"... Aug 30 02:32:07 musical-fidelity volumio[1344]: info: Loading plugin "tidal"... Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Loading plugin "gpios"... Aug 30 02:32:09 musical-fidelity volumio[1344]: error: ATTENTION!!!: Plugin gpios does not return adequate promise from onVolumioStart: please update! Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Loading plugin "updater_comm"... Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Plugin mpdemulation is not enabled Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Loading plugin "rest_api"... Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Loading plugin "websocket"... Aug 30 02:32:09 musical-fidelity volumio[1344]: info: ___________ START PLUGINS ___________ Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Adding METAVOLUMIO REST API Endpoints Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 02:32:09 musical-fidelity volumio[1344]: info: [1724985129392] CoreMusicLibrary::Adding element Shairport-Sync Aug 30 02:32:09 musical-fidelity sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name undefined Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 02:32:09 musical-fidelity sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Preparing CD Folders Aug 30 02:32:09 musical-fidelity sudo[1608]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Adding CD REST API Endpoints Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Detecting CD presence with Flag file Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Starting RAAT Plugin Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Additional UI Settings Added for plugin music_service/raat Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Streaming services startup Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Starting Streaming Daemon Aug 30 02:32:09 musical-fidelity sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 30 02:32:09 musical-fidelity sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 02:32:09 musical-fidelity volumio[1344]: info: [1724985129535] CoreMusicLibrary::Adding element Webradio Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 02:32:09 musical-fidelity systemd[1]: Stopping Volumio Streaming Daemon... Aug 30 02:32:09 musical-fidelity volumio[1344]: error: Hi Res Audio Failed Login: Missing Login Data Aug 30 02:32:09 musical-fidelity systemd[1]: Starting Volumio Streaming Daemon... Aug 30 02:32:09 musical-fidelity systemd[1]: Started Volumio Streaming Daemon. Aug 30 02:32:09 musical-fidelity sudo[1624]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: ############################ Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: # Volumio Streaming Daemon # Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: # Running on port 7777 # Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: ############################ Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: Checking variant in static cache Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: Enabled services: Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: 1) tidal Aug 30 02:32:09 musical-fidelity volumio-streaming-daemon[1634]: 2) qobuz Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 02:32:09 musical-fidelity volumio[1344]: [SpotifyConnect] Creating VLS config file Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: [SpotifyConnect] SpotifyConnect Daemon config issues! Aug 30 02:32:09 musical-fidelity volumio[1344]: [SpotifyConnect] volspotify config error: [ 'device-name = "undefined" # Name of the Spotify connect device', Aug 30 02:32:09 musical-fidelity volumio[1344]: [length]: 1 ] Aug 30 02:32:09 musical-fidelity volumio[1344]: [SpotifyConnect] Starting metadata listener Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Refreshing TIDAL token Aug 30 02:32:09 musical-fidelity sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Aug 30 02:32:09 musical-fidelity sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:09 musical-fidelity volumio[1344]: error: Plugin gpios does not return adequate promise from onStart: please update! Aug 30 02:32:09 musical-fidelity systemd[1]: Starting Volspotconnect2 Daemon... Aug 30 02:32:09 musical-fidelity systemd[1]: Started Volspotconnect2 Daemon. Aug 30 02:32:09 musical-fidelity sudo[1643]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Loading i18n strings for locale en Aug 30 02:32:09 musical-fidelity volumio[1344]: Updating browse sources language Aug 30 02:32:09 musical-fidelity volumio[1344]: Cannot find translation for sourceBluetooth Aug 30 02:32:09 musical-fidelity volumio[1344]: Cannot find translation for sourceUSB/PC Aug 30 02:32:09 musical-fidelity volumio[1344]: Cannot find translation for sourceShairport-Sync Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::initPlayerControls Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: BOOT COMPLETED Aug 30 02:32:09 musical-fidelity volumio[1344]: [Metrics] CommandRouter: 12s 454.09ms Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::Close All Modals sent Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::Close All Modals sent Aug 30 02:32:09 musical-fidelity volumio[1344]: Express server listening on port 3000 Aug 30 02:32:09 musical-fidelity volumio[1344]: [Metrics] WebUI: 13s 476.67ms Aug 30 02:32:09 musical-fidelity volumio[1344]: Volumio Calling Home Aug 30 02:32:09 musical-fidelity volumio[1648]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Aug 30 02:32:09 musical-fidelity volumio[1648]: Reading Config from "/tmp/volspotify.toml" Aug 30 02:32:09 musical-fidelity volumio[1648]: Malformed config key: missing field `Authentication` Aug 30 02:32:09 musical-fidelity systemd[1]: volspotconnect.service: main process exited, code=exited, status=1/FAILURE Aug 30 02:32:09 musical-fidelity systemd[1]: Unit volspotconnect.service entered failed state. Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreStateMachine::resetVolumioState Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreStateMachine::getcurrentVolume Aug 30 02:32:09 musical-fidelity volumio[1344]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 02:32:09 musical-fidelity volumio[1344]: info: Stopping AccessToken refresher cron for QOBUZ Aug 30 02:32:09 musical-fidelity volumio[1344]: info: AccessToken refresher cron started for QOBUZ Aug 30 02:32:09 musical-fidelity kernel: uart-pl011 3f201000.serial: no DMA platform data Aug 30 02:32:10 musical-fidelity volumio[1344]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 02:32:10 musical-fidelity volumio[1344]: info: Serial port opened successfully Aug 30 02:32:10 musical-fidelity sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart leddaemon.service Aug 30 02:32:10 musical-fidelity sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:10 musical-fidelity systemd[1]: Starting LED Daemon Service... Aug 30 02:32:10 musical-fidelity systemd[1]: Started LED Daemon Service. Aug 30 02:32:10 musical-fidelity sudo[1671]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:10 musical-fidelity led-daemon[1676]: Starting Network LED Daemon Aug 30 02:32:10 musical-fidelity volumio[1344]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Aug 30 02:32:10 musical-fidelity volumio[1344]: info: Setting Device type: Raspberry PI Aug 30 02:32:10 musical-fidelity volumio[1344]: [SpotifyConnect] Vollibrespot Daemon service started! Aug 30 02:32:10 musical-fidelity volumio[1344]: [Metrics] SpotifyConnect: 0s 743.41ms Aug 30 02:32:10 musical-fidelity volumio[1344]: info: RAAT Albumart path created successfully Aug 30 02:32:10 musical-fidelity volumio[1344]: info: Bluetooth name changed to undefined Aug 30 02:32:10 musical-fidelity volumio[1344]: info: Shairport-Sync Stopped Aug 30 02:32:10 musical-fidelity volumio[1344]: info: MPD running with PID747 Aug 30 02:32:10 musical-fidelity volumio[1344]: ,establishing connection Aug 30 02:32:10 musical-fidelity volumio[1344]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 02:32:10 musical-fidelity volumio[1344]: TypeError: Cannot read property 'charAt' of undefined Aug 30 02:32:10 musical-fidelity volumio[1344]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24) Aug 30 02:32:10 musical-fidelity volumio[1344]: at ontimeout (timers.js:482:11) Aug 30 02:32:10 musical-fidelity volumio[1344]: at tryOnTimeout (timers.js:317:5) Aug 30 02:32:10 musical-fidelity volumio[1344]: at Timer.listOnTimeout (timers.js:277:5) Aug 30 02:32:10 musical-fidelity sudo[1686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Aug 30 02:32:10 musical-fidelity volumio[1344]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 02:32:10 musical-fidelity sudo[1686]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 02:32:10 musical-fidelity sudo[1686]: pam_unix(sudo:session): session closed for user root Aug 30 02:32:11 musical-fidelity sudo[1703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 02:31 Aug 30 02:32:11 musical-fidelity sudo[1703]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"