2020-09-05 17:47:07 export USER=root
2020-09-05 17:47:07 ./build.sh
Building TNC testing tools
Building wlantest
Building hs20-osu-client
Building hostapd
Building wpa_supplicant
wpa_cli.c: In function ‘wpa_cli_cmd_all_bss’:
wpa_cli.c:3105:3: warning: ‘ssid’ may be used uninitialized in this function [-Wmaybe-uninitialized]
   printf("%s\t%s\t%s\t%s\t%s\n", bssid, freq, level, flags, ssid);
   ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
wpa_cli.c:3064:55: note: ‘ssid’ was declared here
  char buf[512], *pos, *bssid, *freq, *level, *flags, *ssid;
                                                       ^~~~
wpa_cli.c:3105:3: warning: ‘flags’ may be used uninitialized in this function [-Wmaybe-uninitialized]
   printf("%s\t%s\t%s\t%s\t%s\n", bssid, freq, level, flags, ssid);
   ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
wpa_cli.c:3064:47: note: ‘flags’ was declared here
  char buf[512], *pos, *bssid, *freq, *level, *flags, *ssid;
                                               ^~~~~
wpa_cli.c:3105:3: warning: ‘level’ may be used uninitialized in this function [-Wmaybe-uninitialized]
   printf("%s\t%s\t%s\t%s\t%s\n", bssid, freq, level, flags, ssid);
   ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
wpa_cli.c:3064:39: note: ‘level’ was declared here
  char buf[512], *pos, *bssid, *freq, *level, *flags, *ssid;
                                       ^~~~~
wpa_cli.c:3105:3: warning: ‘freq’ may be used uninitialized in this function [-Wmaybe-uninitialized]
   printf("%s\t%s\t%s\t%s\t%s\n", bssid, freq, level, flags, ssid);
   ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
wpa_cli.c:3064:32: note: ‘freq’ was declared here
  char buf[512], *pos, *bssid, *freq, *level, *flags, *ssid;
                                ^~~~
wpa_cli.c:3105:3: warning: ‘bssid’ may be used uninitialized in this function [-Wmaybe-uninitialized]
   printf("%s\t%s\t%s\t%s\t%s\n", bssid, freq, level, flags, ssid);
   ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
wpa_cli.c:3064:24: note: ‘bssid’ was declared here
  char buf[512], *pos, *bssid, *freq, *level, *flags, *ssid;
                        ^~~~~
