2020-02-23 00:28:08 export USER=root
2020-02-23 00:28:08 ./build.sh
Building TNC testing tools
Building wlantest
Building hs20-osu-client
Building hostapd
Building wpa_supplicant
2020-02-23 00:59:42 ./start.sh
2020-02-23 00:59:50 	./run-tests.py grpform_no_wsc_done 
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 grpform_no_wsc_done 1/1
Test: P2P group formation with WSC-Done not sent
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Drop WSC_Done
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Drop WSC_Done
PASS grpform_no_wsc_done 32.398177 2020-02-23 01:00:45.637948
passed all 1 test case(s)
2020-02-23 01:00:46 	./run-tests.py grpform_not_ready 
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 grpform_not_ready 1/1
Test: Not ready for GO Negotiation (listen)
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan2: Trying to discover peer 02:00:00:00:00:00
PASS grpform_not_ready 8.184858 2020-02-23 01:00:58.767515
passed all 1 test case(s)
2020-02-23 01:00:59 	./run-tests.py grpform_not_ready2 
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 grpform_not_ready2 1/1
Test: Not ready for GO Negotiation (search)
wlan1: Trying to discover peer 02:00:00:00:00:00
Could not discover peer
Traceback (most recent call last):
  File "./run-tests.py", line 523, in main
    t(dev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_p2p_grpform.py", line 964, in test_grpform_not_ready2
    raise Exception("Could not discover peer")
Exception: Could not discover peer
FAIL grpform_not_ready2 21.037859 2020-02-23 01:01:24.456482
passed 0 test case(s)
skipped 0 test case(s)
failed tests: grpform_not_ready2
2020-02-23 01:01:25 	./run-tests.py grpform_pbc 
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 grpform_pbc 1/1
Test: P2P group formation using PBC and re-init GO Negotiation
Start GO negotiation wlan0 -> wlan1
wlan0: Trying to discover peer 02:00:00:00:01:00
go_neg_init_pbc thread caught an exception from p2p_go_neg_init: Peer 02:00:00:00:01:00 not found
GO Negotiation timed out
Traceback (most recent call last):
  File "./run-tests.py", line 523, in main
    t(dev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_p2p_grpform.py", line 143, in test_grpform_pbc
    [i_res, r_res] = go_neg_pbc(i_dev=dev[0], i_intent=15, r_dev=dev[1], r_intent=0)
  File "/lkp/benchmarks/hwsim/tests/hwsim/p2p_utils.py", line 339, in go_neg_pbc
    raise Exception("GO Negotiation timed out")
Exception: GO Negotiation timed out
FAIL grpform_pbc 21.989672 2020-02-23 01:01:51.000477
passed 0 test case(s)
skipped 0 test case(s)
failed tests: grpform_pbc
2020-02-23 01:01:51 	./run-tests.py grpform_pbc_multiple 
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 grpform_pbc_multiple 1/1
Test: P2P group formation using PBC multiple times in a row
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
PASS grpform_pbc_multiple 59.035589 2020-02-23 01:02:54.791608
passed all 1 test case(s)
2020-02-23 01:02:55 	./run-tests.py grpform_pbc_overlap 
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 grpform_pbc_overlap 1/1
Test: P2P group formation during PBC overlap
Starting AP wlan3
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Removing BSS wlan3
PASS grpform_pbc_overlap 11.007922 2020-02-23 01:03:10.402731
passed all 1 test case(s)
2020-02-23 01:03:11 	./run-tests.py grpform_pbc_overlap_group_iface 
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 grpform_pbc_overlap_group_iface 1/1
Test: P2P group formation during PBC overlap using group interfaces
Starting AP wlan3
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Removing BSS wlan3
PASS grpform_pbc_overlap_group_iface 11.6901 2020-02-23 01:03:26.295859
passed all 1 test case(s)
2020-02-23 01:03:26 	./run-tests.py grpform_pd 
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 grpform_pd 1/1
Test: P2P group formation with PD-before-GO-Neg workaround
Start GO negotiation wlan0 -> wlan1
wlan0: Trying to discover peer 02:00:00:00:01:00
wlan1: Trying to discover peer 02:00:00:00:00:00
Group formed
PASS grpform_pd 16.783065 2020-02-23 01:03:47.733615
passed all 1 test case(s)
2020-02-23 01:03:48 	./run-tests.py grpform_pd_no_probe_resp 
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 grpform_pd_no_probe_resp 1/1
Test: GO Negotiation after PD, but no Probe Response
wlan1: Trying to discover peer 02:00:00:00:00:00
Group formation timed out
Traceback (most recent call last):
  File "./run-tests.py", line 523, in main
    t(dev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_p2p_grpform.py", line 602, in test_grpform_pd_no_probe_resp
    raise Exception("Group formation timed out")
Exception: Group formation timed out
FAIL grpform_pd_no_probe_resp 18.414972 2020-02-23 01:04:10.764067
passed 0 test case(s)
skipped 0 test case(s)
failed tests: grpform_pd_no_probe_resp
2020-02-23 01:04:11 	./run-tests.py grpform_per_sta_psk 
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 grpform_per_sta_psk 1/1
Test: P2P group formation with per-STA PSKs
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
wlan2: Trying to discover peer 02:00:00:00:00:00
PASS grpform_per_sta_psk 36.983027 2020-02-23 01:04:52.497192
passed all 1 test case(s)
2020-02-23 01:04:53 	./run-tests.py grpform_per_sta_psk_wps 
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 grpform_per_sta_psk_wps 1/1
Test: P2P group formation with per-STA PSKs with non-P2P WPS STA
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
PASS grpform_per_sta_psk_wps 28.08148 2020-02-23 01:05:25.577698
passed all 1 test case(s)
2020-02-23 01:05:26 	./run-tests.py grpform_pref_chan_go 
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 grpform_pref_chan_go 1/1
Test: P2P group formation preferred channel selection by GO
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
PASS grpform_pref_chan_go 15.314423 2020-02-23 01:05:45.671068
passed all 1 test case(s)
2020-02-23 01:05:46 	./run-tests.py grpform_pref_chan_go_overridden 
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 grpform_pref_chan_go_overridden 1/1
Test: P2P group formation preferred channel selection by GO overridden by client
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
PASS grpform_pref_chan_go_overridden 15.741781 2020-02-23 01:06:06.432659
passed all 1 test case(s)
2020-02-23 01:06:07 	./run-tests.py grpform_random_addr 
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 grpform_random_addr 1/1
Test: P2P group formation with random interface addresses
Start GO negotiation wlan0 -> wlan1
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan0: Trying to discover peer 02:00:00:00:01:00
Group formed
PASS grpform_random_addr 24.708019 2020-02-23 01:06:35.567022
passed all 1 test case(s)
2020-02-23 01:06:36 	./run-tests.py grpform_reject 
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 grpform_reject 1/1
Test: User rejecting group formation attempt by a P2P peer
wlan1: Trying to discover peer 02:00:00:00:00:00
wlan1: Trying to discover peer 02:00:00:00:00:00
PASS grpform_reject 3.318998 2020-02-23 01:06:43.602589
passed all 1 test case(s)
2020-02-23 01:06:44 	./run-tests.py grpform_wait_peer 
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 grpform_wait_peer 1/1
Test: P2P group formation wait for peer to become ready
wlan0: Trying to discover peer 02:00:00:00:01:00
PASS grpform_wait_peer 18.760862 2020-02-23 01:07:07.148032
passed all 1 test case(s)
2020-02-23 01:07:07 	./run-tests.py hapd_ctrl_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 hapd_ctrl_chan_switch 1/1
Test: hostapd and CHAN_SWITCH ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_chan_switch 3.003802 2020-02-23 01:07:14.766452
passed all 1 test case(s)
2020-02-23 01:07:15 	./run-tests.py hapd_ctrl_disassoc_imminent 
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 hapd_ctrl_disassoc_imminent 1/1
Test: hostapd and DISASSOC_IMMINENT ctrl_iface command
Starting AP wlan3
Connect STA wlan0 to AP
PASS hapd_ctrl_disassoc_imminent 5.604183 2020-02-23 01:07:24.973924
passed all 1 test case(s)
2020-02-23 01:07:25 	./run-tests.py hapd_ctrl_disconnect 
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 hapd_ctrl_disconnect 1/1
Test: hostapd and disconnection ctrl_iface commands
Starting AP wlan3
Connect STA wlan0 to AP
PASS hapd_ctrl_disconnect 10.554041 2020-02-23 01:07:40.384729
passed all 1 test case(s)
2020-02-23 01:07:41 	./run-tests.py hapd_ctrl_disconnect_no_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 hapd_ctrl_disconnect_no_tx 1/1
Test: hostapd disconnecting STA without transmitting Deauth/Disassoc
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS hapd_ctrl_disconnect_no_tx 12.101499 2020-02-23 01:07:57.140585
passed all 1 test case(s)
2020-02-23 01:07:57 	./run-tests.py hapd_ctrl_eapol_reauth_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 hapd_ctrl_eapol_reauth_errors 1/1
Test: hostapd and EAPOL_REAUTH errors
Starting AP wlan3
PASS hapd_ctrl_eapol_reauth_errors 2.684638 2020-02-23 01:08:04.347875
passed all 1 test case(s)
2020-02-23 01:08:04 	./run-tests.py hapd_ctrl_eapol_relog 
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 hapd_ctrl_eapol_relog 1/1
Test: hostapd and RELOG
Starting AP wlan3
PASS hapd_ctrl_eapol_relog 2.989639 2020-02-23 01:08:12.089669
passed all 1 test case(s)
2020-02-23 01:08:12 	./run-tests.py hapd_ctrl_ess_disassoc 
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 hapd_ctrl_ess_disassoc 1/1
Test: hostapd and ESS_DISASSOC ctrl_iface command
Starting AP wlan3
Connect STA wlan0 to AP
PASS hapd_ctrl_ess_disassoc 4.774138 2020-02-23 01:08:21.049019
passed all 1 test case(s)
2020-02-23 01:08:21 	./run-tests.py hapd_ctrl_ext_io_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 hapd_ctrl_ext_io_errors 1/1
Test: hostapd and external I/O errors
Starting AP wlan3
PASS hapd_ctrl_ext_io_errors 3.238055 2020-02-23 01:08:28.949754
passed all 1 test case(s)
2020-02-23 01:08:29 	./run-tests.py hapd_ctrl_get 
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 hapd_ctrl_get 1/1
Test: hostapd and GET ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_get 3.283881 2020-02-23 01:08:37.160882
passed all 1 test case(s)
2020-02-23 01:08:37 	./run-tests.py hapd_ctrl_global 
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 hapd_ctrl_global 1/1
Test: hostapd and GET ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_global 2.676822 2020-02-23 01:08:44.628659
passed all 1 test case(s)
2020-02-23 01:08:45 	./run-tests.py hapd_ctrl_hs20_deauth_req 
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 hapd_ctrl_hs20_deauth_req 1/1
Test: hostapd and HS20_DEAUTH_REQ ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_hs20_deauth_req 3.269361 2020-02-23 01:08:52.479444
passed all 1 test case(s)
2020-02-23 01:08:53 	./run-tests.py hapd_ctrl_hs20_wnm_notif 
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 hapd_ctrl_hs20_wnm_notif 1/1
Test: hostapd and HS20_WNM_NOTIF ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_hs20_wnm_notif 2.730006 2020-02-23 01:08:59.620569
passed all 1 test case(s)
2020-02-23 01:09:00 	./run-tests.py hapd_ctrl_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 hapd_ctrl_level 1/1
Test: hostapd and LEVEL ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_level 3.141702 2020-02-23 01:09:07.351805
passed all 1 test case(s)
2020-02-23 01:09:07 	./run-tests.py hapd_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 hapd_ctrl_log_level 1/1
Test: hostapd ctrl_iface LOG_LEVEL
Starting AP wlan3
PASS hapd_ctrl_log_level 2.741175 2020-02-23 01:09:14.466570
passed all 1 test case(s)
2020-02-23 01:09:15 	./run-tests.py hapd_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 hapd_ctrl_mib 1/1
Test: hostapd and MIB ctrl_iface command with open network
Starting AP wlan3
Connect STA wlan0 to AP
PASS hapd_ctrl_mib 4.6733 2020-02-23 01:09:23.831218
passed all 1 test case(s)
2020-02-23 01:09:24 	./run-tests.py hapd_ctrl_new_sta 
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 hapd_ctrl_new_sta 1/1
Test: hostapd and NEW_STA ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_new_sta 2.972206 2020-02-23 01:09:31.201816
passed all 1 test case(s)
2020-02-23 01:09:31 	./run-tests.py hapd_ctrl_not_yet_fully_enabled 
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 hapd_ctrl_not_yet_fully_enabled 1/1
Test: hostapd and ctrl_iface commands when BSS not yet fully enabled
Starting AP wlan3
PASS hapd_ctrl_not_yet_fully_enabled 1.334468 2020-02-23 01:09:37.275378
passed all 1 test case(s)
2020-02-23 01:09:38 	./run-tests.py hapd_ctrl_p2p_manager 
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 hapd_ctrl_p2p_manager 1/1
Test: hostapd as P2P Device manager
Starting AP wlan3
Connect STA wlan0 to AP
PASS hapd_ctrl_p2p_manager 10.186063 2020-02-23 01:09:52.065064
passed all 1 test case(s)
2020-02-23 01:09:52 	./run-tests.py hapd_ctrl_poll_sta_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 hapd_ctrl_poll_sta_errors 1/1
Test: hostapd and POLL_STA errors
Starting AP wlan3
PASS hapd_ctrl_poll_sta_errors 2.725881 2020-02-23 01:09:59.176581
passed all 1 test case(s)
2020-02-23 01:09:59 	./run-tests.py hapd_ctrl_radar 
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 hapd_ctrl_radar 1/1
Test: hostapd and RADAR ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_radar 2.73677 2020-02-23 01:10:07.038568
passed all 1 test case(s)
2020-02-23 01:10:07 	./run-tests.py hapd_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 hapd_ctrl_set 1/1
Test: hostapd and SET ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_set 2.717542 2020-02-23 01:10:14.223071
passed all 1 test case(s)
2020-02-23 01:10:14 	./run-tests.py hapd_ctrl_set_accept_mac_file 
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 hapd_ctrl_set_accept_mac_file 1/1
Test: hostapd and SET accept_mac_file ctrl_iface command
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS hapd_ctrl_set_accept_mac_file 8.300397 2020-02-23 01:10:27.503445
passed all 1 test case(s)
2020-02-23 01:10:28 	./run-tests.py hapd_ctrl_set_accept_mac_file_vlan 
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 hapd_ctrl_set_accept_mac_file_vlan 1/1
Test: hostapd and SET accept_mac_file ctrl_iface command (VLAN ID)
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS hapd_ctrl_set_accept_mac_file_vlan 8.622903 2020-02-23 01:10:41.132887
passed all 1 test case(s)
2020-02-23 01:10:41 	./run-tests.py hapd_ctrl_set_deny_mac_file 
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 hapd_ctrl_set_deny_mac_file 1/1
Test: hostapd and SET deny_mac_file ctrl_iface command
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS hapd_ctrl_set_deny_mac_file 8.334699 2020-02-23 01:10:54.185106
passed all 1 test case(s)
2020-02-23 01:10:54 	./run-tests.py hapd_ctrl_set_error_cases 
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 hapd_ctrl_set_error_cases 1/1
Test: hostapd and SET error cases
Starting AP wlan3
PASS hapd_ctrl_set_error_cases 3.8183 2020-02-23 01:11:02.589931
passed all 1 test case(s)
2020-02-23 01:11:03 	./run-tests.py hapd_ctrl_sta 
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 hapd_ctrl_sta 1/1
Test: hostapd and STA ctrl_iface commands
Starting AP wlan3
Connect STA wlan0 to AP
STA: {'min_txpower': '-1', 'tx_rate_info': '585 mcs 6', 'addr': '02:00:00:00:00:00', 'listen_interval': '5', 'connected_time': '0', 'supported_rates': '02 04 0b 16 0c 12 18 24 30 48 60 6c', 'inactive_msec': '45', 'rx_rate_info': '520 mcs 5', 'capability': '0x431', 'AKMSuiteSelector': '00-0f-ac-2', 'dot11RSNAStatsSTAAddress': '02:00:00:00:00:00', 'signal': '-30', 'wpa': '2', 'supp_op_classes': '5151525354737475767778797a7b7c7d7e7f808182', 'ht_caps_info': '0x1076', 'dot11RSNAStatsVersion': '1', 'ext_capab': '04004a02014000400001', 'tx_bytes': '817', 'ht_mcs_bitmask': 'ffff0000000000000000', 'hostapdWPAPTKGroupState': '0', 'dot11RSNAStatsSelectedPairwiseCipher': '00-0f-ac-4', 'dot11RSNAStatsTKIPRemoteMICFailures': '0', 'flags': '[AUTH][ASSOC][AUTHORIZED][SHORT_PREAMBLE][WMM][HT]', 'rx_packets': '7', 'timeout_next': 'NULLFUNC POLL', 'tx_packets': '8', 'aid': '1', 'rx_bytes': '604', 'dot11RSNAStatsTKIPLocalMICFailures': '0', 'max_txpower': '2', 'hostapdWPAPTKState': '11'}
PASS hapd_ctrl_sta 6.108688 2020-02-23 01:11:13.522663
passed all 1 test case(s)
2020-02-23 01:11:14 	./run-tests.py hapd_ctrl_status 
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 hapd_ctrl_status 1/1
Test: hostapd ctrl_iface STATUS commands
Starting AP wlan3
STATUS: {'dtim_period': '2', 'ht_mcs_bitmask': 'ffff0000000000000000', 'num_sta_no_short_preamble': '0', 'channel': '1', 'olbc_ht': '0', 'ssid[0]': 'hapd-ctrl', 'num_sta_no_short_slot_time': '0', 'bssid[0]': '02:00:00:00:03:00', 'ieee80211ac': '0', 'num_sta_ht_20_mhz': '0', 'num_sta_ht_no_gf': '0', 'olbc': '0', 'num_sta_non_erp': '0', 'cac_time_left_seconds': 'N/A', 'ieee80211n': '1', 'freq': '2412', 'num_sta[0]': '0', 'beacon_int': '100', 'cac_time_seconds': '0', 'phy': 'phy3', 'max_txpower': '20', 'secondary_channel': '0', 'num_sta_no_ht': '0', 'ieee80211ax': '0', 'edmg_channel': '0', 'bss[0]': 'wlan3', 'state': 'ENABLED', 'supported_rates': '02 04 0b 16 0c 12 18 24 30 48 60 6c', 'ht_caps_info': '000c', 'ht_op_mode': '0x0', 'edmg_enable': '0', 'num_sta_ht40_intolerant': '0'}
STATUS-DRIVER: {'operstate': '1', 'capa.max_scan_ssids': '4', 'last_mgmt_freq': '0', 'capa.rrm_flags': '0x10', 'capa.max_conc_chan_2_4': '0', 'perm_addr': '02:00:00:00:03:00', 'capa.max_stations': '0', 'eapol_tx_sock': '13', 'poll_command_supported': '1', 'bssid': '00:00:00:00:00:00', 'auth_attempt_bssid': '00:00:00:00:00:00', 'capa.max_sched_scan_plan_interval': '4294967295', 'capa.max_sched_scan_plan_iterations': '0', 'capa.auth': '0x7', 'associated': '0', 'capa.conc_capab': '0', 'capa.sched_scan_supported': '0', 'drv_ifindex': '6', 'data_tx_status': '1', 'phyname': 'phy3', 'country': '00', 'monitor_sock': '-1', 'capa.key_mgmt': '0x1ff0f', 'ifname': 'wlan3', 'capa.max_sched_scan_ssids': '0', 'beacon_set': '1', 'capa.max_acl_mac_addrs': '0', 'monitor_ifidx': '-1', 'brname': '', 'capa.max_match_sets': '0', 'capa.max_conc_chan_5_0': '0', 'capa.enc': '0xfef', 'freq': '2412', 'capa.num_multichan_concurrent': '0', 'prev_bssid': '00:00:00:00:00:00', 'in_interface_list': '1', 'capa.mac_addr_rand_scan_supported': '1', 'addr': '02:00:00:00:03:00', 'auth_bssid': '00:00:00:00:00:00', 'ifindex': '6', 'capa.max_sched_scan_plans': '1', 'capa.mac_addr_rand_sched_scan_supported': '0', 'assoc_freq': '0', 'capa.flags': '0x4000531db5bfbe0', 'capa.probe_resp_offloads': '0x0', 'monitor_refcount': '0', 'capa.max_remain_on_chan': '5000', 'scan_state': 'NO_SCAN'}
PASS hapd_ctrl_status 2.88168 2020-02-23 01:11:22.252676
passed all 1 test case(s)
2020-02-23 01:11:22 	./run-tests.py hapd_ctrl_test_fail 
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 hapd_ctrl_test_fail 1/1
Test: hostapd and TEST_ALLOC_FAIL/TEST_FAIL
Starting AP wlan3
PASS hapd_ctrl_test_fail 3.224088 2020-02-23 01:11:29.393950
passed all 1 test case(s)
2020-02-23 01:11:30 	./run-tests.py hapd_ctrl_unknown 
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 hapd_ctrl_unknown 1/1
Test: hostapd and unknown ctrl_iface command
Starting AP wlan3
PASS hapd_ctrl_unknown 2.846038 2020-02-23 01:11:37.683854
passed all 1 test case(s)
2020-02-23 01:11:38 	./run-tests.py hapd_ctrl_update_beacon 
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 hapd_ctrl_update_beacon 1/1
Test: hostapd and UPDATE_BEACON
Starting AP wlan3
Connect STA wlan0 to AP
PASS hapd_ctrl_update_beacon 5.668746 2020-02-23 01:11:47.792706
passed all 1 test case(s)
2020-02-23 01:11:48 	./run-tests.py hapd_ctrl_vendor_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 hapd_ctrl_vendor_errors 1/1
Test: hostapd and VENDOR errors
Starting AP wlan3
PASS hapd_ctrl_vendor_errors 2.897793 2020-02-23 01:11:54.854196
passed all 1 test case(s)
2020-02-23 01:11:55 	./run-tests.py hapd_dup_network_global_wpa 
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 hapd_dup_network_global_wpa 1/1
Test: hostapd and DUP_NETWORK command (WPA)
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
PASS hapd_dup_network_global_wpa 8.223126 2020-02-23 01:12:07.984736
passed all 1 test case(s)
2020-02-23 01:12:08 	./run-tests.py hapd_dup_network_global_wpa2 
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 hapd_dup_network_global_wpa2 1/1
Test: hostapd and DUP_NETWORK command (WPA2)
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
PASS hapd_dup_network_global_wpa2 13.809745 2020-02-23 01:12:26.185841
passed all 1 test case(s)
2020-02-23 01:12:26 	./run-tests.py he160 --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 he160 1/1
Test: HE with 160 MHz channel width (1) [long]
Starting AP wlan3
Waiting for CAC to complete
Connect STA wlan0 to AP
PASS he160 71.88634 2020-02-23 01:13:43.498228
passed all 1 test case(s)
2020-02-23 01:13:44 	./run-tests.py he160_no_dfs 
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 he160_no_dfs 1/1
Test: HE with 160 MHz channel width and no DFS (104 minus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he160_no_dfs 8.500208 2020-02-23 01:13:56.383051
passed all 1 test case(s)
2020-02-23 01:13:57 	./run-tests.py he160_no_dfs_100_plus 
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 he160_no_dfs_100_plus 1/1
Test: HE with 160 MHz channel width and no DFS (100 plus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he160_no_dfs_100_plus 7.739323 2020-02-23 01:14:09.222125
passed all 1 test case(s)
2020-02-23 01:14:10 	./run-tests.py he160_no_dfs_108_plus 
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 he160_no_dfs_108_plus 1/1
Test: HE with 160 MHz channel width and no DFS (108 plus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he160_no_dfs_108_plus 7.983703 2020-02-23 01:14:22.903647
passed all 1 test case(s)
2020-02-23 01:14:23 	./run-tests.py he160_no_dfs_112_minus 
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 he160_no_dfs_112_minus 1/1
Test: HE with 160 MHz channel width and no DFS (112 minus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: ZA
Try to clear country
Connect STA wlan0 to AP
PASS he160_no_dfs_112_minus 13.772194 2020-02-23 01:14:42.683192
passed all 1 test case(s)
2020-02-23 01:14:43 	./run-tests.py he160_no_dfs_116_plus 
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 he160_no_dfs_116_plus 1/1
Test: HE with 160 MHz channel width and no DFS (116 plus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he160_no_dfs_116_plus 7.518413 2020-02-23 01:14:54.241891
passed all 1 test case(s)
2020-02-23 01:14:55 	./run-tests.py he160_no_dfs_120_minus 
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 he160_no_dfs_120_minus 1/1
Test: HE with 160 MHz channel width and no DFS (120 minus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he160_no_dfs_120_minus 6.896757 2020-02-23 01:15:06.202619
passed all 1 test case(s)
2020-02-23 01:15:06 	./run-tests.py he160_no_dfs_124_plus 
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 he160_no_dfs_124_plus 1/1
Test: HE with 160 MHz channel width and no DFS (124 plus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he160_no_dfs_124_plus 7.128556 2020-02-23 01:15:19.161100
passed all 1 test case(s)
2020-02-23 01:15:19 	./run-tests.py he160_no_dfs_128_minus 
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 he160_no_dfs_128_minus 1/1
Test: HE with 160 MHz channel width and no DFS (128 minus)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he160_no_dfs_128_minus 7.012145 2020-02-23 01:15:32.361901
passed all 1 test case(s)
2020-02-23 01:15:32 	./run-tests.py he160_no_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 he160_no_ht40 1/1
Test: HE with 160 MHz channel width and HT40 disabled
Starting AP wlan3
Country code at the end: 00
PASS he160_no_ht40 3.401506 2020-02-23 01:15:40.736675
passed all 1 test case(s)
2020-02-23 01:15:41 	./run-tests.py he160b --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 he160b 1/1
Test: HE with 160 MHz channel width (2) [long]
Starting AP wlan4
Waiting for CAC to complete
Connect STA wlan0 to AP
Failed to trigger scan: FAIL-BUSY

Traceback (most recent call last):
  File "./run-tests.py", line 519, in main
    t(dev, apdev, params)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_he.py", line 570, in test_he160b
    dev[0].flush_scan_cache()
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1163, in flush_scan_cache
    self.scan(freq=freq, only_new=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1140, in scan
    raise Exception("Failed to trigger scan: " + str(res))
Exception: Failed to trigger scan: FAIL-BUSY

FAIL he160b 69.11589 2020-02-23 01:16:54.232746
passed 0 test case(s)
skipped 0 test case(s)
failed tests: he160b
2020-02-23 01:16:54 	./run-tests.py he80 
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 he80 1/1
Test: HE with 80 MHz channel width
Starting AP wlan3
Connect STA wlan0 to AP
hostapd STATUS: {'ht_caps_info': '000e', 'num_sta_ht40_intolerant': '0', 'channel': '36', 'ieee80211ax': '1', 'ht_mcs_bitmask': 'ffff0000000000000000', 'he_oper_centr_freq_seg1_idx': '0', 'he_oper_centr_freq_seg0_idx': '42', 'vht_oper_chwidth': '1', 'vht_oper_centr_freq_seg1_idx': '0', 'phy': 'phy3', 'he_oper_chwidth': '1', 'edmg_channel': '0', 'ht_op_mode': '0x0', 'max_txpower': '23', 'num_sta_ht_no_gf': '0', 'state': 'ENABLED', 'freq': '5180', 'ssid[0]': 'he', 'supported_rates': '0c 12 18 24 30 48 60 6c', 'num_sta[0]': '1', 'edmg_enable': '0', 'tx_vht_mcs_map': 'aaaa', 'olbc': '0', 'vht_caps_info': '00000002', 'ieee80211n': '1', 'rx_vht_mcs_map': 'aaaa', 'olbc_ht': '0', 'bssid[0]': '02:00:00:00:03:00', 'bss[0]': 'wlan3', 'num_sta_no_short_preamble': '1', 'beacon_int': '100', 'num_sta_non_erp': '0', 'cac_time_left_seconds': 'N/A', 'num_sta_no_short_slot_time': '1', 'cac_time_seconds': '0', 'dtim_period': '2', 'num_sta_no_ht': '0', 'vht_oper_centr_freq_seg0_idx': '42', 'secondary_channel': '1', 'num_sta_ht_20_mhz': '0', 'ieee80211ac': '1'}
hostapd STA: {'ht_caps_info': '0x1076', 'tx_packets': '6', 'flags': '[AUTH][ASSOC][AUTHORIZED][WMM][HT][VHT][HE]', 'tx_bytes': '1830', 'connected_time': '0', 'ext_capab': '04004a02014000400001', 'rx_bytes': '3398', 'capability': '0x1', 'rx_rate_info': '1170 vhtmcs 6 vhtnss 2', 'addr': '02:00:00:00:00:00', 'supported_rates': '0c 12 18 24 30 48 60 6c', 'ht_mcs_bitmask': 'ffff0000000000000000', 'aid': '1', 'timeout_next': 'NULLFUNC POLL', 'tx_vht_mcs_map': 'aaaa', 'rx_packets': '10', 'vht_caps_info': '0x038004fa', 'inactive_msec': '57', 'rx_vht_mcs_map': 'aaaa', 'listen_interval': '5', 'signal': '-27', 'supp_op_classes': '73515354737475767778797a7b808182', 'tx_rate_info': '65 vhtmcs 0 vhtnss 1'}
Country code at the end: 00
PASS he80 7.338595 2020-02-23 01:17:05.746683
passed all 1 test case(s)
2020-02-23 01:17:06 	./run-tests.py he80_csa 
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 he80_csa 1/1
Test: HE with 80 MHz channel width and CSA
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
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_he.py", line 847, in test_he80_csa
    hwsim_utils.test_connectivity(dev[0], hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 206, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL he80_csa 16.405352 2020-02-23 01:17:26.844886
passed 0 test case(s)
skipped 0 test case(s)
failed tests: he80_csa
2020-02-23 01:17:27 	./run-tests.py he80_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 he80_invalid 1/1
Test: HE with invalid 80 MHz channel configuration (seg1)
Starting AP wlan3
Country code at the end: 00
PASS he80_invalid 4.024044 2020-02-23 01:17:35.825135
passed all 1 test case(s)
2020-02-23 01:17:36 	./run-tests.py he80_invalid2 
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 he80_invalid2 1/1
Test: HE with invalid 80 MHz channel configuration (seg0)
Starting AP wlan3
Country code at the end: 00
PASS he80_invalid2 3.706061 2020-02-23 01:17:43.411017
passed all 1 test case(s)
2020-02-23 01:17:43 	./run-tests.py he80_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 he80_params 1/1
Test: HE with 80 MHz channel width and number of optional features enabled
Starting AP wlan3
Connect STA wlan1 to AP
Connect STA wlan0 to AP
Connect STA wlan2 to AP
Country code at the end: 00
PASS he80_params 15.795377 2020-02-23 01:18:05.193221
passed all 1 test case(s)
2020-02-23 01:18:05 	./run-tests.py he80_pwr_constraint 
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 he80_pwr_constraint 1/1
Test: HE with 80 MHz channel width and local power constraint
Starting AP wlan3
Connect STA wlan0 to AP
Failed to trigger scan: FAIL-BUSY

Traceback (most recent call last):
  File "./run-tests.py", line 521, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_he.py", line 925, in test_he80_pwr_constraint
    dev[0].flush_scan_cache()
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1168, in flush_scan_cache
    self.scan(freq=2422, only_new=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1140, in scan
    raise Exception("Failed to trigger scan: " + str(res))
Exception: Failed to trigger scan: FAIL-BUSY

FAIL he80_pwr_constraint 6.598609 2020-02-23 01:18:16.208671
passed 0 test case(s)
skipped 0 test case(s)
failed tests: he80_pwr_constraint
2020-02-23 01:18:17 	./run-tests.py he80_to_24g_he 
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 he80_to_24g_he 1/1
Test: HE with 80 MHz channel width reconfigured to 2.4 GHz HE
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he80_to_24g_he 7.935841 2020-02-23 01:18:29.229641
passed all 1 test case(s)
2020-02-23 01:18:29 	./run-tests.py he80b 
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 he80b 1/1
Test: HE with 80 MHz channel width (HT40- channel 40)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he80b 8.076589 2020-02-23 01:18:43.136221
passed all 1 test case(s)
2020-02-23 01:18:43 	./run-tests.py he80c 
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 he80c 1/1
Test: HE with 80 MHz channel width (HT40+ channel 44)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he80c 7.915343 2020-02-23 01:18:56.954806
passed all 1 test case(s)
2020-02-23 01:18:57 	./run-tests.py he80d 
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 he80d 1/1
Test: HE with 80 MHz channel width (HT40- channel 48)
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he80d 7.685756 2020-02-23 01:19:10.862888
passed all 1 test case(s)
2020-02-23 01:19:11 	./run-tests.py he80plus80 
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 he80plus80 1/1
Test: HE with 80+80 MHz channel width
Starting AP wlan3
Starting AP wlan4
Connect STA wlan1 to AP
PASS he80plus80 7.566634 2020-02-23 01:19:23.986823
passed all 1 test case(s)
2020-02-23 01:19:24 	./run-tests.py he80plus80_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 he80plus80_invalid 1/1
Test: HE with invalid 80+80 MHz channel
Starting AP wlan3
Country code at the end: 00
PASS he80plus80_invalid 3.794623 2020-02-23 01:19:31.950674
passed all 1 test case(s)
2020-02-23 01:19:32 	./run-tests.py he_20 
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 he_20 1/1
Test: HE and 20 MHz channel
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he_20 5.636669 2020-02-23 01:19:41.324832
passed all 1 test case(s)
2020-02-23 01:19:41 	./run-tests.py he_40 
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 he_40 1/1
Test: HE and 40 MHz channel
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he_40 6.521003 2020-02-23 01:19:53.347907
passed all 1 test case(s)
2020-02-23 01:19:53 	./run-tests.py he_40_fallback_to_20 
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 he_40_fallback_to_20 1/1
Test: HE and 40 MHz channel configuration falling back to 20 MHz
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he_40_fallback_to_20 7.127738 2020-02-23 01:20:06.403918
passed all 1 test case(s)
2020-02-23 01:20:06 	./run-tests.py he_on_24ghz 
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 he_on_24ghz 1/1
Test: Subset of HE features on 2.4 GHz
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS he_on_24ghz 8.445053 2020-02-23 01:20:19.583985
passed all 1 test case(s)
2020-02-23 01:20:20 	./run-tests.py he_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 he_open 1/1
Test: HE AP with open mode configuration
Starting AP wlan3
Connect STA wlan0 to AP
PASS he_open 5.755545 2020-02-23 01:20:29.738753
passed all 1 test case(s)
2020-02-23 01:20:30 	./run-tests.py he_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 he_params 1/1
Test: HE AP parameters
Starting AP wlan3
Connect STA wlan0 to AP
PASS he_params 5.291551 2020-02-23 01:20:40.027105
passed all 1 test case(s)
2020-02-23 01:20:40 	./run-tests.py he_tkip 
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 he_tkip 1/1
Test: HE and TKIP
Starting AP wlan3
Connect STA wlan0 to AP
hostapd STATUS: {'ieee80211ax': '1', 'ssid[0]': 'he', 'phy': 'phy3', 'secondary_channel': '0', 'ieee80211ac': '0', 'num_sta_no_ht': '1', 'num_sta_no_short_preamble': '1', 'he_oper_centr_freq_seg0_idx': '42', 'num_sta_no_short_slot_time': '1', 'num_sta_non_erp': '0', 'num_sta[0]': '1', 'supported_rates': '0c 12 18 24 30 48 60 6c', 'state': 'ENABLED', 'channel': '36', 'he_oper_chwidth': '1', 'edmg_channel': '0', 'freq': '5180', 'ht_op_mode': '0x13', 'num_sta_ht_20_mhz': '0', 'max_txpower': '23', 'olbc': '0', 'cac_time_seconds': '0', 'dtim_period': '2', 'edmg_enable': '0', 'num_sta_ht40_intolerant': '0', 'olbc_ht': '0', 'num_sta_ht_no_gf': '0', 'bss[0]': 'wlan3', 'ieee80211n': '0', 'he_oper_centr_freq_seg1_idx': '0', 'bssid[0]': '02:00:00:00:03:00', 'cac_time_left_seconds': 'N/A', 'beacon_int': '100'}
Country code at the end: 00
PASS he_tkip 8.275412 2020-02-23 01:20:54.154118
passed all 1 test case(s)
2020-02-23 01:20:54 	./run-tests.py he_use_sta_nsts 
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 he_use_sta_nsts 1/1
Test: HE with 80 MHz channel width and use_sta_nsts=1
Starting AP wlan3
Connect STA wlan0 to AP
Country code at the end: 00
PASS he_use_sta_nsts 6.906283 2020-02-23 01:21:06.970701
passed all 1 test case(s)
2020-02-23 01:21:07 	./run-tests.py he_wifi_generation 
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 he_wifi_generation 1/1
Test: HE and wifi_generation
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan5 to AP
Country code at the end: 00
PASS he_wifi_generation 11.006481 2020-02-23 01:21:22.137510
passed all 1 test case(s)
2020-02-23 01:21:22 	./run-tests.py hostapd_oom_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 hostapd_oom_open 1/1
Test: hostapd failing to setup open mode due to OOM
Starting AP wlan3
Starting AP wlan4
Iteration 1 - ATTACH failed
Starting AP wlan4
Iteration 2 - ATTACH failed
Starting AP wlan4
Iteration 3 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 4 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 5 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 6 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 7 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 8 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 9 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 10 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 11 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 12 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 13 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 14 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 15 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 16 - ATTACH failed
Starting AP wlan4
Iteration 17 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 18 - Could not ping hostapd
Starting AP wlan4
Iteration 19 - ATTACH failed
Starting AP wlan4
Iteration 20 - ATTACH failed
Starting AP wlan4
Iteration 21 - Could not ping hostapd
Starting AP wlan4
Iteration 22 - Failed to set hostapd parameter driver
Starting AP wlan4
Iteration 23 - Failed to set hostapd parameter hw_mode
Starting AP wlan4
Iteration 24 - Failed to set hostapd parameter channel
Starting AP wlan4
Iteration 25 - Failed to set hostapd parameter ieee80211n
Starting AP wlan4
Iteration 26 - Failed to set hostapd parameter logger_stdout
Starting AP wlan4
Iteration 27 - Failed to set hostapd parameter logger_stdout_level
Starting AP wlan4
Iteration 28 - Failed to set hostapd parameter ssid
Starting AP wlan4
Iteration 29 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 30 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 31 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 32 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 33 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 34 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 35 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 36 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 37 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 38 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 39 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 40 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 41 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 42 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 43 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 44 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 45 - AP startup timed out
Starting AP wlan4
Iteration 46 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 47 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 48 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 49 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 50 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 51 - success
Removing BSS wlan4
Iteration 51 - ATTACH failed
Starting AP wlan4
Iteration 52 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 53 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 54 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 55 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 56 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 57 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 58 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 59 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 60 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 61 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 62 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 63 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 64 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 65 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 66 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 67 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 6:main
Starting AP wlan4
Iteration 68 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 1:main
Starting AP wlan4
Iteration 69 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 7:main
Starting AP wlan4
Iteration 70 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 10:main
Starting AP wlan4
Iteration 71 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 10:main
PASS hostapd_oom_open 82.425302 2020-02-23 01:22:49.037903
passed all 1 test case(s)
2020-02-23 01:22:49 	./run-tests.py hostapd_oom_wpa2_eap 
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 hostapd_oom_wpa2_eap 1/1
Test: hostapd failing to setup WPA2-EAP mode due to OOM
Starting AP wlan3
Starting AP wlan4
Iteration 1 - ATTACH failed
Starting AP wlan4
Iteration 2 - ATTACH failed
Starting AP wlan4
Iteration 3 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 4 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 5 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 6 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 7 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 8 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 9 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 10 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 11 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 12 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 13 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 14 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 15 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 16 - ATTACH failed
Starting AP wlan4
Iteration 17 - Could not add hostapd interface wlan4
Starting AP wlan4
Iteration 18 - Could not ping hostapd
Starting AP wlan4
Iteration 19 - ATTACH failed
Starting AP wlan4
Iteration 20 - ATTACH failed
Starting AP wlan4
Iteration 21 - Could not ping hostapd
Starting AP wlan4
Iteration 22 - Failed to set hostapd parameter driver
Starting AP wlan4
Iteration 23 - Failed to set hostapd parameter hw_mode
Starting AP wlan4
Iteration 24 - Failed to set hostapd parameter channel
Starting AP wlan4
Iteration 25 - Failed to set hostapd parameter ieee80211n
Starting AP wlan4
Iteration 26 - Failed to set hostapd parameter logger_stdout
Starting AP wlan4
Iteration 27 - Failed to set hostapd parameter logger_stdout_level
Starting AP wlan4
Iteration 28 - Failed to set hostapd parameter ssid
Starting AP wlan4
Iteration 29 - Failed to set hostapd parameter nas_identifier
Starting AP wlan4
Iteration 30 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 31 - Failed to set hostapd parameter rsn_pairwise
Starting AP wlan4
Iteration 32 - Failed to set hostapd parameter wpa_key_mgmt
Starting AP wlan4
Iteration 33 - Failed to set hostapd parameter wpa
Starting AP wlan4
Iteration 34 - Failed to set hostapd parameter rsn_pairwise
Starting AP wlan4
Iteration 35 - Failed to set hostapd parameter rsn_pairwise
Starting AP wlan4
Iteration 36 - Failed to set hostapd parameter auth_server_addr
Starting AP wlan4
Iteration 37 - Failed to set hostapd parameter auth_server_addr
Starting AP wlan4
Iteration 38 - Failed to set hostapd parameter acct_server_addr
Starting AP wlan4
Iteration 39 - Failed to set hostapd parameter acct_server_addr
Starting AP wlan4
Iteration 40 - Failed to set hostapd parameter auth_server_shared_secret
Starting AP wlan4
Iteration 41 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 42 - Failed to set hostapd parameter acct_server_port
Starting AP wlan4
Iteration 43 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 44 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 45 - Failed to set hostapd parameter acct_server_port
Starting AP wlan4
Iteration 46 - Failed to set hostapd parameter auth_server_port
Starting AP wlan4
Iteration 47 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 48 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 49 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 50 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 51 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 52 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 53 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 54 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 55 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 56 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 57 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 58 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 59 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 60 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 61 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 62 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 63 - AP startup timed out
Starting AP wlan4
Iteration 64 - Failed to enable hostapd interface wlan4
Starting AP wlan4
Iteration 65 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 66 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 67 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 68 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 69 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 70 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 71 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 72 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 73 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 74 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 75 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 76 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 77 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 78 - success
Removing BSS wlan4
Iteration 78 - ATTACH failed
Starting AP wlan4
Iteration 79 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 80 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 81 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 82 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 83 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 84 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 85 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 86 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 87 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 88 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 89 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 90 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 91 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 92 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 93 - success
Removing BSS wlan4
Iteration 93 - ATTACH failed
Starting AP wlan4
Iteration 94 - success
Removing BSS wlan4
Iteration 94 - ATTACH failed
Starting AP wlan4
Iteration 95 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 96 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 0:main
Starting AP wlan4
Iteration 97 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 5:main
Starting AP wlan4
Iteration 98 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 7:main
Starting AP wlan4
Iteration 99 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 1:main
Starting AP wlan4
Iteration 100 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 1:main
Starting AP wlan4
Iteration 101 - success
Removing BSS wlan4
GET_ALLOC_FAIL: 1:main
PASS hostapd_oom_wpa2_eap 128.30054 2020-02-23 01:25:01.804581
passed all 1 test case(s)
2020-02-23 01:25:02 	./run-tests.py hostapd_oom_wpa2_eap_connect --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 hostapd_oom_wpa2_eap_connect 1/1
Test: hostapd failing during WPA2-EAP mode connection due to OOM
Starting AP wlan3
Iteration 1
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 2
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 3
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 4
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 5
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 6
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 7
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 8
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 9
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 10
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 11
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 12
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 13
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 14
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 15
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 16
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 17
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 18
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 19
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 20
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 21
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 22
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 23
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 24
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 25
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 26
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 27
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 28
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 29
Connect STA wlan0 to AP
Re-select to avoid long wait for temp disavle
GET_ALLOC_FAIL: 0:main
Iteration 30
Connect STA wlan0 to AP
Timeout while waiting for connection in iteration 30
GET_ALLOC_FAIL: 0:main
Iteration 31
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 32
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 33
Connect STA wlan0 to AP
Timeout while waiting for connection in iteration 33
GET_ALLOC_FAIL: 0:main
Iteration 34
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 35
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 36
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 37
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 38
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 39
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 40
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 41
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 42
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 43
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 44
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 45
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 46
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 47
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 48
Connect STA wlan0 to AP
GET_ALLOC_FAIL: 0:main
Iteration 49
Connect STA wlan0 to AP
Re-select to avoid long wait for temp disavle