-- Logs begin at Sun 2022-10-02 08:58:20 UTC, end at Sun 2022-10-02 10:28:26 UTC. -- Oct 02 10:27:00 volumiopizw1 sudo[6630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 02 10:27:00 volumiopizw1 sudo[6630]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:00 volumiopizw1 sudo[6630]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:00 volumiopizw1 wireless.js[6486]: trying... Oct 02 10:27:01 volumiopizw1 sudo[6635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 02 10:27:01 volumiopizw1 sudo[6635]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:01 volumiopizw1 sudo[6635]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:01 volumiopizw1 wireless.js[6486]: trying... Oct 02 10:27:02 volumiopizw1 sudo[6640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 02 10:27:02 volumiopizw1 sudo[6640]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:02 volumiopizw1 sudo[6640]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:02 volumiopizw1 wireless.js[6486]: trying... Oct 02 10:27:03 volumiopizw1 sudo[6645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 02 10:27:03 volumiopizw1 sudo[6645]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:03 volumiopizw1 sudo[6645]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:03 volumiopizw1 wireless.js[6486]: trying... Oct 02 10:27:04 volumiopizw1 sudo[6650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 02 10:27:04 volumiopizw1 sudo[6650]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:04 volumiopizw1 sudo[6650]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:04 volumiopizw1 wireless.js[6486]: trying... Oct 02 10:27:05 volumiopizw1 dhcpcd[353]: wlan0: leased 192.168.16.223 for 7200 seconds Oct 02 10:27:05 volumiopizw1 avahi-daemon[326]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.16.223. Oct 02 10:27:05 volumiopizw1 dhcpcd[353]: wlan0: adding route to 192.168.16.0/24 Oct 02 10:27:05 volumiopizw1 avahi-daemon[326]: New relevant interface wlan0.IPv4 for mDNS. Oct 02 10:27:05 volumiopizw1 avahi-daemon[326]: Registering new address record for 192.168.16.223 on wlan0.IPv4. Oct 02 10:27:05 volumiopizw1 dhcpcd[353]: wlan0: adding default route via 192.168.16.1 Oct 02 10:27:05 volumiopizw1 sudo[6655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 02 10:27:05 volumiopizw1 sudo[6655]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:05 volumiopizw1 sudo[6655]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:05 volumiopizw1 wireless.js[6486]: Connected to: ----iexceo2G Oct 02 10:27:05 volumiopizw1 wireless.js[6486]: ---- Oct 02 10:27:05 volumiopizw1 volumio[830]: info: Discovery: adding 9e22f455-b045-41c5-bada-7cdd2cad7cc0 Oct 02 10:27:05 volumiopizw1 dnsmasq[824]: reading /etc/resolv.conf Oct 02 10:27:05 volumiopizw1 volumio[830]: info: Discovery: Found device Volumiopizw2 Oct 02 10:27:05 volumiopizw1 dnsmasq[824]: using nameserver 192.168.16.1#53 Oct 02 10:27:05 volumiopizw1 dnsmasq[824]: using nameserver 208.67.222.222#53 Oct 02 10:27:05 volumiopizw1 dnsmasq[824]: using nameserver 208.67.220.220#53 Oct 02 10:27:05 volumiopizw1 volumio[830]: info: Discovery: Connecting to remote: 192.168.16.202 Oct 02 10:27:05 volumiopizw1 sudo[6671]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 02 10:27:05 volumiopizw1 sudo[6671]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:05 volumiopizw1 sudo[6671]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:05 volumiopizw1 wireless.js[6486]: ... joined AP, wlan0 IPv4 is 192.168.16.223, ipV6 is undefined Oct 02 10:27:05 volumiopizw1 volumio[830]: info: Discovery: Connected to remote: 192.168.16.202 Oct 02 10:27:05 volumiopizw1 wireless.js[6486]: It's done! AP Oct 02 10:27:06 volumiopizw1 systemd[1]: Started Wireless Services. Oct 02 10:27:06 volumiopizw1 volumio[830]: info: Discovery: adding b4633c84-1d5e-4a7c-9171-ae84d7a737f8 Oct 02 10:27:06 volumiopizw1 volumio[830]: info: Discovery: Found device volumiopizw1 Oct 02 10:27:06 volumiopizw1 volumio[830]: info: CoreCommandRouter::volumioGetState Oct 02 10:27:06 volumiopizw1 volumio[830]: info: CorePlayQueue::getTrack 394 Oct 02 10:27:06 volumiopizw1 ntpd[573]: Listen normally on 7 wlan0 192.168.16.223:123 Oct 02 10:27:06 volumiopizw1 ntpd[573]: new interface(s) found: waking up resolver Oct 02 10:27:06 volumiopizw1 sudo[6465]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:06 volumiopizw1 ntpd[573]: ntpd exiting on signal 15 (Terminated) Oct 02 10:27:06 volumiopizw1 systemd[1]: Stopping Network Time Service... Oct 02 10:27:06 volumiopizw1 systemd[1]: ntp.service: Succeeded. Oct 02 10:27:06 volumiopizw1 systemd[1]: Stopped Network Time Service. Oct 02 10:27:06 volumiopizw1 systemd[1]: Starting Network Time Service... Oct 02 10:27:06 volumiopizw1 ntpd[6697]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 02 10:27:06 volumiopizw1 ntpd[6697]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Oct 02 10:27:06 volumiopizw1 systemd[1]: Started Network Time Service. Oct 02 10:27:06 volumiopizw1 ntpd[6703]: proto: precision = 2.000 usec (-19) Oct 02 10:27:06 volumiopizw1 ntpd[6703]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 02 10:27:06 volumiopizw1 ntpd[6703]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 02 10:27:06 volumiopizw1 ntpd[6703]: Listen and drop on 0 v6wildcard [::]:123 Oct 02 10:27:06 volumiopizw1 ntpd[6703]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 02 10:27:06 volumiopizw1 ntpd[6703]: Listen normally on 2 lo 127.0.0.1:123 Oct 02 10:27:06 volumiopizw1 ntpd[6703]: Listen normally on 3 wlan0 192.168.16.223:123 Oct 02 10:27:06 volumiopizw1 ntpd[6703]: Listening on routing socket on fd #20 for interface updates Oct 02 10:27:06 volumiopizw1 ntpd[6703]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Oct 02 10:27:06 volumiopizw1 ntpd[6703]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Oct 02 10:27:07 volumiopizw1 ntpd[6703]: Soliciting pool server 172.233.91.137 Oct 02 10:27:08 volumiopizw1 ntpd[6703]: Soliciting pool server 208.88.66.8 Oct 02 10:27:11 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Oct 02 10:27:11 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Oct 02 10:27:11 volumiopizw1 sudo[6714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 02 10:27:11 volumiopizw1 sudo[6714]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:11 volumiopizw1 sudo[6714]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:11 volumiopizw1 sudo[6717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 02 10:27:11 volumiopizw1 sudo[6717]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:11 volumiopizw1 sudo[6717]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:14 volumiopizw1 volumio[830]: verbose: New Socket.io Connection to 192.168.16.223:3000 from 192.168.16.202 UA: node-XMLHttpRequest Total Clients: 6 Oct 02 10:27:14 volumiopizw1 volumio[830]: info: CoreCommandRouter::volumioGetState Oct 02 10:27:14 volumiopizw1 volumio[830]: info: CorePlayQueue::getTrack 394 Oct 02 10:27:14 volumiopizw1 ntpd[6703]: Soliciting pool server 208.88.66.8 Oct 02 10:27:14 volumiopizw1 ntpd[6703]: Soliciting pool server 172.105.192.74 Oct 02 10:27:15 volumiopizw1 ntpd[6703]: Soliciting pool server 172.233.91.137 Oct 02 10:27:16 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Oct 02 10:27:16 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Oct 02 10:27:16 volumiopizw1 volumio[830]: info: Refreshing Cached IP Addresses Oct 02 10:27:16 volumiopizw1 sudo[6733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Oct 02 10:27:16 volumiopizw1 sudo[6733]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:16 volumiopizw1 sudo[6735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 02 10:27:16 volumiopizw1 sudo[6735]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:16 volumiopizw1 sudo[6733]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:16 volumiopizw1 systemd[1]: upmpdcli.service: Succeeded. Oct 02 10:27:16 volumiopizw1 sudo[6738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 02 10:27:16 volumiopizw1 sudo[6735]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:16 volumiopizw1 sudo[6738]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:16 volumiopizw1 sudo[6738]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:26 volumiopizw1 sudo[6745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 02 10:27:26 volumiopizw1 sudo[6745]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:27 volumiopizw1 sudo[6747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 02 10:27:27 volumiopizw1 sudo[6747]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:27 volumiopizw1 sudo[6745]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:27 volumiopizw1 sudo[6747]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:27 volumiopizw1 sudo[6750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 02 10:27:27 volumiopizw1 sudo[6750]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:27:27 volumiopizw1 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 02 10:27:27 volumiopizw1 sudo[6750]: pam_unix(sudo:session): session closed for user root Oct 02 10:27:27 volumiopizw1 volumio[830]: info: Upmpdcli Daemon Started Oct 02 10:27:27 volumiopizw1 volumio[6755]: writing RSA key Oct 02 10:28:13 volumiopizw1 ntpd[6703]: Soliciting pool server 172.105.192.74 Oct 02 10:28:14 volumiopizw1 ntpd[6703]: Soliciting pool server 129.250.35.250 Oct 02 10:28:17 volumiopizw1 ntpd[6703]: Soliciting pool server 162.159.200.123 Oct 02 10:28:22 volumiopizw1 volumio[830]: verbose: New Socket.io Connection to 192.168.16.201 from 192.168.16.144 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Total Clients: 4 Oct 02 10:28:22 volumiopizw1 volumio[830]: verbose: New Socket.io Connection to 192.168.16.201 from 192.168.16.144 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Total Clients: 5 Oct 02 10:28:22 volumiopizw1 volumio[830]: verbose: New Socket.io Connection to 192.168.16.201 from 192.168.16.144 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Total Clients: 6 Oct 02 10:28:22 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::volumioGetVisibleSources Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 02 10:28:23 volumiopizw1 sudo[6888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 02 10:28:23 volumiopizw1 sudo[6888]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:28:23 volumiopizw1 sudo[6890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::volumioGetState Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CorePlayQueue::getTrack 394 Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::volumioGetState Oct 02 10:28:23 volumiopizw1 sudo[6888]: pam_unix(sudo:session): session closed for user root Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CorePlayQueue::getTrack 394 Oct 02 10:28:23 volumiopizw1 sudo[6890]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 02 10:28:23 volumiopizw1 volumio[830]: info: Received Get System Info Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 02 10:28:23 volumiopizw1 sudo[6890]: pam_unix(sudo:session): session closed for user root Oct 02 10:28:23 volumiopizw1 volumio[830]: info: Discovery: Getting this device information Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::volumioGetState Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CorePlayQueue::getTrack 394 Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CoreCommandRouter::volumioGetState Oct 02 10:28:23 volumiopizw1 volumio[830]: info: CorePlayQueue::getTrack 394 Oct 02 10:28:23 volumiopizw1 volumio[830]: info: Listing playlists Oct 02 10:28:24 volumiopizw1 volumio[830]: verbose: New Socket.io Connection to 192.168.16.223 from 192.168.16.144 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Total Clients: 7 Oct 02 10:28:24 volumiopizw1 volumio[830]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 10:28:24 volumiopizw1 volumio[830]: Error: certificate is not yet valid Oct 02 10:28:24 volumiopizw1 volumio[830]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) Oct 02 10:28:24 volumiopizw1 volumio[830]: at TLSSocket.emit (events.js:315:20) Oct 02 10:28:24 volumiopizw1 volumio[830]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Oct 02 10:28:24 volumiopizw1 volumio[830]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Oct 02 10:28:24 volumiopizw1 volumio[830]: code: 'CERT_NOT_YET_VALID' Oct 02 10:28:24 volumiopizw1 volumio[830]: } Oct 02 10:28:24 volumiopizw1 volumio[830]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 10:28:24 volumiopizw1 ntpd[6703]: Soliciting pool server 45.76.211.39 Oct 02 10:28:25 volumiopizw1 ntpd[6703]: Soliciting pool server 2001:678:8::123 Oct 02 10:28:26 volumiopizw1 sudo[6906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2022-10-02 10:27 Oct 02 10:28:26 volumiopizw1 sudo[6906]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 10:43:40 AM CEST" VOLUMIO_VERSION="3.378" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4bc817297375b72097a1fade15c6518b"