2020-09-05 17:47:39 ./start.sh
2020-09-05 17:47:40 	./run-tests.py erp_radius 
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 erp_radius 1/1
Test: ERP enabled on RADIUS server and peer
Starting AP as-erp
Starting AP wlan3
Connect STA wlan0 to AP
PASS erp_radius 0.329997 2020-09-05 17:47:41.946356
passed all 1 test case(s)
2020-09-05 17:47:41 	./run-tests.py erp_radius_eap_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 erp_radius_eap_methods 1/1
Test: ERP enabled on RADIUS server and peer
Starting AP as-erp
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
PASS erp_radius_eap_methods 2.097134 2020-09-05 17:47:44.177751
passed all 1 test case(s)
2020-09-05 17:47:44 	./run-tests.py erp_radius_eap_tls_v13 
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 erp_radius_eap_tls_v13 1/1
Test: ERP enabled on RADIUS server and peer using EAP-TLS v1.3
Starting AP as-erp
Starting AP wlan3
Connect STA wlan0 to AP
PASS erp_radius_eap_tls_v13 0.226891 2020-09-05 17:47:44.528522
passed all 1 test case(s)
2020-09-05 17:47:44 	./run-tests.py erp_radius_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 erp_radius_ext 1/1
Test: ERP enabled on a separate RADIUS server and peer
Starting AP wlan3
Connect STA wlan0 to AP
PASS erp_radius_ext 0.306549 2020-09-05 17:47:44.967670
passed all 1 test case(s)
2020-09-05 17:47:44 	./run-tests.py erp_radius_no_wildcard_user 
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 erp_radius_no_wildcard_user 1/1
Test: ERP enabled on RADIUS server and peer and no wildcard user
Starting AP as-erp
Starting AP wlan3
Connect STA wlan0 to AP
PASS erp_radius_no_wildcard_user 0.303199 2020-09-05 17:47:45.405114
passed all 1 test case(s)
2020-09-05 17:47:45 	./run-tests.py erp_server_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 erp_server_no_match 1/1
Test: ERP enabled on server and peer, but server has no key match
Starting AP wlan3
Connect STA wlan0 to AP
PASS erp_server_no_match 0.255558 2020-09-05 17:47:45.787689
passed all 1 test case(s)
2020-09-05 17:47:45 	./run-tests.py ext_password_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 ext_password_eap 1/1
Test: External password storage for EAP password
Starting AP wlan3
Connect STA wlan0 to AP
PASS ext_password_eap 0.178059 2020-09-05 17:47:46.098978
passed all 1 test case(s)
2020-09-05 17:47:46 	./run-tests.py ext_password_interworking 
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 ext_password_interworking 1/1
Test: External password storage for Interworking network selection
Starting AP wlan3
PASS ext_password_interworking 0.225177 2020-09-05 17:47:46.449353
passed all 1 test case(s)
2020-09-05 17:47:46 	./run-tests.py ext_password_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 ext_password_psk 1/1
Test: External password storage for PSK
Starting AP wlan3
Connect STA wlan0 to AP
PASS ext_password_psk 0.181825 2020-09-05 17:47:46.756949
passed all 1 test case(s)
2020-09-05 17:47:46 	./run-tests.py ext_password_psk_not_found 
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 ext_password_psk_not_found 1/1
Test: External password storage for PSK and PSK not found
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Connect STA wlan5 to AP
PASS ext_password_psk_not_found 1.471326 2020-09-05 17:47:48.353711
passed all 1 test case(s)
2020-09-05 17:47:48 	./run-tests.py ext_radio_work 
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 ext_radio_work 1/1
Test: External radio work item
PASS ext_radio_work 1.032866 2020-09-05 17:47:49.520009
passed all 1 test case(s)
2020-09-05 17:47:49 	./run-tests.py ext_radio_work_disconnect_connect 
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 ext_radio_work_disconnect_connect 1/1
Test: External radio work and DISCONNECT clearing connection attempt
Starting AP wlan3
Connect STA wlan0 to AP
PASS ext_radio_work_disconnect_connect 0.626523 2020-09-05 17:47:50.276579
passed all 1 test case(s)
2020-09-05 17:47:50 	./run-tests.py fils_and_ft 
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 fils_and_ft 1/1
Test: FILS SK using ERP and FT initial mobility domain association
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Starting AP wlan4 (old add_ap argument type)
PASS fils_and_ft 0.644678 2020-09-05 17:47:51.050109
passed all 1 test case(s)
2020-09-05 17:47:51 	./run-tests.py fils_and_ft_over_air 
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 fils_and_ft_over_air 1/1
Test: FILS SK using ERP and FT-over-air (SHA256)
Starting AP as-erp
Set up ERP key hierarchy without FILS/FT authentication
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Initial mobility domain association using FILS authentication
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
FT protocol using FT key hierarchy established during FILS authentication
FT protocol using the previously established FT key hierarchy from FILS authentication
PASS fils_and_ft_over_air 0.989455 2020-09-05 17:47:52.166366
passed all 1 test case(s)
2020-09-05 17:47:52 	./run-tests.py fils_and_ft_over_air_sha384 
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 fils_and_ft_over_air_sha384 1/1
Test: FILS SK using ERP and FT-over-air (SHA384)
Starting AP as-erp
Set up ERP key hierarchy without FILS/FT authentication
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Initial mobility domain association using FILS authentication
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
FT protocol using FT key hierarchy established during FILS authentication
FT protocol using the previously established FT key hierarchy from FILS authentication
PASS fils_and_ft_over_air_sha384 0.972827 2020-09-05 17:47:53.267643
passed all 1 test case(s)
2020-09-05 17:47:53 	./run-tests.py fils_and_ft_over_ds 
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 fils_and_ft_over_ds 1/1
Test: FILS SK using ERP and FT-over-DS (SHA256)
Starting AP as-erp
Set up ERP key hierarchy without FILS/FT authentication
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Initial mobility domain association using FILS authentication
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
FT protocol using FT key hierarchy established during FILS authentication
FT protocol using the previously established FT key hierarchy from FILS authentication
PASS fils_and_ft_over_ds 0.822279 2020-09-05 17:47:54.215438
passed all 1 test case(s)
2020-09-05 17:47:54 	./run-tests.py fils_and_ft_over_ds_sha384 
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 fils_and_ft_over_ds_sha384 1/1
Test: FILS SK using ERP and FT-over-DS (SHA384)
Starting AP as-erp
Set up ERP key hierarchy without FILS/FT authentication
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Initial mobility domain association using FILS authentication
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
FT protocol using FT key hierarchy established during FILS authentication
FT protocol using the previously established FT key hierarchy from FILS authentication
PASS fils_and_ft_over_ds_sha384 0.82017 2020-09-05 17:47:55.162694
passed all 1 test case(s)
2020-09-05 17:47:55 	./run-tests.py fils_assoc_replay 
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 fils_assoc_replay 1/1
Test: FILS AP and replayed Association Request frame
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Replay the last Association Request frame
CCMP PN: ['0x000000000001', '0x000000000002']
PASS fils_assoc_replay 0.555065 2020-09-05 17:47:55.844474
passed all 1 test case(s)
2020-09-05 17:47:55 	./run-tests.py fils_auth_gtk_rekey 
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 fils_auth_gtk_rekey 1/1
Test: GTK rekeying after FILS authentication
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_auth_gtk_rekey 6.16846 2020-09-05 17:48:02.139194
passed all 1 test case(s)
2020-09-05 17:48:02 	./run-tests.py fils_auth_ptk_rekey_ap 
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 fils_auth_ptk_rekey_ap 1/1
Test: PTK rekeying after FILS authentication triggered by AP
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_auth_ptk_rekey_ap 3.287504 2020-09-05 17:48:05.551900
passed all 1 test case(s)
2020-09-05 17:48:05 	./run-tests.py fils_auth_ptk_rekey_ap_erp 
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 fils_auth_ptk_rekey_ap_erp 1/1
Test: PTK rekeying after FILS authentication triggered by AP (ERP)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_auth_ptk_rekey_ap_erp 3.279754 2020-09-05 17:48:08.961814
passed all 1 test case(s)
2020-09-05 17:48:08 	./run-tests.py fils_auth_ptk_rekey_ap_ext_key_id 
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 fils_auth_ptk_rekey_ap_ext_key_id 1/1
Test: PTK rekeying after FILS authentication triggered by AP (Ext Key ID)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_auth_ptk_rekey_ap_ext_key_id 3.292189 2020-09-05 17:48:12.382363
passed all 1 test case(s)
2020-09-05 17:48:12 	./run-tests.py fils_sk_auth_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 fils_sk_auth_mismatch 1/1
Test: FILS SK authentication type mismatch (PFS not supported)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_auth_mismatch 0.260858 2020-09-05 17:48:12.773062
passed all 1 test case(s)
2020-09-05 17:48:12 	./run-tests.py fils_sk_erp 
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 fils_sk_erp 1/1
Test: FILS SK using ERP
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp 0.256124 2020-09-05 17:48:13.156924
passed all 1 test case(s)
2020-09-05 17:48:13 	./run-tests.py fils_sk_erp_and_reauth 
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 fils_sk_erp_and_reauth 1/1
Test: FILS SK using ERP and AP going away
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp_and_reauth 1.163553 2020-09-05 17:48:14.446544
passed all 1 test case(s)
2020-09-05 17:48:14 	./run-tests.py fils_sk_erp_another_ssid 
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 fils_sk_erp_another_ssid 1/1
Test: FILS SK using ERP and roam to another SSID
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp_another_ssid 0.427981 2020-09-05 17:48:15.001464
passed all 1 test case(s)
2020-09-05 17:48:15 	./run-tests.py fils_sk_erp_followed_by_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 fils_sk_erp_followed_by_pmksa_caching 1/1
Test: FILS SK ERP following by PMKSA caching
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp_followed_by_pmksa_caching 0.335439 2020-09-05 17:48:15.463863
passed all 1 test case(s)
2020-09-05 17:48:15 	./run-tests.py fils_sk_erp_radius_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 fils_sk_erp_radius_ext 1/1
Test: FILS SK using ERP and external RADIUS server
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp_radius_ext 0.262808 2020-09-05 17:48:15.852856
passed all 1 test case(s)
2020-09-05 17:48:15 	./run-tests.py fils_sk_erp_radius_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 fils_sk_erp_radius_roam 1/1
Test: FILS SK/ERP and roaming with different AKM
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Starting AP wlan4 (old add_ap argument type)
PASS fils_sk_erp_radius_roam 0.358209 2020-09-05 17:48:16.339134
passed all 1 test case(s)
2020-09-05 17:48:16 	./run-tests.py fils_sk_erp_roam_diff_akm 
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 fils_sk_erp_roam_diff_akm 1/1
Test: FILS SK using ERP and SHA256/SHA384 change in roam
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Starting AP wlan4 (old add_ap argument type)
PASS fils_sk_erp_roam_diff_akm 0.394077 2020-09-05 17:48:16.860399
passed all 1 test case(s)
2020-09-05 17:48:16 	./run-tests.py fils_sk_erp_server_flush 
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 fils_sk_erp_server_flush 1/1
Test: FILS SK ERP and ERP flush on server, but not on peer
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp_server_flush 0.444374 2020-09-05 17:48:17.433493
passed all 1 test case(s)
2020-09-05 17:48:17 	./run-tests.py fils_sk_erp_sha384 
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 fils_sk_erp_sha384 1/1
Test: FILS SK using ERP and SHA384
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp_sha384 0.247771 2020-09-05 17:48:17.809901
passed all 1 test case(s)
2020-09-05 17:48:17 	./run-tests.py fils_sk_erp_sim 
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 fils_sk_erp_sim 1/1
Test: FILS SK using ERP with SIM
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_erp_sim 0.369071 2020-09-05 17:48:18.305696
passed all 1 test case(s)
2020-09-05 17:48:18 	./run-tests.py fils_sk_full_auth 
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 fils_sk_full_auth 1/1
Test: FILS SK full authentication
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_full_auth 1.124876 2020-09-05 17:48:19.558044
passed all 1 test case(s)
2020-09-05 17:48:19 	./run-tests.py fils_sk_hlp 
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 fils_sk_hlp 1/1
Test: FILS SK HLP (rapid commit server)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_hlp 0.218725 2020-09-05 17:48:19.903387
passed all 1 test case(s)
2020-09-05 17:48:19 	./run-tests.py fils_sk_hlp_dhcp_parsing 
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 fils_sk_hlp_dhcp_parsing 1/1
Test: FILS SK HLP and DHCP response parsing
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_hlp_dhcp_parsing 0.61193 2020-09-05 17:48:20.642812
passed all 1 test case(s)
2020-09-05 17:48:20 	./run-tests.py fils_sk_hlp_no_rapid_commit 
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 fils_sk_hlp_no_rapid_commit 1/1
Test: FILS SK HLP (no rapid commit server)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_hlp_no_rapid_commit 0.228353 2020-09-05 17:48:20.998537
passed all 1 test case(s)
2020-09-05 17:48:21 	./run-tests.py fils_sk_hlp_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 fils_sk_hlp_oom 1/1
Test: FILS SK HLP and hostapd OOM
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_hlp_oom 1.450655 2020-09-05 17:48:22.576104
passed all 1 test case(s)
2020-09-05 17:48:22 	./run-tests.py fils_sk_hlp_req_parsing 
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 fils_sk_hlp_req_parsing 1/1
Test: FILS SK HLP request parsing
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_hlp_req_parsing 0.421439 2020-09-05 17:48:23.126486
passed all 1 test case(s)
2020-09-05 17:48:23 	./run-tests.py fils_sk_hlp_timeout 
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 fils_sk_hlp_timeout 1/1
Test: FILS SK HLP (rapid commit server timeout)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_hlp_timeout 0.249688 2020-09-05 17:48:23.504563
passed all 1 test case(s)
2020-09-05 17:48:23 	./run-tests.py fils_sk_multiple_realms 
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 fils_sk_multiple_realms 1/1
Test: FILS SK and multiple realms
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_multiple_realms 0.251568 2020-09-05 17:48:23.883712
passed all 1 test case(s)
2020-09-05 17:48:23 	./run-tests.py fils_sk_pfs_19 
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 fils_sk_pfs_19 1/1
Test: FILS SK with PFS (DH group 19)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_19 0.258762 2020-09-05 17:48:24.266595
passed all 1 test case(s)
2020-09-05 17:48:24 	./run-tests.py fils_sk_pfs_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 fils_sk_pfs_20 1/1
Test: FILS SK with PFS (DH group 20)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_20 0.260736 2020-09-05 17:48:24.652748
passed all 1 test case(s)
2020-09-05 17:48:24 	./run-tests.py fils_sk_pfs_21 
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 fils_sk_pfs_21 1/1
Test: FILS SK with PFS (DH group 21)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_21 0.252189 2020-09-05 17:48:25.035392
passed all 1 test case(s)
2020-09-05 17:48:25 	./run-tests.py fils_sk_pfs_25 
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 fils_sk_pfs_25 1/1
Test: FILS SK with PFS (DH group 25)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_25 0.254092 2020-09-05 17:48:25.416341
passed all 1 test case(s)
2020-09-05 17:48:25 	./run-tests.py fils_sk_pfs_26 
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 fils_sk_pfs_26 1/1
Test: FILS SK with PFS (DH group 26)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_26 0.254236 2020-09-05 17:48:25.799252
passed all 1 test case(s)
2020-09-05 17:48:25 	./run-tests.py fils_sk_pfs_27 
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 fils_sk_pfs_27 1/1
Test: FILS SK with PFS (DH group 27)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_27 0.257445 2020-09-05 17:48:26.183904
passed all 1 test case(s)
2020-09-05 17:48:26 	./run-tests.py fils_sk_pfs_28 
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 fils_sk_pfs_28 1/1
Test: FILS SK with PFS (DH group 28)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_28 0.251965 2020-09-05 17:48:26.562035
passed all 1 test case(s)
2020-09-05 17:48:26 	./run-tests.py fils_sk_pfs_29 
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 fils_sk_pfs_29 1/1
Test: FILS SK with PFS (DH group 29)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_29 0.253943 2020-09-05 17:48:26.942733
passed all 1 test case(s)
2020-09-05 17:48:26 	./run-tests.py fils_sk_pfs_30 
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 fils_sk_pfs_30 1/1
Test: FILS SK with PFS (DH group 30)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_30 0.261886 2020-09-05 17:48:27.330703
passed all 1 test case(s)
2020-09-05 17:48:27 	./run-tests.py fils_sk_pfs_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 fils_sk_pfs_group_mismatch 1/1
Test: FILS SK PFS DH group mismatch
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_group_mismatch 0.191941 2020-09-05 17:48:27.650144
passed all 1 test case(s)
2020-09-05 17:48:27 	./run-tests.py fils_sk_pfs_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 fils_sk_pfs_pmksa_caching 1/1
Test: FILS SK with PFS and PMKSA caching
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pfs_pmksa_caching 0.557531 2020-09-05 17:48:28.335665
passed all 1 test case(s)
2020-09-05 17:48:28 	./run-tests.py fils_sk_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 fils_sk_pmksa_caching 1/1
Test: FILS SK and PMKSA caching
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pmksa_caching 0.394334 2020-09-05 17:48:28.859057
passed all 1 test case(s)
2020-09-05 17:48:28 	./run-tests.py fils_sk_pmksa_caching_and_cache_id 
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 fils_sk_pmksa_caching_and_cache_id 1/1
Test: FILS SK and PMKSA caching with Cache Identifier
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Starting AP wlan4 (old add_ap argument type)
PASS fils_sk_pmksa_caching_and_cache_id 0.34933 2020-09-05 17:48:29.335304
passed all 1 test case(s)
2020-09-05 17:48:29 	./run-tests.py fils_sk_pmksa_caching_ctrl_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 fils_sk_pmksa_caching_ctrl_ext 1/1
Test: FILS SK and PMKSA caching with Cache Identifier and external management
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PMKSA_GET: 02:00:00:00:03:00 f3e97ce314bfdaab7b2a99ae670d3ba3 fe28a08b9c5d452324b7f709304c3db610184f87c7f639d240e22205c6a91c6c731af57f83857567bce7cfbfbf43f247 30240 43200 524288 0 ffee

