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