2020-06-14 17:56:50 export USER=root 2020-06-14 17:56:50 ./build.sh Building TNC testing tools Building wlantest Building hs20-osu-client Building hostapd Building wpa_supplicant 2020-06-14 17:59:38 ./start.sh 2020-06-14 17:59:39 ./run-tests.py wpas_ctrl_log_level DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_log_level 1/1 Test: wpa_supplicant ctrl_iface LOG_LEVEL PASS wpas_ctrl_log_level 0.071743 2020-06-14 17:59:41.432802 passed all 1 test case(s) 2020-06-14 17:59:41 ./run-tests.py wpas_ctrl_many_networks DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_many_networks 1/1 Test: wpa_supplicant ctrl_iface LIST_NETWORKS with huge number of networks PASS wpas_ctrl_many_networks 6.239447 2020-06-14 17:59:48.023602 passed all 1 test case(s) 2020-06-14 17:59:48 ./run-tests.py wpas_ctrl_mgmt_tx DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_mgmt_tx 1/1 Test: wpa_supplicant ctrl_iface MGMT_TX PASS wpas_ctrl_mgmt_tx 0.090001 2020-06-14 17:59:48.524201 passed all 1 test case(s) 2020-06-14 17:59:48 ./run-tests.py wpas_ctrl_mib DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_mib 1/1 Test: wpa_supplicant ctrl_iface MIB PASS wpas_ctrl_mib 0.077825 2020-06-14 17:59:49.059303 passed all 1 test case(s) 2020-06-14 17:59:49 ./run-tests.py wpas_ctrl_misc DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_misc 1/1 Test: wpa_supplicant ctrl_iface and miscellaneous commands PASS wpas_ctrl_misc 0.066115 2020-06-14 17:59:49.677775 passed all 1 test case(s) 2020-06-14 17:59:49 ./run-tests.py wpas_ctrl_network DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_network 1/1 Test: wpa_supplicant ctrl_iface network set/get PASS wpas_ctrl_network 0.130372 2020-06-14 17:59:50.204219 passed all 1 test case(s) 2020-06-14 17:59:50 ./run-tests.py wpas_ctrl_network_oom DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_network_oom 1/1 Test: wpa_supplicant ctrl_iface network OOM in string parsing PASS wpas_ctrl_network_oom 0.153749 2020-06-14 17:59:50.855429 passed all 1 test case(s) 2020-06-14 17:59:50 ./run-tests.py wpas_ctrl_nfc_get_handover DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_nfc_get_handover 1/1 Test: wpa_supplicant ctrl_iface NFC_GET_HANDOVER PASS wpas_ctrl_nfc_get_handover 0.102695 2020-06-14 17:59:51.363619 passed all 1 test case(s) 2020-06-14 17:59:51 ./run-tests.py wpas_ctrl_nfc_report_handover DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_nfc_report_handover 1/1 Test: wpa_supplicant ctrl_iface NFC_REPORT_HANDOVER PASS wpas_ctrl_nfc_report_handover 0.086908 2020-06-14 17:59:51.978552 passed all 1 test case(s) 2020-06-14 17:59:52 ./run-tests.py wpas_ctrl_nfc_tag_read DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_nfc_tag_read 1/1 Test: wpa_supplicant ctrl_iface WPS_NFC_TAG_READ PASS wpas_ctrl_nfc_tag_read 0.08809 2020-06-14 17:59:52.501647 passed all 1 test case(s) 2020-06-14 17:59:52 ./run-tests.py wpas_ctrl_oom DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_oom 1/1 Test: Various wpa_supplicant ctrl_iface OOM cases PASS wpas_ctrl_oom 0.278042 2020-06-14 17:59:53.216545 passed all 1 test case(s) 2020-06-14 17:59:53 ./run-tests.py wpas_ctrl_p2p_listen_offload DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_p2p_listen_offload 1/1 Test: wpa_supplicant P2P_LO_START and P2P_LO_STOP commands PASS wpas_ctrl_p2p_listen_offload 0.077406 2020-06-14 17:59:53.699673 passed all 1 test case(s) 2020-06-14 17:59:53 ./run-tests.py wpas_ctrl_pno DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_pno 1/1 Test: wpa_supplicant ctrl_iface pno PASS wpas_ctrl_pno 0.111449 2020-06-14 17:59:54.318632 passed all 1 test case(s) 2020-06-14 17:59:54 ./run-tests.py wpas_ctrl_preauth DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_preauth 1/1 Test: wpa_supplicant ctrl_iface preauth PASS wpas_ctrl_preauth 0.082565 2020-06-14 17:59:54.870775 passed all 1 test case(s) 2020-06-14 17:59:54 ./run-tests.py wpas_ctrl_roam DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_roam 1/1 Test: wpa_supplicant ctrl_iface ROAM error cases Starting AP wlan3 Connect STA wlan0 to AP PASS wpas_ctrl_roam 0.402048 2020-06-14 17:59:55.654794 passed all 1 test case(s) 2020-06-14 17:59:55 ./run-tests.py wpas_ctrl_rsp DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_rsp 1/1 Test: wpa_supplicant ctrl_iface CTRL-RSP- PASS wpas_ctrl_rsp 0.073325 2020-06-14 17:59:56.155943 passed all 1 test case(s) 2020-06-14 17:59:56 ./run-tests.py wpas_ctrl_sched_scan_plans DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_sched_scan_plans 1/1 Test: wpa_supplicant sched_scan_plans parsing PASS wpas_ctrl_sched_scan_plans 0.075234 2020-06-14 17:59:56.607075 passed all 1 test case(s) 2020-06-14 17:59:56 ./run-tests.py wpas_ctrl_set DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_set 1/1 Test: wpa_supplicant ctrl_iface SET PASS wpas_ctrl_set 0.113484 2020-06-14 17:59:57.136898 passed all 1 test case(s) 2020-06-14 17:59:57 ./run-tests.py wpas_ctrl_set_lci_errors DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_set_lci_errors 1/1 Test: wpa_supplicant SET lci error cases PASS wpas_ctrl_set_lci_errors 0.081711 2020-06-14 17:59:57.725226 passed all 1 test case(s) 2020-06-14 17:59:57 ./run-tests.py wpas_ctrl_set_radio_disabled DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_set_radio_disabled 1/1 Test: wpa_supplicant SET radio_disabled PASS wpas_ctrl_set_radio_disabled 0.074892 2020-06-14 17:59:58.261331 passed all 1 test case(s) 2020-06-14 17:59:58 ./run-tests.py wpas_ctrl_set_sched_scan_relative_rssi DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_set_sched_scan_relative_rssi 1/1 Test: wpa_supplicant SET relative RSSI PASS wpas_ctrl_set_sched_scan_relative_rssi 0.068788 2020-06-14 17:59:58.705071 passed all 1 test case(s) 2020-06-14 17:59:58 ./run-tests.py wpas_ctrl_set_tdls_trigger_control DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_set_tdls_trigger_control 1/1 Test: wpa_supplicant SET tdls_trigger_control PASS wpas_ctrl_set_tdls_trigger_control 0.071261 2020-06-14 17:59:59.158042 passed all 1 test case(s) 2020-06-14 17:59:59 ./run-tests.py wpas_ctrl_set_uapsd DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_set_uapsd 1/1 Test: wpa_supplicant ctrl_iface SET uapsd PASS wpas_ctrl_set_uapsd 0.071673 2020-06-14 17:59:59.620766 passed all 1 test case(s) 2020-06-14 17:59:59 ./run-tests.py wpas_ctrl_set_wps_params DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_set_wps_params 1/1 Test: wpa_supplicant ctrl_iface SET config_methods PASS wpas_ctrl_set_wps_params 0.074883 2020-06-14 18:00:00.106064 passed all 1 test case(s) 2020-06-14 18:00:00 ./run-tests.py wpas_ctrl_signal_monitor DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_signal_monitor 1/1 Test: wpa_supplicant SIGNAL_MONITOR command Starting AP wlan3 Connect STA wlan0 to AP Connect STA wlan1 to AP Connect STA wlan2 to AP PASS wpas_ctrl_signal_monitor 1.288656 2020-06-14 18:00:01.956504 passed all 1 test case(s) 2020-06-14 18:00:02 ./run-tests.py wpas_ctrl_socket_full DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_socket_full 1/1 Test: wpa_supplicant control socket and full send buffer PASS wpas_ctrl_socket_full 1.08718 2020-06-14 18:00:03.526361 passed all 1 test case(s) 2020-06-14 18:00:03 ./run-tests.py wpas_ctrl_suspend_resume DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_suspend_resume 1/1 Test: wpa_supplicant SUSPEND/RESUME PASS wpas_ctrl_suspend_resume 5.309572 2020-06-14 18:00:09.256334 passed all 1 test case(s) 2020-06-14 18:00:09 ./run-tests.py wpas_ctrl_tdls_chan_switch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_tdls_chan_switch 1/1 Test: wpa_supplicant ctrl_iface tdls_chan_switch error cases PASS wpas_ctrl_tdls_chan_switch 0.0554 2020-06-14 18:00:09.689098 passed all 1 test case(s) 2020-06-14 18:00:09 ./run-tests.py wpas_ctrl_tdls_discover DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_tdls_discover 1/1 Test: wpa_supplicant ctrl_iface tdls_discover PASS wpas_ctrl_tdls_discover 0.069771 2020-06-14 18:00:10.124198 passed all 1 test case(s) 2020-06-14 18:00:10 ./run-tests.py wpas_ctrl_vendor DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_vendor 1/1 Test: wpa_supplicant ctrl_iface VENDOR PASS wpas_ctrl_vendor 0.072952 2020-06-14 18:00:10.576442 passed all 1 test case(s) 2020-06-14 18:00:10 ./run-tests.py wpas_ctrl_vendor_elem DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_vendor_elem 1/1 Test: wpa_supplicant ctrl_iface VENDOR_ELEM PASS wpas_ctrl_vendor_elem 0.078766 2020-06-14 18:00:11.021361 passed all 1 test case(s) 2020-06-14 18:00:11 ./run-tests.py wpas_ctrl_wait DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_wait 1/1 Test: wpa_supplicant control interface wait for client Start wpa_supplicant: ['../../wpa_supplicant/wpa_supplicant', '-BdddW', '-P', 'logs/current/wpas_ctrl_wait.pid-wpas', '-f', 'logs/current/wpas_ctrl_wait.log-wpas', '-Dnl80211', '-c', 'logs/current/wpas_ctrl_wait.conf', '-i', 'wlan7', '-T'] PASS wpas_ctrl_wait 0.357484 2020-06-14 18:00:11.766636 passed all 1 test case(s) 2020-06-14 18:00:11 ./run-tests.py wpas_ctrl_wps_errors DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_ctrl_wps_errors 1/1 Test: wpa_supplicant ctrl_iface WPS error cases PASS wpas_ctrl_wps_errors 0.076429 2020-06-14 18:00:12.247944 passed all 1 test case(s) 2020-06-14 18:00:12 ./run-tests.py wpas_mesh_ctrl DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_ctrl 1/1 Test: wpa_supplicant ctrl_iface mesh command error cases PASS wpas_mesh_ctrl 0.07261 2020-06-14 18:00:12.783658 passed all 1 test case(s) 2020-06-14 18:00:12 ./run-tests.py wpas_mesh_dynamic_interface DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_dynamic_interface 1/1 Test: wpa_supplicant mesh with dynamic interface mesh0 address 42:00:00:00:00:00 mesh-wlan1-0 address 42:00:00:00:01:00 dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 523, in main t(dev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 727, in test_wpas_mesh_dynamic_interface check_mesh_joined_connected([wpas0, wpas1], connectivity=True) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_dynamic_interface 6.52509 2020-06-14 18:00:19.702353 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_dynamic_interface 2020-06-14 18:00:19 ./run-tests.py wpas_mesh_dynamic_interface_remove DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_dynamic_interface_remove 1/1 Test: wpa_supplicant mesh with dynamic interface and removal mesh5 address 42:00:00:00:05:00 dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 523, in main t(dev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 789, in test_wpas_mesh_dynamic_interface_remove check_mesh_joined_connected([wpas5, dev[0]], connectivity=True) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_dynamic_interface_remove 6.713899 2020-06-14 18:00:26.839319 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_dynamic_interface_remove 2020-06-14 18:00:27 ./run-tests.py wpas_mesh_gate_forwarding DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_gate_forwarding 1/1 Test: Mesh forwards traffic to unknown sta to mesh gates dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 519, in main t(dev, apdev, params) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1421, in test_wpas_mesh_gate_forwarding hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_gate_forwarding 6.432523 2020-06-14 18:00:33.871202 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_gate_forwarding 2020-06-14 18:00:33 ./run-tests.py wpas_mesh_group_added DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_group_added 1/1 Test: wpa_supplicant MESH group add PASS wpas_mesh_group_added 0.281052 2020-06-14 18:00:34.607981 passed all 1 test case(s) 2020-06-14 18:00:34 ./run-tests.py wpas_mesh_group_remove DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_group_remove 1/1 Test: wpa_supplicant MESH group remove PASS wpas_mesh_group_remove 0.271618 2020-06-14 18:00:35.324140 passed all 1 test case(s) 2020-06-14 18:00:35 ./run-tests.py wpas_mesh_max_peering DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_max_peering 1/1 Test: Mesh max peering limit one: [3, 3, 2] zero: [0, 0, 0] one: [1, 3, 2] zero: [2, 0, 0] PASS wpas_mesh_max_peering 5.404295 2020-06-14 18:00:41.200672 passed all 1 test case(s) 2020-06-14 18:00:41 ./run-tests.py wpas_mesh_mode_scan DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_mode_scan 1/1 Test: wpa_supplicant MESH scan support PASS wpas_mesh_mode_scan 0.497022 2020-06-14 18:00:42.205334 passed all 1 test case(s) 2020-06-14 18:00:42 ./run-tests.py wpas_mesh_open DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open 1/1 Test: wpa_supplicant open MESH network connectivity dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 521, in main t(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 209, in test_wpas_mesh_open check_mesh_joined_connected(dev, connectivity=True) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_open 6.456794 2020-06-14 18:00:49.172407 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_open 2020-06-14 18:00:49 ./run-tests.py wpas_mesh_open_5ghz DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open_5ghz 1/1 Test: wpa_supplicant open MESH network on 5 GHz band dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 521, in main t(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 907, in test_wpas_mesh_open_5ghz _test_wpas_mesh_open_5ghz(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 927, in _test_wpas_mesh_open_5ghz check_mesh_joined_connected(dev, connectivity=True) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_open_5ghz 6.739668 2020-06-14 18:00:56.471358 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_open_5ghz 2020-06-14 18:00:56 ./run-tests.py wpas_mesh_open_5ghz_coex DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open_5ghz_coex 1/1 Test: Mesh network on 5 GHz band and 20/40 coex change Starting AP wlan3 PASS wpas_mesh_open_5ghz_coex 1.860467 2020-06-14 18:00:58.781647 passed all 1 test case(s) 2020-06-14 18:00:58 ./run-tests.py wpas_mesh_open_ht40 DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open_ht40 1/1 Test: Mesh and HT40 support difference dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 521, in main t(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 990, in test_wpas_mesh_open_ht40 _test_wpas_mesh_open_ht40(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1021, in _test_wpas_mesh_open_ht40 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_open_ht40 6.851927 2020-06-14 18:01:06.073905 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_open_ht40 2020-06-14 18:01:06 ./run-tests.py wpas_mesh_open_no_auto DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open_no_auto 1/1 Test: wpa_supplicant open MESH network connectivity dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 521, in main t(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 244, in test_wpas_mesh_open_no_auto check_mesh_joined_connected(dev, connectivity=True, timeout0=30) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_open_no_auto 6.03286 2020-06-14 18:01:12.695600 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_open_no_auto 2020-06-14 18:01:12 ./run-tests.py wpas_mesh_open_vht20 DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open_vht20 1/1 Test: wpa_supplicant open MESH network on VHT 20 MHz channel dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 521, in main t(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1090, in test_wpas_mesh_open_vht20 _test_wpas_mesh_open_vht20(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1110, in _test_wpas_mesh_open_vht20 check_mesh_joined_connected(dev, connectivity=True) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_open_vht20 5.799745 2020-06-14 18:01:18.968405 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_open_vht20 2020-06-14 18:01:19 ./run-tests.py wpas_mesh_open_vht40 DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open_vht40 1/1 Test: wpa_supplicant open MESH network on VHT 40 MHz channel dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 521, in main t(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1038, in test_wpas_mesh_open_vht40 _test_wpas_mesh_open_vht40(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1058, in _test_wpas_mesh_open_vht40 check_mesh_joined_connected(dev, connectivity=True) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_open_vht40 5.761865 2020-06-14 18:01:25.144483 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_open_vht40 2020-06-14 18:01:25 ./run-tests.py wpas_mesh_open_vht_80p80 DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_open_vht_80p80 1/1 Test: wpa_supplicant open MESH network on VHT 80+80 MHz channel dev1->dev2 unicast data delivery failed Traceback (most recent call last): File "./run-tests.py", line 521, in main t(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1134, in test_wpas_mesh_open_vht_80p80 _test_wpas_mesh_open_vht_80p80(dev, apdev) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 1154, in _test_wpas_mesh_open_vht_80p80 check_mesh_joined_connected(dev, connectivity=True) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 120, in check_mesh_joined_connected check_mesh_connected2(dev, timeout0=timeout0, connectivity=connectivity) File "/lkp/benchmarks/hwsim/tests/hwsim/test_wpas_mesh.py", line 116, in check_mesh_connected2 hwsim_utils.test_connectivity(dev[0], dev[1]) File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 195, in test_connectivity raise Exception(last_err) Exception: dev1->dev2 unicast data delivery failed FAIL wpas_mesh_open_vht_80p80 6.558644 2020-06-14 18:01:32.273367 passed 0 test case(s) skipped 0 test case(s) failed tests: wpas_mesh_open_vht_80p80 2020-06-14 18:01:32 ./run-tests.py wpas_mesh_password_mismatch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_password_mismatch 1/1 Test: Mesh network and one device with mismatching password PASS wpas_mesh_password_mismatch 22.690481 2020-06-14 18:01:55.427175 passed all 1 test case(s) 2020-06-14 18:01:55 ./run-tests.py wpas_mesh_password_mismatch_retry --long DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_password_mismatch_retry 1/1 Test: Mesh password mismatch and retry [long] PASS wpas_mesh_password_mismatch_retry 64.9718 2020-06-14 18:03:00.817034 passed all 1 test case(s) 2020-06-14 18:03:00 ./run-tests.py wpas_mesh_peer_connected DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_peer_connected 1/1 Test: wpa_supplicant MESH peer connected PASS wpas_mesh_peer_connected 0.511306 2020-06-14 18:03:01.833293 passed all 1 test case(s) 2020-06-14 18:03:01 ./run-tests.py wpas_mesh_peer_disconnected DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_peer_disconnected 1/1 Test: wpa_supplicant MESH peer disconnected PASS wpas_mesh_peer_disconnected 1.040667 2020-06-14 18:03:03.328856 passed all 1 test case(s) 2020-06-14 18:03:03 ./run-tests.py wpas_mesh_pmksa_caching DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_pmksa_caching 1/1 Test: Secure mesh network and PMKSA caching PASS wpas_mesh_pmksa_caching 1.66955 2020-06-14 18:03:05.498051 passed all 1 test case(s) 2020-06-14 18:03:05 ./run-tests.py wpas_mesh_pmksa_caching2 DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_pmksa_caching2 1/1 Test: Secure mesh network and PMKSA caching with no_auto_peer=1 PASS wpas_mesh_pmksa_caching2 2.710961 2020-06-14 18:03:08.601612 passed all 1 test case(s) 2020-06-14 18:03:08 ./run-tests.py wpas_mesh_pmksa_caching_ext DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_pmksa_caching_ext 1/1 Test: Secure mesh network and PMKSA caching and external storage MESH_PMKSA_GET: 02:00:00:00:00:00 dec5074d9e42a612b4ee4ece2f3e13ad 8f652c24fbda3eaad1cd6100f923276cd31ed7316002ded22935285b1361bb59 43200 MESH_PMKSA_GET: 02:00:00:00:00:00 dec5074d9e42a612b4ee4ece2f3e13ad 8f652c24fbda3eaad1cd6100f923276cd31ed7316002ded22935285b1361bb59 43200 PASS wpas_mesh_pmksa_caching_ext 2.531838 2020-06-14 18:03:11.656111 passed all 1 test case(s) 2020-06-14 18:03:11 ./run-tests.py wpas_mesh_pmksa_caching_no_match DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_pmksa_caching_no_match 1/1 Test: Secure mesh network and PMKSA caching with no PMKID match PASS wpas_mesh_pmksa_caching_no_match 3.544484 2020-06-14 18:03:15.695306 passed all 1 test case(s) 2020-06-14 18:03:15 ./run-tests.py wpas_mesh_reconnect DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_reconnect 1/1 Test: Secure mesh network plink counting during reconnection PASS wpas_mesh_reconnect 4.583955 2020-06-14 18:03:20.764390 passed all 1 test case(s) 2020-06-14 18:03:20 ./run-tests.py wpas_mesh_secure DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_secure 1/1 Test: wpa_supplicant secure MESH network connectivity PASS wpas_mesh_secure 0.623773 2020-06-14 18:03:21.815834 passed all 1 test case(s) 2020-06-14 18:03:21 ./run-tests.py wpas_mesh_secure_dropped_frame DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_secure_dropped_frame 1/1 Test: Secure mesh network connectivity when the first plink Open is dropped Drop the first Action frame PASS wpas_mesh_secure_dropped_frame 1.563686 2020-06-14 18:03:23.940471 passed all 1 test case(s) 2020-06-14 18:03:24 ./run-tests.py wpas_mesh_secure_no_auto DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_secure_no_auto 1/1 Test: wpa_supplicant secure MESH network connectivity PASS wpas_mesh_secure_no_auto 1.556699 2020-06-14 18:03:25.948117 passed all 1 test case(s) 2020-06-14 18:03:26 ./run-tests.py wpas_mesh_secure_sae_group_mismatch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_secure_sae_group_mismatch 1/1 Test: wpa_supplicant secure MESH and SAE group mismatch PASS wpas_mesh_secure_sae_group_mismatch 2.822848 2020-06-14 18:03:29.249685 passed all 1 test case(s) 2020-06-14 18:03:29 ./run-tests.py wpas_mesh_secure_sae_group_negotiation DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_secure_sae_group_negotiation 1/1 Test: wpa_supplicant secure MESH and SAE group negotiation PASS wpas_mesh_secure_sae_group_negotiation 2.318692 2020-06-14 18:03:32.043443 passed all 1 test case(s) 2020-06-14 18:03:32 ./run-tests.py wpas_mesh_secure_sae_missing_password DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_secure_sae_missing_password 1/1 Test: wpa_supplicant secure MESH and missing SAE password PASS wpas_mesh_secure_sae_missing_password 0.293658 2020-06-14 18:03:32.790900 passed all 1 test case(s) 2020-06-14 18:03:32 ./run-tests.py wpas_mesh_secure_sae_password DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wpas_mesh_secure_sae_password 1/1 Test: wpa_supplicant secure mesh using sae_password PASS wpas_mesh_secure_sae_password 0.83969 2020-06-14 18:03:34.048655 passed all 1 test case(s) 2020-06-14 18:03:34 ./run-tests.py wps_config_methods DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_config_methods 1/1 Test: WPS config method update PASS wps_config_methods 0.196106 2020-06-14 18:03:34.683411 passed all 1 test case(s) 2020-06-14 18:03:34 ./run-tests.py wps_ext DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext 1/1 Test: WPS against external implementation Starting AP wlan3 PASS wps_ext 0.947353 2020-06-14 18:03:36.040421 passed all 1 test case(s) 2020-06-14 18:03:36 ./run-tests.py wps_ext_ap_settings_m2d DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_ap_settings_m2d 1/1 Test: WPS and AP Settings: M2D Starting AP wlan3 PASS wps_ext_ap_settings_m2d 0.665289 2020-06-14 18:03:37.185629 passed all 1 test case(s) 2020-06-14 18:03:37 ./run-tests.py wps_ext_ap_settings_mac_addr_mismatch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_ap_settings_mac_addr_mismatch 1/1 Test: WPS and AP Settings: MAC Address mismatch Starting AP wlan3 PASS wps_ext_ap_settings_mac_addr_mismatch 0.671528 2020-06-14 18:03:38.322365 passed all 1 test case(s) 2020-06-14 18:03:38 ./run-tests.py wps_ext_ap_settings_mac_addr_missing DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_ap_settings_mac_addr_missing 1/1 Test: WPS and AP Settings: missing MAC Address Starting AP wlan3 PASS wps_ext_ap_settings_mac_addr_missing 0.659086 2020-06-14 18:03:39.436188 passed all 1 test case(s) 2020-06-14 18:03:39 ./run-tests.py wps_ext_ap_settings_missing DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_ap_settings_missing 1/1 Test: WPS and AP Settings: missing Starting AP wlan3 PASS wps_ext_ap_settings_missing 0.735377 2020-06-14 18:03:40.595379 passed all 1 test case(s) 2020-06-14 18:03:40 ./run-tests.py wps_ext_ap_settings_reject_encr_type DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_ap_settings_reject_encr_type 1/1 Test: WPS and AP Settings: reject Encr Type Starting AP wlan3 PASS wps_ext_ap_settings_reject_encr_type 0.710602 2020-06-14 18:03:41.765148 passed all 1 test case(s) 2020-06-14 18:03:41 ./run-tests.py wps_ext_ap_settings_success DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_ap_settings_success 1/1 Test: WPS and AP Settings: success Starting AP wlan3 PASS wps_ext_ap_settings_success 0.741883 2020-06-14 18:03:42.981068 passed all 1 test case(s) 2020-06-14 18:03:43 ./run-tests.py wps_ext_cred_proto_auth_type_missing DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_auth_type_missing 1/1 Test: WPS and Credential: Auth Type missing Starting AP wlan3 PASS wps_ext_cred_proto_auth_type_missing 0.656512 2020-06-14 18:03:44.052819 passed all 1 test case(s) 2020-06-14 18:03:44 ./run-tests.py wps_ext_cred_proto_encr_type_missing DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_encr_type_missing 1/1 Test: WPS and Credential: Encr Type missing Starting AP wlan3 PASS wps_ext_cred_proto_encr_type_missing 0.716609 2020-06-14 18:03:45.244534 passed all 1 test case(s) 2020-06-14 18:03:45 ./run-tests.py wps_ext_cred_proto_invalid_encr_type DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_invalid_encr_type 1/1 Test: WPS and Credential: Invalid Encr Type Starting AP wlan3 PASS wps_ext_cred_proto_invalid_encr_type 0.629314 2020-06-14 18:03:46.259480 passed all 1 test case(s) 2020-06-14 18:03:46 ./run-tests.py wps_ext_cred_proto_mac_addr_mismatch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_mac_addr_mismatch 1/1 Test: WPS and Credential: MAC Address mismatch Starting AP wlan3 PASS wps_ext_cred_proto_mac_addr_mismatch 0.867471 2020-06-14 18:03:47.537296 passed all 1 test case(s) 2020-06-14 18:03:47 ./run-tests.py wps_ext_cred_proto_mac_addr_missing DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_mac_addr_missing 1/1 Test: WPS and Credential: MAC Address missing Starting AP wlan3 PASS wps_ext_cred_proto_mac_addr_missing 0.613554 2020-06-14 18:03:48.562131 passed all 1 test case(s) 2020-06-14 18:03:48 ./run-tests.py wps_ext_cred_proto_missing_cred DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_missing_cred 1/1 Test: WPS and Credential: Missing Credential Starting AP wlan3 PASS wps_ext_cred_proto_missing_cred 0.734308 2020-06-14 18:03:49.845080 passed all 1 test case(s) 2020-06-14 18:03:49 ./run-tests.py wps_ext_cred_proto_network_key_missing DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_network_key_missing 1/1 Test: WPS and Credential: Network Key missing Starting AP wlan3 PASS wps_ext_cred_proto_network_key_missing 0.634362 2020-06-14 18:03:50.966353 passed all 1 test case(s) 2020-06-14 18:03:51 ./run-tests.py wps_ext_cred_proto_network_key_missing_open DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_network_key_missing_open 1/1 Test: WPS and Credential: Network Key missing (open) Starting AP wlan3 PASS wps_ext_cred_proto_network_key_missing_open 0.772729 2020-06-14 18:03:52.221496 passed all 1 test case(s) 2020-06-14 18:03:52 ./run-tests.py wps_ext_cred_proto_ssid_missing DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_ssid_missing 1/1 Test: WPS and Credential: SSID missing Starting AP wlan3 PASS wps_ext_cred_proto_ssid_missing 0.577392 2020-06-14 18:03:53.218618 passed all 1 test case(s) 2020-06-14 18:03:53 ./run-tests.py wps_ext_cred_proto_ssid_zero_len DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_ssid_zero_len 1/1 Test: WPS and Credential: Zero-length SSID Starting AP wlan3 PASS wps_ext_cred_proto_ssid_zero_len 0.546751 2020-06-14 18:03:54.148818 passed all 1 test case(s) 2020-06-14 18:03:54 ./run-tests.py wps_ext_cred_proto_success DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_success 1/1 Test: WPS and Credential: success Starting AP wlan3 PASS wps_ext_cred_proto_success 0.70967 2020-06-14 18:03:55.241358 passed all 1 test case(s) 2020-06-14 18:03:55 ./run-tests.py wps_ext_cred_proto_zero_padding DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_cred_proto_zero_padding 1/1 Test: WPS and Credential: zeropadded attributes Starting AP wlan3 PASS wps_ext_cred_proto_zero_padding 0.59357 2020-06-14 18:03:56.128043 passed all 1 test case(s) 2020-06-14 18:03:56 ./run-tests.py wps_ext_kwa_proto_data_after_kwa DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_kwa_proto_data_after_kwa 1/1 Test: WPS and KWA error: Data after KWA Starting AP wlan3 PASS wps_ext_kwa_proto_data_after_kwa 0.420024 2020-06-14 18:03:56.809730 passed all 1 test case(s) 2020-06-14 18:03:56 ./run-tests.py wps_ext_kwa_proto_kwa_mismatch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_kwa_proto_kwa_mismatch 1/1 Test: WPS and KWA error: KWA mismatch Starting AP wlan3 PASS wps_ext_kwa_proto_kwa_mismatch 0.386483 2020-06-14 18:03:57.489096 passed all 1 test case(s) 2020-06-14 18:03:57 ./run-tests.py wps_ext_kwa_proto_no_kwa DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_kwa_proto_no_kwa 1/1 Test: WPS and KWA error: No KWA attribute Starting AP wlan3 PASS wps_ext_kwa_proto_no_kwa 0.365446 2020-06-14 18:03:58.097574 passed all 1 test case(s) 2020-06-14 18:03:58 ./run-tests.py wps_ext_m1_invalid DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m1_invalid 1/1 Test: WPS proto: M1 failing parsing Starting AP wlan3 PASS wps_ext_m1_invalid 0.471097 2020-06-14 18:03:58.937305 passed all 1 test case(s) 2020-06-14 18:03:59 ./run-tests.py wps_ext_m1_missing_msg_type DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m1_missing_msg_type 1/1 Test: WPS proto: M1 missing Msg Type Starting AP wlan3 PASS wps_ext_m1_missing_msg_type 0.473668 2020-06-14 18:03:59.808648 passed all 1 test case(s) 2020-06-14 18:03:59 ./run-tests.py wps_ext_m1_pubkey_oom DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m1_pubkey_oom 1/1 Test: WPS proto: M1 PubKey OOM Starting AP wlan3 PASS wps_ext_m1_pubkey_oom 0.416792 2020-06-14 18:04:00.598178 passed all 1 test case(s) 2020-06-14 18:04:00 ./run-tests.py wps_ext_m1_workaround DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m1_workaround 1/1 Test: WPS proto: M1 Manufacturer/Model workaround Starting AP wlan3 PASS wps_ext_m1_workaround 0.339205 2020-06-14 18:04:01.194047 passed all 1 test case(s) 2020-06-14 18:04:01 ./run-tests.py wps_ext_m2_ack DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_ack 1/1 Test: WPS proto: M2 followed by ACK Starting AP wlan3 PASS wps_ext_m2_ack 0.508948 2020-06-14 18:04:01.961616 passed all 1 test case(s) 2020-06-14 18:04:02 ./run-tests.py wps_ext_m2_ack_e_nonce_mismatch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_ack_e_nonce_mismatch 1/1 Test: WPS proto: M2 followed by ACK with e-nonce mismatch Starting AP wlan3 PASS wps_ext_m2_ack_e_nonce_mismatch 0.536112 2020-06-14 18:04:02.861424 passed all 1 test case(s) 2020-06-14 18:04:02 ./run-tests.py wps_ext_m2_ack_invalid DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_ack_invalid 1/1 Test: WPS proto: M2 followed by invalid ACK Starting AP wlan3 PASS wps_ext_m2_ack_invalid 0.525453 2020-06-14 18:04:03.759168 passed all 1 test case(s) 2020-06-14 18:04:03 ./run-tests.py wps_ext_m2_ack_invalid_msg_type DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_ack_invalid_msg_type 1/1 Test: WPS proto: M2 followed by ACK with invalid Msg Type Starting AP wlan3 PASS wps_ext_m2_ack_invalid_msg_type 0.459838 2020-06-14 18:04:04.600974 passed all 1 test case(s) 2020-06-14 18:04:04 ./run-tests.py wps_ext_m2_ack_no_msg_type DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_ack_no_msg_type 1/1 Test: WPS proto: M2 followed by ACK missing Msg Type Starting AP wlan3 PASS wps_ext_m2_ack_no_msg_type 0.499402 2020-06-14 18:04:05.367193 passed all 1 test case(s) 2020-06-14 18:04:05 ./run-tests.py wps_ext_m2_nack_e_nonce_mismatch DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_nack_e_nonce_mismatch 1/1 Test: WPS proto: M2 followed by NACK with e-nonce mismatch Starting AP wlan3 PASS wps_ext_m2_nack_e_nonce_mismatch 0.504323 2020-06-14 18:04:06.226236 passed all 1 test case(s) 2020-06-14 18:04:06 ./run-tests.py wps_ext_m2_nack_invalid DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_nack_invalid 1/1 Test: WPS proto: M2 followed by invalid NACK Starting AP wlan3 PASS wps_ext_m2_nack_invalid 0.511108 2020-06-14 18:04:07.001201 passed all 1 test case(s) 2020-06-14 18:04:07 ./run-tests.py wps_ext_m2_nack_invalid_msg_type DEV: wlan0: 02:00:00:00:00:00 DEV: wlan1: 02:00:00:00:01:00 DEV: wlan2: 02:00:00:00:02:00 APDEV: wlan3 APDEV: wlan4 START wps_ext_m2_nack_invalid_msg_type 1/1 Test: WPS proto: M2 followed by NACK with invalid Msg Type Starting AP wlan3 PASS wps_ext_m2_nack_invalid_msg_type 0.489192 2020-06-14 18:04:07.763840 passed all 1 test case(s) 2020-06-14 18:04:07 ./stop.sh 2020-06-14 18:04:09 ./start.sh channels=4 2020-06-14 18:04:09 ./stop.sh