-- Logs begin at Sun 2024-07-14 10:56:43 UTC, end at Sun 2024-07-14 10:58:13 UTC. -- Jul 14 10:57:00 volumio wireless.js[739]: WIRELESS DAEMON: start Jul 14 10:57:00 volumio wireless.js[739]: WIRELESS: Loaded configuration Jul 14 10:57:00 volumio wireless.js[739]: Cleaning previous... Jul 14 10:57:00 volumio systemd[1]: Stopped hotspot.service. Jul 14 10:57:00 volumio sudo[791]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 14 10:57:00 volumio sudo[791]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:00 volumio sudo[791]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:00 volumio sudo[799]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 14 10:57:00 volumio sudo[799]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:01 volumio sudo[799]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:01 volumio systemd[1]: Started Music Player Daemon. Jul 14 10:57:01 volumio udisks-glue[554]: Updating DB (#1) ... Jul 14 10:57:01 volumio udisks-glue[554]: volume: 90% repeat: off random: off single: off consume: off Jul 14 10:57:01 volumio wireless.js[739]: Stopped aP Jul 14 10:57:01 volumio systemd[1]: Stopped hotspot.service. Jul 14 10:57:01 volumio sudo[819]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 14 10:57:01 volumio sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:01 volumio sudo[819]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:01 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Jul 14 10:57:01 volumio sudo[829]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 14 10:57:01 volumio sudo[829]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:01 volumio sudo[829]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:01 volumio avahi-daemon[579]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jul 14 10:57:01 volumio avahi-daemon[579]: New relevant interface wlan0.IPv4 for mDNS. Jul 14 10:57:01 volumio avahi-daemon[579]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Jul 14 10:57:01 volumio kernel: brcmfmac: power management disabled Jul 14 10:57:01 volumio systemd[1]: Starting hotspot.service... Jul 14 10:57:01 volumio systemd[1]: Started hotspot.service. Jul 14 10:57:01 volumio systemd[1]: Starting dhcpd.service... Jul 14 10:57:01 volumio systemd[1]: Starting dnsmasq.service... Jul 14 10:57:01 volumio systemd[1]: Started Wireless Services. Jul 14 10:57:01 volumio systemd[1]: Starting Volumio Backend Module... Jul 14 10:57:01 volumio systemd[1]: Started Volumio Backend Module. Jul 14 10:57:01 volumio systemd[1]: Starting Volumio Streaming Daemon... Jul 14 10:57:01 volumio systemd[1]: Started Volumio Streaming Daemon. Jul 14 10:57:01 volumio winbind[564]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Jul 14 10:57:01 volumio winbind[564]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 14 10:57:01 volumio winbind[564]: Unable to setup corepath for winbindd: No such file or directory Jul 14 10:57:01 volumio winbind[564]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jul 14 10:57:01 volumio winbind[564]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 14 10:57:01 volumio winbind[564]: Unable to setup corepath for winbindd: No such file or directory Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio winbind[564]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio winbind[564]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01, 0] ../source3/winbindd/winbindd.c:1549(main) Jul 14 10:57:01 volumio winbind[564]: winbindd version 4.2.14-Debian started. Jul 14 10:57:01 volumio winbind[564]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01, 0] ../lib/util/util.c:220(directory_create_or_exist) Jul 14 10:57:01 volumio winbind[564]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jul 14 10:57:01 volumio winbind[564]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jul 14 10:57:01 volumio winbind[564]: Unable to setup corepath for winbindd: No such file or directory Jul 14 10:57:01 volumio winbindd[838]: [2024/07/14 10:57:01.905585, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01.905585, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio winbindd[838]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 14 10:57:01 volumio winbindd[838]: [2024/07/14 10:57:01.908838, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio winbindd[838]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 14 10:57:01 volumio winbind[564]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 14 10:57:01 volumio winbind[564]: [2024/07/14 10:57:01.908838, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio winbind[564]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jul 14 10:57:01 volumio nmbd[567]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Jul 14 10:57:01 volumio nmbd[567]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 14 10:57:01 volumio nmbd[567]: Unable to setup corepath for nmbd: No such file or directory Jul 14 10:57:01 volumio nmbd[861]: [2024/07/14 10:57:01.957881, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio nmbd[861]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 14 10:57:01 volumio nmbd[861]: [2024/07/14 10:57:01.959535, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio nmbd[861]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 14 10:57:01 volumio nmbd[567]: [2024/07/14 10:57:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio nmbd[567]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 14 10:57:01 volumio nmbd[567]: [2024/07/14 10:57:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio nmbd[567]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 14 10:57:01 volumio nmbd[567]: [2024/07/14 10:57:01, 0] ../source3/nmbd/nmbd.c:908(main) Jul 14 10:57:01 volumio nmbd[567]: nmbd version 4.2.14-Debian started. Jul 14 10:57:01 volumio nmbd[567]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jul 14 10:57:01 volumio nmbd[567]: [2024/07/14 10:57:01.957881, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio nmbd[567]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 14 10:57:01 volumio nmbd[567]: [2024/07/14 10:57:01.959535, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:01 volumio nmbd[567]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jul 14 10:57:01 volumio nmbd[862]: [2024/07/14 10:57:01.963311, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Jul 14 10:57:01 volumio nmbd[862]: started asyncdns process 863 Jul 14 10:57:01 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Jul 14 10:57:01 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Jul 14 10:57:01 volumio nmbd[567]: . Jul 14 10:57:01 volumio winbindd[866]: [2024/07/14 10:57:01.978108, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Jul 14 10:57:01 volumio winbindd[866]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jul 14 10:57:01 volumio systemd[1]: Started LSB: start Winbind daemon. Jul 14 10:57:01 volumio nmbd[862]: [2024/07/14 10:57:01.981281, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jul 14 10:57:01 volumio nmbd[862]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jul 14 10:57:01 volumio winbind[564]: . Jul 14 10:57:02 volumio dnsmasq[873]: started, version 2.72 cachesize 150 Jul 14 10:57:02 volumio dnsmasq[873]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Jul 14 10:57:02 volumio dnsmasq[873]: reading /etc/resolv.conf Jul 14 10:57:02 volumio dnsmasq[873]: using nameserver 192.168.2.9#53 Jul 14 10:57:02 volumio dnsmasq[873]: using nameserver 208.67.222.222#53 Jul 14 10:57:02 volumio dnsmasq[873]: using nameserver 208.67.222.222#53 Jul 14 10:57:02 volumio dnsmasq[873]: using nameserver 208.67.220.220#53 Jul 14 10:57:02 volumio dnsmasq[873]: read /etc/hosts - 4 addresses Jul 14 10:57:02 volumio systemd[1]: Started dnsmasq.service. Jul 14 10:57:02 volumio systemd[1]: Starting Host and Network Name Lookups. Jul 14 10:57:02 volumio systemd[1]: Reached target Host and Network Name Lookups. Jul 14 10:57:02 volumio winbindd[866]: [2024/07/14 10:57:02.167791, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jul 14 10:57:02 volumio winbindd[866]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jul 14 10:57:02 volumio winbindd[874]: [2024/07/14 10:57:02.172450, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:02 volumio winbindd[874]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jul 14 10:57:02 volumio dhcpd[850]: Internet Systems Consortium DHCP Server 4.3.1 Jul 14 10:57:02 volumio dhcpd[850]: Copyright 2004-2014 Internet Systems Consortium. Jul 14 10:57:02 volumio dhcpd[850]: All rights reserved. Jul 14 10:57:02 volumio dhcpd[850]: For info, please visit https://www.isc.org/software/dhcp/ Jul 14 10:57:02 volumio dhcpd[850]: Config file: /etc/dhcp/dhcpd.conf Jul 14 10:57:02 volumio dhcpd[850]: Database file: /var/lib/dhcp/dhcpd.leases Jul 14 10:57:02 volumio dhcpd[850]: PID file: /var/run/dhcpd.pid Jul 14 10:57:02 volumio hotspot[850]: Internet Systems Consortium DHCP Server 4.3.1 Jul 14 10:57:02 volumio hotspot[850]: Copyright 2004-2014 Internet Systems Consortium. Jul 14 10:57:02 volumio hotspot[850]: All rights reserved. Jul 14 10:57:02 volumio hotspot[850]: For info, please visit https://www.isc.org/software/dhcp/ Jul 14 10:57:02 volumio hotspot[850]: Config file: /etc/dhcp/dhcpd.conf Jul 14 10:57:02 volumio hotspot[850]: Database file: /var/lib/dhcp/dhcpd.leases Jul 14 10:57:02 volumio hotspot[850]: PID file: /var/run/dhcpd.pid Jul 14 10:57:02 volumio dhcpd[850]: Internet Systems Consortium DHCP Server 4.3.1 Jul 14 10:57:02 volumio dhcpd[850]: Copyright 2004-2014 Internet Systems Consortium. Jul 14 10:57:02 volumio dhcpd[850]: All rights reserved. Jul 14 10:57:02 volumio dhcpd[850]: For info, please visit https://www.isc.org/software/dhcp/ Jul 14 10:57:02 volumio dhcpd[850]: Wrote 2 leases to leases file. Jul 14 10:57:02 volumio hotspot[850]: Wrote 2 leases to leases file. Jul 14 10:57:02 volumio dhcpd[850]: Listening on LPF/wlan0/b8:27:eb:3a:f7:81/192.168.211.0/24 Jul 14 10:57:02 volumio dhcpd[850]: Sending on LPF/wlan0/b8:27:eb:3a:f7:81/192.168.211.0/24 Jul 14 10:57:02 volumio dhcpd[850]: Jul 14 10:57:02 volumio dhcpd[850]: No subnet declaration for eth0 (192.168.2.93). Jul 14 10:57:02 volumio dhcpd[850]: ** Ignoring requests on eth0. If this is not what Jul 14 10:57:02 volumio dhcpd[850]: you want, please write a subnet declaration Jul 14 10:57:02 volumio dhcpd[850]: in your dhcpd.conf file for the network segment Jul 14 10:57:02 volumio dhcpd[850]: to which interface eth0 is attached. ** Jul 14 10:57:02 volumio dhcpd[850]: Jul 14 10:57:02 volumio dhcpd[850]: Sending on Socket/fallback/fallback-net Jul 14 10:57:02 volumio dhcpd[884]: Server starting service. Jul 14 10:57:02 volumio systemd[1]: Started dhcpd.service. Jul 14 10:57:02 volumio hotspot[850]: Listening on LPF/wlan0/b8:27:eb:3a:f7:81/192.168.211.0/24 Jul 14 10:57:02 volumio hotspot[850]: Sending on LPF/wlan0/b8:27:eb:3a:f7:81/192.168.211.0/24 Jul 14 10:57:02 volumio hotspot[850]: No subnet declaration for eth0 (192.168.2.93). Jul 14 10:57:02 volumio hotspot[850]: ** Ignoring requests on eth0. If this is not what Jul 14 10:57:02 volumio hotspot[850]: you want, please write a subnet declaration Jul 14 10:57:02 volumio hotspot[850]: in your dhcpd.conf file for the network segment Jul 14 10:57:02 volumio hotspot[850]: to which interface eth0 is attached. ** Jul 14 10:57:02 volumio hotspot[850]: Sending on Socket/fallback/fallback-net Jul 14 10:57:02 volumio smbd[864]: Starting SMB/CIFS daemon: smbd[2024/07/14 10:57:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:02 volumio smbd[864]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:02 volumio smbd[864]: [2024/07/14 10:57:02, 0] ../lib/util/util.c:220(directory_create_or_exist) Jul 14 10:57:02 volumio smbd[864]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jul 14 10:57:02 volumio smbd[864]: [2024/07/14 10:57:02, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jul 14 10:57:02 volumio smbd[864]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jul 14 10:57:02 volumio smbd[864]: [2024/07/14 10:57:02, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jul 14 10:57:02 volumio smbd[864]: Unable to setup corepath for smbd: No such file or directory Jul 14 10:57:02 volumio smbd[864]: [2024/07/14 10:57:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:02 volumio smbd[864]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:02 volumio smbd[864]: [2024/07/14 10:57:02, 0] ../source3/smbd/server.c:1241(main) Jul 14 10:57:02 volumio smbd[864]: smbd version 4.2.14-Debian started. Jul 14 10:57:02 volumio smbd[864]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: ############################ Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: # Volumio Streaming Daemon # Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: # Running on port 7777 # Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: ############################ Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: Checking variant in static cache Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: Enabled services: Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: 1) tidal Jul 14 10:57:03 volumio volumio-streaming-daemon[854]: 2) qobuz Jul 14 10:57:03 volumio smbd[883]: [2024/07/14 10:57:03.118743, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio smbd[883]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:03 volumio smbd[883]: [2024/07/14 10:57:03.120257, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio smbd[883]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:03 volumio smbd[883]: [2024/07/14 10:57:03.120453, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio smbd[883]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:03 volumio smbd[864]: [2024/07/14 10:57:03.118743, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio smbd[864]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:03 volumio smbd[864]: [2024/07/14 10:57:03.120257, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio smbd[864]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:03 volumio smbd[864]: [2024/07/14 10:57:03.120453, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio smbd[864]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:03 volumio smbd[864]: . Jul 14 10:57:03 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Jul 14 10:57:03 volumio systemd[1]: Starting Multi-User System. Jul 14 10:57:03 volumio systemd[1]: Reached target Multi-User System. Jul 14 10:57:03 volumio systemd[1]: Starting Graphical Interface. Jul 14 10:57:03 volumio systemd[1]: Reached target Graphical Interface. Jul 14 10:57:03 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 14 10:57:03 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 14 10:57:03 volumio systemd[1]: Startup finished in 10.187s (kernel) + 21.505s (userspace) = 31.692s. Jul 14 10:57:03 volumio winbindd[894]: [2024/07/14 10:57:03.198602, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio winbindd[894]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Jul 14 10:57:03 volumio hotspot[848]: Launching Ordinary Hostapd Jul 14 10:57:03 volumio winbindd[897]: [2024/07/14 10:57:03.463067, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio winbindd[897]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Jul 14 10:57:03 volumio smbd[885]: [2024/07/14 10:57:03.635389, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jul 14 10:57:03 volumio smbd[885]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jul 14 10:57:03 volumio smbd[898]: [2024/07/14 10:57:03.641107, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jul 14 10:57:03 volumio smbd[898]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jul 14 10:57:03 volumio dhcpcd[707]: wlan0: carrier acquired Jul 14 10:57:03 volumio dhcpcd[707]: wlan0: soliciting an IPv6 router Jul 14 10:57:05 volumio volumio[853]: info: ------------------------------------------- Jul 14 10:57:05 volumio volumio[853]: info: ----- Volumio2 ---- Jul 14 10:57:05 volumio volumio[853]: info: ------------------------------------------- Jul 14 10:57:05 volumio volumio[853]: info: ----- System startup ---- Jul 14 10:57:05 volumio volumio[853]: info: ------------------------------------------- Jul 14 10:57:05 volumio volumio[853]: info: MYVOLUMIO Environment detected Jul 14 10:57:06 volumio volumio[853]: info: Plugin folders cleanup Jul 14 10:57:06 volumio volumio[853]: info: Scanning into folder /volumio/app/plugins/ Jul 14 10:57:06 volumio volumio[853]: info: Scanning category audio_interface Jul 14 10:57:06 volumio volumio[853]: info: Scanning category miscellanea Jul 14 10:57:06 volumio volumio[853]: info: Scanning category music_service Jul 14 10:57:06 volumio volumio[853]: info: Scanning category plugins.json Jul 14 10:57:06 volumio volumio[853]: info: Scanning category system_controller Jul 14 10:57:06 volumio volumio[853]: info: Scanning category user_interface Jul 14 10:57:06 volumio volumio[853]: info: Scanning into folder /data/plugins/ Jul 14 10:57:06 volumio volumio[853]: info: Plugin folders cleanup completed Jul 14 10:57:06 volumio volumio[853]: info: ------------------------------------------- Jul 14 10:57:06 volumio volumio[853]: info: ----- Core plugins startup ---- Jul 14 10:57:06 volumio volumio[853]: info: ------------------------------------------- Jul 14 10:57:06 volumio volumio[853]: info: Loading plugins from folder /volumio/app/plugins/ Jul 14 10:57:06 volumio volumio[853]: info: Adding plugin upnp to MyMusic Plugins Jul 14 10:57:06 volumio volumio[853]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 14 10:57:06 volumio volumio[853]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 14 10:57:06 volumio volumio[853]: info: Loading plugins from folder /data/plugins/ Jul 14 10:57:06 volumio volumio[853]: info: Loading plugin "system"... Jul 14 10:57:06 volumio volumio[853]: info: Loading plugin "appearance"... Jul 14 10:57:06 volumio volumio-remote-updater[557]: [2024-07-14 10:57:06] [connect] Successful connection Jul 14 10:57:07 volumio volumio[853]: info: Loading plugin "network"... Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "services"... Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "alsa_controller"... Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "wizard"... Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "volumio_command_line_client"... Jul 14 10:57:08 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:08 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:08 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:08 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "upnp"... Jul 14 10:57:08 volumio volumio[853]: info: [1720954628329] Starting Upmpd Daemon Jul 14 10:57:08 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "my_music"... Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "mpd"... Jul 14 10:57:08 volumio volumio[853]: info: Loading plugin "upnp_browser"... Jul 14 10:57:09 volumio dhcpcd[707]: wlan0: using IPv4LL address 169.254.227.239 Jul 14 10:57:09 volumio avahi-daemon[579]: Registering new address record for 169.254.227.239 on wlan0.IPv4. Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "networkfs"... Jul 14 10:57:10 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "alarm-clock"... Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "airplay_emulation"... Jul 14 10:57:10 volumio volumio[853]: info: Starting Shairport Sync Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "last_100"... Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "webradio"... Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "i2s_dacs"... Jul 14 10:57:10 volumio volumio[853]: info: I2S DAC not set, start Auto-detection Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "volumiodiscovery"... Jul 14 10:57:10 volumio volumio[853]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 14 10:57:10 volumio node[853]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 14 10:57:10 volumio node[853]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 10:57:10 volumio node[853]: *** WARNING *** For more information see Jul 14 10:57:10 volumio node[853]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 14 10:57:10 volumio node[853]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 10:57:10 volumio node[853]: *** WARNING *** For more information see Jul 14 10:57:10 volumio volumio[853]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 10:57:10 volumio volumio[853]: *** WARNING *** For more information see Jul 14 10:57:10 volumio volumio[853]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 14 10:57:10 volumio volumio[853]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 10:57:10 volumio volumio[853]: *** WARNING *** For more information see Jul 14 10:57:10 volumio volumio[853]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 14 10:57:10 volumio volumio[853]: Discovery: StartAdv! undefined Jul 14 10:57:10 volumio volumio[853]: Discovery: Started advertising... Volumio - undefined Jul 14 10:57:10 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "outputs"... Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "albumart"... Jul 14 10:57:10 volumio volumio[853]: info: Plugin example_plugin is not enabled Jul 14 10:57:10 volumio volumio[853]: info: Loading plugin "updater_comm"... Jul 14 10:57:11 volumio volumio[853]: info: Plugin mpdemulation is not enabled Jul 14 10:57:11 volumio volumio[853]: info: Loading plugin "rest_api"... Jul 14 10:57:11 volumio volumio[853]: info: Loading plugin "websocket"... Jul 14 10:57:11 volumio volumio[853]: info: ___________ START PLUGINS ___________ Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 10:57:11 volumio volumio[853]: info: [1720954631251] CoreMusicLibrary::Adding element Media Servers Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 10:57:11 volumio volumio[853]: info: [1720954631283] CoreMusicLibrary::Adding element Last_100 Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 10:57:11 volumio volumio[853]: info: [1720954631288] CoreMusicLibrary::Adding element Webradio Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 10:57:11 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 10:57:11 volumio volumio[853]: info: ------------------------------------------- Jul 14 10:57:11 volumio volumio[853]: info: ----- MyVolumio plugins startup ---- Jul 14 10:57:11 volumio volumio[853]: info: ------------------------------------------- Jul 14 10:57:11 volumio volumio[853]: info: Loading plugins from folder /myvolumio/plugins Jul 14 10:57:11 volumio volumio[853]: info: Loading plugins from folder /data/myvolumio/plugins Jul 14 10:57:11 volumio volumio[853]: info: Loading plugin "streaming_services"... Jul 14 10:57:11 volumio volumio[853]: Forking 3 albumart workers Jul 14 10:57:11 volumio volumio[853]: info: Loading plugin "my_volumio"... Jul 14 10:57:12 volumio volumio[853]: Starting albumart workers Jul 14 10:57:12 volumio volumio[853]: Starting albumart workers Jul 14 10:57:12 volumio volumio[853]: Starting albumart workers Jul 14 10:57:12 volumio volumio[853]: info: Streaming services startup Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: Starting MyVolumio Remote Streaming Endpoints Jul 14 10:57:12 volumio sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 14 10:57:12 volumio sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:12 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jul 14 10:57:12 volumio systemd[1]: Starting Volumio Streaming Daemon... Jul 14 10:57:12 volumio systemd[1]: Started Volumio Streaming Daemon. Jul 14 10:57:12 volumio sudo[961]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:12 volumio volumio[853]: info: Loading i18n strings for locale es Jul 14 10:57:12 volumio volumio[853]: Updating browse sources language Jul 14 10:57:12 volumio volumio[853]: Cannot find translation for sourceMedia Servers Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: ############################ Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: # Volumio Streaming Daemon # Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: # Running on port 7777 # Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: ############################ Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: Checking variant in static cache Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: Enabled services: Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: 1) tidal Jul 14 10:57:12 volumio volumio-streaming-daemon[967]: 2) qobuz Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::initPlayerControls Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 10:57:12 volumio volumio[853]: info: BOOT COMPLETED Jul 14 10:57:12 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:57:14 volumio ntpd[691]: Listen normally on 4 wlan0 192.168.211.1 UDP 123 Jul 14 10:57:14 volumio ntpd[691]: Listen normally on 5 wlan0 169.254.227.239 UDP 123 Jul 14 10:57:14 volumio ntpd[691]: peers refreshed Jul 14 10:57:18 volumio volumio[853]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::Close All Modals sent Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::Close All Modals sent Jul 14 10:57:18 volumio volumio[853]: Express server listening on port 3000 Jul 14 10:57:18 volumio volumio[853]: Volumio Calling Home Jul 14 10:57:18 volumio volumio[853]: info: MyVolumio not started Jul 14 10:57:18 volumio volumio[853]: info: CoreStateMachine::resetVolumioState Jul 14 10:57:18 volumio volumio[853]: info: CoreStateMachine::getcurrentVolume Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::volumioRetrievevolume Jul 14 10:57:18 volumio sudo[991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 10:57:18 volumio sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:18 volumio sudo[991]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:18 volumio volumio[853]: info: Setting Device type: Raspberry PI Jul 14 10:57:18 volumio volumio[853]: info: MPD running with PID582 ,establishing connection Jul 14 10:57:18 volumio sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jul 14 10:57:18 volumio sudo[1002]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:18 volumio sudo[1002]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:18 volumio volumio[853]: info: VolumeController:: Volume=90 Mute =false Jul 14 10:57:18 volumio volumio[853]: info: CoreStateMachine::pushState Jul 14 10:57:18 volumio volumio[853]: info: CoreStateMachine::getState Jul 14 10:57:18 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::volumioPushState Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 10:57:18 volumio volumio[853]: info: Jul 14 10:57:18 volumio volumio[853]: ---------------------------- Client requests Volume 100 Jul 14 10:57:18 volumio volumio[853]: info: VolumeController::SetAlsaVolume100 Jul 14 10:57:18 volumio volumio[853]: info: CoreStateMachine::pushState Jul 14 10:57:18 volumio volumio[853]: info: CoreStateMachine::getState Jul 14 10:57:18 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::volumioPushState Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 10:57:18 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:57:18 volumio volumio[853]: info: Reloading queue from file Jul 14 10:57:18 volumio volumio[853]: info: Jul 14 10:57:18 volumio volumio[853]: ---------------------------- MPD announces state update: mixer Jul 14 10:57:18 volumio volumio[853]: info: Jul 14 10:57:18 volumio volumio[853]: info: ControllerMpd::getState Jul 14 10:57:18 volumio volumio[853]: info: ControllerMpd::sendMpdCommand status Jul 14 10:57:18 volumio volumio[853]: info: sending command... Jul 14 10:57:19 volumio volumio[853]: info: Setting volume on startup at 100 Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::setRepeat true single undefined Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::pushState Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::getState Jul 14 10:57:19 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::volumioPushState Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::setRandom null Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::pushState Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::getState Jul 14 10:57:19 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::volumioPushState Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 10:57:19 volumio volumio[853]: info: parsing response... Jul 14 10:57:19 volumio volumio[853]: info: ControllerMpd::parseState Jul 14 10:57:19 volumio volumio[853]: info: ControllerMpd::pushState Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::servicePushState Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::syncState Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::pushState Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::getState Jul 14 10:57:19 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::volumioPushState Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 10:57:19 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:19 volumio volumio[853]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 14 10:57:19 volumio volumio[853]: info: ------------------------------ 114ms Jul 14 10:57:19 volumio sudo[1014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 14 10:57:19 volumio sudo[1014]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:19 volumio sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 14 10:57:19 volumio sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:19 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Jul 14 10:57:19 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 14 10:57:19 volumio sudo[1020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 14 10:57:19 volumio sudo[1014]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 14 10:57:19 volumio sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:19 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 14 10:57:19 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 14 10:57:19 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jul 14 10:57:19 volumio sudo[1016]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:19 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 14 10:57:19 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 14 10:57:19 volumio sudo[1020]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:19 volumio shairport-sync[1041]: Successful Startup Jul 14 10:57:19 volumio volumio[853]: info: Upmpdcli Daemon Started Jul 14 10:57:19 volumio volumio[853]: info: Shairport-Sync Started Jul 14 10:57:19 volumio volumio[853]: Error adding Membership: Error: addMembership EINVAL Jul 14 10:57:19 volumio volumio[853]: info: Shairport-Sync Started Jul 14 10:57:19 volumio volumio[853]: info: CoreCommandRouter::volumioGetState Jul 14 10:57:19 volumio volumio[853]: info: CoreStateMachine::getState Jul 14 10:57:19 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:40 volumio systemd[1]: Time has been changed Jul 14 10:57:41 volumio hostapd[896]: wlan0: STA 0a:bf:5c:3c:40:58 IEEE 802.11: associated Jul 14 10:57:41 volumio hostapd[896]: wlan0: STA 0a:bf:5c:3c:40:58 RADIUS: starting accounting session 6693AEFF-00000000 Jul 14 10:57:41 volumio hostapd[896]: wlan0: STA 0a:bf:5c:3c:40:58 WPA: pairwise key handshake completed (RSN) Jul 14 10:57:41 volumio volumio-streaming-daemon[967]: Checking variant in static cache Jul 14 10:57:41 volumio volumio[853]: info: Fetching Streaming Services browse cache Jul 14 10:57:41 volumio dhcpd[884]: DHCPDISCOVER from 0a:bf:5c:3c:40:58 (Galaxy-A20e) via wlan0 Jul 14 10:57:41 volumio volumio[853]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Jul 14 10:57:41 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 10:57:41 volumio volumio[853]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Jul 14 10:57:41 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 10:57:42 volumio volumio-remote-updater[557]: [2024-07-14 10:57:42] [connect] Successful connection Jul 14 10:57:42 volumio volumio-remote-updater[557]: [2024-07-14 10:57:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1720954662 101 Jul 14 10:57:42 volumio dhcpd[884]: DHCPOFFER on 192.168.211.2 to 0a:bf:5c:3c:40:58 (Galaxy-A20e) via wlan0 Jul 14 10:57:42 volumio dhcpd[884]: DHCPREQUEST for 192.168.211.2 (192.168.211.1) from 0a:bf:5c:3c:40:58 (Galaxy-A20e) via wlan0 Jul 14 10:57:42 volumio dhcpd[884]: DHCPACK on 192.168.211.2 to 0a:bf:5c:3c:40:58 via wlan0 Jul 14 10:57:44 volumio volumio[853]: info: CoreCommandRouter::volumioGetVisibleSources Jul 14 10:57:44 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 10:57:44 volumio volumio[853]: info: CoreCommandRouter::volumioGetState Jul 14 10:57:44 volumio volumio[853]: info: CoreStateMachine::getState Jul 14 10:57:44 volumio volumio[853]: info: CorePlayQueue::getTrack 0 Jul 14 10:57:44 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 14 10:57:44 volumio volumio[853]: info: Listing playlists Jul 14 10:57:44 volumio volumio[853]: info: CoreCommandRouter::volumioGetQueue Jul 14 10:57:44 volumio volumio[853]: info: CoreStateMachine::getQueue Jul 14 10:57:44 volumio volumio[853]: info: CorePlayQueue::getQueue Jul 14 10:57:45 volumio volumio[853]: Discovery: adding ea265773-36ac-4a46-a7de-87b84549b0b2 Jul 14 10:57:45 volumio volumio[853]: info: mDNS: Found device Volumio Jul 14 10:57:45 volumio sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 10:57:45 volumio sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:45 volumio sudo[1106]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:45 volumio volumio[853]: Discovery: this is already registered, ea265773-36ac-4a46-a7de-87b84549b0b2 Jul 14 10:57:45 volumio volumio[853]: info: mDNS: Found device Volumio Jul 14 10:57:45 volumio sudo[1115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 10:57:45 volumio sudo[1115]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:57:45 volumio sudo[1115]: pam_unix(sudo:session): session closed for user root Jul 14 10:57:51 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 14 10:57:52 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 14 10:57:52 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 14 10:57:53 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 14 10:57:53 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 14 10:57:54 volumio volumio[853]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.565&uuid=47a5163e2ce04be905b4765d7230f4ad" http://updates.volumio.org:7070/downloader-v1/track-device Jul 14 10:57:54 volumio volumio[853]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 14 10:57:54 volumio volumio[853]: Dload Upload Total Spent Left Speed Jul 14 10:57:54 volumio volumio[853]: [630B blob data] Jul 14 10:57:54 volumio volumio[853]: retrying in 5 seconds, trial 0 Jul 14 10:57:54 volumio volumio[853]: Volumio Calling Home Jul 14 10:57:56 volumio volumio[853]: info: READ Jul 14 10:58:02 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 10:58:02 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:58:03 volumio volumio[853]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 14 10:58:10 volumio volumio[853]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.565&uuid=47a5163e2ce04be905b4765d7230f4ad" http://updates.volumio.org:7070/downloader-v1/track-device Jul 14 10:58:10 volumio volumio[853]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 14 10:58:10 volumio volumio[853]: Dload Upload Total Spent Left Speed Jul 14 10:58:10 volumio volumio[853]: [551B blob data] Jul 14 10:58:10 volumio volumio[853]: retrying in 5 seconds, trial 1 Jul 14 10:58:10 volumio volumio[853]: Volumio Calling Home Jul 14 10:58:12 volumio volumio[853]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 10:58:12 volumio volumio[853]: TypeError: Cannot create property 'type' on string 'invalid server key' Jul 14 10:58:12 volumio volumio[853]: at WebSocket.onError (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:450:16) Jul 14 10:58:12 volumio volumio[853]: at emitOne (events.js:116:13) Jul 14 10:58:12 volumio volumio[853]: at WebSocket.emit (events.js:211:7) Jul 14 10:58:12 volumio volumio[853]: at ClientRequest.upgrade (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:738:12) Jul 14 10:58:12 volumio volumio[853]: at Object.onceWrapper (events.js:319:30) Jul 14 10:58:12 volumio volumio[853]: at emitThree (events.js:136:13) Jul 14 10:58:12 volumio volumio[853]: at ClientRequest.emit (events.js:217:7) Jul 14 10:58:12 volumio volumio[853]: at Socket.socketOnData (_http_client.js:472:11) Jul 14 10:58:12 volumio volumio[853]: at emitOne (events.js:116:13) Jul 14 10:58:12 volumio volumio[853]: at Socket.emit (events.js:211:7) Jul 14 10:58:12 volumio volumio[853]: at addChunk (_stream_readable.js:263:12) Jul 14 10:58:12 volumio volumio[853]: at readableAddChunk (_stream_readable.js:250:11) Jul 14 10:58:12 volumio volumio[853]: at Socket.Readable.push (_stream_readable.js:208:10) Jul 14 10:58:12 volumio volumio[853]: at TCP.onread (net.js:607:20) Jul 14 10:58:12 volumio volumio[853]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 10:58:13 volumio sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 10:57 Jul 14 10:58:13 volumio sudo[1328]: 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="f1b59d96a3893a42f8609371956ecba0438017d7" VOLUMIO_FE_VERSION="95791212f747b95a2cb050c16459a831bfe5c7e7" VOLUMIO_BE_VERSION="1c3c01aeeeb4cff8e6c9a4b6c34e1a558d1b237b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 12 19:57:25 CET 2019" VOLUMIO_VERSION="2.565" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="64b803aae2d00ba86d00d612c4abb38d"