Starting AP wlan4 (old add_ap argument type)
PASS fils_sk_pmksa_caching_ctrl_ext 0.349991 2020-09-05 17:48:29.811728
passed all 1 test case(s)
2020-09-05 17:48:29 	./run-tests.py fils_sk_pmksa_caching_ocv 
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 fils_sk_pmksa_caching_ocv 1/1
Test: FILS SK and PMKSA caching with OCV
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_pmksa_caching_ocv 0.400128 2020-09-05 17:48:30.339289
passed all 1 test case(s)
2020-09-05 17:48:30 	./run-tests.py fils_sk_sha384_full_auth 
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 fils_sk_sha384_full_auth 1/1
Test: FILS SK full authentication (SHA384)
Starting AP as-erp
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fils_sk_sha384_full_auth 1.126309 2020-09-05 17:48:31.592695
passed all 1 test case(s)
2020-09-05 17:48:31 	./run-tests.py fst_ack_response_proto 
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 fst_ack_response_proto 1/1
Test: FST protocol testing for Ack Response
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
PASS fst_ack_response_proto 0.50124 2020-09-05 17:48:32.222509
passed all 1 test case(s)
2020-09-05 17:48:32 	./run-tests.py fst_ap_ack_request_with_bad_fsts_id 
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 fst_ap_ack_request_with_bad_fsts_id 1/1
Test: FST AP ack request with bad fsts id
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack request received with bad fsts_id)
PASS fst_ap_ack_request_with_bad_fsts_id 5.466184 2020-09-05 17:48:37.816126
passed all 1 test case(s)
2020-09-05 17:48:37 	./run-tests.py fst_ap_ack_request_with_no_session 
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 fst_ap_ack_request_with_no_session 1/1
Test: FST AP ack request with no session
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Frame was ignored (Ack request)
PASS fst_ap_ack_request_with_no_session 5.464473 2020-09-05 17:48:43.407063
passed all 1 test case(s)
2020-09-05 17:48:43 	./run-tests.py fst_ap_ack_request_with_session_not_established_init_side 
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 fst_ap_ack_request_with_session_not_established_init_side 1/1
Test: FST AP ack request with session not established init side
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack request received on the initiator side before session was established)
PASS fst_ap_ack_request_with_session_not_established_init_side 5.994046 2020-09-05 17:48:49.526960
passed all 1 test case(s)
2020-09-05 17:48:49 	./run-tests.py fst_ap_ack_request_with_session_not_established_resp_side 
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 fst_ap_ack_request_with_session_not_established_resp_side 1/1
Test: FST AP ack request with session not established resp side
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack request received on the responder side before session was established)
PASS fst_ap_ack_request_with_session_not_established_resp_side 5.995709 2020-09-05 17:48:55.649141
passed all 1 test case(s)
2020-09-05 17:48:55 	./run-tests.py fst_ap_ack_request_with_session_not_set_up 
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 fst_ap_ack_request_with_session_not_set_up 1/1
Test: FST AP ack request with session not set up
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack request received before the session was set up)
PASS fst_ap_ack_request_with_session_not_set_up 5.469281 2020-09-05 17:49:01.246949
passed all 1 test case(s)
2020-09-05 17:49:01 	./run-tests.py fst_ap_ack_response_with_no_ack_request 
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 fst_ap_ack_response_with_no_ack_request 1/1
Test: FST AP ack response with no ack request
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack response received before ack request was sent)
PASS fst_ap_ack_response_with_no_ack_request 5.476693 2020-09-05 17:49:06.850654
passed all 1 test case(s)
2020-09-05 17:49:06 	./run-tests.py fst_ap_ack_response_with_no_session 
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 fst_ap_ack_response_with_no_session 1/1
Test: FST AP ack response with no session
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Frame was ignored (Ack response)
PASS fst_ap_ack_response_with_no_session 5.475787 2020-09-05 17:49:12.450784
passed all 1 test case(s)
2020-09-05 17:49:12 	./run-tests.py fst_ap_ack_response_with_session_not_established_init_side 
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 fst_ap_ack_response_with_session_not_established_init_side 1/1
Test: FST AP ack response with session not established init side
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack response received on the initiator side before session was established)
PASS fst_ap_ack_response_with_session_not_established_init_side 5.996441 2020-09-05 17:49:18.574917
passed all 1 test case(s)
2020-09-05 17:49:18 	./run-tests.py fst_ap_ack_response_with_session_not_established_resp_side 
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 fst_ap_ack_response_with_session_not_established_resp_side 1/1
Test: FST AP ack response with session not established resp side
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack response received on the responder side before session was established)
PASS fst_ap_ack_response_with_session_not_established_resp_side 5.999277 2020-09-05 17:49:24.701151
passed all 1 test case(s)
2020-09-05 17:49:24 	./run-tests.py fst_ap_ack_response_with_session_not_set_up 
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 fst_ap_ack_response_with_session_not_set_up 1/1
Test: FST AP ack response with session not set up
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad scenario was handled correctly (Ack response received before the session was set up)
PASS fst_ap_ack_response_with_session_not_set_up 5.473749 2020-09-05 17:49:30.299973
passed all 1 test case(s)
2020-09-05 17:49:30 	./run-tests.py fst_ap_config_default 
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 fst_ap_config_default 1/1
Test: FST AP configuration default parameters
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
hostapd didn't start with valid config parameters
Traceback (most recent call last):
  File "./run-tests.py", line 531, in main
    t(dev, apdev, params)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_fst_config.py", line 406, in test_fst_ap_config_default
    raise Exception("hostapd didn't start with valid config parameters")
