-- Logs begin at Sun 2025-04-20 11:53:03 UTC, end at Sun 2025-04-20 12:02:01 UTC. -- Apr 20 12:01:02 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Apr 20 12:01:02 volumio volumio[1076]: info: Saving new wireless network Apr 20 12:01:02 volumio sudo[3828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Apr 20 12:01:02 volumio sudo[3828]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:02 volumio sudo[3828]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:02 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 20 12:01:02 volumio volumio[1076]: info: Discovery: Restarting Advertising due to device name change Apr 20 12:01:02 volumio sudo[3833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 20 12:01:02 volumio sudo[3833]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:02 volumio wpa_supplicant[3582]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory Apr 20 12:01:02 volumio systemd[1]: Stopping Wireless Services... Apr 20 12:01:02 volumio wpa_supplicant[3582]: nl80211: Failed to set IPv4 unicast in multicast filter Apr 20 12:01:02 volumio wpa_supplicant[3582]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory Apr 20 12:01:02 volumio wpa_supplicant[3582]: nl80211: Failed to set IPv4 unicast in multicast filter Apr 20 12:01:02 volumio wpa_supplicant[3582]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0 Apr 20 12:01:02 volumio wpa_supplicant[3582]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING Apr 20 12:01:02 volumio dhcpcd[794]: wlan0: carrier lost Apr 20 12:01:02 volumio kernel: wlan0: deauthenticating from bc:54:fc:f7:8f:d3 by local choice (Reason: 3=DEAUTH_LEAVING) Apr 20 12:01:02 volumio avahi-daemon[776]: Withdrawing address record for 192.168.0.102 on wlan0. Apr 20 12:01:02 volumio avahi-daemon[776]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.102. Apr 20 12:01:02 volumio avahi-daemon[776]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 20 12:01:02 volumio wpa_supplicant[3582]: wlan0: CTRL-EVENT-DISCONNECTED bssid=bc:54:fc:f7:8f:d3 reason=3 locally_generated=1 Apr 20 12:01:02 volumio volumio[1076]: info: Discovery: A device disappeared from network Apr 20 12:01:02 volumio volumio[1076]: info: Discovery: Device volumio disappeared from network Apr 20 12:01:02 volumio dhcpcd[794]: wlan0: deleting route to 192.168.0.0/24 Apr 20 12:01:02 volumio dhcpcd[794]: wlan0: deleting default route via 192.168.0.1 Apr 20 12:01:02 volumio wpa_supplicant[3582]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Apr 20 12:01:03 volumio wpa_supplicant[3582]: wlan0: CTRL-EVENT-TERMINATING Apr 20 12:01:03 volumio systemd[1]: wireless.service: Succeeded. Apr 20 12:01:03 volumio systemd[1]: Stopped Wireless Services. Apr 20 12:01:03 volumio systemd[1]: Starting Wireless Services... Apr 20 12:01:03 volumio wireless.js[3859]: Cleaning previous... Apr 20 12:01:03 volumio sudo[3873]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:01:03 volumio sudo[3873]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:03 volumio sudo[3873]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:03 volumio sudo[3875]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:01:03 volumio sudo[3875]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:03 volumio sudo[3875]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:03 volumio wireless.js[3859]: Stopped aP Apr 20 12:01:03 volumio sudo[3884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:01:03 volumio sudo[3884]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:03 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:03 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:03 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:03 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:03 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:03 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:03 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:03 volumio sudo[3884]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:03 volumio sudo[3886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 20 12:01:03 volumio sudo[3886]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:04 volumio sudo[3886]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:04 volumio sudo[3893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:01:04 volumio sudo[3893]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:04 volumio sudo[3893]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:04 volumio sudo[3895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 20 12:01:04 volumio sudo[3895]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:05 volumio ntpd[3670]: Deleting interface #3 wlan0, 192.168.0.102#123, interface stats: received=21, sent=21, dropped=0, active_time=39 secs Apr 20 12:01:05 volumio ntpd[3670]: 162.159.200.123 local addr 192.168.0.102 -> Apr 20 12:01:05 volumio ntpd[3670]: 78.46.102.180 local addr 192.168.0.102 -> Apr 20 12:01:05 volumio ntpd[3670]: 193.182.111.14 local addr 192.168.0.102 -> Apr 20 12:01:06 volumio sudo[3895]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:06 volumio wireless.js[3859]: Start wireless flow Apr 20 12:01:06 volumio wireless.js[3859]: Stopped hotspot (if there).. Apr 20 12:01:06 volumio sudo[3904]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:01:06 volumio sudo[3904]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:06 volumio sudo[3904]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:06 volumio sudo[3906]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:01:06 volumio sudo[3906]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:06 volumio sudo[3906]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:06 volumio wireless.js[3859]: DHCP IP Apr 20 12:01:06 volumio wireless.js[3859]: Start ap Apr 20 12:01:06 volumio wpa_supplicant[3908]: Successfully initialized wpa_supplicant Apr 20 12:01:06 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:06 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:06 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:06 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:06 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:06 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:06 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:06 volumio sudo[3909]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 20 12:01:06 volumio sudo[3909]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:06 volumio dhcpcd[3910]: sending commands to master dhcpcd process Apr 20 12:01:06 volumio dhcpcd[794]: control command: /sbin/dhcpcd Apr 20 12:01:06 volumio sudo[3909]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:07 volumio wireless.js[3859]: trying... Apr 20 12:01:07 volumio sudo[3917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:07 volumio sudo[3917]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:07 volumio sudo[3917]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:07 volumio volumio[1076]: info: Discovery: Started advertising with name: Volumio Apr 20 12:01:08 volumio wireless.js[3859]: trying... Apr 20 12:01:08 volumio sudo[3923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:08 volumio sudo[3923]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:08 volumio sudo[3923]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:08 volumio wpa_supplicant[3913]: wlan0: SME: Trying to authenticate with bc:54:fc:f7:8f:d5 (SSID='MERCURY_5G_8FD3' freq=5745 MHz) Apr 20 12:01:08 volumio kernel: wlan0: authenticate with bc:54:fc:f7:8f:d5 Apr 20 12:01:08 volumio kernel: wlan0: send auth to bc:54:fc:f7:8f:d5 (try 1/3) Apr 20 12:01:08 volumio kernel: wlan0: authenticated Apr 20 12:01:08 volumio kernel: wlan0: VHT capa missing/short, disabling VHT/HE/EHT Apr 20 12:01:08 volumio wpa_supplicant[3913]: wlan0: Trying to associate with bc:54:fc:f7:8f:d5 (SSID='MERCURY_5G_8FD3' freq=5745 MHz) Apr 20 12:01:08 volumio kernel: wlan0: associate with bc:54:fc:f7:8f:d5 (try 1/3) Apr 20 12:01:08 volumio kernel: wlan0: RX AssocResp from bc:54:fc:f7:8f:d5 (capab=0x1011 status=0 aid=1) Apr 20 12:01:08 volumio kernel: wlan0: associated Apr 20 12:01:08 volumio wpa_supplicant[3913]: wlan0: Associated with bc:54:fc:f7:8f:d5 Apr 20 12:01:08 volumio wpa_supplicant[3913]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 20 12:01:08 volumio wpa_supplicant[3913]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Apr 20 12:01:08 volumio wpa_supplicant[3913]: wlan0: WPA: Key negotiation completed with bc:54:fc:f7:8f:d5 [PTK=CCMP GTK=CCMP] Apr 20 12:01:08 volumio wpa_supplicant[3913]: wlan0: CTRL-EVENT-CONNECTED - Connection to bc:54:fc:f7:8f:d5 completed [id=0 id_str=] Apr 20 12:01:08 volumio dhcpcd[794]: wlan0: carrier acquired Apr 20 12:01:08 volumio dhcpcd[794]: wlan0: IAID a2:d1:80:44 Apr 20 12:01:09 volumio dhcpcd[794]: wlan0: soliciting an IPv6 router Apr 20 12:01:09 volumio dhcpcd[794]: wlan0: rebinding lease of 192.168.0.102 Apr 20 12:01:09 volumio dhcpcd[794]: wlan0: probing address 192.168.0.102/24 Apr 20 12:01:09 volumio wireless.js[3859]: trying... Apr 20 12:01:09 volumio sudo[3930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:09 volumio sudo[3930]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:09 volumio sudo[3930]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:10 volumio wireless.js[3859]: trying... Apr 20 12:01:10 volumio sudo[3935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:10 volumio sudo[3935]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:10 volumio sudo[3935]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:11 volumio wireless.js[3859]: trying... Apr 20 12:01:11 volumio sudo[3940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:11 volumio sudo[3940]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:11 volumio sudo[3940]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:12 volumio wireless.js[3859]: trying... Apr 20 12:01:12 volumio sudo[3945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:12 volumio sudo[3945]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:12 volumio sudo[3945]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:13 volumio wireless.js[3859]: trying... Apr 20 12:01:13 volumio sudo[3969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:13 volumio sudo[3969]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:13 volumio sudo[3969]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:14 volumio wireless.js[3859]: trying... Apr 20 12:01:14 volumio sudo[3999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:14 volumio sudo[3999]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:14 volumio sudo[3999]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:14 volumio dhcpcd[794]: wlan0: leased 192.168.0.102 for 7200 seconds Apr 20 12:01:14 volumio avahi-daemon[776]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.102. Apr 20 12:01:14 volumio avahi-daemon[776]: New relevant interface wlan0.IPv4 for mDNS. Apr 20 12:01:14 volumio avahi-daemon[776]: Registering new address record for 192.168.0.102 on wlan0.IPv4. Apr 20 12:01:14 volumio dhcpcd[794]: wlan0: adding route to 192.168.0.0/24 Apr 20 12:01:14 volumio dhcpcd[794]: wlan0: adding default route via 192.168.0.1 Apr 20 12:01:14 volumio ntpd[3670]: ntpd exiting on signal 15 (Terminated) Apr 20 12:01:14 volumio systemd[1]: Stopping Network Time Service... Apr 20 12:01:14 volumio systemd[1]: ntp.service: Succeeded. Apr 20 12:01:14 volumio systemd[1]: Stopped Network Time Service. Apr 20 12:01:14 volumio systemd[1]: Starting Network Time Service... Apr 20 12:01:14 volumio ntpd[4033]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 20 12:01:14 volumio ntpd[4033]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 20 12:01:14 volumio systemd[1]: Started Network Time Service. Apr 20 12:01:14 volumio ntpd[4039]: proto: precision = 0.315 usec (-22) Apr 20 12:01:14 volumio ntpd[4039]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 20 12:01:14 volumio ntpd[4039]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 20 12:01:14 volumio ntpd[4039]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 845 days ago Apr 20 12:01:14 volumio ntpd[4039]: Listen and drop on 0 v6wildcard [::]:123 Apr 20 12:01:14 volumio ntpd[4039]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 20 12:01:14 volumio ntpd[4039]: Listen normally on 2 lo 127.0.0.1:123 Apr 20 12:01:14 volumio ntpd[4039]: Listen normally on 3 wlan0 192.168.0.102:123 Apr 20 12:01:14 volumio ntpd[4039]: Listening on routing socket on fd #20 for interface updates Apr 20 12:01:14 volumio ntpd[4039]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 20 12:01:14 volumio ntpd[4039]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 20 12:01:15 volumio wireless.js[3859]: trying... Apr 20 12:01:15 volumio sudo[4044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:15 volumio sudo[4044]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:15 volumio sudo[4044]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:15 volumio wireless.js[3859]: Connected to: ----MERCURY_5G_8FD3 Apr 20 12:01:15 volumio wireless.js[3859]: ---- Apr 20 12:01:15 volumio sudo[4047]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:15 volumio sudo[4047]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:15 volumio sudo[4047]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:15 volumio wireless.js[3859]: ... joined AP, wlan0 IPv4 is 192.168.0.102, ipV6 is undefined Apr 20 12:01:15 volumio wireless.js[3859]: It's done! AP Apr 20 12:01:15 volumio systemd[1]: Started Wireless Services. Apr 20 12:01:15 volumio sudo[3833]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:15 volumio volumio[1076]: info: Discovery: adding 492524ff-0d18-4e9b-b0b7-e00a3046faf7 Apr 20 12:01:15 volumio volumio[1076]: info: Discovery: Found device Volumio Apr 20 12:01:15 volumio volumio[1076]: info: CoreCommandRouter::volumioGetState Apr 20 12:01:15 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:15 volumio ntpd[4039]: Soliciting pool server 193.182.111.14 Apr 20 12:01:16 volumio ntpd[4039]: Soliciting pool server 78.46.102.180 Apr 20 12:01:17 volumio ntpd[4039]: Soliciting pool server 78.46.102.180 Apr 20 12:01:18 volumio ntpd[4039]: Soliciting pool server 2606:4700:f1::1 Apr 20 12:01:18 volumio ntpd[4039]: Soliciting pool server 162.159.200.123 Apr 20 12:01:19 volumio volumio[1076]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 12:01:19 volumio volumio[1076]: info: Retrying Login Due to Network Error Apr 20 12:01:20 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 20 12:01:20 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 20 12:01:20 volumio sudo[4066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:20 volumio sudo[4066]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:20 volumio sudo[4066]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:20 volumio sudo[4069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:01:20 volumio sudo[4069]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:20 volumio sudo[4069]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:25 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 20 12:01:25 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 20 12:01:25 volumio volumio[1076]: info: Refreshing Cached IP Addresses Apr 20 12:01:25 volumio sudo[4085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 20 12:01:25 volumio sudo[4085]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:25 volumio sudo[4087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:01:25 volumio sudo[4087]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:25 volumio sudo[4085]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:25 volumio sudo[4087]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:25 volumio sudo[4090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:25 volumio sudo[4090]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:25 volumio sudo[4090]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:25 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 20 12:01:26 volumio sudo[4095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:01:26 volumio sudo[4095]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:26 volumio sudo[4095]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:26 volumio sudo[4098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:26 volumio sudo[4098]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:26 volumio sudo[4098]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:26 volumio volumio[1076]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9 Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::volumioGetVisibleSources Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::volumioGetState Apr 20 12:01:26 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 20 12:01:26 volumio volumio[1076]: info: Received Get System Info Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:01:26 volumio volumio[1076]: info: Discovery: Getting this device information Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::volumioGetState Apr 20 12:01:26 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::volumioGetState Apr 20 12:01:26 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:26 volumio volumio[1076]: info: Listing playlists Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 20 12:01:26 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 20 12:01:26 volumio sudo[4103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 20 12:01:26 volumio sudo[4103]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:27 volumio sudo[4103]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:27 volumio sudo[4109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:01:27 volumio sudo[4109]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:27 volumio sudo[4109]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:27 volumio sudo[4116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:01:27 volumio sudo[4116]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:27 volumio sudo[4116]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:27 volumio sudo[4123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:01:27 volumio sudo[4123]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:27 volumio sudo[4123]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:27 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 20 12:01:27 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 20 12:01:27 volumio sudo[4129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:01:27 volumio sudo[4129]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:27 volumio sudo[4131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:27 volumio sudo[4131]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:27 volumio sudo[4129]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:27 volumio sudo[4131]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:27 volumio sudo[4135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 20 12:01:27 volumio sudo[4135]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:28 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 20 12:01:28 volumio volumio[1076]: info: Received Get System Info Apr 20 12:01:28 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:01:28 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:01:28 volumio volumio[1076]: info: Discovery: Getting this device information Apr 20 12:01:28 volumio volumio[1076]: info: CoreCommandRouter::volumioGetState Apr 20 12:01:28 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:28 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:01:28 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 20 12:01:29 volumio volumio[1076]: info: MyVolumio login type: Token Apr 20 12:01:30 volumio sudo[4135]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:31 volumio volumio[1076]: info: CALLMETHOD: system_controller network saveWiredNet [object Object] Apr 20 12:01:31 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , saveWiredNet Apr 20 12:01:31 volumio sudo[4139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 20 12:01:31 volumio sudo[4139]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:31 volumio sudo[4139]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:31 volumio sudo[4142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 20 12:01:31 volumio sudo[4142]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:31 volumio sudo[4142]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:31 volumio volumio[1076]: info: Permissions for /etc/network/interfaces set Apr 20 12:01:31 volumio volumio[1076]: info: Restarting Wired Network Apr 20 12:01:31 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 20 12:01:31 volumio volumio[1076]: info: Discovery: Restarting Advertising due to device name change Apr 20 12:01:31 volumio sudo[4145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0 Apr 20 12:01:31 volumio sudo[4145]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:31 volumio sudo[4145]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:31 volumio sudo[4147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down Apr 20 12:01:31 volumio sudo[4147]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:31 volumio sudo[4147]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:32 volumio sudo[4149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up Apr 20 12:01:32 volumio sudo[4149]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:32 volumio kernel: RTL8211DN Gigabit Ethernet r8169-0-200:00: attached PHY driver (mii_bus:phy_addr=r8169-0-200:00, irq=MAC) Apr 20 12:01:32 volumio sudo[4149]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:32 volumio kernel: r8169 0000:02:00.0 eth0: Link is Down Apr 20 12:01:32 volumio volumio[1076]: info: Discovery: A device disappeared from network Apr 20 12:01:32 volumio volumio[1076]: info: Discovery: Device volumio disappeared from network Apr 20 12:01:35 volumio sudo[4154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:01:35 volumio sudo[4154]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:35 volumio sudo[4156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:35 volumio sudo[4154]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:35 volumio sudo[4156]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:35 volumio sudo[4156]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:35 volumio volumio[1076]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Apr 20 12:01:35 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Apr 20 12:01:35 volumio sudo[4160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 20 12:01:35 volumio sudo[4160]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:35 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 20 12:01:35 volumio sudo[4160]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:36 volumio volumio[1076]: info: Upmpdcli Daemon Started Apr 20 12:01:36 volumio sudo[4164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 20 12:01:36 volumio sudo[4164]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:36 volumio sudo[4164]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:36 volumio sudo[4167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 20 12:01:36 volumio sudo[4167]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:36 volumio sudo[4167]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:36 volumio volumio[1076]: info: Permissions for /etc/network/interfaces set Apr 20 12:01:36 volumio volumio[1076]: info: Restarting Wireless Network Apr 20 12:01:36 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 20 12:01:36 volumio volumio[1076]: info: Discovery: Restarting Advertising due to device name change Apr 20 12:01:36 volumio sudo[4175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 20 12:01:36 volumio volumio[4162]: writing RSA key Apr 20 12:01:36 volumio sudo[4175]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:36 volumio wpa_supplicant[3913]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory Apr 20 12:01:36 volumio wpa_supplicant[3913]: nl80211: Failed to set IPv4 unicast in multicast filter Apr 20 12:01:36 volumio wpa_supplicant[3913]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory Apr 20 12:01:36 volumio wpa_supplicant[3913]: nl80211: Failed to set IPv4 unicast in multicast filter Apr 20 12:01:36 volumio wpa_supplicant[3913]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0 Apr 20 12:01:36 volumio systemd[1]: Stopping Wireless Services... Apr 20 12:01:36 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 20 12:01:36 volumio wpa_supplicant[3913]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING Apr 20 12:01:36 volumio kernel: wlan0: deauthenticating from bc:54:fc:f7:8f:d5 by local choice (Reason: 3=DEAUTH_LEAVING) Apr 20 12:01:36 volumio dhcpcd[794]: wlan0: carrier lost Apr 20 12:01:36 volumio wpa_supplicant[3913]: wlan0: CTRL-EVENT-DISCONNECTED bssid=bc:54:fc:f7:8f:d5 reason=3 locally_generated=1 Apr 20 12:01:36 volumio avahi-daemon[776]: Withdrawing address record for 192.168.0.102 on wlan0. Apr 20 12:01:36 volumio avahi-daemon[776]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.102. Apr 20 12:01:36 volumio avahi-daemon[776]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 20 12:01:36 volumio dhcpcd[794]: wlan0: deleting route to 192.168.0.0/24 Apr 20 12:01:36 volumio dhcpcd[794]: wlan0: deleting default route via 192.168.0.1 Apr 20 12:01:36 volumio wpa_supplicant[3913]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Apr 20 12:01:36 volumio wpa_supplicant[3913]: wlan0: CTRL-EVENT-TERMINATING Apr 20 12:01:36 volumio systemd[1]: wireless.service: Succeeded. Apr 20 12:01:36 volumio systemd[1]: Stopped Wireless Services. Apr 20 12:01:36 volumio systemd[1]: Starting Wireless Services... Apr 20 12:01:36 volumio volumio[1076]: info: Discovery: Started advertising with name: Volumio Apr 20 12:01:37 volumio wireless.js[4220]: Cleaning previous... Apr 20 12:01:37 volumio sudo[4235]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:01:37 volumio sudo[4235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:37 volumio sudo[4235]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:37 volumio sudo[4237]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:01:37 volumio sudo[4237]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:37 volumio sudo[4237]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:37 volumio wireless.js[4220]: Stopped aP Apr 20 12:01:37 volumio sudo[4246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:01:37 volumio sudo[4246]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:37 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:37 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:37 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:37 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:37 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:37 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:37 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:37 volumio sudo[4246]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:37 volumio sudo[4248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 20 12:01:37 volumio sudo[4248]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:37 volumio sudo[4248]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:37 volumio sudo[4255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:01:37 volumio sudo[4255]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:37 volumio sudo[4255]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:37 volumio sudo[4257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 20 12:01:37 volumio sudo[4257]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:38 volumio ntpd[4039]: Deleting interface #3 wlan0, 192.168.0.102#123, interface stats: received=20, sent=22, dropped=0, active_time=24 secs Apr 20 12:01:38 volumio ntpd[4039]: 162.159.200.123 local addr 192.168.0.102 -> Apr 20 12:01:38 volumio ntpd[4039]: 78.46.102.180 local addr 192.168.0.102 -> Apr 20 12:01:38 volumio ntpd[4039]: 193.182.111.14 local addr 192.168.0.102 -> Apr 20 12:01:39 volumio sudo[4257]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:39 volumio wireless.js[4220]: Start wireless flow Apr 20 12:01:39 volumio wireless.js[4220]: Stopped hotspot (if there).. Apr 20 12:01:39 volumio sudo[4266]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:01:39 volumio sudo[4266]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:39 volumio sudo[4266]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:39 volumio sudo[4268]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:01:39 volumio sudo[4268]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:39 volumio sudo[4268]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:39 volumio wireless.js[4220]: DHCP IP Apr 20 12:01:39 volumio wpa_supplicant[4270]: Successfully initialized wpa_supplicant Apr 20 12:01:39 volumio wireless.js[4220]: Start ap Apr 20 12:01:39 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:39 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:39 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:39 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:39 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:39 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:39 volumio kernel: ACPI: \: failed to evaluate _DSM bf0212f2-788f-c64d-a5b3-1f738e285ade (0x1001) Apr 20 12:01:39 volumio sudo[4271]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 20 12:01:39 volumio sudo[4271]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:39 volumio dhcpcd[4272]: sending commands to master dhcpcd process Apr 20 12:01:39 volumio dhcpcd[794]: control command: /sbin/dhcpcd Apr 20 12:01:39 volumio sudo[4271]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:40 volumio wireless.js[4220]: trying... Apr 20 12:01:40 volumio sudo[4279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:40 volumio sudo[4279]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:40 volumio sudo[4279]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:41 volumio volumio[1076]: info: Discovery: Started advertising with name: Volumio Apr 20 12:01:41 volumio wireless.js[4220]: trying... Apr 20 12:01:41 volumio sudo[4285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:41 volumio sudo[4285]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:41 volumio sudo[4285]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:42 volumio wpa_supplicant[4275]: wlan0: SME: Trying to authenticate with bc:54:fc:f7:8f:d5 (SSID='MERCURY_5G_8FD3' freq=5745 MHz) Apr 20 12:01:42 volumio kernel: wlan0: authenticate with bc:54:fc:f7:8f:d5 Apr 20 12:01:42 volumio wpa_supplicant[4275]: wlan0: Trying to associate with bc:54:fc:f7:8f:d5 (SSID='MERCURY_5G_8FD3' freq=5745 MHz) Apr 20 12:01:42 volumio kernel: wlan0: send auth to bc:54:fc:f7:8f:d5 (try 1/3) Apr 20 12:01:42 volumio kernel: wlan0: authenticated Apr 20 12:01:42 volumio kernel: wlan0: VHT capa missing/short, disabling VHT/HE/EHT Apr 20 12:01:42 volumio kernel: wlan0: associate with bc:54:fc:f7:8f:d5 (try 1/3) Apr 20 12:01:42 volumio kernel: wlan0: RX AssocResp from bc:54:fc:f7:8f:d5 (capab=0x1011 status=0 aid=1) Apr 20 12:01:42 volumio kernel: wlan0: associated Apr 20 12:01:42 volumio wpa_supplicant[4275]: wlan0: Associated with bc:54:fc:f7:8f:d5 Apr 20 12:01:42 volumio wpa_supplicant[4275]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 20 12:01:42 volumio wpa_supplicant[4275]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Apr 20 12:01:42 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 20 12:01:42 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 20 12:01:42 volumio volumio[1076]: info: Refreshing Cached IP Addresses Apr 20 12:01:42 volumio sudo[4288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 20 12:01:42 volumio sudo[4288]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:42 volumio sudo[4288]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:42 volumio wpa_supplicant[4275]: wlan0: WPA: Key negotiation completed with bc:54:fc:f7:8f:d5 [PTK=CCMP GTK=CCMP] Apr 20 12:01:42 volumio wpa_supplicant[4275]: wlan0: CTRL-EVENT-CONNECTED - Connection to bc:54:fc:f7:8f:d5 completed [id=0 id_str=] Apr 20 12:01:42 volumio dhcpcd[794]: wlan0: carrier acquired Apr 20 12:01:42 volumio dhcpcd[794]: wlan0: confile file changed, expiring leases Apr 20 12:01:42 volumio dhcpcd[794]: wlan0: IAID a2:d1:80:44 Apr 20 12:01:42 volumio sudo[4292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:01:42 volumio sudo[4292]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:42 volumio sudo[4292]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:42 volumio sudo[4295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:42 volumio sudo[4295]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:42 volumio sudo[4295]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:42 volumio dhcpcd[794]: wlan0: soliciting an IPv6 router Apr 20 12:01:42 volumio wireless.js[4220]: trying... Apr 20 12:01:42 volumio sudo[4301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:42 volumio sudo[4301]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:42 volumio sudo[4301]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:43 volumio dhcpcd[794]: wlan0: rebinding lease of 192.168.0.102 Apr 20 12:01:43 volumio dhcpcd[794]: wlan0: probing address 192.168.0.102/24 Apr 20 12:01:43 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 20 12:01:43 volumio wireless.js[4220]: trying... Apr 20 12:01:43 volumio sudo[4304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:43 volumio sudo[4304]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:43 volumio sudo[4304]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:44 volumio wireless.js[4220]: trying... Apr 20 12:01:44 volumio sudo[4307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:44 volumio sudo[4307]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:44 volumio sudo[4307]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:45 volumio wireless.js[4220]: trying... Apr 20 12:01:45 volumio sudo[4310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:45 volumio sudo[4310]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:45 volumio sudo[4310]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:46 volumio wireless.js[4220]: trying... Apr 20 12:01:46 volumio sudo[4313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:46 volumio sudo[4313]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:46 volumio sudo[4313]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:47 volumio wireless.js[4220]: trying... Apr 20 12:01:47 volumio sudo[4316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:47 volumio sudo[4316]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:47 volumio sudo[4316]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:48 volumio dhcpcd[794]: wlan0: leased 192.168.0.102 for 7200 seconds Apr 20 12:01:48 volumio dhcpcd[794]: wlan0: adding route to 192.168.0.0/24 Apr 20 12:01:48 volumio dhcpcd[794]: wlan0: adding default route via 192.168.0.1 Apr 20 12:01:48 volumio avahi-daemon[776]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.102. Apr 20 12:01:48 volumio avahi-daemon[776]: New relevant interface wlan0.IPv4 for mDNS. Apr 20 12:01:48 volumio avahi-daemon[776]: Registering new address record for 192.168.0.102 on wlan0.IPv4. Apr 20 12:01:48 volumio ntpd[4039]: ntpd exiting on signal 15 (Terminated) Apr 20 12:01:48 volumio systemd[1]: Stopping Network Time Service... Apr 20 12:01:48 volumio systemd[1]: ntp.service: Succeeded. Apr 20 12:01:48 volumio systemd[1]: Stopped Network Time Service. Apr 20 12:01:48 volumio systemd[1]: Starting Network Time Service... Apr 20 12:01:48 volumio wireless.js[4220]: trying... Apr 20 12:01:48 volumio sudo[4355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:01:48 volumio sudo[4355]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:48 volumio sudo[4355]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:48 volumio wireless.js[4220]: Connected to: ----MERCURY_5G_8FD3 Apr 20 12:01:48 volumio wireless.js[4220]: ---- Apr 20 12:01:48 volumio ntpd[4350]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 20 12:01:48 volumio ntpd[4350]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 20 12:01:48 volumio systemd[1]: Started Network Time Service. Apr 20 12:01:48 volumio ntpd[4360]: proto: precision = 0.315 usec (-22) Apr 20 12:01:48 volumio ntpd[4360]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 20 12:01:48 volumio ntpd[4360]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 20 12:01:48 volumio ntpd[4360]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 845 days ago Apr 20 12:01:48 volumio ntpd[4360]: Listen and drop on 0 v6wildcard [::]:123 Apr 20 12:01:48 volumio ntpd[4360]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 20 12:01:48 volumio ntpd[4360]: Listen normally on 2 lo 127.0.0.1:123 Apr 20 12:01:48 volumio ntpd[4360]: Listen normally on 3 wlan0 192.168.0.102:123 Apr 20 12:01:48 volumio ntpd[4360]: Listening on routing socket on fd #20 for interface updates Apr 20 12:01:48 volumio ntpd[4360]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 20 12:01:48 volumio ntpd[4360]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 20 12:01:48 volumio sudo[4361]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:48 volumio sudo[4361]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:48 volumio sudo[4361]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:48 volumio wireless.js[4220]: ... joined AP, wlan0 IPv4 is 192.168.0.102, ipV6 is undefined Apr 20 12:01:48 volumio wireless.js[4220]: It's done! AP Apr 20 12:01:49 volumio systemd[1]: Started Wireless Services. Apr 20 12:01:49 volumio sudo[4175]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:49 volumio volumio[1076]: info: Discovery: adding 492524ff-0d18-4e9b-b0b7-e00a3046faf7 Apr 20 12:01:49 volumio volumio[1076]: info: Discovery: Found device Volumio Apr 20 12:01:49 volumio volumio[1076]: info: CoreCommandRouter::volumioGetState Apr 20 12:01:49 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:49 volumio ntpd[4360]: Soliciting pool server 193.182.111.14 Apr 20 12:01:50 volumio ntpd[4360]: Soliciting pool server 78.46.102.180 Apr 20 12:01:51 volumio ntpd[4360]: Soliciting pool server 2001:470:1d:281::123 Apr 20 12:01:52 volumio sudo[4371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:01:52 volumio sudo[4371]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:52 volumio sudo[4371]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:52 volumio sudo[4374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:52 volumio sudo[4374]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:52 volumio sudo[4374]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:52 volumio sudo[4377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 20 12:01:52 volumio sudo[4377]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:52 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 20 12:01:52 volumio sudo[4377]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:52 volumio volumio[1076]: info: Upmpdcli Daemon Started Apr 20 12:01:52 volumio ntpd[4360]: Soliciting pool server 162.159.200.123 Apr 20 12:01:53 volumio volumio[4379]: writing RSA key Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 20 12:01:53 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 20 12:01:54 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 20 12:01:54 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 20 12:01:54 volumio sudo[4419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:54 volumio sudo[4419]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:54 volumio sudo[4419]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:54 volumio sudo[4422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:01:54 volumio sudo[4422]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:54 volumio sudo[4422]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:59 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 20 12:01:59 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 20 12:01:59 volumio volumio[1076]: info: Refreshing Cached IP Addresses Apr 20 12:01:59 volumio sudo[4436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 20 12:01:59 volumio sudo[4436]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:59 volumio sudo[4436]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:59 volumio sudo[4439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:01:59 volumio sudo[4439]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:59 volumio sudo[4439]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:59 volumio sudo[4441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:01:59 volumio sudo[4441]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:01:59 volumio sudo[4441]: pam_unix(sudo:session): session closed for user root Apr 20 12:01:59 volumio volumio[1076]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 12:01:59 volumio volumio[1076]: info: Retrying Login Due to Network Error Apr 20 12:01:59 volumio volumio[1076]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Apr 20 12:01:59 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 20 12:01:59 volumio volumio[1076]: info: Preparing to save Alsa Options, stopping services first Apr 20 12:01:59 volumio volumio[1076]: info: CoreCommandRouter::volumioGetState Apr 20 12:01:59 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:59 volumio volumio[1076]: info: CoreCommandRouter::volumioPause Apr 20 12:01:59 volumio volumio[1076]: info: CoreStateMachine::pause Apr 20 12:01:59 volumio volumio[1076]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:01:59 volumio volumio[1076]: info: CoreStateMachine::servicePause Apr 20 12:01:59 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:01:59 volumio volumio[1076]: info: CoreCommandRouter::servicePause Apr 20 12:01:59 volumio volumio[1076]: info: ControllerMpd::pause Apr 20 12:01:59 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand pause Apr 20 12:01:59 volumio volumio[1076]: info: Saving Audio Output to: {"output_device":{"value":"2","label":"USB AUDIO DAC"}} Apr 20 12:01:59 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 20 12:02:00 volumio volumio[1076]: info: Setting mixer PCM for card USB AUDIO DAC Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 20 12:02:00 volumio volumio[1076]: info: Updating Volume Controller Parameters: Device: 2 Name: USB AUDIO DAC Mixer: PCM Max Vol: 100 Vol Curve; linear Vol Steps: 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 20 12:02:00 volumio volumio[1076]: info: Disabling external Volume Control Apr 20 12:02:00 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:02:00 volumio volumio[1076]: info: Preparing to generate the ALSA configuration file Apr 20 12:02:00 volumio volumio[1076]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 20 12:02:00 volumio volumio[1076]: info: Reading ALSA contributions from plugins. Apr 20 12:02:00 volumio volumio[1076]: info: Apr 20 12:02:00 volumio volumio[1076]: ---------------------------- MPD announces state update: player Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand pause took 410 milliseconds Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::getState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:02:00 volumio volumio[1076]: info: Apr 20 12:02:00 volumio volumio[1076]: ---------------------------- MPD announces state update: player Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::getState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:02:00 volumio volumio[1076]: info: Apr 20 12:02:00 volumio volumio[1076]: ---------------------------- MPD announces state update: player Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::getState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:02:00 volumio volumio[1076]: info: Apr 20 12:02:00 volumio volumio[1076]: ---------------------------- MPD announces state update: player Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::getState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand status took 56 milliseconds Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand status took 55 milliseconds Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand status took 54 milliseconds Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand status took 52 milliseconds Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::parseState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::parseState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::parseState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::parseState Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 20 12:02:00 volumio volumio[1076]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:02:00 volumio volumio[1076]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::servicePushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":210157,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??","artist":"???","album":"???? DSD","uri":"USB/口水翻唱试音碟/乔维怡《凤凰于飞》专辑-推荐/02. 难道.wav","trackType":"wav"} Apr 20 12:02:00 volumio volumio[1076]: verbose: CURRENT POSITION 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState stateService pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState currentStatus pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::volumioPushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::servicePushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":210157,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??","artist":"???","album":"???? DSD","uri":"USB/口水翻唱试音碟/乔维怡《凤凰于飞》专辑-推荐/02. 难道.wav","trackType":"wav"} Apr 20 12:02:00 volumio volumio[1076]: verbose: CURRENT POSITION 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState stateService pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState currentStatus pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::volumioPushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::servicePushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":210157,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??","artist":"???","album":"???? DSD","uri":"USB/口水翻唱试音碟/乔维怡《凤凰于飞》专辑-推荐/02. 难道.wav","trackType":"wav"} Apr 20 12:02:00 volumio volumio[1076]: verbose: CURRENT POSITION 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState stateService pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState currentStatus pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::volumioPushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:02:00 volumio volumio[1076]: info: ControllerMpd::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::servicePushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":210157,"duration":279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??","artist":"???","album":"???? DSD","uri":"USB/口水翻唱试音碟/乔维怡《凤凰于飞》专辑-推荐/02. 难道.wav","trackType":"wav"} Apr 20 12:02:00 volumio volumio[1076]: verbose: CURRENT POSITION 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState stateService pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::syncState currentStatus pause Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::pushState Apr 20 12:02:00 volumio volumio[1076]: info: CorePlayQueue::getTrack 1 Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::volumioPushState Apr 20 12:02:00 volumio volumio[1076]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:02:00 volumio volumio[1076]: info: ------------------------------ 252ms Apr 20 12:02:00 volumio volumio[1076]: info: ------------------------------ 252ms Apr 20 12:02:00 volumio volumio[1076]: info: ------------------------------ 258ms Apr 20 12:02:00 volumio volumio[1076]: info: ------------------------------ 257ms Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 20 12:02:00 volumio volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 20 12:02:00 volumio volumio[1076]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 12:02:00 volumio volumio[1076]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Apr 20 12:02:00 volumio volumio[1076]: at Object.readdirSync (fs.js:1048:3) Apr 20 12:02:00 volumio volumio[1076]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Apr 20 12:02:00 volumio volumio[1076]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Apr 20 12:02:00 volumio volumio[1076]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Apr 20 12:02:00 volumio volumio[1076]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Apr 20 12:02:00 volumio volumio[1076]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Apr 20 12:02:00 volumio volumio[1076]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Apr 20 12:02:00 volumio volumio[1076]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Apr 20 12:02:00 volumio volumio[1076]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Apr 20 12:02:00 volumio volumio[1076]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Apr 20 12:02:00 volumio volumio[1076]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Apr 20 12:02:00 volumio volumio[1076]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Apr 20 12:02:00 volumio volumio[1076]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Apr 20 12:02:00 volumio volumio[1076]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Apr 20 12:02:00 volumio volumio[1076]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Apr 20 12:02:00 volumio volumio[1076]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Apr 20 12:02:00 volumio volumio[1076]: errno: -20, Apr 20 12:02:00 volumio volumio[1076]: syscall: 'scandir', Apr 20 12:02:00 volumio volumio[1076]: code: 'ENOTDIR', Apr 20 12:02:00 volumio volumio[1076]: path: '/tmp/peppyrunning' Apr 20 12:02:00 volumio volumio[1076]: } Apr 20 12:02:00 volumio volumio[1076]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 12:02:01 volumio sudo[4478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-20 12:01 Apr 20 12:02:01 volumio sudo[4478]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"