-- Logs begin at Thu 2019-02-14 19:12:00 JST, end at Thu 2024-04-18 23:47:56 JST. -- Apr 18 23:46:01 volumio volumio[695]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Apr 18 23:46:01 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Apr 18 23:46:01 volumio sudo[2891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 18 23:46:01 volumio sudo[2891]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:01 volumio sudo[2891]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:01 volumio sudo[2893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 18 23:46:01 volumio sudo[2893]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:01 volumio sudo[2893]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:01 volumio volumio[695]: info: Permissions for /etc/network/interfaces set Apr 18 23:46:01 volumio volumio[695]: info: Restarting Wireless Network Apr 18 23:46:01 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 18 23:46:01 volumio volumio[695]: info: Discovery: Restarting Advertising due to device name change Apr 18 23:46:01 volumio sudo[2896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 18 23:46:01 volumio sudo[2896]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:01 volumio systemd[1]: wireless.service: Killing process 2110 (wpa_supplicant) with signal SIGKILL. Apr 18 23:46:01 volumio systemd[1]: wireless.service: Killing process 2135 (dhcpcd) with signal SIGKILL. Apr 18 23:46:01 volumio systemd[1]: Stopping Wireless Services... Apr 18 23:46:01 volumio systemd[1]: wireless.service: Succeeded. Apr 18 23:46:01 volumio systemd[1]: Stopped Wireless Services. Apr 18 23:46:02 volumio systemd[1]: Starting Wireless Services... Apr 18 23:46:02 volumio volumio[695]: info: Discovery: A device disappeared from network Apr 18 23:46:02 volumio volumio[695]: info: Discovery: Device volumio disappeared from network Apr 18 23:46:02 volumio volumio[695]: info: Discovery: A device disappeared from network Apr 18 23:46:03 volumio wireless.js[2898]: Cleaning previous... Apr 18 23:46:03 volumio sudo[2912]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 18 23:46:03 volumio sudo[2912]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio avahi-daemon[438]: Withdrawing address record for 192.168.2.142 on wlan0. Apr 18 23:46:03 volumio avahi-daemon[438]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.2.142. Apr 18 23:46:03 volumio avahi-daemon[438]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 18 23:46:03 volumio sudo[2912]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio sudo[2914]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 18 23:46:03 volumio sudo[2914]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio sudo[2914]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio wireless.js[2898]: Stopped aP Apr 18 23:46:03 volumio sudo[2921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 18 23:46:03 volumio sudo[2921]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio sudo[2921]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio sudo[2923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 18 23:46:03 volumio sudo[2923]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio sudo[2923]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio sudo[2930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 18 23:46:03 volumio sudo[2930]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio sudo[2930]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio sudo[2932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 18 23:46:03 volumio sudo[2932]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio sudo[2932]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio wireless.js[2898]: command failed: No such device (-19) Apr 18 23:46:03 volumio wireless.js[2898]: Start wireless flow Apr 18 23:46:03 volumio wireless.js[2898]: Stopped hotspot (if there).. Apr 18 23:46:03 volumio sudo[2937]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 18 23:46:03 volumio sudo[2937]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio sudo[2937]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio sudo[2939]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 18 23:46:03 volumio sudo[2939]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio sudo[2939]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:03 volumio wireless.js[2898]: DHCP IP Apr 18 23:46:03 volumio wireless.js[2898]: Start ap Apr 18 23:46:03 volumio wpa_supplicant[2941]: Successfully initialized wpa_supplicant Apr 18 23:46:03 volumio wpa_supplicant[2941]: nl80211: Driver does not support authentication/association or connect commands Apr 18 23:46:03 volumio wpa_supplicant[2941]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Apr 18 23:46:03 volumio wpa_supplicant[2941]: rfkill: Cannot get wiphy information Apr 18 23:46:03 volumio wpa_supplicant[2941]: ioctl[SIOCSIWAP]: Operation not permitted Apr 18 23:46:03 volumio sudo[2942]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 18 23:46:03 volumio sudo[2942]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:03 volumio dhcpcd[2945]: main: control_open: Connection refused Apr 18 23:46:03 volumio dhcpcd[2945]: dev: loaded udev Apr 18 23:46:03 volumio dhcpcd[2945]: `192.168.2.300' is not a valid IP address Apr 18 23:46:03 volumio wpa_supplicant[2941]: ioctl[SIOCSIWENCODEEXT]: Invalid argument Apr 18 23:46:03 volumio wpa_supplicant[2941]: ioctl[SIOCSIWENCODEEXT]: Invalid argument Apr 18 23:46:03 volumio dhcpcd[2945]: DUID 00:01:00:01:2d:69:1c:cf:b8:27:eb:96:fb:61 Apr 18 23:46:03 volumio dhcpcd[2945]: eth0: IAID eb:96:fb:61 Apr 18 23:46:03 volumio dhcpcd[2945]: eth0: adding address fe80::ba27:ebff:fe96:fb61 Apr 18 23:46:03 volumio dhcpcd[2945]: ipv6_addaddr1: Permission denied Apr 18 23:46:03 volumio dhcpcd[2945]: wlan0: waiting for carrier Apr 18 23:46:04 volumio wireless.js[2898]: trying... Apr 18 23:46:05 volumio dhcpcd[2945]: eth0: rebinding lease of 192.168.2.141 Apr 18 23:46:05 volumio wpa_supplicant[2964]: wlan0: Trying to associate with 04:ab:18:b7:58:99 (SSID='elecom-b75897' freq=2447 MHz) Apr 18 23:46:05 volumio wpa_supplicant[2964]: Failed to add supported operating classes IE Apr 18 23:46:05 volumio wpa_supplicant[2964]: ioctl[SIOCSIWFREQ]: Operation not supported Apr 18 23:46:05 volumio wpa_supplicant[2964]: wlan0: Association request to the driver failed Apr 18 23:46:05 volumio sudo[2968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:05 volumio sudo[2968]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:05 volumio sudo[2968]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:05 volumio dhcpcd[2945]: eth0: soliciting an IPv6 router Apr 18 23:46:05 volumio dhcpcd[2945]: eth0: NAK: address in use from 192.168.2.1 Apr 18 23:46:05 volumio dhcpcd[2945]: eth0: message: address in use Apr 18 23:46:05 volumio avahi-daemon[438]: Withdrawing address record for 192.168.2.141 on eth0. Apr 18 23:46:05 volumio avahi-daemon[438]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.2.141. Apr 18 23:46:05 volumio dhcpcd[741]: eth0: pid -1886984339 deleted IP address 192.168.2.141/24 Apr 18 23:46:05 volumio avahi-daemon[438]: Interface eth0.IPv4 no longer relevant for mDNS. Apr 18 23:46:05 volumio dhcpcd[741]: eth0: deleting route to 192.168.2.0/24 Apr 18 23:46:05 volumio dhcpcd[741]: eth0: deleting default route via 192.168.2.1 Apr 18 23:46:05 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:46:05 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:46:05 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:05 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:46:05 volumio dhcpcd[741]: eth0: rebinding lease of 192.168.2.141 Apr 18 23:46:05 volumio dhcpcd[2945]: eth0: soliciting a DHCP lease Apr 18 23:46:05 volumio wireless.js[2898]: trying... Apr 18 23:46:05 volumio sudo[3010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:05 volumio sudo[3010]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:05 volumio sudo[3010]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:06 volumio volumio[695]: info: Discovery: Started advertising with name: Volumio Apr 18 23:46:06 volumio wireless.js[2898]: trying... Apr 18 23:46:06 volumio sudo[3014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:06 volumio sudo[3014]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:06 volumio sudo[3014]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:07 volumio ntpd[619]: Deleting interface #3 eth0, 192.168.2.141#123, interface stats: received=225, sent=225, dropped=0, active_time=713 secs Apr 18 23:46:07 volumio ntpd[619]: 133.243.238.163 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 122.215.240.51 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 45.159.48.231 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 139.162.96.56 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 129.250.35.251 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 162.159.200.1 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 202.182.111.234 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 172.105.240.243 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 45.77.20.103 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 172.105.204.105 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 133.243.238.243 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: 162.159.200.123 local addr 192.168.2.141 -> Apr 18 23:46:07 volumio ntpd[619]: Deleting interface #4 wlan0, 192.168.2.142#123, interface stats: received=0, sent=0, dropped=0, active_time=437 secs Apr 18 23:46:07 volumio wpa_supplicant[2964]: wlan0: Associated with 04:ab:18:b7:58:99 Apr 18 23:46:07 volumio wpa_supplicant[2964]: wlan0: WPA: Key negotiation completed with 04:ab:18:b7:58:99 [PTK=CCMP GTK=CCMP] Apr 18 23:46:07 volumio wpa_supplicant[2964]: wlan0: CTRL-EVENT-CONNECTED - Connection to 04:ab:18:b7:58:99 completed [id=0 id_str=] Apr 18 23:46:07 volumio dhcpcd[2945]: wlan0: carrier acquired Apr 18 23:46:07 volumio dhcpcd[2945]: `192.168.2.300' is not a valid IP address Apr 18 23:46:07 volumio dhcpcd[2945]: wlan0: IAID 54:c6:fa:3b Apr 18 23:46:07 volumio dhcpcd[2945]: wlan0: adding address fe80::4a22:54ff:fec6:fa3b Apr 18 23:46:07 volumio dhcpcd[2945]: ipv6_addaddr1: Permission denied Apr 18 23:46:07 volumio wireless.js[2898]: trying... Apr 18 23:46:07 volumio sudo[3018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:07 volumio sudo[3018]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:07 volumio sudo[3018]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:08 volumio dhcpcd[2945]: wlan0: soliciting an IPv6 router Apr 18 23:46:08 volumio dhcpcd[2945]: wlan0: rebinding lease of 192.168.2.142 Apr 18 23:46:08 volumio wireless.js[2898]: trying... Apr 18 23:46:08 volumio sudo[3021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:08 volumio dhcpcd[2945]: eth0: offered 192.168.2.143 from 192.168.2.1 Apr 18 23:46:08 volumio sudo[3021]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:08 volumio sudo[3021]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:08 volumio dhcpcd[741]: eth0: probing address 192.168.2.141/24 Apr 18 23:46:08 volumio dhcpcd[2945]: wlan0: NAK: address in use from 192.168.2.1 Apr 18 23:46:08 volumio dhcpcd[2945]: wlan0: message: address in use Apr 18 23:46:09 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:46:09 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:09 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:46:09 volumio dhcpcd[2945]: wlan0: soliciting a DHCP lease Apr 18 23:46:09 volumio dhcpcd[2945]: eth0: probing address 192.168.2.143/24 Apr 18 23:46:09 volumio wireless.js[2898]: trying... Apr 18 23:46:09 volumio sudo[3078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:09 volumio sudo[3078]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:09 volumio sudo[3078]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:10 volumio wireless.js[2898]: trying... Apr 18 23:46:10 volumio sudo[3081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:10 volumio sudo[3081]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:10 volumio sudo[3081]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:11 volumio wireless.js[2898]: trying... Apr 18 23:46:11 volumio sudo[3085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:11 volumio sudo[3085]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:11 volumio sudo[3085]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:12 volumio dhcpcd[2945]: wlan0: offered 192.168.2.144 from 192.168.2.1 Apr 18 23:46:12 volumio dhcpcd[2945]: wlan0: probing address 192.168.2.144/24 Apr 18 23:46:12 volumio wireless.js[2898]: trying... Apr 18 23:46:12 volumio sudo[3088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:12 volumio sudo[3088]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:12 volumio sudo[3088]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:13 volumio wireless.js[2898]: trying... Apr 18 23:46:13 volumio sudo[3091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:13 volumio sudo[3091]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:13 volumio sudo[3091]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:13 volumio dhcpcd[2945]: eth0: leased 192.168.2.143 for 172800 seconds Apr 18 23:46:13 volumio avahi-daemon[438]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.143. Apr 18 23:46:13 volumio dhcpcd[2945]: eth0: adding route to 192.168.2.0/24 Apr 18 23:46:13 volumio dhcpcd[2945]: eth0: adding default route via 192.168.2.1 Apr 18 23:46:13 volumio avahi-daemon[438]: New relevant interface eth0.IPv4 for mDNS. Apr 18 23:46:13 volumio avahi-daemon[438]: Registering new address record for 192.168.2.143 on eth0.IPv4. Apr 18 23:46:13 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:46:13 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:46:13 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:13 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:46:13 volumio dhcpcd[2945]: forked to background, child pid 3115 Apr 18 23:46:14 volumio sudo[2942]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:14 volumio dhcpcd[741]: eth0: leased 192.168.2.141 for 172800 seconds Apr 18 23:46:14 volumio dhcpcd[741]: eth0: adding route to 192.168.2.0/24 Apr 18 23:46:14 volumio dhcpcd[741]: eth0: adding default route via 192.168.2.1 Apr 18 23:46:14 volumio avahi-daemon[438]: Registering new address record for 192.168.2.141 on eth0.IPv4. Apr 18 23:46:14 volumio volumio[695]: info: Discovery: adding undefined Apr 18 23:46:14 volumio volumio[695]: info: Discovery: Found device Volumio Apr 18 23:46:14 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:14 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:14 volumio wireless.js[2898]: trying... Apr 18 23:46:14 volumio sudo[3137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:14 volumio sudo[3137]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:14 volumio sudo[3137]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:15 volumio ntpd[619]: Listen normally on 5 eth0 192.168.2.143:123 Apr 18 23:46:15 volumio ntpd[619]: Listen normally on 6 eth0 192.168.2.141:123 Apr 18 23:46:15 volumio ntpd[619]: new interface(s) found: waking up resolver Apr 18 23:46:15 volumio wireless.js[2898]: trying... Apr 18 23:46:15 volumio sudo[3140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:15 volumio sudo[3140]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:15 volumio sudo[3140]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:16 volumio ntpd[619]: 162.159.200.1 local addr 192.168.2.143 -> Apr 18 23:46:16 volumio wireless.js[2898]: trying... Apr 18 23:46:16 volumio sudo[3143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:16 volumio sudo[3143]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:16 volumio sudo[3143]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:17 volumio ntpd[619]: Soliciting pool server 133.130.121.141 Apr 18 23:46:17 volumio dhcpcd[3115]: wlan0: leased 192.168.2.144 for 172800 seconds Apr 18 23:46:17 volumio dhcpcd[3115]: wlan0: adding route to 192.168.2.0/24 Apr 18 23:46:17 volumio avahi-daemon[438]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.2.144. Apr 18 23:46:17 volumio avahi-daemon[438]: New relevant interface wlan0.IPv4 for mDNS. Apr 18 23:46:17 volumio dhcpcd[3115]: wlan0: adding default route via 192.168.2.1 Apr 18 23:46:17 volumio avahi-daemon[438]: Registering new address record for 192.168.2.144 on wlan0.IPv4. Apr 18 23:46:17 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:46:17 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:46:17 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:17 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:17 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:46:17 volumio wireless.js[2898]: trying... Apr 18 23:46:17 volumio sudo[3167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 18 23:46:17 volumio sudo[3167]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:17 volumio sudo[3167]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:17 volumio wireless.js[2898]: Connected to: ----elecom-b75897 Apr 18 23:46:17 volumio wireless.js[2898]: ---- Apr 18 23:46:17 volumio sudo[3171]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:46:17 volumio sudo[3171]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:17 volumio sudo[3171]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:17 volumio wireless.js[2898]: ... joined AP, wlan0 IPv4 is 192.168.2.144, ipV6 is undefined Apr 18 23:46:17 volumio wireless.js[2898]: It's done! AP Apr 18 23:46:18 volumio iw[3174]: command failed: No such device (-19) Apr 18 23:46:18 volumio iwconfig[3175]: Error for wireless request "Set Power Management" (8B2C) : Apr 18 23:46:18 volumio iwconfig[3175]: SET failed on device wlan0 ; Operation not supported. Apr 18 23:46:18 volumio systemd[1]: Started Wireless Services. Apr 18 23:46:18 volumio sudo[2896]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:18 volumio ntpd[619]: 122.215.240.51 local addr 192.168.2.143 -> Apr 18 23:46:18 volumio ntpd[619]: 162.159.200.123 local addr 192.168.2.143 -> Apr 18 23:46:18 volumio ntpd[619]: Soliciting pool server 167.179.119.205 Apr 18 23:46:18 volumio volumio[695]: info: Discovery: this is already registered, undefined Apr 18 23:46:18 volumio volumio[695]: info: Discovery: Found device Volumio Apr 18 23:46:18 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:18 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:19 volumio ntpd[619]: Soliciting pool server 45.76.218.37 Apr 18 23:46:19 volumio ntpd[619]: Listen normally on 7 wlan0 192.168.2.144:123 Apr 18 23:46:19 volumio ntpd[619]: new interface(s) found: waking up resolver Apr 18 23:46:19 volumio ntpd[619]: Soliciting pool server 162.159.200.123 Apr 18 23:46:20 volumio ntpd[619]: Soliciting pool server 129.250.35.250 Apr 18 23:46:23 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 18 23:46:23 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 18 23:46:23 volumio sudo[3178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:46:23 volumio sudo[3178]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:23 volumio sudo[3178]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:23 volumio sudo[3181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 18 23:46:23 volumio sudo[3181]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:23 volumio sudo[3181]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:23 volumio ntpd[619]: Soliciting pool server 202.181.103.212 Apr 18 23:46:24 volumio ntpd[619]: Soliciting pool server 2001:678:8::123 Apr 18 23:46:24 volumio ntpd[619]: Soliciting pool server 162.159.200.1 Apr 18 23:46:25 volumio ntpd[619]: Soliciting pool server 122.215.240.52 Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 18 23:46:28 volumio volumio[695]: info: Refreshing Cached IP Addresses Apr 18 23:46:28 volumio sudo[3186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 18 23:46:28 volumio sudo[3186]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:28 volumio sudo[3188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 23:46:28 volumio sudo[3188]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:28 volumio sudo[3186]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:28 volumio volumio[695]: error: Upnp client error: Error: This socket has been ended by the other party Apr 18 23:46:28 volumio sudo[3188]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:28 volumio sudo[3191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:46:28 volumio sudo[3191]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:28 volumio sudo[3191]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:28 volumio sudo[3195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 23:46:28 volumio sudo[3195]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:28 volumio sudo[3195]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:28 volumio sudo[3197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:46:28 volumio sudo[3197]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:28 volumio sudo[3197]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:28 volumio volumio[695]: verbose: New Socket.io Connection to 192.168.2.143 from 192.168.2.133 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 4 Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::volumioGetVisibleSources Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:28 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 18 23:46:28 volumio volumio[695]: info: Received Get System Info Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 23:46:28 volumio volumio[695]: info: Discovery: Getting this device information Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:28 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:28 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:28 volumio volumio[695]: info: Listing playlists Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 18 23:46:28 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 18 23:46:29 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 18 23:46:29 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 18 23:46:29 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 18 23:46:29 volumio sudo[3203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 18 23:46:29 volumio sudo[3203]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:29 volumio sudo[3203]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:29 volumio sudo[3208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 18 23:46:29 volumio sudo[3208]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:29 volumio sudo[3208]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:29 volumio sudo[3216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 18 23:46:29 volumio sudo[3216]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:29 volumio sudo[3216]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:29 volumio sudo[3222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 18 23:46:29 volumio sudo[3222]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:29 volumio sudo[3222]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:29 volumio sudo[3228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 23:46:29 volumio sudo[3228]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:29 volumio sudo[3228]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:29 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 18 23:46:29 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 18 23:46:29 volumio sudo[3231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:46:29 volumio sudo[3231]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:29 volumio sudo[3231]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:29 volumio sudo[3235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 18 23:46:29 volumio sudo[3235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:30 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 18 23:46:30 volumio volumio[695]: info: Received Get System Info Apr 18 23:46:30 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 23:46:30 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 23:46:30 volumio volumio[695]: info: Discovery: Getting this device information Apr 18 23:46:30 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:30 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:30 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 23:46:31 volumio sudo[3235]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:31 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 18 23:46:31 volumio volumio[695]: info: Received Get System Info Apr 18 23:46:31 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 23:46:31 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 23:46:31 volumio volumio[695]: info: Discovery: Getting this device information Apr 18 23:46:31 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:31 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:31 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 23:46:38 volumio sudo[3239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 23:46:38 volumio sudo[3239]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:38 volumio sudo[3239]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:38 volumio sudo[3241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:46:38 volumio sudo[3241]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:38 volumio sudo[3241]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:38 volumio sudo[3244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 18 23:46:38 volumio sudo[3244]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:38 volumio sudo[3244]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:38 volumio volumio[695]: info: Upmpdcli Daemon Started Apr 18 23:46:45 volumio volumio[695]: info: CALLMETHOD: system_controller network saveWiredNet [object Object] Apr 18 23:46:45 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , saveWiredNet Apr 18 23:46:47 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 18 23:46:47 volumio volumio[695]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 18 23:46:47 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 18 23:46:47 volumio volumio[695]: info: Received Get System Version Apr 18 23:46:47 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 18 23:46:47 volumio volumio[695]: info: Received Get System Info Apr 18 23:46:47 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 23:46:47 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 23:46:47 volumio volumio[695]: info: Discovery: Getting this device information Apr 18 23:46:47 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:47 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:47 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 23:46:48 volumio volumio[695]: info: CALLMETHOD: system_controller network saveWiredNet [object Object] Apr 18 23:46:48 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , saveWiredNet Apr 18 23:46:48 volumio sudo[3249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 18 23:46:48 volumio sudo[3249]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:48 volumio sudo[3249]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:48 volumio sudo[3251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 18 23:46:48 volumio sudo[3251]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:48 volumio sudo[3251]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:48 volumio volumio[695]: info: Permissions for /etc/network/interfaces set Apr 18 23:46:48 volumio volumio[695]: info: Restarting Wired Network Apr 18 23:46:48 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 18 23:46:48 volumio volumio[695]: info: Discovery: Restarting Advertising due to device name change Apr 18 23:46:48 volumio sudo[3254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0 Apr 18 23:46:48 volumio sudo[3254]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:48 volumio avahi-daemon[438]: Withdrawing address record for 192.168.2.143 on eth0. Apr 18 23:46:48 volumio avahi-daemon[438]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.2.143. Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: pid 3255 deleted IP address 192.168.2.143/24 Apr 18 23:46:48 volumio dhcpcd[741]: eth0: pid 0 deleted route to 192.168.2.0/24 Apr 18 23:46:48 volumio dhcpcd[741]: eth0: pid 0 deleted default route via 192.168.2.1 Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: deleting route to 192.168.2.0/24 Apr 18 23:46:48 volumio dhcpcd[741]: eth0: pid 3255 deleted IP address 192.168.2.141/24 Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: deleting default route via 192.168.2.1 Apr 18 23:46:48 volumio avahi-daemon[438]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.141. Apr 18 23:46:48 volumio avahi-daemon[438]: Withdrawing address record for 192.168.2.141 on eth0. Apr 18 23:46:48 volumio avahi-daemon[438]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.2.141. Apr 18 23:46:48 volumio avahi-daemon[438]: Interface eth0.IPv4 no longer relevant for mDNS. Apr 18 23:46:48 volumio sudo[3254]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:48 volumio volumio[695]: info: Discovery: A device disappeared from network Apr 18 23:46:48 volumio volumio[695]: info: Discovery: Device volumio disappeared from network Apr 18 23:46:48 volumio sudo[3259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down Apr 18 23:46:48 volumio sudo[3259]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:48 volumio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Apr 18 23:46:48 volumio kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Apr 18 23:46:48 volumio sudo[3259]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:48 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:46:48 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:46:48 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:48 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:48 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:46:48 volumio dhcpcd[741]: eth0: rebinding lease of 192.168.2.141 Apr 18 23:46:48 volumio dhcpcd[741]: eth0: bpf_send: Network is down Apr 18 23:46:48 volumio sudo[3286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up Apr 18 23:46:48 volumio dhcpcd[741]: arp_read: eth0: Network is down Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: rebinding lease of 192.168.2.141 Apr 18 23:46:48 volumio dhcpcd[3115]: arp_announce1: Network is down Apr 18 23:46:48 volumio sudo[3286]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: bpf_send: Network is down Apr 18 23:46:48 volumio dhcpcd[3115]: arp_read: eth0: Network is down Apr 18 23:46:48 volumio dhcpcd[3115]: dhcp_readbpf: eth0: Network is down Apr 18 23:46:48 volumio kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Apr 18 23:46:48 volumio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Apr 18 23:46:48 volumio sudo[3286]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:48 volumio dhcpcd[741]: dhcp_readbpf: eth0: Network is down Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: pid 3255 deleted IP address 192.168.2.141/24 Apr 18 23:46:48 volumio dhcpcd[741]: eth0: carrier lost Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: rebinding lease of 192.168.2.141 Apr 18 23:46:48 volumio dhcpcd[3115]: eth0: carrier lost Apr 18 23:46:49 volumio ifplugd(eth0)[618]: Link beat lost. Apr 18 23:46:49 volumio volumio[695]: info: Discovery: A device disappeared from network Apr 18 23:46:50 volumio dhcpcd[3115]: eth0: carrier acquired Apr 18 23:46:50 volumio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Apr 18 23:46:50 volumio dhcpcd[741]: eth0: carrier acquired Apr 18 23:46:50 volumio dhcpcd[741]: eth0: confile file changed, expiring leases Apr 18 23:46:50 volumio dhcpcd[3115]: eth0: confile file changed, expiring leases Apr 18 23:46:50 volumio dhcpcd[3115]: eth0: IAID eb:96:fb:61 Apr 18 23:46:50 volumio dhcpcd[741]: eth0: IAID eb:96:fb:61 Apr 18 23:46:50 volumio dhcpcd[741]: eth0: probing address 127.0.0.1/24 Apr 18 23:46:50 volumio dhcpcd[3115]: eth0: probing address 127.0.0.1/24 Apr 18 23:46:50 volumio dhcpcd[741]: eth0: soliciting an IPv6 router Apr 18 23:46:51 volumio dhcpcd[3115]: eth0: soliciting an IPv6 router Apr 18 23:46:51 volumio ifplugd(eth0)[618]: Link beat detected. Apr 18 23:46:51 volumio ntpd[619]: Deleting interface #5 eth0, 192.168.2.143#123, interface stats: received=76, sent=76, dropped=0, active_time=36 secs Apr 18 23:46:51 volumio ntpd[619]: 122.215.240.52 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 162.159.200.1 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 202.181.103.212 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 129.250.35.250 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 162.159.200.123 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 45.76.218.37 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 167.179.119.205 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 133.130.121.141 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 133.243.238.243 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 172.105.204.105 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 45.77.20.103 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 172.105.240.243 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 202.182.111.234 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 129.250.35.251 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 139.162.96.56 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 45.159.48.231 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: 133.243.238.163 local addr 192.168.2.143 -> Apr 18 23:46:51 volumio ntpd[619]: Deleting interface #6 eth0, 192.168.2.141#123, interface stats: received=0, sent=0, dropped=0, active_time=36 secs Apr 18 23:46:53 volumio volumio[695]: info: Discovery: Started advertising with name: Volumio Apr 18 23:46:54 volumio volumio[695]: info: Discovery: adding undefined Apr 18 23:46:54 volumio volumio[695]: info: Discovery: Found device Volumio Apr 18 23:46:54 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:46:54 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:46:55 volumio dhcpcd[741]: eth0: using static address 127.0.0.1/24 Apr 18 23:46:55 volumio dhcpcd[741]: eth0: adding route to 127.0.0.0/24 Apr 18 23:46:55 volumio avahi-daemon[438]: Joining mDNS multicast group on interface eth0.IPv4 with address 127.0.0.1. Apr 18 23:46:55 volumio avahi-daemon[438]: New relevant interface eth0.IPv4 for mDNS. Apr 18 23:46:55 volumio avahi-daemon[438]: Registering new address record for 127.0.0.1 on eth0.IPv4. Apr 18 23:46:55 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:46:55 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:55 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:46:55 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:46:55 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:46:55 volumio dhcpcd[3115]: eth0: using static address 127.0.0.1/24 Apr 18 23:46:55 volumio dhcpcd[3115]: eth0: adding route to 127.0.0.0/24 Apr 18 23:46:58 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 18 23:46:58 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 18 23:46:58 volumio volumio[695]: info: Refreshing Cached IP Addresses Apr 18 23:46:58 volumio sudo[3431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 18 23:46:58 volumio sudo[3431]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:58 volumio sudo[3433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 23:46:58 volumio sudo[3433]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:58 volumio sudo[3431]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:58 volumio volumio[695]: error: Upnp client error: Error: This socket has been ended by the other party Apr 18 23:46:58 volumio sudo[3433]: pam_unix(sudo:session): session closed for user root Apr 18 23:46:58 volumio sudo[3436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:46:58 volumio sudo[3436]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:46:58 volumio sudo[3436]: pam_unix(sudo:session): session closed for user root Apr 18 23:47:09 volumio sudo[3440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 23:47:09 volumio sudo[3440]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:47:09 volumio sudo[3440]: pam_unix(sudo:session): session closed for user root Apr 18 23:47:09 volumio sudo[3442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 23:47:09 volumio sudo[3442]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:47:09 volumio sudo[3442]: pam_unix(sudo:session): session closed for user root Apr 18 23:47:09 volumio sudo[3446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 18 23:47:09 volumio sudo[3446]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 23:47:09 volumio sudo[3446]: pam_unix(sudo:session): session closed for user root Apr 18 23:47:09 volumio volumio[695]: info: Upmpdcli Daemon Started Apr 18 23:47:31 volumio nmbd[596]: [2024/04/18 23:47:31.715982, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 18 23:47:31 volumio nmbd[596]: Packet send failed to 192.168.2.255(138) ERRNO=Network is unreachable Apr 18 23:47:47 volumio dhcpcd[3115]: eth0: carrier lost Apr 18 23:47:47 volumio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Apr 18 23:47:47 volumio dhcpcd[741]: eth0: carrier lost Apr 18 23:47:47 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:47:47 volumio avahi-daemon[438]: Withdrawing address record for 127.0.0.1 on eth0. Apr 18 23:47:47 volumio dhcpcd[741]: eth0: deleting route to 127.0.0.0/24 Apr 18 23:47:47 volumio avahi-daemon[438]: Leaving mDNS multicast group on interface eth0.IPv4 with address 127.0.0.1. Apr 18 23:47:47 volumio avahi-daemon[438]: Interface eth0.IPv4 no longer relevant for mDNS. Apr 18 23:47:47 volumio dhcpcd[3115]: eth0: deleting route to 127.0.0.0/24 Apr 18 23:47:47 volumio dnsmasq[689]: reading /etc/resolv.conf Apr 18 23:47:47 volumio ifplugd(eth0)[618]: Link beat lost. Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 192.168.2.1#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.222.222#53 Apr 18 23:47:47 volumio dnsmasq[689]: using nameserver 208.67.220.220#53 Apr 18 23:47:54 volumio kernel: mmc0: card 1234 removed Apr 18 23:47:54 volumio volumio[695]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:1234/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/8ca0658c-01 /dev/disk/by-label/boot /dev/disk/by-uuid/F102-DE29 /dev/disk/by-path/platform-3f202000.mmc-part1 /dev/disk/by-id/mmc-SA16G_0x48d78dad-part1","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:1234/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F102-DE29","ID_FS_UUID_ENC":"F102-DE29","ID_FS_VERSION":"FAT16","ID_NAME":"SA16G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"8ca0658c-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0x48d78dad","MAJOR":"179","MINOR":"1","PARTN":"1","SEQNUM":"1396","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"42422980"} Apr 18 23:47:54 volumio systemd[1]: Stopped target Local File Systems. Apr 18 23:47:54 volumio volumio[695]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:1234/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/db7775c5-9234-4b9a-955e-7341a245d498 /dev/disk/by-id/mmc-SA16G_0x48d78dad-part2 /dev/disk/by-path/platform-3f202000.mmc-part2 /dev/disk/by-partuuid/8ca0658c-02 /dev/disk/by-label/volumio","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:1234/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_UUID_ENC":"db7775c5-9234-4b9a-955e-7341a245d498","ID_FS_VERSION":"1.0","ID_NAME":"SA16G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0x48d78dad","MAJOR":"179","MINOR":"2","PARTN":"2","SEQNUM":"1397","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"42411838"} Apr 18 23:47:54 volumio systemd[1]: Unmounting /boot... Apr 18 23:47:54 volumio volumio[695]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:1234/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/volumio_data /dev/disk/by-uuid/4112086d-38d3-4206-a7af-ef93bf4e4008 /dev/disk/by-partuuid/8ca0658c-03 /dev/disk/by-id/mmc-SA16G_0x48d78dad-part3 /dev/disk/by-path/platform-3f202000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:1234/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_UUID_ENC":"4112086d-38d3-4206-a7af-ef93bf4e4008","ID_FS_VERSION":"1.0","ID_NAME":"SA16G","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"24809184","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"8ca0658c-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"8ca0658c","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0x48d78dad","MAJOR":"179","MINOR":"3","PARTN":"3","SEQNUM":"1398","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"42547856"} Apr 18 23:47:54 volumio kernel: FAT-fs (mmcblk0p1): unable to read boot sector to mark fs as dirty Apr 18 23:47:54 volumio systemd[1]: boot.mount: Succeeded. Apr 18 23:47:54 volumio systemd[1]: Unmounted /boot. Apr 18 23:47:54 volumio systemd[1]: systemd-fsck@dev-mmcblk0p1.service: Succeeded. Apr 18 23:47:54 volumio systemd[1]: Stopped File System Check on /dev/mmcblk0p1. Apr 18 23:47:55 volumio volumio[695]: verbose: New Socket.io Connection to 192.168.2.144 from 192.168.2.133 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 5 Apr 18 23:47:55 volumio volumio[695]: info: Received Get System Info Apr 18 23:47:55 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 18 23:47:55 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 18 23:47:55 volumio volumio[695]: info: Discovery: Getting this device information Apr 18 23:47:55 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:47:55 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:47:55 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 23:47:55 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 18 23:47:55 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 18 23:47:55 volumio kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #1689314: lblock 0: comm node: error -5 reading directory block Apr 18 23:47:55 volumio volumio[695]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 23:47:55 volumio volumio[695]: Error: EIO: i/o error, scandir '/data/plugins/' Apr 18 23:47:55 volumio volumio[695]: at Object.readdirSync (fs.js:1021:3) Apr 18 23:47:55 volumio volumio[695]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30) Apr 18 23:47:55 volumio volumio[695]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1515:29) Apr 18 23:47:55 volumio volumio[695]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1300:45) Apr 18 23:47:55 volumio volumio[695]: at Socket.emit (events.js:315:20) Apr 18 23:47:55 volumio volumio[695]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 18 23:47:55 volumio volumio[695]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 18 23:47:55 volumio volumio[695]: errno: -5, Apr 18 23:47:55 volumio volumio[695]: syscall: 'scandir', Apr 18 23:47:55 volumio volumio[695]: code: 'EIO', Apr 18 23:47:55 volumio volumio[695]: path: '/data/plugins/' Apr 18 23:47:55 volumio volumio[695]: } Apr 18 23:47:55 volumio volumio[695]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 23:47:55 volumio nmbd[596]: [2024/04/18 23:47:55.769559, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Apr 18 23:47:55 volumio nmbd[596]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Apr 18 23:47:55 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #1689278: comm nmbd: reading directory lblock 0 Apr 18 23:47:55 volumio kernel: EXT4-fs (mmcblk0p3): previous I/O error to superblock detected Apr 18 23:47:55 volumio kernel: EXT4-fs error (device mmcblk0p3): ext4_read_inode_bitmap:203: comm nmbd: Cannot read inode bitmap - block_group = 848, inode_bitmap = 6946833 Apr 18 23:47:55 volumio kernel: EXT4-fs error (device mmcblk0p3): ext4_check_bdev_write_error:218: comm nmbd: Error while async write back metadata Apr 18 23:47:55 volumio kernel: EXT4-fs error (device mmcblk0p3): ext4_read_inode_bitmap:203: comm nmbd: Cannot read inode bitmap - block_group = 848, inode_bitmap = 6946833 Apr 18 23:47:55 volumio kernel: EXT4-fs error (device mmcblk0p3) in ext4_free_inode:362: IO failure Apr 18 23:47:55 volumio kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #1689278: comm nmbd: reading directory lblock 0 Apr 18 23:47:55 volumio nmbd[596]: [2024/04/18 23:47:55.843356, 0] ../source3/nmbd/nmbd_serverlistdb.c:317(write_browse_list) Apr 18 23:47:55 volumio nmbd[596]: write_browse_list: Can't open file /var/cache/samba/browse.dat.: Input/output error Apr 18 23:47:56 volumio sudo[3582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-18 23:46 Apr 18 23:47:56 volumio sudo[3582]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"