May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:23 testing sudo[27140]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 11:56:23 testing sudo[27140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:23 testing sudo[27140]: pam_unix(sudo:session): session closed for user root May 29 11:56:23 testing sudo[27146]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 11:56:23 testing sudo[27146]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:23 testing sudo[27146]: pam_unix(sudo:session): session closed for user root May 29 11:56:23 testing volumio[6086]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.7 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 29 11:56:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:24 testing sudo[27406]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 11:56:24 testing sudo[27406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:24 testing sudo[27406]: pam_unix(sudo:session): session closed for user root May 29 11:56:24 testing sudo[27411]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 11:56:24 testing sudo[27411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:24 testing sudo[27411]: pam_unix(sudo:session): session closed for user root May 29 11:56:24 testing volumio[6086]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.7 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 29 11:56:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing sudo[27464]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 11:56:25 testing sudo[27464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing sudo[27464]: pam_unix(sudo:session): session closed for user root May 29 11:56:25 testing sudo[27468]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 11:56:25 testing sudo[27468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:25 testing sudo[27468]: pam_unix(sudo:session): session closed for user root May 29 11:56:25 testing volumio[6086]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.7 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::volumioGetVisibleSources May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 29 11:56:25 testing volumio[6086]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 29 11:56:25 testing volumio[6086]: info: Received Get System Info May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:56:25 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:25 testing volumio[6086]: info: Listing playlists May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 29 11:56:25 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:26 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 29 11:56:26 testing volumio[6086]: info: Received Get System Info May 29 11:56:26 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:56:26 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:56:26 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:56:26 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:26 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:56:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:27 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 29 11:56:27 testing volumio[6086]: info: Received Get System Info May 29 11:56:27 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:56:27 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:56:27 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:56:27 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:27 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:56:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing volumio[6086]: info: Executing endpoint metavolumio May 29 11:56:28 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:30 testing volumio[6086]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 11:56:30 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 29 11:56:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:30 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 29 11:56:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:30 testing sudo[28719]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 29 11:56:30 testing sudo[28719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:30 testing sudo[28739]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 29 11:56:30 testing sudo[28730]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 29 11:56:30 testing sudo[28739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing sudo[28730]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing sudo[28719]: pam_unix(sudo:session): session closed for user root May 29 11:56:30 testing sudo[28739]: pam_unix(sudo:session): session closed for user root May 29 11:56:30 testing sudo[28730]: pam_unix(sudo:session): session closed for user root May 29 11:56:30 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 29 11:56:30 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 29 11:56:30 testing sudo[28747]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 29 11:56:30 testing sudo[28747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing sudo[28763]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 11:56:30 testing sudo[28763]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:30 testing sudo[28754]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 11:56:30 testing sudo[28754]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing sudo[28763]: pam_unix(sudo:session): session closed for user root May 29 11:56:30 testing sudo[28747]: pam_unix(sudo:session): session closed for user root May 29 11:56:30 testing sudo[28754]: pam_unix(sudo:session): session closed for user root May 29 11:56:30 testing sudo[28778]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 29 11:56:30 testing sudo[28778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing sudo[28778]: pam_unix(sudo:session): session closed for user root May 29 11:56:30 testing volumio[6086]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 29 11:56:30 testing volumio[6086]: wlan0 Interface doesn't support scanning : Operation not supported May 29 11:56:30 testing volumio[6086]: info: Cannot use regular scanning, forcing with ap-force May 29 11:56:30 testing sudo[28798]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 29 11:56:30 testing sudo[28798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing sudo[28798]: pam_unix(sudo:session): session closed for user root May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:32 testing systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 29 11:56:32 testing dbus-daemon[534]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.45' (uid=0 pid=29140 comm="timedatectl show --property=NTPSynchronized --valu") May 29 11:56:32 testing systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 29 11:56:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:32 testing dbus-daemon[534]: [system] Successfully activated service 'org.freedesktop.timedate1' May 29 11:56:32 testing systemd[1]: Started systemd-timedated.service - Time & Date Service. May 29 11:56:32 testing setdatetime-helper.sh[29122]: Time is already synchronized. May 29 11:56:32 testing systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 29 11:56:32 testing systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 29 11:56:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:38 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:38 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:39 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:39 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:40 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:40 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:41 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:41 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:42 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:42 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 29 11:56:43 testing volumio[6086]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 29 11:56:43 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 29 11:56:43 testing volumio[6086]: info: Received Get System Version May 29 11:56:43 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 29 11:56:43 testing volumio[6086]: info: Received Get System Info May 29 11:56:43 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:56:43 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:56:43 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:56:43 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:43 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:43 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:43 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:44 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:44 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:45 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:45 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:46 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:46 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:47 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:47 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:48 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:48 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:49 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:49 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:50 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:50 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:51 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:51 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:52 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:52 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:56:52 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:56:52 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:56:52 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:52 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:56:52 testing volumio[6086]: verbose: New Socket.io Connection to 192.168.1.104:3000 from 192.168.1.161 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 May 29 11:56:52 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:53 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 29 11:56:53 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:53 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:53 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:56:54 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:56:54 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:56:54 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:54 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:54 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:54 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:55 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:55 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:56 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:56 testing volumio[6086]: verbose: New Socket.io Connection to 192.168.1.104:3000 from 192.168.1.161 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 May 29 11:56:56 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:56 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:56 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 29 11:56:56 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 29 11:56:56 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:56 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:56 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:56 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:56 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:56 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:56 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:56 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:56 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:56 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:56 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:56 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:56 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:57 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:57 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:57 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:57 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:57 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:57 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:57 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:57 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:57 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:57 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:57 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:57 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:57 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:57 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:58 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing sudo[2738]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 11:56:58 testing sudo[2738]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:58 testing sudo[2745]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 11:56:58 testing sudo[2745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:58 testing sudo[2738]: pam_unix(sudo:session): session closed for user root May 29 11:56:58 testing sudo[2745]: pam_unix(sudo:session): session closed for user root May 29 11:56:58 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:58 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:58 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:58 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:58 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing volumio[6086]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.161 UA: Mozilla/5.0 (Linux; Android 12; HD1901 Build/SKQ1.211113.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 29 11:56:58 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:58 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:58 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:58 testing sudo[2914]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 11:56:58 testing sudo[2914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:58 testing sudo[2914]: pam_unix(sudo:session): session closed for user root May 29 11:56:58 testing sudo[2920]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 11:56:58 testing sudo[2920]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:56:58 testing sudo[2920]: pam_unix(sudo:session): session closed for user root May 29 11:56:59 testing volumio[6086]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.161 UA: Mozilla/5.0 (Linux; Android 12; HD1901 Build/SKQ1.211113.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::volumioGetVisibleSources May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 29 11:56:59 testing volumio[6086]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 29 11:56:59 testing volumio[6086]: info: Received Get System Info May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:56:59 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:59 testing volumio[6086]: info: Listing playlists May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 29 11:56:59 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:56:59 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:56:59 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:00 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:00 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 29 11:57:00 testing volumio[6086]: info: Received Get System Info May 29 11:57:00 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:57:00 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:57:00 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:57:00 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:57:00 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:57:00 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 29 11:57:00 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 29 11:57:00 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:01 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:01 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:02 testing systemd[1]: systemd-timedated.service: Deactivated successfully. May 29 11:57:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:02 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:02 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:03 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:03 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::getUIConfigOnPlugin May 29 11:57:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 29 11:57:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 29 11:57:04 testing sudo[4249]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 29 11:57:04 testing sudo[4249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing sudo[4249]: pam_unix(sudo:session): session closed for user root May 29 11:57:04 testing sudo[4256]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 29 11:57:04 testing sudo[4256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing sudo[4274]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 29 11:57:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:04 testing sudo[4274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing sudo[4274]: pam_unix(sudo:session): session closed for user root May 29 11:57:04 testing sudo[4256]: pam_unix(sudo:session): session closed for user root May 29 11:57:04 testing sudo[4265]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 29 11:57:04 testing sudo[4265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 29 11:57:04 testing sudo[4265]: pam_unix(sudo:session): session closed for user root May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 29 11:57:04 testing sudo[4286]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 29 11:57:04 testing sudo[4286]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 29 11:57:04 testing volumio[6086]: info: Received Get System Info May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:57:04 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:57:04 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:57:04 testing sudo[4286]: pam_unix(sudo:session): session closed for user root May 29 11:57:04 testing sudo[4291]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 29 11:57:04 testing sudo[4291]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing sudo[4305]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 29 11:57:04 testing sudo[4305]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing sudo[4291]: pam_unix(sudo:session): session closed for user root May 29 11:57:04 testing sudo[4305]: pam_unix(sudo:session): session closed for user root May 29 11:57:04 testing volumio[6086]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 29 11:57:04 testing volumio[6086]: wlan0 Interface doesn't support scanning : Operation not supported May 29 11:57:04 testing volumio[6086]: info: Cannot use regular scanning, forcing with ap-force May 29 11:57:04 testing sudo[4321]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 29 11:57:04 testing sudo[4321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:04 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:04 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:05 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:05 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing sudo[4321]: pam_unix(sudo:session): session closed for user root May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:06 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:06 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:07 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:07 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:08 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:08 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:09 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:09 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:10 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:10 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:11 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:11 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:12 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:12 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:13 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:13 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:14 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:14 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:15 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:15 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:16 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:16 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 29 11:57:17 testing volumio[6086]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 29 11:57:17 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 29 11:57:17 testing volumio[6086]: info: Received Get System Version May 29 11:57:17 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 29 11:57:17 testing volumio[6086]: info: Received Get System Info May 29 11:57:17 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:57:17 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:57:17 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:57:17 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:57:17 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:17 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:17 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:18 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:18 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:19 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:19 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:20 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:20 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:21 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:21 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 29 11:57:22 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 29 11:57:22 testing volumio[6086]: info: Discovery: Getting this device information May 29 11:57:22 testing volumio[6086]: info: CoreCommandRouter::volumioGetState May 29 11:57:22 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:22 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:22 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:23 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:23 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:24 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:24 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:25 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:25 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:26 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:26 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:27 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:27 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:28 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:28 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings May 29 11:57:29 testing volumio[6086]: info: Saving new wireless network May 29 11:57:29 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:29 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:29 testing sudo[10222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf May 29 11:57:29 testing sudo[10222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:29 testing sudo[10222]: pam_unix(sudo:session): session closed for user root May 29 11:57:29 testing volumio[6086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart May 29 11:57:29 testing volumio[6086]: info: Discovery: Restarting Advertising due to device name change May 29 11:57:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:30 testing sudo[10239]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service May 29 11:57:30 testing sudo[10239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:30 testing systemd[1]: Starting wireless.service - Wireless Services... May 29 11:57:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:30 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:30 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:31 testing volumio[6086]: info: Discovery: A device disappeared from network May 29 11:57:31 testing volumio[6086]: info: Discovery: Device testing disappeared from network May 29 11:57:31 testing volumio[6086]: info: Discovery: A device disappeared from network May 29 11:57:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:31 testing volumio[6086]: info: Discovery: A device disappeared from network May 29 11:57:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:31 testing systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... May 29 11:57:31 testing dnsmasq[6117]: exiting on receipt of SIGTERM May 29 11:57:31 testing systemd[1]: dnsmasq.service: Deactivated successfully. May 29 11:57:31 testing systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. May 29 11:57:31 testing systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... May 29 11:57:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:31 testing systemd[1]: hostapd.service: Deactivated successfully. May 29 11:57:31 testing systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. May 29 11:57:31 testing systemd[1]: hostapd.service: Consumed 1.174s CPU time. May 29 11:57:31 testing sudo[10544]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 29 11:57:31 testing sudo[10544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 29 11:57:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:31 testing avahi-daemon[530]: Withdrawing address record for 192.168.211.1 on wlan0. May 29 11:57:31 testing avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 29 11:57:31 testing avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. May 29 11:57:31 testing sudo[10544]: pam_unix(sudo:session): session closed for user root May 29 11:57:31 testing sudo[10559]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 29 11:57:31 testing sudo[10559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 29 11:57:31 testing systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 29 11:57:31 testing systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 29 11:57:31 testing systemd[1]: welcome.service: Deactivated successfully. May 29 11:57:31 testing systemd[1]: Stopped welcome.service - Show a welcome message on console. May 29 11:57:31 testing systemd[1]: Stopping welcome.service - Show a welcome message on console... May 29 11:57:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:31 testing sudo[10559]: pam_unix(sudo:session): session closed for user root May 29 11:57:31 testing systemd[1]: Starting welcome.service - Show a welcome message on console... May 29 11:57:31 testing welcome[10571]: Resolved ip:[1] 192.168.1.104 May 29 11:57:31 testing systemd[1]: Finished welcome.service - Show a welcome message on console. May 29 11:57:31 testing systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 29 11:57:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:31 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:31 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:32 testing sudo[10640]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 29 11:57:32 testing sudo[10640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:32 testing kernel: rtl8192cu: MAC auto ON okay! May 29 11:57:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:32 testing kernel: rtl8192cu: Tx queue select: 0x05 May 29 11:57:32 testing sudo[10640]: pam_unix(sudo:session): session closed for user root May 29 11:57:32 testing sudo[10671]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 29 11:57:32 testing sudo[10671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:32 testing sudo[10671]: pam_unix(sudo:session): session closed for user root May 29 11:57:32 testing sudo[10698]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 29 11:57:32 testing sudo[10698]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:32 testing sudo[10698]: pam_unix(sudo:session): session closed for user root May 29 11:57:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:32 testing sudo[10710]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 29 11:57:32 testing sudo[10710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:32 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:32 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:33 testing sudo[10710]: pam_unix(sudo:session): session closed for user root May 29 11:57:33 testing sudo[10980]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 29 11:57:33 testing sudo[10980]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:33 testing sudo[10980]: pam_unix(sudo:session): session closed for user root May 29 11:57:33 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:33 testing sudo[10990]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CA May 29 11:57:33 testing sudo[10990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:34 testing sudo[10990]: pam_unix(sudo:session): session closed for user root May 29 11:57:34 testing sudo[11022]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 29 11:57:34 testing sudo[11022]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 29 11:57:34 testing sudo[11022]: pam_unix(sudo:session): session closed for user root May 29 11:57:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:34 testing sudo[11036]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 29 11:57:34 testing sudo[11036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 29 11:57:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:34 testing sudo[11036]: pam_unix(sudo:session): session closed for user root May 29 11:57:34 testing wpa_supplicant[11061]: Successfully initialized wpa_supplicant May 29 11:57:34 testing kernel: rtl8192cu: MAC auto ON okay! May 29 11:57:34 testing sudo[11065]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 29 11:57:34 testing sudo[11065]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 29 11:57:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:34 testing sudo[11065]: pam_unix(sudo:session): session closed for user root May 29 11:57:34 testing kernel: rtl8192cu: Tx queue select: 0x05 May 29 11:57:34 testing dhcpcd[638]: control_free: No such file or directory May 29 11:57:34 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:34 testing dhcpcd[638]: ps_ctl_dispatch: cannot handle another client May 29 11:57:34 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:34 testing volumio[6086]: info: Discovery: Started advertising with name: testing May 29 11:57:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:35 testing sudo[11197]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 29 11:57:35 testing sudo[11197]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:35 testing sudo[11197]: pam_unix(sudo:session): session closed for user root May 29 11:57:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:35 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:35 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:35 testing volumio[6086]: compat.c: read() failed: Resource temporarily unavailable May 29 11:57:35 testing volumio[6086]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 11:57:35 testing volumio[6086]: Error: dns service error: unknown May 29 11:57:35 testing volumio[6086]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 29 11:57:35 testing volumio[6086]: errorCode: -65537 May 29 11:57:35 testing volumio[6086]: } May 29 11:57:35 testing volumio[6086]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 11:57:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:36 testing wpa_supplicant[11103]: wlan0: SME: Trying to authenticate with d6:6a:6a:3c:02:24 (SSID='DIRECT-okDCP-L2550DW_BR0224' freq=2457 MHz) May 29 11:57:36 testing kernel: wlan0: authenticate with d6:6a:6a:3c:02:24 (local address=e8:4e:06:20:2c:de) May 29 11:57:36 testing kernel: wlan0: send auth to d6:6a:6a:3c:02:24 (try 1/3) May 29 11:57:36 testing kernel: wlan0: authenticated May 29 11:57:36 testing wpa_supplicant[11103]: wlan0: Trying to associate with d6:6a:6a:3c:02:24 (SSID='DIRECT-okDCP-L2550DW_BR0224' freq=2457 MHz) May 29 11:57:36 testing kernel: wlan0: associate with d6:6a:6a:3c:02:24 (try 1/3) May 29 11:57:36 testing kernel: wlan0: RX AssocResp from d6:6a:6a:3c:02:24 (capab=0x431 status=0 aid=1) May 29 11:57:36 testing kernel: wlan0: AP has invalid WMM params (AIFSN=1 for ACI 2), will use 2 May 29 11:57:36 testing kernel: wlan0: AP has invalid WMM params (AIFSN=1 for ACI 3), will use 2 May 29 11:57:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:36 testing wpa_supplicant[11103]: wlan0: Associated with d6:6a:6a:3c:02:24 May 29 11:57:36 testing wpa_supplicant[11103]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 29 11:57:36 testing kernel: wlan0: associated May 29 11:57:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:36 testing sudo[11427]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 29 11:57:36 testing sudo[11427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:36 testing sudo[11427]: pam_unix(sudo:session): session closed for user root May 29 11:57:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:36 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:36 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:37 testing sudo[11567]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-29 11:56' May 29 11:57:37 testing sudo[11567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 29 11:57:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:37 testing dhcpcd[638]: wlan1: removing interface May 29 11:57:37 testing dhcpcd[638]: wlan1: waiting for carrier May 29 11:57:37 testing dhcpcd[638]: wlan1: removing interface PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="1da895bfdbb6eb90d965df32a25a3568df7c84ed" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu May 29 13:12:59 UTC 2025" VOLUMIO_VERSION="4.004" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2df63d74196e499fa1e34fb765df1cca"