Exception: hostapd didn't start with valid config parameters
FAIL fst_ap_config_default 1.201026 2020-09-05 17:49:31.626224
passed 0 test case(s)
skipped 0 test case(s)
failed tests: fst_ap_config_default
2020-09-05 17:49:31 	./run-tests.py fst_ap_config_good 
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 fst_ap_config_good 1/1
Test: FST AP configuration good parameters
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
hostapd didn't start with valid config parameters
Traceback (most recent call last):
  File "./run-tests.py", line 531, in main
    t(dev, apdev, params)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_fst_config.py", line 400, in test_fst_ap_config_good
    raise Exception("hostapd didn't start with valid config parameters")
Exception: hostapd didn't start with valid config parameters
FAIL fst_ap_config_good 1.214574 2020-09-05 17:49:32.968016
passed 0 test case(s)
skipped 0 test case(s)
failed tests: fst_ap_config_good
2020-09-05 17:49:32 	./run-tests.py fst_ap_config_group_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 fst_ap_config_group_len 1/1
Test: FST AP configuration Group max length
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_group_len 1.038532 2020-09-05 17:49:34.143336
passed all 1 test case(s)
2020-09-05 17:49:34 	./run-tests.py fst_ap_config_llt_nan 
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 fst_ap_config_llt_nan 1/1
Test: FST AP configuration LLT is not a number
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_llt_nan 1.037366 2020-09-05 17:49:35.306875
passed all 1 test case(s)
2020-09-05 17:49:35 	./run-tests.py fst_ap_config_llt_neg 
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 fst_ap_config_llt_neg 1/1
Test: FST AP configuration negative LLT
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_llt_neg 1.039218 2020-09-05 17:49:36.472550
passed all 1 test case(s)
2020-09-05 17:49:36 	./run-tests.py fst_ap_config_llt_too_big 
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 fst_ap_config_llt_too_big 1/1
Test: FST AP configuration LLT is too big
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_llt_too_big 1.036907 2020-09-05 17:49:37.637726
passed all 1 test case(s)
2020-09-05 17:49:37 	./run-tests.py fst_ap_config_llt_zero 
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 fst_ap_config_llt_zero 1/1
Test: FST AP configuration zero LLT
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_llt_zero 1.038161 2020-09-05 17:49:38.802893
passed all 1 test case(s)
2020-09-05 17:49:38 	./run-tests.py fst_ap_config_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 fst_ap_config_oom 1/1
Test: FST AP configuration and OOM
Starting AP wlan3 (old add_ap argument type)
PASS fst_ap_config_oom 0.103994 2020-09-05 17:49:39.033615
passed all 1 test case(s)
2020-09-05 17:49:39 	./run-tests.py fst_ap_config_pri_large 
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 fst_ap_config_pri_large 1/1
Test: FST AP configuration Priority too large
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_pri_large 1.038533 2020-09-05 17:49:40.196485
passed all 1 test case(s)
2020-09-05 17:49:40 	./run-tests.py fst_ap_config_pri_nan 
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 fst_ap_config_pri_nan 1/1
Test: FST AP configuration Priority not a number
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_pri_nan 1.03777 2020-09-05 17:49:41.359994
passed all 1 test case(s)
2020-09-05 17:49:41 	./run-tests.py fst_ap_config_pri_neg 
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 fst_ap_config_pri_neg 1/1
Test: FST AP configuration Priority negative
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_pri_neg 1.037882 2020-09-05 17:49:42.523844
passed all 1 test case(s)
2020-09-05 17:49:42 	./run-tests.py fst_ap_config_pri_zero 
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 fst_ap_config_pri_zero 1/1
Test: FST AP configuration Priority zero
kill_pid: pidfile logs/current/myhostapd.pid does not exist - try again after a second
kill_pid: pidfile logs/current/myhostapd.pid does not exist - could not kill the process
PASS fst_ap_config_pri_zero 1.037601 2020-09-05 17:49:43.687593
passed all 1 test case(s)
2020-09-05 17:49:43 	./run-tests.py fst_ap_connect_to_fst_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 fst_ap_connect_to_fst_sta 1/1
Test: FST AP connecting to FST STA
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
PASS fst_ap_connect_to_fst_sta 2.391988 2020-09-05 17:49:46.205204
passed all 1 test case(s)
2020-09-05 17:49:46 	./run-tests.py fst_ap_connect_to_non_fst_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 fst_ap_connect_to_non_fst_sta 1/1
Test: FST AP connecting to non-FST STA
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan0 to AP
PASS fst_ap_connect_to_non_fst_sta 2.383183 2020-09-05 17:49:48.716235
passed all 1 test case(s)
2020-09-05 17:49:48 	./run-tests.py fst_ap_ctrl_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 fst_ap_ctrl_iface 1/1
Test: FST control interface behavior
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Initial session params:
{'old_peer_addr': '00:00:00:00:00:00', 'new_peer_addr': '00:00:00:00:00:00', 'new_ifname': 'NONE', 'old_ifname': 'NONE', 'llt': '50', 'state': 'INITIAL'}
Session params after configuration:
{'old_peer_addr': '02:00:00:00:05:00', 'new_peer_addr': '02:00:00:00:05:00', 'new_ifname': 'wlan4', 'old_ifname': 'wlan3', 'llt': '100', 'state': 'INITIAL'}
Interface peers: ['02:00:00:00:05:00']
Peer MB IEs: 9e1c0c0200000000000000000000000000000000000000ff0200000006009e1c0c0400000000000000000000000000000000000000ff020000000600
Interfaces: [{'name': 'wlan4|02', 'priority': '00', 'llt': '00'}, {'name': 'wlan3|02', 'priority': '00', 'llt': '00'}]
Groups: ['fstg0']
PASS fst_ap_ctrl_iface 0.493596 2020-09-05 17:49:49.334749
passed all 1 test case(s)
2020-09-05 17:49:49 	./run-tests.py fst_ap_initiate_session 
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 fst_ap_initiate_session 1/1
Test: FST AP initiate session
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Session initiated
PASS fst_ap_initiate_session 0.471228 2020-09-05 17:49:49.934006
passed all 1 test case(s)
2020-09-05 17:49:49 	./run-tests.py fst_ap_initiate_session_bad_peer_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 fst_ap_initiate_session_bad_peer_addr 1/1
Test: FST AP initiate session - bad peer address
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (Peer address)
PASS fst_ap_initiate_session_bad_peer_addr 0.464581 2020-09-05 17:49:50.523738
passed all 1 test case(s)
2020-09-05 17:49:50 	./run-tests.py fst_ap_initiate_session_concurrent_setup_request 
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 fst_ap_initiate_session_concurrent_setup_request 1/1
Test: FST AP initiate session - concurrent setup request
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (Concurrent setup request)
PASS fst_ap_initiate_session_concurrent_setup_request 0.471483 2020-09-05 17:49:51.122013
passed all 1 test case(s)
2020-09-05 17:49:51 	./run-tests.py fst_ap_initiate_session_invalid_session_id 
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 fst_ap_initiate_session_invalid_session_id 1/1
Test: FST AP initiate session - invalid session id
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (Session ID)
PASS fst_ap_initiate_session_invalid_session_id 0.464742 2020-09-05 17:49:51.713557
passed all 1 test case(s)
2020-09-05 17:49:51 	./run-tests.py fst_ap_initiate_session_no_new_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 fst_ap_initiate_session_no_new_iface 1/1
Test: FST AP initiate session - no new iface
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (No new_iface was set)
PASS fst_ap_initiate_session_no_new_iface 0.470638 2020-09-05 17:49:52.310531
passed all 1 test case(s)
2020-09-05 17:49:52 	./run-tests.py fst_ap_initiate_session_no_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 fst_ap_initiate_session_no_params 1/1
Test: FST AP initiate session - no params
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (No params passed to session initiate)
PASS fst_ap_initiate_session_no_params 0.46722 2020-09-05 17:49:52.905798
passed all 1 test case(s)
2020-09-05 17:49:52 	./run-tests.py fst_ap_initiate_session_request_with_bad_stie 
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 fst_ap_initiate_session_request_with_bad_stie 1/1
Test: FST AP initiate session - request with bad stie
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (Request with bad st ie)
PASS fst_ap_initiate_session_request_with_bad_stie 5.463311 2020-09-05 17:49:58.495852
passed all 1 test case(s)
2020-09-05 17:49:58 	./run-tests.py fst_ap_initiate_session_response_with_bad_stie 
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 fst_ap_initiate_session_response_with_bad_stie 1/1
Test: FST AP initiate session - response with bad stie
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (Response with bad st ie)
PASS fst_ap_initiate_session_response_with_bad_stie 0.454826 2020-09-05 17:49:59.076748
passed all 1 test case(s)
2020-09-05 17:49:59 	./run-tests.py fst_ap_initiate_session_response_with_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 fst_ap_initiate_session_response_with_reject 1/1
Test: FST AP initiate session - response with reject
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (Response with reject)
PASS fst_ap_initiate_session_response_with_reject 0.468755 2020-09-05 17:49:59.672934
passed all 1 test case(s)
2020-09-05 17:49:59 	./run-tests.py fst_ap_initiate_session_response_with_zero_llt 
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 fst_ap_initiate_session_response_with_zero_llt 1/1
Test: FST AP initiate session - zero llt
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (Response with zero llt)
PASS fst_ap_initiate_session_response_with_zero_llt 0.476592 2020-09-05 17:50:00.276840
passed all 1 test case(s)
2020-09-05 17:50:00 	./run-tests.py fst_ap_initiate_session_stt_no_response 
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 fst_ap_initiate_session_stt_no_response 1/1
Test: FST AP initiate session - stt no response
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Bad parameter was detected (No response, STT)
PASS fst_ap_initiate_session_stt_no_response 0.98285 2020-09-05 17:50:01.386474
passed all 1 test case(s)
2020-09-05 17:50:01 	./run-tests.py fst_ap_remove_session_bad_session_id 
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 fst_ap_remove_session_bad_session_id 1/1
Test: FST AP remove session - bad session id
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Remove scenario ended as expected (Bad session id)
PASS fst_ap_remove_session_bad_session_id 0.461013 2020-09-05 17:50:01.973635
passed all 1 test case(s)
2020-09-05 17:50:01 	./run-tests.py fst_ap_remove_session_established 
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 fst_ap_remove_session_established 1/1
Test: FST AP remove session - established
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Session removed
PASS fst_ap_remove_session_established 0.46757 2020-09-05 17:50:02.566511
passed all 1 test case(s)
2020-09-05 17:50:02 	./run-tests.py fst_ap_remove_session_no_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 fst_ap_remove_session_no_params 1/1
Test: FST AP remove session - no params
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Remove scenario ended as expected (No params)
PASS fst_ap_remove_session_no_params 0.463076 2020-09-05 17:50:03.154787
passed all 1 test case(s)
2020-09-05 17:50:03 	./run-tests.py fst_ap_remove_session_not_established 
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 fst_ap_remove_session_not_established 1/1
Test: FST AP remove session - not established
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Remove scenario ended as expected (Remove non-established session)
PASS fst_ap_remove_session_not_established 5.466371 2020-09-05 17:50:08.746932
passed all 1 test case(s)
2020-09-05 17:50:08 	./run-tests.py fst_ap_session_request_with_no_session 
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 fst_ap_session_request_with_no_session 1/1
Test: FST AP session request with no session
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Frame received, session created
PASS fst_ap_session_request_with_no_session 0.46252 2020-09-05 17:50:09.334966
passed all 1 test case(s)
2020-09-05 17:50:09 	./run-tests.py fst_ap_session_response_accept_with_no_session 
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 fst_ap_session_response_accept_with_no_session 1/1
Test: FST AP session response accept with no session
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect STA wlan5 to AP
Connect STA wlan6 to AP
Success. Frame was ignored (Session Response)
PASS fst_ap_session_response_accept_with_no_session 5.463639 2020-09-05 17:50:14.924646
passed all 1 test case(s)
2020-09-05 17:50:14 ./stop.sh
2020-09-05 17:50:16 ./start.sh channels=4
2020-09-05 17:50:16 ./stop.sh