2017-10-05 23:06:08 export USER=root
2017-10-05 23:06:08 ./build.sh
Building TNC testing tools
Building wlantest
Building hostapd
Building wpa_supplicant
2017-10-05 23:07:07 ./start.sh
2017-10-05 23:07:07 	./run-tests.py ap_acl_accept 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acl_accept 1/1
Test: MAC ACL accept list
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan1 to AP
Connect STA wlan0 to AP
PASS ap_acl_accept 1.192388 2017-10-05 23:07:09.634259
passed all 1 test case(s)
2017-10-05 23:07:09 	./run-tests.py ap_acl_deny 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acl_deny 1/1
Test: MAC ACL deny list
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS ap_acl_deny 1.152253 2017-10-05 23:07:10.921774
passed all 1 test case(s)
2017-10-05 23:07:10 	./run-tests.py ap_acs 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs 1/1
Test: Automatic channel selection
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs 6.460035 2017-10-05 23:07:17.541037
passed all 1 test case(s)
2017-10-05 23:07:17 	./run-tests.py ap_acs_40mhz 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_40mhz 1/1
Test: Automatic channel selection for 40 MHz channel
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_40mhz 7.787325 2017-10-05 23:07:25.488517
passed all 1 test case(s)
2017-10-05 23:07:25 	./run-tests.py ap_acs_40mhz_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 ap_acs_40mhz_minus 1/1
Test: Automatic channel selection for HT40- channel
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
PASS ap_acs_40mhz_minus 0.516938 2017-10-05 23:07:26.209321
passed all 1 test case(s)
2017-10-05 23:07:26 	./run-tests.py ap_acs_5ghz 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_5ghz 1/1
Test: Automatic channel selection on 5 GHz
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_5ghz 5.438496 2017-10-05 23:07:31.802082
passed all 1 test case(s)
2017-10-05 23:07:31 	./run-tests.py ap_acs_5ghz_40mhz 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_5ghz_40mhz 1/1
Test: Automatic channel selection on 5 GHz for 40 MHz channel
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_5ghz_40mhz 5.664074 2017-10-05 23:07:37.626049
passed all 1 test case(s)
2017-10-05 23:07:37 	./run-tests.py ap_acs_bias 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_bias 1/1
Test: Automatic channel selection with bias values
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_bias 6.512287 2017-10-05 23:07:44.310355
passed all 1 test case(s)
2017-10-05 23:07:44 	./run-tests.py ap_acs_chanlist 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_chanlist 1/1
Test: Automatic channel selection with chanlist set
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_chanlist 2.015111 2017-10-05 23:07:46.494146
passed all 1 test case(s)
2017-10-05 23:07:46 	./run-tests.py ap_acs_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 ap_acs_errors 1/1
Test: Automatic channel selection failures
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
PASS ap_acs_errors 0.610901 2017-10-05 23:07:47.280975
passed all 1 test case(s)
2017-10-05 23:07:47 	./run-tests.py ap_acs_survey 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_survey 1/1
Test: Automatic channel selection using acs_survey parameter
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_survey 1.527389 2017-10-05 23:07:48.966421
passed all 1 test case(s)
2017-10-05 23:07:49 	./run-tests.py ap_acs_vht 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_vht 1/1
Test: Automatic channel selection for VHT
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_vht 5.66865 2017-10-05 23:07:54.802475
passed all 1 test case(s)
2017-10-05 23:07:54 	./run-tests.py ap_acs_vht160 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_vht160 1/1
Test: Automatic channel selection for VHT160
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_vht160 0.653378 2017-10-05 23:07:55.664414
passed all 1 test case(s)
2017-10-05 23:07:55 	./run-tests.py ap_acs_vht160_scan_disable 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_vht160_scan_disable 1/1
Test: Automatic channel selection for VHT160 and DISABLE during scan
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
PASS ap_acs_vht160_scan_disable 3.237986 2017-10-05 23:07:59.051989
passed all 1 test case(s)
2017-10-05 23:07:59 	./run-tests.py ap_acs_vht40 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_acs_vht40 1/1
Test: Automatic channel selection for VHT40
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_acs_vht40 0.850379 2017-10-05 23:08:00.076126
passed all 1 test case(s)
2017-10-05 23:08:00 	./run-tests.py ap_add_with_driver 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_add_with_driver 1/1
Test: Add hostapd interface with driver specified
Connect STA wlan0 to AP
PASS ap_add_with_driver 0.135234 2017-10-05 23:08:00.384484
passed all 1 test case(s)
2017-10-05 23:08:00 	./run-tests.py ap_anqp_domain_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 ap_anqp_domain_id 1/1
Test: ANQP Domain ID
Starting AP wlan3
Starting AP wlan4
PASS ap_anqp_domain_id 0.263783 2017-10-05 23:08:00.794401
passed all 1 test case(s)
2017-10-05 23:08:00 	./run-tests.py ap_anqp_no_sharing_diff_ess 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_anqp_no_sharing_diff_ess 1/1
Test: ANQP no sharing between ESSs
Starting AP wlan3
Starting AP wlan4
Normal network selection with shared ANQP results
PASS ap_anqp_no_sharing_diff_ess 0.259109 2017-10-05 23:08:01.230442
passed all 1 test case(s)
2017-10-05 23:08:01 	./run-tests.py ap_anqp_no_sharing_missing_info 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_anqp_no_sharing_missing_info 1/1
Test: ANQP no sharing due to missing information
Starting AP wlan3
Starting AP wlan4
Normal network selection with shared ANQP results
PASS ap_anqp_no_sharing_missing_info 0.241073 2017-10-05 23:08:01.637368
passed all 1 test case(s)
2017-10-05 23:08:01 	./run-tests.py ap_anqp_sharing 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_anqp_sharing 1/1
Test: ANQP sharing within ESS and explicit unshare
Starting AP wlan3
Starting AP wlan4
Normal network selection with shared ANQP results
Explicit ANQP request to unshare ANQP results
PASS ap_anqp_sharing 0.278611 2017-10-05 23:08:02.076302
passed all 1 test case(s)
2017-10-05 23:08:02 	./run-tests.py ap_anqp_sharing_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 ap_anqp_sharing_oom 1/1
Test: ANQP sharing within ESS and explicit unshare OOM
Starting AP wlan3
Starting AP wlan4
PASS ap_anqp_sharing_oom 0.287182 2017-10-05 23:08:02.514239
passed all 1 test case(s)
2017-10-05 23:08:02 	./run-tests.py ap_basic_rates 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_basic_rates 1/1
Test: Open AP with lots of basic rates
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_basic_rates 0.120547 2017-10-05 23:08:02.798048
passed all 1 test case(s)
2017-10-05 23:08:02 	./run-tests.py ap_beacon_rate_ht 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_beacon_rate_ht 1/1
Test: Open AP with Beacon frame TX rate HT-MCS 0
Starting AP wlan3
Skip test case: Setting Beacon frame TX rate not supported
SKIP ap_beacon_rate_ht 0.057799 2017-10-05 23:08:03.044449
passed all 0 test case(s)
skipped 1 test case(s)
2017-10-05 23:08:03 	./run-tests.py ap_beacon_rate_ht2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_beacon_rate_ht2 1/1
Test: Open AP with Beacon frame TX rate HT-MCS 1 in VHT BSS
Starting AP wlan3
Skip test case: Setting Beacon frame TX rate not supported
SKIP ap_beacon_rate_ht2 0.053788 2017-10-05 23:08:03.272773
passed all 0 test case(s)
skipped 1 test case(s)
2017-10-05 23:08:03 	./run-tests.py ap_beacon_rate_legacy 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_beacon_rate_legacy 1/1
Test: Open AP with Beacon frame TX rate 5.5 Mbps
Starting AP wlan3
Skip test case: Setting Beacon frame TX rate not supported
SKIP ap_beacon_rate_legacy 0.064008 2017-10-05 23:08:03.508745
passed all 0 test case(s)
skipped 1 test case(s)
2017-10-05 23:08:03 	./run-tests.py ap_beacon_rate_legacy2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_beacon_rate_legacy2 1/1
Test: Open AP with Beacon frame TX rate 12 Mbps in VHT BSS
Starting AP wlan3
Skip test case: Setting Beacon frame TX rate not supported
SKIP ap_beacon_rate_legacy2 0.058852 2017-10-05 23:08:03.740233
passed all 0 test case(s)
skipped 1 test case(s)
2017-10-05 23:08:03 	./run-tests.py ap_beacon_rate_vht 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_beacon_rate_vht 1/1
Test: Open AP with Beacon frame TX rate VHT-MCS 0
Starting AP wlan3
Skip test case: Setting Beacon frame TX rate not supported
SKIP ap_beacon_rate_vht 0.069109 2017-10-05 23:08:03.967382
passed all 0 test case(s)
skipped 1 test case(s)
2017-10-05 23:08:03 	./run-tests.py ap_bss_add_many 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_bss_add_many 1/1
Test: Large number of BSS add operations with hostapd
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-0
Starting BSS phy=phy3 ifname=wlan3-1
Starting BSS phy=phy3 ifname=wlan3-2
Starting BSS phy=phy3 ifname=wlan3-3
Starting BSS phy=phy3 ifname=wlan3-4
Starting BSS phy=phy3 ifname=wlan3-5
Starting BSS phy=phy3 ifname=wlan3-6
Starting BSS phy=phy3 ifname=wlan3-7
Starting BSS phy=phy3 ifname=wlan3-8
Starting BSS phy=phy3 ifname=wlan3-9
Starting BSS phy=phy3 ifname=wlan3-10
Starting BSS phy=phy3 ifname=wlan3-11
Starting BSS phy=phy3 ifname=wlan3-12
Starting BSS phy=phy3 ifname=wlan3-13
Starting BSS phy=phy3 ifname=wlan3-14
Starting BSS phy=phy3 ifname=wlan3-15
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Removing BSS wlan3-0
Connect STA wlan0 to AP
Removing BSS wlan3-1
Connect STA wlan0 to AP
Removing BSS wlan3-2
Connect STA wlan0 to AP
Removing BSS wlan3-3
Connect STA wlan0 to AP
Removing BSS wlan3-4
Connect STA wlan0 to AP
Removing BSS wlan3-5
Connect STA wlan0 to AP
Removing BSS wlan3-6
Connect STA wlan0 to AP
Removing BSS wlan3-7
Connect STA wlan0 to AP
Removing BSS wlan3-8
Connect STA wlan0 to AP
Removing BSS wlan3-9
Connect STA wlan0 to AP
Removing BSS wlan3-10
Connect STA wlan0 to AP
Removing BSS wlan3-11
Connect STA wlan0 to AP
Removing BSS wlan3-12
Connect STA wlan0 to AP
Removing BSS wlan3-13
Connect STA wlan0 to AP
Removing BSS wlan3-14
Connect STA wlan0 to AP
Removing BSS wlan3-15
PASS ap_bss_add_many 1.150052 2017-10-05 23:08:05.268845
passed all 1 test case(s)
2017-10-05 23:08:05 	./run-tests.py ap_bss_add_out_of_memory 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_bss_add_out_of_memory 1/1
Test: Running out of memory while adding a BSS
Starting AP wlan4
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-2
Removing BSS wlan3-2
Removing BSS wlan3
PASS ap_bss_add_out_of_memory 0.180093 2017-10-05 23:08:05.620988
passed all 1 test case(s)
2017-10-05 23:08:05 	./run-tests.py ap_bss_add_remove 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_bss_add_remove 1/1
Test: Dynamic BSS add/remove operations with hostapd
Set up three BSSes one by one
Starting BSS phy=phy3 ifname=wlan3
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Starting BSS phy=phy3 ifname=wlan3-2
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Starting BSS phy=phy3 ifname=wlan3-3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Remove the last BSS and re-add it
Removing BSS wlan3-3
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Starting BSS phy=phy3 ifname=wlan3-3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Remove the middle BSS and re-add it
Removing BSS wlan3-2
Connect STA wlan1 to AP
Connect STA wlan0 to AP
Connect STA wlan2 to AP
Starting BSS phy=phy3 ifname=wlan3-2
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Remove the first BSS and re-add it and other BSSs
Removing BSS wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-2
Starting BSS phy=phy3 ifname=wlan3-3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Remove two BSSes and re-add them
Removing BSS wlan3-2
Connect STA wlan1 to AP
Connect STA wlan0 to AP
Connect STA wlan2 to AP
Removing BSS wlan3-3
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Starting BSS phy=phy3 ifname=wlan3-2
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Starting BSS phy=phy3 ifname=wlan3-3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Remove three BSSes in and re-add them
Removing BSS wlan3-3
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Removing BSS wlan3-2
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Removing BSS wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Starting BSS phy=phy3 ifname=wlan3
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Starting BSS phy=phy3 ifname=wlan3-2
Connect STA wlan2 to AP
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Starting BSS phy=phy3 ifname=wlan3-3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Test error handling if a duplicate ifname is tried
Starting BSS phy=phy3 ifname=wlan3-3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
PASS ap_bss_add_remove 6.212109 2017-10-05 23:08:11.991688
passed all 1 test case(s)
2017-10-05 23:08:12 	./run-tests.py ap_bss_add_remove_during_ht_scan 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_bss_add_remove_during_ht_scan 1/1
Test: Dynamic BSS add during HT40 co-ex scan
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-2
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Removing BSS wlan3-2
Removing BSS wlan3
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-2
Removing BSS wlan3-2
Connect STA wlan1 to AP
Connect STA wlan0 to AP
Removing BSS wlan3
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-2
Removing BSS wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS ap_bss_add_remove_during_ht_scan 11.049364 2017-10-05 23:08:23.234578
passed all 1 test case(s)
2017-10-05 23:08:23 	./run-tests.py ap_bss_add_reuse_existing 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_bss_add_reuse_existing 1/1
Test: Dynamic BSS add operation reusing existing interface
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-2
Removing BSS wlan3-2
PASS ap_bss_add_reuse_existing 0.095892 2017-10-05 23:08:23.478962
passed all 1 test case(s)
2017-10-05 23:08:23 	./run-tests.py ap_bss_config_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 ap_bss_config_file 1/1
Test: hostapd BSS config file
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Connect STA wlan2 to AP
PASS ap_bss_config_file 0.369573 2017-10-05 23:08:23.993425
passed all 1 test case(s)
2017-10-05 23:08:24 	./run-tests.py ap_bss_load 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_bss_load 1/1
Test: AP with open mode (no security) configuration
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_bss_load 2.389666 2017-10-05 23:08:26.543111
passed all 1 test case(s)
2017-10-05 23:08:26 	./run-tests.py ap_bss_load_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 ap_bss_load_fail 1/1
Test: BSS Load update failing to get survey data
Starting AP wlan3
PASS ap_bss_load_fail 0.165583 2017-10-05 23:08:26.860960
passed all 1 test case(s)
2017-10-05 23:08:26 	./run-tests.py ap_change_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 ap_change_ssid 1/1
Test: Dynamic SSID change with hostapd and WPA2-PSK
Starting AP wlan3
Connect STA wlan0 to AP
Change SSID dynamically
PASS ap_change_ssid 0.21341 2017-10-05 23:08:27.227852
passed all 1 test case(s)
2017-10-05 23:08:27 	./run-tests.py ap_cipher_bip 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_bip 1/1
Test: WPA2-PSK with BIP
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 279, in test_ap_cipher_bip
    check_group_mgmt_cipher(dev[0], apdev[0], "AES-128-CMAC")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 51, in check_group_mgmt_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_bip 5.24306 2017-10-05 23:08:32.620542
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_bip
2017-10-05 23:08:32 	./run-tests.py ap_cipher_bip_cmac_256 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_bip_cmac_256 1/1
Test: WPA2-PSK with BIP-CMAC-256
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 291, in test_ap_cipher_bip_cmac_256
    check_group_mgmt_cipher(dev[0], apdev[0], "BIP-CMAC-256")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 51, in check_group_mgmt_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_bip_cmac_256 5.212464 2017-10-05 23:08:37.973394
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_bip_cmac_256
2017-10-05 23:08:37 	./run-tests.py ap_cipher_bip_gmac_128 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_bip_gmac_128 1/1
Test: WPA2-PSK with BIP-GMAC-128
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 283, in test_ap_cipher_bip_gmac_128
    check_group_mgmt_cipher(dev[0], apdev[0], "BIP-GMAC-128")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 51, in check_group_mgmt_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_bip_gmac_128 5.19926 2017-10-05 23:08:43.301333
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_bip_gmac_128
2017-10-05 23:08:43 	./run-tests.py ap_cipher_bip_gmac_256 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_bip_gmac_256 1/1
Test: WPA2-PSK with BIP-GMAC-256
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 287, in test_ap_cipher_bip_gmac_256
    check_group_mgmt_cipher(dev[0], apdev[0], "BIP-GMAC-256")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 51, in check_group_mgmt_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_bip_gmac_256 5.183532 2017-10-05 23:08:48.624150
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_bip_gmac_256
2017-10-05 23:08:48 	./run-tests.py ap_cipher_ccmp 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_ccmp 1/1
Test: WPA2-PSK/CCMP connection
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 219, in test_ap_cipher_ccmp
    check_cipher(dev[0], apdev[0], "CCMP")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 29, in check_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_ccmp 5.219886 2017-10-05 23:08:54.022672
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_ccmp
2017-10-05 23:08:54 	./run-tests.py ap_cipher_ccmp_256 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_ccmp_256 1/1
Test: WPA2-PSK/CCMP-256 connection
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 227, in test_ap_cipher_ccmp_256
    check_cipher(dev[0], apdev[0], "CCMP-256")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 29, in check_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_ccmp_256 5.171406 2017-10-05 23:08:59.313285
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_ccmp_256
2017-10-05 23:08:59 	./run-tests.py ap_cipher_gcmp 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_gcmp 1/1
Test: WPA2-PSK/GCMP connection
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 223, in test_ap_cipher_gcmp
    check_cipher(dev[0], apdev[0], "GCMP")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 29, in check_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_gcmp 5.175247 2017-10-05 23:09:04.619352
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_gcmp
2017-10-05 23:09:04 	./run-tests.py ap_cipher_gcmp_256 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cipher_gcmp_256 1/1
Test: WPA2-PSK/GCMP-256 connection
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 231, in test_ap_cipher_gcmp_256
    check_cipher(dev[0], apdev[0], "GCMP-256")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 29, in check_cipher
    hwsim_utils.test_connectivity(dev, hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_gcmp_256 5.181229 2017-10-05 23:09:10.002319
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_gcmp_256
2017-10-05 23:09:10 	./run-tests.py ap_cipher_mixed_wpa_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 ap_cipher_mixed_wpa_wpa2 1/1
Test: WPA2-PSK/CCMP/ and WPA-PSK/TKIP mixed configuration
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 262, in test_ap_cipher_mixed_wpa_wpa2
    hwsim_utils.test_connectivity(dev[0], hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_cipher_mixed_wpa_wpa2 5.180581 2017-10-05 23:09:15.320978
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_mixed_wpa_wpa2
2017-10-05 23:09:15 	./run-tests.py ap_cipher_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 ap_cipher_tkip 1/1
Test: WPA2-PSK/TKIP connection
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_cipher_tkip 0.152902 2017-10-05 23:09:15.627872
passed all 1 test case(s)
2017-10-05 23:09:15 	./run-tests.py ap_cipher_tkip_countermeasures_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 ap_cipher_tkip_countermeasures_ap 1/1
Test: WPA-PSK/TKIP countermeasures (detected by AP)
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_cipher_tkip_countermeasures_ap 2.142393 2017-10-05 23:09:17.929865
passed all 1 test case(s)
2017-10-05 23:09:17 	./run-tests.py ap_cipher_tkip_countermeasures_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 ap_cipher_tkip_countermeasures_sta 1/1
Test: WPA-PSK/TKIP countermeasures (detected by STA)
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_cipher_tkip_countermeasures_sta 2.154813 2017-10-05 23:09:20.247146
passed all 1 test case(s)
2017-10-05 23:09:20 	./run-tests.py ap_cipher_tkip_countermeasures_sta2 --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 ap_cipher_tkip_countermeasures_sta2 1/1
Test: WPA-PSK/TKIP countermeasures (detected by two STAs) [long]
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
Waiting for TKIP countermeasures to end
Connect STA wlan0 to AP
No connection result
Traceback (most recent call last):
  File "./run-tests.py", line 451, in main
    t(dev, apdev, params)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ciphers.py", line 197, in test_ap_cipher_tkip_countermeasures_sta2
    raise Exception("No connection result")
Exception: No connection result
FAIL ap_cipher_tkip_countermeasures_sta2 12.253081 2017-10-05 23:09:32.689855
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_cipher_tkip_countermeasures_sta2
2017-10-05 23:09:32 	./run-tests.py ap_cli_order 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_cli_order 1/1
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_cli_order 0.1276 2017-10-05 23:09:32.975856
passed all 1 test case(s)
2017-10-05 23:09:32 	./run-tests.py ap_config_eap_user_file_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 ap_config_eap_user_file_parsing 1/1
Test: hostapd eap_user_file parsing
Starting AP wlan3
PASS ap_config_eap_user_file_parsing 0.063078 2017-10-05 23:09:33.185979
passed all 1 test case(s)
2017-10-05 23:09:33 	./run-tests.py ap_config_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 ap_config_errors 1/1
Test: Various hostapd configuration errors
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Removing BSS wlan3
Starting AP wlan3
Removing BSS wlan3
PASS ap_config_errors 0.096001 2017-10-05 23:09:33.409532
passed all 1 test case(s)
2017-10-05 23:09:33 	./run-tests.py ap_config_invalid_value 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_config_invalid_value 1/1
Test: Ignoring invalid hostapd configuration parameter updates
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_config_invalid_value 0.111417 2017-10-05 23:09:33.652720
passed all 1 test case(s)
2017-10-05 23:09:33 	./run-tests.py ap_config_reload 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_config_reload 1/1
Test: hostapd configuration reload
Starting AP wlan3
Connect STA wlan0 to AP
Disconnection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 451, in main
    t(dev, apdev, params)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_config.py", line 100, in test_ap_config_reload
    dev[0].wait_disconnected()
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1280, in wait_disconnected
    raise Exception(error)
Exception: Disconnection timed out
FAIL ap_config_reload 10.240865 2017-10-05 23:09:44.017808
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_config_reload
2017-10-05 23:09:44 	./run-tests.py ap_config_reload_before_enable 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_config_reload_before_enable 1/1
Test: hostapd configuration reload before enable
Starting interface wlan3
PASS ap_config_reload_before_enable 0.039403 2017-10-05 23:09:44.207410
passed all 1 test case(s)
2017-10-05 23:09:44 	./run-tests.py ap_config_reload_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 ap_config_reload_file 1/1
Test: hostapd configuration reload from file
Starting interface wlan3
Connect STA wlan0 to AP
Disconnection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 451, in main
    t(dev, apdev, params)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_config.py", line 115, in test_ap_config_reload_file
    dev[0].wait_disconnected()
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1280, in wait_disconnected
    raise Exception(error)
Exception: Disconnection timed out
FAIL ap_config_reload_file 10.23285 2017-10-05 23:09:54.574212
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_config_reload_file
2017-10-05 23:09:54 	./run-tests.py ap_config_set_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 ap_config_set_errors 1/1
Test: hostapd configuration parsing errors
Starting AP wlan3
hs20_conn_capab limit at 16380
PASS ap_config_set_errors 1.616979 2017-10-05 23:09:56.348455
passed all 1 test case(s)
2017-10-05 23:09:56 	./run-tests.py ap_config_set_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 ap_config_set_oom 1/1
Test: hostapd configuration parsing OOM
Starting AP wlan3
PASS ap_config_set_oom 0.063704 2017-10-05 23:09:56.530559
passed all 1 test case(s)
2017-10-05 23:09:56 	./run-tests.py ap_config_sigusr1 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_config_sigusr1 1/1
Test: hostapd SIGUSR1
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_config_sigusr1 0.110301 2017-10-05 23:09:56.757834
passed all 1 test case(s)
2017-10-05 23:09:56 	./run-tests.py ap_country 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_country 1/1
Test: WPA2-PSK AP setting country code and using 5 GHz band
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_params.py", line 117, in test_ap_country
    hwsim_utils.test_connectivity(dev[0], hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_country 5.300367 2017-10-05 23:10:02.187818
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_country
2017-10-05 23:10:02 	./run-tests.py ap_csa_1_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 ap_csa_1_switch 1/1
Test: AP Channel Switch, one switch
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_1_switch 1.207326 2017-10-05 23:10:03.563430
passed all 1 test case(s)
2017-10-05 23:10:03 	./run-tests.py ap_csa_1_switch_count_0 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_csa_1_switch_count_0 1/1
Test: AP Channel Switch, one switch with count 0
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_1_switch_count_0 0.179693 2017-10-05 23:10:03.915969
passed all 1 test case(s)
2017-10-05 23:10:03 	./run-tests.py ap_csa_1_switch_count_1 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_csa_1_switch_count_1 1/1
Test: AP Channel Switch, one switch with count 1
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_1_switch_count_1 0.166534 2017-10-05 23:10:04.240346
passed all 1 test case(s)
2017-10-05 23:10:04 	./run-tests.py ap_csa_1_switch_count_2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_csa_1_switch_count_2 1/1
Test: AP Channel Switch, one switch with count 2
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_1_switch_count_2 0.366832 2017-10-05 23:10:04.778147
passed all 1 test case(s)
2017-10-05 23:10:04 	./run-tests.py ap_csa_2_switches 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_csa_2_switches 1/1
Test: AP Channel Switch, two switches
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_2_switches 2.235053 2017-10-05 23:10:07.138975
passed all 1 test case(s)
2017-10-05 23:10:07 	./run-tests.py ap_csa_2_switches_count_0 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_csa_2_switches_count_0 1/1
Test: AP Channel Switch, two switches with count 0
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_2_switches_count_0 0.132401 2017-10-05 23:10:07.451632
passed all 1 test case(s)
2017-10-05 23:10:07 	./run-tests.py ap_csa_2_switches_count_1 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_csa_2_switches_count_1 1/1
Test: AP Channel Switch, two switches with count 1
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_2_switches_count_1 0.129625 2017-10-05 23:10:07.717836
passed all 1 test case(s)
2017-10-05 23:10:07 	./run-tests.py ap_csa_ecsa_only 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_csa_ecsa_only 1/1
Test: AP Channel Switch, one switch with only ECSA IE
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_ecsa_only 1.137302 2017-10-05 23:10:08.980170
passed all 1 test case(s)
2017-10-05 23:10:09 	./run-tests.py ap_csa_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 ap_csa_invalid 1/1
Test: AP Channel Switch - invalid channel
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_csa_invalid 0.175241 2017-10-05 23:10:09.298487
passed all 1 test case(s)
2017-10-05 23:10:09 	./run-tests.py ap_double_disable 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_double_disable 1/1
Test: Double DISABLE regression test
Starting BSS phy=phy3 ifname=wlan3
Starting BSS phy=phy3 ifname=wlan3-2
PASS ap_double_disable 0.108463 2017-10-05 23:10:09.589430
passed all 1 test case(s)
2017-10-05 23:10:09 	./run-tests.py ap_dtim_period 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_dtim_period 1/1
Test: DTIM period configuration
Starting AP wlan3
Connect STA wlan0 to AP
DTIM count 5  DTIM period 10
PASS ap_dtim_period 0.15295 2017-10-05 23:10:09.881135
passed all 1 test case(s)
2017-10-05 23:10:09 	./run-tests.py ap_duplicate_bssid 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_duplicate_bssid 1/1
Test: Duplicate BSSID
Starting AP wlan3
Starting BSS phy=phy3 ifname=wlan3-2
Starting BSS phy=phy3 ifname=wlan3-3
Connect STA wlan0 to AP
PASS ap_duplicate_bssid 0.135734 2017-10-05 23:10:10.166062
passed all 1 test case(s)
2017-10-05 23:10:10 	./run-tests.py ap_eapol_version 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_eapol_version 1/1
Test: hostapd eapol_version configuration
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS ap_eapol_version 0.315418 2017-10-05 23:10:10.612770
passed all 1 test case(s)
2017-10-05 23:10:10 	./run-tests.py ap_element_parse 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_element_parse 1/1
Test: Information element parsing - extra coverage
Starting AP wlan3
PASS ap_element_parse 0.081581 2017-10-05 23:10:10.820060
passed all 1 test case(s)
2017-10-05 23:10:10 	./run-tests.py ap_element_parse_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 ap_element_parse_oom 1/1
Test: Information element parsing OOM
Starting AP wlan3
{'noise': '-89', 'ssid': 'test-wpa2-psk', 'bssid': '02:00:00:00:03:00', 'level': '-30', 'tsf': '1507216210959651', 'age': '0', 'snr': '59', 'capabilities': '0x0401', 'qual': '0', 'est_throughput': '65000', 'beacon_int': '100', 'flags': '[ESS]', 'freq': '2412', 'ie': '000d746573742d777061322d70736b010882848b960c1218240301012a010432043048606c3b0251002d1a0c001bffff0000000000000000000001000000000000000000003d16010000000000000000000000000000000000000000007f080400000200000040dd180050f2020101000003a4000027a4000042435e0062322f00dd0d506f9a0a00000600411c440028', 'id': '123', 'update_idx': '108'}
PASS ap_element_parse_oom 0.09073 2017-10-05 23:10:11.038325
passed all 1 test case(s)
2017-10-05 23:10:11 	./run-tests.py ap_enable_disable_reenable 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_enable_disable_reenable 1/1
Test: Enable, disable, re-enable AP
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS ap_enable_disable_reenable 0.298692 2017-10-05 23:10:11.469206
passed all 1 test case(s)
2017-10-05 23:10:11 	./run-tests.py ap_fragmentation_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 ap_fragmentation_open 1/1
Test: Open AP with fragmentation threshold
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_fragmentation_open 0.153114 2017-10-05 23:10:11.756542
passed all 1 test case(s)
2017-10-05 23:10:11 	./run-tests.py ap_fragmentation_rts_set_high 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_fragmentation_rts_set_high 1/1
Test: WPA2-PSK AP with fragmentation and RTS thresholds larger than frame length
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_params.py", line 30, in test_ap_fragmentation_rts_set_high
    hwsim_utils.test_connectivity(dev[0], hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_fragmentation_rts_set_high 5.1791 2017-10-05 23:10:17.069481
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_fragmentation_rts_set_high
2017-10-05 23:10:17 	./run-tests.py ap_fragmentation_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 ap_fragmentation_wpa2 1/1
Test: WPA2-PSK AP with fragmentation threshold
Starting AP wlan3
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_params.py", line 52, in test_ap_fragmentation_wpa2
    hwsim_utils.test_connectivity(dev[0], hapd)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_fragmentation_wpa2 5.201441 2017-10-05 23:10:22.410864
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_fragmentation_wpa2
2017-10-05 23:10:22 	./run-tests.py ap_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 ap_ft 1/1
Test: WPA2-PSK-FT AP
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 194, in test_ap_ft
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft 5.29836 2017-10-05 23:10:27.874507
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft
2017-10-05 23:10:27 	./run-tests.py ap_ft_ap_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 ap_ft_ap_oom 1/1
Test: WPA2-PSK-FT and AP OOM
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom 0.490073 2017-10-05 23:10:28.540966
passed all 1 test case(s)
2017-10-05 23:10:28 	./run-tests.py ap_ft_ap_oom10 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom10 1/1
Test: WPA2-PSK-FT and AP OOM 10
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom10 0.490497 2017-10-05 23:10:29.170428
passed all 1 test case(s)
2017-10-05 23:10:29 	./run-tests.py ap_ft_ap_oom11 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom11 1/1
Test: WPA2-PSK-FT and AP OOM 11
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan1 to AP
PASS ap_ft_ap_oom11 0.287652 2017-10-05 23:10:29.602348
passed all 1 test case(s)
2017-10-05 23:10:29 	./run-tests.py ap_ft_ap_oom2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom2 1/1
Test: WPA2-PSK-FT and AP OOM 2
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom2 1.069343 2017-10-05 23:10:30.789994
passed all 1 test case(s)
2017-10-05 23:10:30 	./run-tests.py ap_ft_ap_oom3 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom3 1/1
Test: WPA2-PSK-FT and AP OOM 3
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom3 0.796252 2017-10-05 23:10:31.729656
passed all 1 test case(s)
2017-10-05 23:10:31 	./run-tests.py ap_ft_ap_oom3b 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom3b 1/1
Test: WPA2-PSK-FT and AP OOM 3b
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom3b 0.28192 2017-10-05 23:10:32.142517
passed all 1 test case(s)
2017-10-05 23:10:32 	./run-tests.py ap_ft_ap_oom4 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom4 1/1
Test: WPA2-PSK-FT and AP OOM 4
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom4 0.395815 2017-10-05 23:10:32.671740
passed all 1 test case(s)
2017-10-05 23:10:32 	./run-tests.py ap_ft_ap_oom5 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom5 1/1
Test: WPA2-PSK-FT and AP OOM 5
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom5 1.17147 2017-10-05 23:10:34.009281
passed all 1 test case(s)
2017-10-05 23:10:34 	./run-tests.py ap_ft_ap_oom6 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom6 1/1
Test: WPA2-PSK-FT and AP OOM 6
Starting AP wlan3
Connect STA wlan0 to AP
Connect STA wlan0 to AP
Connect STA wlan0 to AP
PASS ap_ft_ap_oom6 3.271435 2017-10-05 23:10:37.425218
passed all 1 test case(s)
2017-10-05 23:10:37 	./run-tests.py ap_ft_ap_oom7 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom7 1/1
Test: WPA2-PSK-FT and AP OOM 7
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom7 5.339337 2017-10-05 23:10:42.938472
passed all 1 test case(s)
2017-10-05 23:10:42 	./run-tests.py ap_ft_ap_oom8 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom8 1/1
Test: WPA2-PSK-FT and AP OOM 8
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom8 0.613616 2017-10-05 23:10:43.748892
passed all 1 test case(s)
2017-10-05 23:10:43 	./run-tests.py ap_ft_ap_oom9 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ap_oom9 1/1
Test: WPA2-PSK-FT and AP OOM 9
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_ap_oom9 0.328489 2017-10-05 23:10:44.228863
passed all 1 test case(s)
2017-10-05 23:10:44 	./run-tests.py ap_ft_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 ap_ft_eap 1/1
Test: WPA2-EAP-FT AP
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 573, in test_ap_ft_eap
    generic_ap_ft_eap(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 550, in generic_ap_ft_eap
    over_ds=over_ds, roams=roams)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_eap 5.258338 2017-10-05 23:10:49.640588
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_eap
2017-10-05 23:10:49 	./run-tests.py ap_ft_eap_dis 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_eap_dis 1/1
Test: WPA2-EAP-FT AP with AP discovery
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 581, in test_ap_ft_eap_dis
    generic_ap_ft_eap(dev, apdev, discovery=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 550, in generic_ap_ft_eap
    over_ds=over_ds, roams=roams)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_eap_dis 5.318995 2017-10-05 23:10:55.109686
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_eap_dis
2017-10-05 23:10:55 	./run-tests.py ap_ft_eap_dis_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 ap_ft_eap_dis_over_ds 1/1
Test: WPA2-EAP-FT AP with AP discovery and over-the-DS
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 585, in test_ap_ft_eap_dis_over_ds
    generic_ap_ft_eap(dev, apdev, over_ds=True, discovery=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 550, in generic_ap_ft_eap
    over_ds=over_ds, roams=roams)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_eap_dis_over_ds 5.321925 2017-10-05 23:11:00.580508
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_eap_dis_over_ds
2017-10-05 23:11:00 	./run-tests.py ap_ft_eap_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 ap_ft_eap_over_ds 1/1
Test: WPA2-EAP-FT AP using over-the-DS
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 577, in test_ap_ft_eap_over_ds
    generic_ap_ft_eap(dev, apdev, over_ds=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 550, in generic_ap_ft_eap
    over_ds=over_ds, roams=roams)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_eap_over_ds 5.345085 2017-10-05 23:11:06.131467
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_eap_over_ds
2017-10-05 23:11:06 	./run-tests.py ap_ft_eap_pull 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_eap_pull 1/1
Test: WPA2-EAP-FT AP (pull PMK)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 609, in test_ap_ft_eap_pull
    run_roams(dev[0], apdev, hapd, hapd1, ssid, passphrase, eap=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_eap_pull 5.294075 2017-10-05 23:11:11.596012
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_eap_pull
2017-10-05 23:11:11 	./run-tests.py ap_ft_extra_ie 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_extra_ie 1/1
Test: WPA2-PSK-FT AP with WPA2-PSK enabled and unexpected MDE
Starting AP wlan3
Connect STA wlan1 to AP
Connect STA wlan2 to AP
Connect STA wlan0 to AP
PASS ap_ft_extra_ie 0.347466 2017-10-05 23:11:12.138902
passed all 1 test case(s)
2017-10-05 23:11:12 	./run-tests.py ap_ft_gcmp_256 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_gcmp_256 1/1
Test: WPA2-PSK-FT AP with GCMP-256 cipher
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 1025, in test_ap_ft_gcmp_256
    pairwise_cipher="GCMP-256", group_cipher="GCMP-256")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_gcmp_256 5.304726 2017-10-05 23:11:17.584855
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_gcmp_256
2017-10-05 23:11:17 	./run-tests.py ap_ft_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 ap_ft_gtk_rekey 1/1
Test: WPA2-PSK-FT AP and GTK rekey
Starting AP wlan3
Connect STA wlan0 to AP
GTK rekey timed out after initial association
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 825, in test_ap_ft_gtk_rekey
    raise Exception("GTK rekey timed out after initial association")
Exception: GTK rekey timed out after initial association
FAIL ap_ft_gtk_rekey 2.216288 2017-10-05 23:11:19.970762
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_gtk_rekey
2017-10-05 23:11:20 	./run-tests.py ap_ft_internal_rrb_check 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_internal_rrb_check 1/1
Test: RRB internal delivery only to WPA enabled BSS
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
PASS ap_ft_internal_rrb_check 1.229771 2017-10-05 23:11:21.378999
passed all 1 test case(s)
2017-10-05 23:11:21 	./run-tests.py ap_ft_invalid_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 ap_ft_invalid_resp 1/1
Test: WPA2-PSK-FT AP and invalid response IEs
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_invalid_resp 1.524265 2017-10-05 23:11:23.083528
passed all 1 test case(s)
2017-10-05 23:11:23 	./run-tests.py ap_ft_local_key_gen 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_local_key_gen 1/1
Test: WPA2-PSK-FT AP with local key generation (without pull/push)
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 248, in test_ap_ft_local_key_gen
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_local_key_gen 5.290892 2017-10-05 23:11:28.582444
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_local_key_gen
2017-10-05 23:11:28 	./run-tests.py ap_ft_many 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_many 1/1
Test: WPA2-PSK-FT AP multiple times
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 262, in test_ap_ft_many
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase, roams=50)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_many 5.284116 2017-10-05 23:11:34.035964
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_many
2017-10-05 23:11:34 	./run-tests.py ap_ft_mismatching_r0kh_id_pull 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_mismatching_r0kh_id_pull 1/1
Test: WPA2-PSK-FT AP over DS with mismatching R0KH-ID (pull)
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_mismatching_r0kh_id_pull 1.279702 2017-10-05 23:11:35.463666
passed all 1 test case(s)
2017-10-05 23:11:35 	./run-tests.py ap_ft_mismatching_r0kh_id_pull_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 ap_ft_mismatching_r0kh_id_pull_eap 1/1
Test: WPA2-EAP-FT AP over DS with mismatching R0KH-ID (pull)
Starting AP wlan3 (old add_ap argument type)
Connect STA wlan0 to AP
Starting AP wlan4 (old add_ap argument type)
PASS ap_ft_mismatching_r0kh_id_pull_eap 1.279634 2017-10-05 23:11:36.895104
passed all 1 test case(s)
2017-10-05 23:11:36 	./run-tests.py ap_ft_mismatching_rrb_key_pull 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_mismatching_rrb_key_pull 1/1
Test: WPA2-PSK-FT AP over DS with mismatching RRB key (pull)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 641, in test_ap_ft_mismatching_rrb_key_pull
    fail_test=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_key_pull 5.280773 2017-10-05 23:11:42.321121
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_key_pull
2017-10-05 23:11:42 	./run-tests.py ap_ft_mismatching_rrb_key_pull_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 ap_ft_mismatching_rrb_key_pull_eap 1/1
Test: WPA2-EAP-FT AP over DS with mismatching RRB key (pull)
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 737, in test_ap_ft_mismatching_rrb_key_pull_eap
    fail_test=True, eap=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_key_pull_eap 5.298985 2017-10-05 23:11:47.764250
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_key_pull_eap
2017-10-05 23:11:47 	./run-tests.py ap_ft_mismatching_rrb_key_push 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_mismatching_rrb_key_push 1/1
Test: WPA2-PSK-FT AP over DS with mismatching RRB key (push)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 625, in test_ap_ft_mismatching_rrb_key_push
    fail_test=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_key_push 5.319453 2017-10-05 23:11:53.260051
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_key_push
2017-10-05 23:11:53 	./run-tests.py ap_ft_mismatching_rrb_key_push_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 ap_ft_mismatching_rrb_key_push_eap 1/1
Test: WPA2-EAP-FT AP over DS with mismatching RRB key (push)
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 715, in test_ap_ft_mismatching_rrb_key_push_eap
    fail_test=True, eap=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_key_push_eap 5.281695 2017-10-05 23:11:58.693554
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_key_push_eap
2017-10-05 23:11:58 	./run-tests.py ap_ft_mismatching_rrb_r0kh_pull 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_mismatching_rrb_r0kh_pull 1/1
Test: WPA2-PSK-FT AP over DS with mismatching R0KH key (pull)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 693, in test_ap_ft_mismatching_rrb_r0kh_pull
    fail_test=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_r0kh_pull 5.30375 2017-10-05 23:12:04.149104
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_r0kh_pull
2017-10-05 23:12:04 	./run-tests.py ap_ft_mismatching_rrb_r0kh_pull_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 ap_ft_mismatching_rrb_r0kh_pull_eap 1/1
Test: WPA2-EAP-FT AP over DS with mismatching R0KH key (pull)
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 809, in test_ap_ft_mismatching_rrb_r0kh_pull_eap
    fail_test=True, eap=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_r0kh_pull_eap 5.299376 2017-10-05 23:12:09.628401
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_r0kh_pull_eap
2017-10-05 23:12:09 	./run-tests.py ap_ft_mismatching_rrb_r0kh_push 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_mismatching_rrb_r0kh_push 1/1
Test: WPA2-PSK-FT AP over DS with mismatching R0KH key (push)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 677, in test_ap_ft_mismatching_rrb_r0kh_push
    fail_test=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_r0kh_push 5.294111 2017-10-05 23:12:15.074084
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_r0kh_push
2017-10-05 23:12:15 	./run-tests.py ap_ft_mismatching_rrb_r0kh_push_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 ap_ft_mismatching_rrb_r0kh_push_eap 1/1
Test: WPA2-EAP-FT AP over DS with mismatching R0KH key (push)
Starting AP wlan3 (old add_ap argument type)
Starting AP wlan4 (old add_ap argument type)
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 787, in test_ap_ft_mismatching_rrb_r0kh_push_eap
    fail_test=True, eap=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mismatching_rrb_r0kh_push_eap 5.276162 2017-10-05 23:12:20.501946
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mismatching_rrb_r0kh_push_eap
2017-10-05 23:12:20 	./run-tests.py ap_ft_mixed 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_mixed 1/1
Test: WPA2-PSK-FT mixed-mode AP
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 278, in test_ap_ft_mixed
    run_roams(dev[0], apdev, hapd, hapd1, ssid, passphrase)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_mixed 5.298589 2017-10-05 23:12:25.918747
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_mixed
2017-10-05 23:12:25 	./run-tests.py ap_ft_multi_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 ap_ft_multi_akm 1/1
Test: WPA2-PSK-FT AP with non-FT AKMs enabled
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 227, in test_ap_ft_multi_akm
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_multi_akm 5.321109 2017-10-05 23:12:31.405346
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_multi_akm
2017-10-05 23:12:31 	./run-tests.py ap_ft_old_key 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_old_key 1/1
Test: WPA2-PSK-FT AP (old key)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 208, in test_ap_ft_old_key
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_old_key 5.268172 2017-10-05 23:12:36.871280
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_old_key
2017-10-05 23:12:36 	./run-tests.py ap_ft_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 ap_ft_oom 1/1
Test: WPA2-PSK-FT and OOM
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
Connect STA wlan0 to AP
PASS ap_ft_oom 2.50726 2017-10-05 23:12:39.518327
passed all 1 test case(s)
2017-10-05 23:12:39 	./run-tests.py ap_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 ap_ft_over_ds 1/1
Test: WPA2-PSK-FT AP over DS
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 304, in test_ap_ft_over_ds
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase, over_ds=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_over_ds 5.303155 2017-10-05 23:12:45.005543
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_over_ds
2017-10-05 23:12:45 	./run-tests.py ap_ft_over_ds_disabled 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_over_ds_disabled 1/1
Test: WPA2-PSK-FT AP over DS disabled
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 321, in test_ap_ft_over_ds_disabled
    fail_test=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_over_ds_disabled 5.287398 2017-10-05 23:12:50.477347
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_over_ds_disabled
2017-10-05 23:12:50 	./run-tests.py ap_ft_over_ds_many 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_over_ds_many 1/1
Test: WPA2-PSK-FT AP over DS multiple times
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 334, in test_ap_ft_over_ds_many
    roams=50)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_over_ds_many 5.312496 2017-10-05 23:12:55.953281
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_over_ds_many
2017-10-05 23:12:55 	./run-tests.py ap_ft_over_ds_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 ap_ft_over_ds_proto 1/1
Test: WPA2-PSK-FT AP over DS protocol testing
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_over_ds_proto 0.291924 2017-10-05 23:12:56.436804
passed all 1 test case(s)
2017-10-05 23:12:56 	./run-tests.py ap_ft_over_ds_proto_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 ap_ft_over_ds_proto_ap 1/1
Test: WPA2-PSK-FT AP over DS protocol testing for AP processing
Starting AP wlan3
Connect STA wlan0 to AP
Starting AP wlan4
PASS ap_ft_over_ds_proto_ap 0.263939 2017-10-05 23:12:56.878208
passed all 1 test case(s)
2017-10-05 23:12:56 	./run-tests.py ap_ft_over_ds_pull 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_over_ds_pull 1/1
Test: WPA2-PSK-FT AP over DS (pull PMK)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 476, in test_ap_ft_over_ds_pull
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase, over_ds=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_over_ds_pull 5.314216 2017-10-05 23:13:02.401568
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_over_ds_pull
2017-10-05 23:13:02 	./run-tests.py ap_ft_over_ds_pull_old_key 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_over_ds_pull_old_key 1/1
Test: WPA2-PSK-FT AP over DS (pull PMK; old key)
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 490, in test_ap_ft_over_ds_pull_old_key
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase, over_ds=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_over_ds_pull_old_key 5.317903 2017-10-05 23:13:07.882384
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_over_ds_pull_old_key
2017-10-05 23:13:07 	./run-tests.py ap_ft_over_ds_unexpected 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_over_ds_unexpected 1/1
Test: WPA2-PSK-FT AP over DS and unexpected response
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
Foreign STA address
No over-the-DS in progress
Non-zero status code
Foreign Target AP
No IEs
Invalid IEs (trigger parsing failure)
Too short MDIE
Mobility domain mismatch
No FTIE
FTIE SNonce mismatch
No R0KH-ID subelem in FTIE
No R0KH-ID subelem mismatch in FTIE
No R1KH-ID subelem in FTIE
No RSNE
PASS ap_ft_over_ds_unexpected 0.301671 2017-10-05 23:13:08.345848
passed all 1 test case(s)
2017-10-05 23:13:08 	./run-tests.py ap_ft_over_ds_unknown_target 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_over_ds_unknown_target 1/1
Test: WPA2-PSK-FT AP
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_ft_over_ds_unknown_target 1.175023 2017-10-05 23:13:09.670521
passed all 1 test case(s)
2017-10-05 23:13:09 	./run-tests.py ap_ft_pmf 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_pmf 1/1
Test: WPA2-PSK-FT AP with PMF
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 292, in test_ap_ft_pmf
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_pmf 5.305839 2017-10-05 23:13:15.134237
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_pmf
2017-10-05 23:13:15 	./run-tests.py ap_ft_pmf_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 ap_ft_pmf_over_ds 1/1
Test: WPA2-PSK-FT AP over DS with PMF
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 462, in test_ap_ft_pmf_over_ds
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase, over_ds=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_pmf_over_ds 5.303248 2017-10-05 23:13:20.580840
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_pmf_over_ds
2017-10-05 23:13:20 	./run-tests.py ap_ft_ptk_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 ap_ft_ptk_rekey 1/1
Test: WPA2-PSK-FT PTK rekeying triggered by station after roam
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 1674, in test_ap_ft_ptk_rekey
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase, ptk_rekey="1")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_ptk_rekey 5.341216 2017-10-05 23:13:26.086815
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_ptk_rekey
2017-10-05 23:13:26 	./run-tests.py ap_ft_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 ap_ft_ptk_rekey_ap 1/1
Test: WPA2-PSK-FT PTK rekeying triggered by AP after roam
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 1701, in test_ap_ft_ptk_rekey_ap
    run_roams(dev[0], apdev, hapd0, hapd1, ssid, passphrase)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_ptk_rekey_ap 5.262599 2017-10-05 23:13:31.525105
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_ptk_rekey_ap
2017-10-05 23:13:31 	./run-tests.py ap_ft_reassoc_local_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 ap_ft_reassoc_local_fail 1/1
Test: WPA2-PSK-FT AP Reassociation Request frame and local failure
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
PASS ap_ft_reassoc_local_fail 0.281243 2017-10-05 23:13:31.963308
passed all 1 test case(s)
2017-10-05 23:13:31 	./run-tests.py ap_ft_reassoc_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 ap_ft_reassoc_proto 1/1
Test: WPA2-PSK-FT AP Reassociation Request frame parsing
Starting AP wlan3
Starting AP wlan4
Connect STA wlan0 to AP
PASS ap_ft_reassoc_proto 0.267947 2017-10-05 23:13:32.423742
passed all 1 test case(s)
2017-10-05 23:13:32 	./run-tests.py ap_ft_ric 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_ric 1/1
Test: WPA2-PSK-FT AP and RIC
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
Connect to first AP
Connect STA wlan0 to AP
Roam to the second AP
Roam back to the first AP
PASS ap_ft_ric 0.956221 2017-10-05 23:13:33.574438
passed all 1 test case(s)
2017-10-05 23:13:33 	./run-tests.py ap_ft_rrb 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_rrb 1/1
Test: WPA2-PSK-FT RRB protocol testing
Starting AP wlan3
Connect STA wlan0 to AP
PASS ap_ft_rrb 0.401428 2017-10-05 23:13:34.119114
passed all 1 test case(s)
2017-10-05 23:13:34 	./run-tests.py ap_ft_sae 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_ft_sae 1/1
Test: WPA2-PSK-FT-SAE AP
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 510, in test_ap_ft_sae
    run_roams(dev[0], apdev, hapd0, hapd, ssid, passphrase, sae=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_sae 5.292029 2017-10-05 23:13:39.553573
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_sae
2017-10-05 23:13:39 	./run-tests.py ap_ft_sae_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 ap_ft_sae_over_ds 1/1
Test: WPA2-PSK-FT-SAE AP over DS
Starting AP wlan3
Starting AP wlan4
Connect to first AP
Connect STA wlan0 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 528, in test_ap_ft_sae_over_ds
    over_ds=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_ft.py", line 157, in run_roams
    hwsim_utils.test_connectivity(dev, hapd1ap)
  File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
    raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL ap_ft_sae_over_ds 5.316285 2017-10-05 23:13:45.018824
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_ft_sae_over_ds
2017-10-05 23:13:45 	./run-tests.py ap_hs20_3gpp_constraints 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_3gpp_constraints 1/1
Test: Hotspot 2.0 connection and 3GPP credential constraints
Starting AP wlan3
Starting AP wlan3
PASS ap_hs20_3gpp_constraints 0.284644 2017-10-05 23:13:45.461274
passed all 1 test case(s)
2017-10-05 23:13:45 	./run-tests.py ap_hs20_aka 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_aka 1/1
Test: Hotspot 2.0 with simulated USIM and EAP-AKA
Starting AP wlan3
PASS ap_hs20_aka 0.161657 2017-10-05 23:13:45.773590
passed all 1 test case(s)
2017-10-05 23:13:45 	./run-tests.py ap_hs20_aka_prime 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_aka_prime 1/1
Test: Hotspot 2.0 with simulated USIM and EAP-AKA'
Starting AP wlan3
PASS ap_hs20_aka_prime 0.164692 2017-10-05 23:13:46.082286
passed all 1 test case(s)
2017-10-05 23:13:46 	./run-tests.py ap_hs20_anqp_format_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 ap_hs20_anqp_format_errors 1/1
Test: Interworking network selection and ANQP format errors
Starting AP wlan3
PASS ap_hs20_anqp_format_errors 0.991903 2017-10-05 23:13:47.218422
passed all 1 test case(s)
2017-10-05 23:13:47 	./run-tests.py ap_hs20_anqp_invalid_gas_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 ap_hs20_anqp_invalid_gas_response 1/1
Test: Hotspot 2.0 network selection and invalid GAS response
Starting AP wlan3
ANQP: Unexpected Advertisement Protocol in response
ANQP: Invalid element length for Info ID 1234
PASS ap_hs20_anqp_invalid_gas_response 0.421437 2017-10-05 23:13:47.776790
passed all 1 test case(s)
2017-10-05 23:13:47 	./run-tests.py ap_hs20_auto_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 ap_hs20_auto_interworking 1/1
Test: Hotspot 2.0 connection with auto_interworking=1
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 721, in test_ap_hs20_auto_interworking
    dev[0].wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_auto_interworking 15.092772 2017-10-05 23:14:03.028911
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_auto_interworking
2017-10-05 23:14:03 	./run-tests.py ap_hs20_auto_interworking_no_cred_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 ap_hs20_auto_interworking_no_cred_match 1/1
Test: Hotspot 2.0 connection with auto_interworking=1 but no cred match
Starting AP wlan3
Connect STA wlan0 to AP
Verify that scanning continues when there is partial network block match
Scan completed
Scan completed
PASS ap_hs20_auto_interworking_no_cred_match 12.501451 2017-10-05 23:14:15.668573
passed all 1 test case(s)
2017-10-05 23:14:15 	./run-tests.py ap_hs20_auto_interworking_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 ap_hs20_auto_interworking_no_match 1/1
Test: Hotspot 2.0 connection with auto_interworking=1 and no matching network
Starting AP wlan3
Connect STA wlan0 to AP
start ping
ping done
start ping
ping done
start ping
ping done
start ping
ping done
start ping
ping done
PASS ap_hs20_auto_interworking_no_match 0.986305 2017-10-05 23:14:16.835996
passed all 1 test case(s)
2017-10-05 23:14:16 	./run-tests.py ap_hs20_connect_api 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_connect_api 1/1
Test: Hotspot 2.0 connection with connect API
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 696, in test_ap_hs20_connect_api
    interworking_connect(wpas, bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_connect_api 15.424969 2017-10-05 23:14:32.391406
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_connect_api
2017-10-05 23:14:32 	./run-tests.py ap_hs20_connect_deinit 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_connect_deinit 1/1
Test: Hotspot 2.0 connection interrupted with deinit
Starting AP wlan3
PASS ap_hs20_connect_deinit 0.243754 2017-10-05 23:14:32.810195
passed all 1 test case(s)
2017-10-05 23:14:32 	./run-tests.py ap_hs20_connect_no_full_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 ap_hs20_connect_no_full_match 1/1
Test: Hotspot 2.0 connection and no full match
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1241, in test_ap_hs20_connect_no_full_match
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_connect_no_full_match 15.129872 2017-10-05 23:14:48.128225
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_connect_no_full_match
2017-10-05 23:14:48 	./run-tests.py ap_hs20_cred_and_no_roaming_consortium 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_cred_and_no_roaming_consortium 1/1
Test: Hotspot 2.0 network selection and no roaming consortium
Starting AP wlan3
PASS ap_hs20_cred_and_no_roaming_consortium 0.099232 2017-10-05 23:14:48.366866
passed all 1 test case(s)
2017-10-05 23:14:48 	./run-tests.py ap_hs20_cred_with_nai_realm 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_cred_with_nai_realm 1/1
Test: Hotspot 2.0 network selection and cred_with_nai_realm cred->realm
Starting AP wlan3
PASS ap_hs20_cred_with_nai_realm 0.166745 2017-10-05 23:14:48.675555
passed all 1 test case(s)
2017-10-05 23:14:48 	./run-tests.py ap_hs20_deauth_req_bss 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_deauth_req_bss 1/1
Test: Hotspot 2.0 connection and deauthentication request for BSS
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2415, in test_ap_hs20_deauth_req_bss
    _test_ap_hs20_deauth_req_bss(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2421, in _test_ap_hs20_deauth_req_bss
    eap_test(dev[0], apdev[0], "21[3:26]", "TTLS", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_deauth_req_bss 15.184586 2017-10-05 23:15:03.998824
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_deauth_req_bss
2017-10-05 23:15:04 	./run-tests.py ap_hs20_deauth_req_ess 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_deauth_req_ess 1/1
Test: Hotspot 2.0 connection and deauthentication request for ESS
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2385, in test_ap_hs20_deauth_req_ess
    _test_ap_hs20_deauth_req_ess(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2391, in _test_ap_hs20_deauth_req_ess
    eap_test(dev[0], apdev[0], "21[3:26]", "TTLS", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_deauth_req_ess 15.157065 2017-10-05 23:15:19.318854
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_deauth_req_ess
2017-10-05 23:15:19 	./run-tests.py ap_hs20_deauth_req_from_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 ap_hs20_deauth_req_from_radius 1/1
Test: Hotspot 2.0 connection and deauthentication request from RADIUS
Starting AP wlan3
Timeout on deauth imminent notice
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2447, in test_ap_hs20_deauth_req_from_radius
    _test_ap_hs20_deauth_req_from_radius(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2467, in _test_ap_hs20_deauth_req_from_radius
    raise Exception("Timeout on deauth imminent notice")
Exception: Timeout on deauth imminent notice
FAIL ap_hs20_deauth_req_from_radius 5.205596 2017-10-05 23:15:24.679713
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_deauth_req_from_radius
2017-10-05 23:15:24 	./run-tests.py ap_hs20_deauth_req_without_pmf 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_deauth_req_without_pmf 1/1
Test: Hotspot 2.0 connection and deauthentication request without PMF
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2476, in test_ap_hs20_deauth_req_without_pmf
    eap_test(dev[0], apdev[0], "21[3:26]", "TTLS", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_deauth_req_without_pmf 15.161026 2017-10-05 23:15:40.050448
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_deauth_req_without_pmf
2017-10-05 23:15:40 	./run-tests.py ap_hs20_disallow_aps 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_disallow_aps 1/1
Test: Hotspot 2.0 connection and disallow_aps
Starting AP wlan3
Verify disallow_aps bssid
Verify disallow_aps ssid
Verify disallow_aps clear
PASS ap_hs20_disallow_aps 3.882565 2017-10-05 23:15:44.068661
passed all 1 test case(s)
2017-10-05 23:15:44 	./run-tests.py ap_hs20_domain_suffix_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 ap_hs20_domain_suffix_match 1/1
Test: Hotspot 2.0 and domain_suffix_match
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1819, in test_ap_hs20_domain_suffix_match
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_domain_suffix_match 15.156483 2017-10-05 23:15:59.375220
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_domain_suffix_match
2017-10-05 23:15:59 	./run-tests.py ap_hs20_domain_suffix_match_full 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_domain_suffix_match_full 1/1
Test: Hotspot 2.0 and domain_suffix_match
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1788, in test_ap_hs20_domain_suffix_match_full
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_domain_suffix_match_full 15.198601 2017-10-05 23:16:14.712709
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_domain_suffix_match_full
2017-10-05 23:16:14 	./run-tests.py ap_hs20_eap_cert_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 ap_hs20_eap_cert_unknown 1/1
Test: Hotspot 2.0 connection with certificate, but unknown EAP method
Starting AP wlan3
PASS ap_hs20_eap_cert_unknown 0.106737 2017-10-05 23:16:14.946538
passed all 1 test case(s)
2017-10-05 23:16:14 	./run-tests.py ap_hs20_eap_cert_unsupported 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_cert_unsupported 1/1
Test: Hotspot 2.0 connection with certificate, but unsupported TTLS
Starting AP wlan3
PASS ap_hs20_eap_cert_unsupported 0.099167 2017-10-05 23:16:15.174000
passed all 1 test case(s)
2017-10-05 23:16:15 	./run-tests.py ap_hs20_eap_fast_gtc 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_fast_gtc 1/1
Test: Hotspot 2.0 connection with FAST/EAP-GTC
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 908, in test_ap_hs20_eap_fast_gtc
    eap_test(dev[0], apdev[0], "43[3:6]", "FAST", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_fast_gtc 15.186461 2017-10-05 23:16:30.500980
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_fast_gtc
2017-10-05 23:16:30 	./run-tests.py ap_hs20_eap_fast_mschapv2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_fast_mschapv2 1/1
Test: Hotspot 2.0 connection with FAST/EAP-MSCHAPV2
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 903, in test_ap_hs20_eap_fast_mschapv2
    eap_test(dev[0], apdev[0], "43[3:26]", "FAST", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_fast_mschapv2 15.234935 2017-10-05 23:16:45.894846
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_fast_mschapv2
2017-10-05 23:16:45 	./run-tests.py ap_hs20_eap_invalid_cred 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_invalid_cred 1/1
Test: Hotspot 2.0 connection with invalid cred configuration
Starting AP wlan3
PASS ap_hs20_eap_invalid_cred 0.104837 2017-10-05 23:16:46.164801
passed all 1 test case(s)
2017-10-05 23:16:46 	./run-tests.py ap_hs20_eap_peap_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 ap_hs20_eap_peap_default 1/1
Test: Hotspot 2.0 connection with PEAP/MSCHAPV2 (as default)
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 826, in test_ap_hs20_eap_peap_default
    eap_test(dev[0], apdev[0], "25", "PEAP", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_peap_default 15.197208 2017-10-05 23:17:01.531363
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_peap_default
2017-10-05 23:17:01 	./run-tests.py ap_hs20_eap_peap_gtc 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_peap_gtc 1/1
Test: Hotspot 2.0 connection with PEAP/GTC
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 830, in test_ap_hs20_eap_peap_gtc
    eap_test(dev[0], apdev[0], "25[3:6]", "PEAP", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_peap_gtc 15.136554 2017-10-05 23:17:16.811379
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_peap_gtc
2017-10-05 23:17:16 	./run-tests.py ap_hs20_eap_peap_mschapv2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_peap_mschapv2 1/1
Test: Hotspot 2.0 connection with PEAP/MSCHAPV2
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 821, in test_ap_hs20_eap_peap_mschapv2
    eap_test(dev[0], apdev[0], "25[3:26]", "PEAP", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_peap_mschapv2 15.205793 2017-10-05 23:17:32.197383
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_peap_mschapv2
2017-10-05 23:17:32 	./run-tests.py ap_hs20_eap_peap_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 ap_hs20_eap_peap_unknown 1/1
Test: Hotspot 2.0 connection with PEAP/unknown
Starting AP wlan3
PASS ap_hs20_eap_peap_unknown 0.118142 2017-10-05 23:17:32.472656
passed all 1 test case(s)
2017-10-05 23:17:32 	./run-tests.py ap_hs20_eap_tls 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_tls 1/1
Test: Hotspot 2.0 connection with EAP-TLS
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 924, in test_ap_hs20_eap_tls
    interworking_connect(dev[0], bssid, "TLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_tls 15.180863 2017-10-05 23:17:47.818191
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_tls
2017-10-05 23:17:47 	./run-tests.py ap_hs20_eap_ttls_chap 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_ttls_chap 1/1
Test: Hotspot 2.0 connection with TTLS/CHAP
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 847, in test_ap_hs20_eap_ttls_chap
    eap_test(dev[0], apdev[0], "21[2:2]", "TTLS", "chap user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_ttls_chap 15.184798 2017-10-05 23:18:03.150067
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_ttls_chap
2017-10-05 23:18:03 	./run-tests.py ap_hs20_eap_ttls_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 ap_hs20_eap_ttls_default 1/1
Test: Hotspot 2.0 connection with TTLS/default
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 857, in test_ap_hs20_eap_ttls_default
    eap_test(dev[0], apdev[0], "21", "TTLS", "hs20-test")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_ttls_default 15.1879 2017-10-05 23:18:18.491676
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_ttls_default
2017-10-05 23:18:18 	./run-tests.py ap_hs20_eap_ttls_eap_mschapv2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_ttls_eap_mschapv2 1/1
Test: Hotspot 2.0 connection with TTLS/EAP-MSCHAPv2
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 862, in test_ap_hs20_eap_ttls_eap_mschapv2
    eap_test(dev[0], apdev[0], "21[3:26][6:7][99:99]", "TTLS", "user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_ttls_eap_mschapv2 15.212871 2017-10-05 23:18:33.865571
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_ttls_eap_mschapv2
2017-10-05 23:18:33 	./run-tests.py ap_hs20_eap_ttls_eap_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 ap_hs20_eap_ttls_eap_unknown 1/1
Test: Hotspot 2.0 connection with TTLS/EAP-unknown
Starting AP wlan3
PASS ap_hs20_eap_ttls_eap_unknown 0.107632 2017-10-05 23:18:34.129894
passed all 1 test case(s)
2017-10-05 23:18:34 	./run-tests.py ap_hs20_eap_ttls_eap_unsupported 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_ttls_eap_unsupported 1/1
Test: Hotspot 2.0 connection with TTLS/EAP-OTP(unsupported)
Starting AP wlan3
PASS ap_hs20_eap_ttls_eap_unsupported 0.106741 2017-10-05 23:18:34.398108
passed all 1 test case(s)
2017-10-05 23:18:34 	./run-tests.py ap_hs20_eap_ttls_mschap 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_eap_ttls_mschap 1/1
Test: Hotspot 2.0 connection with TTLS/MSCHAP
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 852, in test_ap_hs20_eap_ttls_mschap
    eap_test(dev[0], apdev[0], "21[2:3]", "TTLS", "mschap user")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 804, in eap_test
    interworking_connect(dev, bssid, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_eap_ttls_mschap 15.158329 2017-10-05 23:18:49.711051
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_eap_ttls_mschap
2017-10-05 23:18:49 	./run-tests.py ap_hs20_eap_ttls_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 ap_hs20_eap_ttls_unknown 1/1
Test: Hotspot 2.0 connection with TTLS/unknown
Starting AP wlan3
PASS ap_hs20_eap_ttls_unknown 0.087747 2017-10-05 23:18:49.934758
passed all 1 test case(s)
2017-10-05 23:18:49 	./run-tests.py ap_hs20_eap_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 ap_hs20_eap_unknown 1/1
Test: Hotspot 2.0 connection with unknown EAP method
Starting AP wlan3
PASS ap_hs20_eap_unknown 0.111947 2017-10-05 23:18:50.201809
passed all 1 test case(s)
2017-10-05 23:18:50 	./run-tests.py ap_hs20_excluded_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 ap_hs20_excluded_ssid 1/1
Test: Hotspot 2.0 exclusion based on SSID
Starting AP wlan3
Starting AP wlan4
Verify network selection to AP wlan4
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1704, in test_ap_hs20_excluded_ssid
    events = policy_test(dev[0], apdev[1], values)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1603, in policy_test
    ev = dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_excluded_ssid 15.194386 2017-10-05 23:19:05.560722
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_excluded_ssid
2017-10-05 23:19:05 	./run-tests.py ap_hs20_ext_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 ap_hs20_ext_sim 1/1
Test: Hotspot 2.0 with external SIM processing
Starting AP wlan3
PASS ap_hs20_ext_sim 0.179689 2017-10-05 23:19:05.876305
passed all 1 test case(s)
2017-10-05 23:19:05 	./run-tests.py ap_hs20_ext_sim_roaming 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_ext_sim_roaming 1/1
Test: Hotspot 2.0 with external SIM processing in roaming network
Starting AP wlan3
PASS ap_hs20_ext_sim_roaming 0.206202 2017-10-05 23:19:06.256408
passed all 1 test case(s)
2017-10-05 23:19:06 	./run-tests.py ap_hs20_external_selection 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_external_selection 1/1
Test: Hotspot 2.0 connection using external network selection and creation
Starting AP wlan3
Connect STA wlan0 to AP
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 3610, in test_ap_hs20_external_selection
    scan_freq="2412", update_identifier="54321")
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1049, in connect
    self.connect_network(id, timeout=20)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 425, in connect_network
    self.wait_connected(timeout=timeout)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_external_selection 20.097867 2017-10-05 23:19:26.511002
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_external_selection
2017-10-05 23:19:26 	./run-tests.py ap_hs20_fetch_osu 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_fetch_osu 1/1
Test: Hotspot 2.0 OSU provider and icon fetch
Starting AP wlan3
Starting AP wlan4
PASS ap_hs20_fetch_osu 3.915462 2017-10-05 23:19:30.553118
passed all 1 test case(s)
2017-10-05 23:19:30 	./run-tests.py ap_hs20_fetch_osu_invalid_dir 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_fetch_osu_invalid_dir 1/1
Test: Hotspot 2.0 OSU provider and invalid directory
Starting AP wlan3
PASS ap_hs20_fetch_osu_invalid_dir 0.100206 2017-10-05 23:19:30.799687
passed all 1 test case(s)
2017-10-05 23:19:30 	./run-tests.py ap_hs20_fetch_osu_no_icon 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_fetch_osu_no_icon 1/1
Test: Hotspot 2.0 OSU provider and no icon found
Starting AP wlan3
PASS ap_hs20_fetch_osu_no_icon 3.818136 2017-10-05 23:19:34.762443
passed all 1 test case(s)
2017-10-05 23:19:34 	./run-tests.py ap_hs20_fetch_osu_no_info 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_fetch_osu_no_info 1/1
Test: Hotspot 2.0 OSU provider and no AP with info
Starting AP wlan3
PASS ap_hs20_fetch_osu_no_info 11.248795 2017-10-05 23:19:46.140788
passed all 1 test case(s)
2017-10-05 23:19:46 	./run-tests.py ap_hs20_fetch_osu_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 ap_hs20_fetch_osu_oom 1/1
Test: Hotspot 2.0 OSU provider and OOM
Starting AP wlan3
PASS ap_hs20_fetch_osu_oom 0.12237 2017-10-05 23:19:46.426486
passed all 1 test case(s)
2017-10-05 23:19:46 	./run-tests.py ap_hs20_fetch_osu_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 ap_hs20_fetch_osu_proto 1/1
Test: Hotspot 2.0 OSU provider and protocol testing
Starting AP wlan3
PASS ap_hs20_fetch_osu_proto 1.161279 2017-10-05 23:19:47.732437
passed all 1 test case(s)
2017-10-05 23:19:47 	./run-tests.py ap_hs20_fetch_osu_stop 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_fetch_osu_stop 1/1
Test: Hotspot 2.0 OSU provider fetch stopped
Starting AP wlan3
PASS ap_hs20_fetch_osu_stop 14.53005 2017-10-05 23:20:02.449862
passed all 1 test case(s)
2017-10-05 23:20:02 	./run-tests.py ap_hs20_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 ap_hs20_ft 1/1
Test: Hotspot 2.0 connection with FT
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 3531, in test_ap_hs20_ft
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_ft 15.220674 2017-10-05 23:20:17.893269
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_ft
2017-10-05 23:20:17 	./run-tests.py ap_hs20_gas_frag_while_associated 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_gas_frag_while_associated 1/1
Test: Hotspot 2.0 connection with fragmented GAS query while associated
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1477, in test_ap_hs20_gas_frag_while_associated
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_gas_frag_while_associated 15.180957 2017-10-05 23:20:33.216166
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_gas_frag_while_associated
2017-10-05 23:20:33 	./run-tests.py ap_hs20_gas_while_associated 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_gas_while_associated 1/1
Test: Hotspot 2.0 connection with GAS query while associated
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1332, in test_ap_hs20_gas_while_associated
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_gas_while_associated 15.169714 2017-10-05 23:20:48.531997
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_gas_while_associated
2017-10-05 23:20:48 	./run-tests.py ap_hs20_gas_while_associated_with_pmf 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_gas_while_associated_with_pmf 1/1
Test: Hotspot 2.0 connection with GAS query while associated and using PMF
Starting AP wlan3
Starting AP wlan4
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1383, in test_ap_hs20_gas_while_associated_with_pmf
    _test_ap_hs20_gas_while_associated_with_pmf(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1407, in _test_ap_hs20_gas_while_associated_with_pmf
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_gas_while_associated_with_pmf 15.217887 2017-10-05 23:21:03.892328
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_gas_while_associated_with_pmf
2017-10-05 23:21:03 	./run-tests.py ap_hs20_gas_with_another_ap_while_associated 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_gas_with_another_ap_while_associated 1/1
Test: GAS query with another AP while associated
Starting AP wlan3
Starting AP wlan4
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1362, in test_ap_hs20_gas_with_another_ap_while_associated
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_gas_with_another_ap_while_associated 15.23014 2017-10-05 23:21:19.275963
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_gas_with_another_ap_while_associated
2017-10-05 23:21:19 	./run-tests.py ap_hs20_gas_with_another_ap_while_using_pmf 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_gas_with_another_ap_while_using_pmf 1/1
Test: GAS query with another AP while associated and using PMF
Starting AP wlan3
Starting AP wlan4
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1420, in test_ap_hs20_gas_with_another_ap_while_using_pmf
    _test_ap_hs20_gas_with_another_ap_while_using_pmf(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1444, in _test_ap_hs20_gas_with_another_ap_while_using_pmf
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_gas_with_another_ap_while_using_pmf 15.233021 2017-10-05 23:21:34.677605
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_gas_with_another_ap_while_using_pmf
2017-10-05 23:21:34 	./run-tests.py ap_hs20_hidden_ssid_in_scan_res 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_hidden_ssid_in_scan_res 1/1
Test: Hotspot 2.0 connection with hidden SSId in scan results
Starting AP wlan3
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 3811, in test_ap_hs20_hidden_ssid_in_scan_res
    interworking_connect(dev[0], bssid, "TTLS")
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 142, in interworking_connect
    interworking_auth(dev, method)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 151, in interworking_auth
    dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_hidden_ssid_in_scan_res 15.203651 2017-10-05 23:21:50.035212
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_hidden_ssid_in_scan_res
2017-10-05 23:21:50 	./run-tests.py ap_hs20_interworking_add_network 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_interworking_add_network 1/1
Test: Hotspot 2.0 connection using INTERWORKING_ADD_NETWORK
Starting AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 3699, in test_ap_hs20_interworking_add_network
    dev[0].wait_connected()
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_interworking_add_network 10.166923 2017-10-05 23:22:00.355534
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_interworking_add_network
2017-10-05 23:22:00 	./run-tests.py ap_hs20_interworking_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 ap_hs20_interworking_oom 1/1
Test: Hotspot 2.0 network selection and OOM
Starting AP wlan3
PASS ap_hs20_interworking_oom 0.655504 2017-10-05 23:22:01.174051
passed all 1 test case(s)
2017-10-05 23:22:01 	./run-tests.py ap_hs20_interworking_select_blocking_scan 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_interworking_select_blocking_scan 1/1
Test: Ongoing INTERWORKING_SELECT blocking SCAN
Starting AP wlan3
PASS ap_hs20_interworking_select_blocking_scan 0.212279 2017-10-05 23:22:01.589458
passed all 1 test case(s)
2017-10-05 23:22:01 	./run-tests.py ap_hs20_max_bss_load 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_max_bss_load 1/1
Test: Hotspot 2.0 and maximum BSS load
Starting AP wlan3
Starting AP wlan4
Verify maximum BSS load constraint
Verify network selection to AP wlan4
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1862, in test_ap_hs20_max_bss_load
    events = policy_test(dev[0], apdev[1], values, only_one=False)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1603, in policy_test
    ev = dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_max_bss_load 15.205914 2017-10-05 23:22:16.958933
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_max_bss_load
2017-10-05 23:22:16 	./run-tests.py ap_hs20_max_bss_load2 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_max_bss_load2 1/1
Test: Hotspot 2.0 and maximum BSS load with one AP not advertising
Starting AP wlan3
Starting AP wlan4
Verify maximum BSS load constraint with AP advertisement
Verify network selection to AP wlan4
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1897, in test_ap_hs20_max_bss_load2
    events = policy_test(dev[0], apdev[1], values, only_one=False)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1603, in policy_test
    ev = dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_max_bss_load2 15.185396 2017-10-05 23:22:32.332593
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_max_bss_load2
2017-10-05 23:22:32 	./run-tests.py ap_hs20_max_bss_load_roaming 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_max_bss_load_roaming 1/1
Test: Hotspot 2.0 and maximum BSS load (roaming)
Starting AP wlan3
Verify network selection to AP wlan3
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1916, in test_ap_hs20_max_bss_load_roaming
    events = policy_test(dev[0], apdev[0], values, only_one=True)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 1603, in policy_test
    ev = dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_max_bss_load_roaming 15.173242 2017-10-05 23:22:47.655446
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_max_bss_load_roaming
2017-10-05 23:22:47 	./run-tests.py ap_hs20_min_bandwidth_and_roaming_partner_preference 
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START ap_hs20_min_bandwidth_and_roaming_partner_preference 1/1
Test: Hotspot 2.0 and minimum bandwidth with roaming partner preference
Starting AP wlan3
Starting AP wlan4
Connection timed out
Traceback (most recent call last):
  File "./run-tests.py", line 453, in main
    t(dev, apdev)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 2359, in test_ap_hs20_min_bandwidth_and_roaming_partner_preference
    check_auto_select(dev[0], bssid2)
  File "/lkp/benchmarks/hwsim/tests/hwsim/test_ap_hs20.py", line 60, in check_auto_select
    ev = dev.wait_connected(timeout=15)
  File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1272, in wait_connected
    raise Exception(error)
Exception: Connection timed out
FAIL ap_hs20_min_bandwidth_and_roaming_partner_preference 15.171497 2017-10-05 23:23:02.970029
passed 0 test case(s)
skipped 0 test case(s)
failed tests: ap_hs20_min_bandwidth_and_roaming_partner_preference
2017-10-05 23:23:02 ./stop.sh
2017-10-05 23:23:04 ./start.sh channels=4
2017-10-05 23:23:05 ./stop.sh