nrf7002 wi-fi wpa2 enterprise mode(eap-tls)

I'm using nrf7002DK to test the wpa2 enterprise mode connection, but it has some problem for connecting.
I'm using ncs 2.8. 

logs output didn't show "connect success", but it stopped on "Wi-Fi connection request sent.." when I choose eap-tls mode.

(I've tried test this code by selecting the personal mode(psk) to connect to wpa personal ap, and it's successfuly connect.)

 *** Booting nRF Connect SDK v2.8.0-a2386bfc8401 ***
00> *** Using Zephyr OS v3.7.99-0bc3393fb112 ***
00> [00:00:00.663,604] <dbg> wpa_supp: wpa_printf_impl: wpa_supplicant v2.11-devel
00> [00:00:00.665,222] <inf> wifi_supplicant: wpa_supplicant initialized
00> [00:00:00.667,144] <dbg> wifi_supplicant: add_interface: Adding interface wlan0 [1] (0x200073b8)
00> [00:00:00.667,694] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: interface_add, argc: 5
00> [00:00:00.668,151] <dbg> wpa_supp: wpa_printf_impl: argv[0]: interface_add
00> [00:00:00.668,548] <dbg> wpa_supp: wpa_printf_impl: argv[1]: wlan0
00> [00:00:00.668,914] <dbg> wpa_supp: wpa_printf_impl: argv[2]: zephyr
00> [00:00:00.669,281] <dbg> wpa_supp: wpa_printf_impl: argv[3]: zephyr
00> [00:00:00.669,677] <dbg> wpa_supp: wpa_printf_impl: argv[4]: zephyr
00> [00:00:00.670,776] <dbg> wpa_supp: wpa_printf_impl: RX global ctrl_iface - hexdump_ascii(len=71):
00> [00:00:00.671,203] <dbg> wpa_supp: _wpa_hexdump_ascii: 
00>                                    49 4e 54 45 52 46 41 43  45 5f 41 44 44 20 77 6c |INTERFAC E_ADD wl
00>                                    61 6e 30 09 7a 65 70 68  79 72 09 7a 65 70 68 79 |an0.zeph yr.zephy
00>                                    72 09 7a 65 70 68 79 72  09 09 09 09 20 77 6c 61 |r.zephyr .... wla
00>                                    6e 30 20 7a 65 70 68 79  72 20 7a 65 70 68 79 72 |n0 zephy r zephyr
00>                                    20 7a 65 70 68 79 72                             | zephyr          
00> [00:00:00.674,591] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE GLOBAL INTERFACE_ADD 'wlan0  zephyr  zephyr  zephyr         wlan0 zephyr zephyr zephyr'
00> [00:00:00.675,689] <dbg> wpa_supp: wpa_printf_impl: Initializing interface 'wlan0' conf 'zephyr' driver 'zephyr' ctrl_interface 'zephyr' bridge 'N/A'
00> [00:00:00.680,999] <dbg> wpa_supp: wpa_printf_impl: Add interface wlan0 to a new radio N/A
00> [00:00:00.687,438] <dbg> wpa_supp: wpa_printf_impl: wpa_supp: Added 802.11b mode based on 802.11g information
00> [00:00:00.688,385] <dbg> wpa_supp: wpa_printf_impl: l2_packet_init: iface wlan0 ifindex 1
00> [00:00:00.689,025] <dbg> wpa_supp: wpa_printf_impl: wlan0: Own MAC address: f4:ce:36:00:1f:e8
00> [00:00:00.689,636] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20008100 alg 0 addr 0 key_idx 0 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
00> [00:00:00.695,373] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20008100 alg 0 addr 0 key_idx 1 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
00> [00:00:00.699,737] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20008100 alg 0 addr 0 key_idx 2 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
00> [00:00:00.705,688] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20008100 alg 0 addr 0 key_idx 3 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
00> [00:00:00.710,021] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20008100 alg 0 addr 0 key_idx 4 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
00> [00:00:00.714,508] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20008100 alg 0 addr 0 key_idx 5 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
00> [00:00:00.720,184] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: flushing PMKID list in the driver
00> [00:00:00.720,764] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: DISCONNECTED -> INACTIVE
00> [00:00:00.784,118] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state DISCONNECTED
00> [00:00:00.784,576] <dbg> wpa_supp: wpa_printf_impl: EAPOL: Supplicant port status: Unauthorized
00> [00:00:00.797,882] <dbg> wpa_supp: wpa_printf_impl: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
00> [00:00:00.798,339] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state INITIALIZE
00> [00:00:00.798,767] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state DISABLED
00> [00:00:00.800,506] <dbg> wpa_supp: wpa_printf_impl: MBO: Update non-preferred channels, non_pref_chan=N/A
00> [00:00:00.801,300] <dbg> wpa_supp: wpa_printf_impl: wlan0: Added interface wlan0
00> [00:00:00.801,849] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: INACTIVE -> DISCONNECTED
00> [00:00:01.799,438] <dbg> wpa_supp: wpa_printf_impl: EAPOL: disable timer tick
00> [00:00:02.663,085] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: remove_network, argc: 2
00> [00:00:02.663,543] <dbg> wpa_supp: wpa_printf_impl: argv[0]: remove_network
00> [00:00:02.663,940] <dbg> wpa_supp: wpa_printf_impl: argv[1]: all
00> [00:00:02.665,069] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'REMOVE_NETWORK all'
00> [00:00:02.665,588] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: REMOVE_NETWORK all
00> [00:00:02.666,931] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'ADD_NETWORK'
00> [00:00:02.667,419] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: ADD_NETWORK
00> [00:00:02.668,609] <dbg> wpa_supp: wpa_printf_impl: Received len: 26, msg_len:26 - CTRL-EVENT-NETWORK-ADDED 0->END
00> [00:00:02.669,555] <dbg> wpa_supp: wpa_printf_impl: NET added: 0
00> [00:00:02.670,013] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.670,440] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.670,806] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.671,173] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ssid
00> [00:00:02.671,569] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "allen"
00> [00:00:02.672,698] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.673,278] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ssid'
00> [00:00:02.673,767] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=7): [REMOVED]
00> [00:00:02.674,255] <dbg> wpa_supp: wpa_printf_impl: ssid - hexdump_ascii(len=5):
00> [00:00:02.674,621] <dbg> wpa_supp: _wpa_hexdump_ascii: 
00>                                    61 6c 6c 65 6e                                   |allen            
00> [00:00:02.675,720] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.676,177] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.676,544] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.676,910] <dbg> wpa_supp: wpa_printf_impl: argv[2]: scan_ssid
00> [00:00:02.677,307] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 1
00> [00:00:02.678,436] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.679,016] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='scan_ssid'
00> [00:00:02.679,504] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
00> [00:00:02.679,992] <dbg> wpa_supp: wpa_printf_impl: scan_ssid=1 (0x1)
00> [00:00:02.680,725] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.681,152] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.681,549] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.681,915] <dbg> wpa_supp: wpa_printf_impl: argv[2]: key_mgmt
00> [00:00:02.682,281] <dbg> wpa_supp: wpa_printf_impl: argv[3]: NONE
00> [00:00:02.683,441] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.684,020] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
00> [00:00:02.684,509] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
00> [00:00:02.684,997] <dbg> wpa_supp: wpa_printf_impl: key_mgmt: 0x4
00> [00:00:02.685,729] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.686,157] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.686,553] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.686,920] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ieee80211w
00> [00:00:02.687,286] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 0
00> [00:00:02.688,446] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.689,025] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ieee80211w'
00> [00:00:02.689,514] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
00> [00:00:02.690,032] <dbg> wpa_supp: wpa_printf_impl: ieee80211w=0 (0x0)
00> [00:00:02.691,040] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 17
00> [00:00:02.691,467] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.691,864] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.692,230] <dbg> wpa_supp: wpa_printf_impl: argv[2]: scan_freq
00> [00:00:02.692,626] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 2412
00> [00:00:02.692,993] <dbg> wpa_supp: wpa_printf_impl: argv[4]: 2417
00> [00:00:02.693,359] <dbg> wpa_supp: wpa_printf_impl: argv[5]: 2422
00> [00:00:02.693,756] <dbg> wpa_supp: wpa_printf_impl: argv[6]: 2427
00> [00:00:02.694,122] <dbg> wpa_supp: wpa_printf_impl: argv[7]: 2432
00> [00:00:02.694,488] <dbg> wpa_supp: wpa_printf_impl: argv[8]: 2437
00> [00:00:02.694,854] <dbg> wpa_supp: wpa_printf_impl: argv[9]: 2442
00> [00:00:02.695,251] <dbg> wpa_supp: wpa_printf_impl: argv[10]: 2447
00> [00:00:02.695,617] <dbg> wpa_supp: wpa_printf_impl: argv[11]: 2452
00> [00:00:02.695,983] <dbg> wpa_supp: wpa_printf_impl: argv[12]: 2457
00> [00:00:02.696,380] <dbg> wpa_supp: wpa_printf_impl: argv[13]: 2462
00> [00:00:02.696,746] <dbg> wpa_supp: wpa_printf_impl: argv[14]: 2467
00> [00:00:02.697,113] <dbg> wpa_supp: wpa_printf_impl: argv[15]: 2472
00> [00:00:02.697,509] <dbg> wpa_supp: wpa_printf_impl: argv[16]: 2484
00> [00:00:02.698,852] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.699,432] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='scan_freq'
00> [00:00:02.699,920] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=69): [REMOVED]
00> [00:00:02.700,866] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.701,324] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.701,690] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.702,056] <dbg> wpa_supp: wpa_printf_impl: argv[2]: proto
00> [00:00:02.702,453] <dbg> wpa_supp: wpa_printf_impl: argv[3]: RSN
00> [00:00:02.703,582] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.704,162] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='proto'
00> [00:00:02.704,620] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
00> [00:00:02.705,139] <dbg> wpa_supp: wpa_printf_impl: proto: 0x2
00> [00:00:02.705,841] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.706,298] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.706,695] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.707,061] <dbg> wpa_supp: wpa_printf_impl: argv[2]: key_mgmt
00> [00:00:02.707,427] <dbg> wpa_supp: wpa_printf_impl: argv[3]: WPA-EAP
00> [00:00:02.708,587] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.709,167] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
00> [00:00:02.709,655] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=7): [REMOVED]
00> [00:00:02.710,144] <dbg> wpa_supp: wpa_printf_impl: key_mgmt: 0x1
00> [00:00:02.710,876] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set, argc: 3
00> [00:00:02.711,273] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set
00> [00:00:02.711,669] <dbg> wpa_supp: wpa_printf_impl: argv[1]: openssl_ciphers
00> [00:00:02.712,066] <dbg> wpa_supp: wpa_printf_impl: argv[2]: "DEFAULT:!EXP:!LOW"
00> [00:00:02.713,256] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET openssl_ciphers "DEFAULT:!EXP:!LOW"'
00> [00:00:02.713,867] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE SET 'openssl_ciphers'='"DEFAULT:!EXP:!LOW"'
00> [00:00:02.714,447] <dbg> wpa_supp: wpa_printf_impl: openssl_ciphers='"DEFAULT:!EXP:!LOW"'
00> [00:00:02.715,209] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.715,637] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.716,033] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.716,400] <dbg> wpa_supp: wpa_printf_impl: argv[2]: group
00> [00:00:02.716,766] <dbg> wpa_supp: wpa_printf_impl: argv[3]: CCMP
00> [00:00:02.717,926] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.718,505] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='group'
00> [00:00:02.718,963] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
00> [00:00:02.719,482] <dbg> wpa_supp: wpa_printf_impl: group: 0x10
00> [00:00:02.720,184] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.720,642] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.721,038] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.721,405] <dbg> wpa_supp: wpa_printf_impl: argv[2]: pairwise
00> [00:00:02.721,771] <dbg> wpa_supp: wpa_printf_impl: argv[3]: CCMP
00> [00:00:02.722,930] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.723,480] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='pairwise'
00> [00:00:02.723,968] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
00> [00:00:02.724,487] <dbg> wpa_supp: wpa_printf_impl: pairwise: 0x10
00> [00:00:02.725,219] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.725,646] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.726,043] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.726,409] <dbg> wpa_supp: wpa_printf_impl: argv[2]: group_mgmt
00> [00:00:02.726,806] <dbg> wpa_supp: wpa_printf_impl: argv[3]: AES-128-CMAC
00> [00:00:02.727,966] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.728,546] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='group_mgmt'
00> [00:00:02.729,034] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=12): [REMOVED]
00> [00:00:02.729,553] <dbg> wpa_supp: wpa_printf_impl: group_mgmt: 0x20
00> [00:00:02.730,285] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.730,712] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.731,109] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.731,475] <dbg> wpa_supp: wpa_printf_impl: argv[2]: proto
00> [00:00:02.731,842] <dbg> wpa_supp: wpa_printf_impl: argv[3]: RSN
00> [00:00:02.732,971] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.733,551] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='proto'
00> [00:00:02.734,039] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
00> [00:00:02.734,893] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.735,321] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.735,717] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.736,083] <dbg> wpa_supp: wpa_printf_impl: argv[2]: eap
00> [00:00:02.736,450] <dbg> wpa_supp: wpa_printf_impl: argv[3]: TLS
00> [00:00:02.737,579] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.738,159] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='eap'
00> [00:00:02.738,616] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
00> [00:00:02.739,501] <dbg> wpa_supp: wpa_printf_impl: eap methods - hexdump(len=16): 00 00 00 00 0d 00 00 00 00 00 00 00 00 00 00 00
00> [00:00:02.740,386] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.740,844] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.741,241] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.741,607] <dbg> wpa_supp: wpa_printf_impl: argv[2]: identity
00> [00:00:02.741,973] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "[email protected]"
00> [00:00:02.743,164] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.743,743] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='identity'
00> [00:00:02.744,232] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=18): [REMOVED]
00> [00:00:02.744,750] <dbg> wpa_supp: wpa_printf_impl: identity - hexdump_ascii(len=16):
00> [00:00:02.745,147] <dbg> wpa_supp: _wpa_hexdump_ascii: 
00>                                    75 73 65 72 40 65 78 61  6d 70 6c 65 2e 6f 72 67 |user@exa mple.org
00> [00:00:02.746,459] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.746,917] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.747,283] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.747,680] <dbg> wpa_supp: wpa_printf_impl: argv[2]: password
00> [00:00:02.748,046] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "password"
00> [00:00:02.749,206] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.749,786] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='password'
00> [00:00:02.750,274] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=10): [REMOVED]
00> [00:00:02.750,793] <dbg> wpa_supp: wpa_printf_impl: password - hexdump_ascii(len=8): [REMOVED]
00> [00:00:02.751,617] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 5
00> [00:00:02.752,044] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.752,441] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.752,807] <dbg> wpa_supp: wpa_printf_impl: argv[2]: anonymous_identity
00> [00:00:02.753,204] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "˜§
00> [00:00:02.753,601] <dbg> wpa_supp: wpa_printf_impl: argv[4]: i‘"
00> [00:00:02.754,760] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.755,340] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='anonymous_identity'
00> [00:00:02.755,828] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=9): [REMOVED]
00> [00:00:02.756,378] <dbg> wpa_supp: wpa_printf_impl: anonymous_identity - hexdump_ascii(len=7):
00> [00:00:02.756,774] <dbg> wpa_supp: _wpa_hexdump_ascii: 
00>                                    98 a7 02 20 69 91 03                             |... i..          
00> [00:00:02.758,422] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.758,880] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.759,246] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.759,613] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ca_cert
00> [00:00:02.760,009] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://ca_cert"
00> [00:00:02.761,169] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.761,749] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ca_cert'
00> [00:00:02.762,237] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=16): [REMOVED]
00> [00:00:02.762,756] <dbg> wpa_supp: wpa_printf_impl: ca_cert - hexdump_ascii(len=14):
00> [00:00:02.763,153] <dbg> wpa_supp: _wpa_hexdump_ascii: 
00>                                    62 6c 6f 62 3a 2f 2f 63  61 5f 63 65 72 74       |blob://c a_cert  
00> [00:00:02.765,472] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.765,930] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.766,296] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.766,662] <dbg> wpa_supp: wpa_printf_impl: argv[2]: client_cert
00> [00:00:02.767,059] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://client_cert"
00> [00:00:02.768,249] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.768,829] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='client_cert'
00> [00:00:02.769,317] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=20): [REMOVED]
00> [00:00:02.769,866] <dbg> wpa_supp: wpa_printf_impl: client_cert - hexdump_ascii(len=18):
00> [00:00:02.770,263] <dbg> wpa_supp: _wpa_hexdump_ascii: 
00>                                    62 6c 6f 62 3a 2f 2f 63  6c 69 65 6e 74 5f 63 65 |blob://c lient_ce
00>                                    72 74                                            |rt               
00> [00:00:02.772,491] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.772,918] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.773,315] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.773,681] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key
00> [00:00:02.774,078] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://private_key"
00> [00:00:02.775,268] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.775,848] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key'
00> [00:00:02.776,336] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=20): [REMOVED]
00> [00:00:02.776,885] <dbg> wpa_supp: wpa_printf_impl: private_key - hexdump_ascii(len=18):
00> [00:00:02.777,252] <dbg> wpa_supp: _wpa_hexdump_ascii: 
00>                                    62 6c 6f 62 3a 2f 2f 70  72 69 76 61 74 65 5f 6b |blob://p rivate_k
00>                                    65 79                                            |ey               
00> [00:00:02.778,961] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
00> [00:00:02.779,388] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
00> [00:00:02.779,785] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
00> [00:00:02.780,151] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key_passwd
00> [00:00:02.780,578] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "test"
00> [00:00:02.781,707] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
00> [00:00:02.782,287] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key_passwd'
00> [00:00:02.782,806] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=6): [REMOVED]
00> [00:00:02.783,355] <dbg> wpa_supp: wpa_printf_impl: private_key_passwd - hexdump_ascii(len=4): [REMOVED]
00> Wi-Fi connection request sent...

My ap logs and radius server didn't show the receive request, so I guess the problem is on firmware program.

Is there something wrong with my code? 

/*
 * Copyright (c) 2016 Intel Corporation.
 *
 * SPDX-License-Identifier: Apache-2.0
 */

#include <zephyr/kernel.h>
#include <errno.h>
#include <zephyr/net/wifi_mgmt.h>
#include <zephyr/net/net_mgmt.h>
#include "ca.h"
#include "client.h"
#include "client_key.h"
#include <zephyr/sys/printk.h>
#include <zephyr/logging/log.h>

LOG_MODULE_REGISTER(wifi, 3);
static volatile bool wifi_connected = false;
struct wifi_eap_config eap_conf = {
	/**  Security type. */
	.type = WIFI_EAP_TYPE_TLS,
	.eap_type_phase1 = WIFI_EAP_TYPE_TLS,
	.eap_type_phase2 = WIFI_EAP_TYPE_TLS, // No inner method needed for TLS
};

struct wifi_enterprise_creds_params enterprise_creds_params = {
	/** CA certification */
	.ca_cert = (char *)ca_pem,
	// /** CA certification length */
	.ca_cert_len = sizeof(ca_pem),
	// /** Client certification */
	.client_cert = (char *)client_pem,
	// /** Client certification length */
	.client_cert_len = sizeof(client_pem),
	// /** Client key */
	.client_key = (char *)client_key,
	// /** Client key length */
	.client_key_len = sizeof(client_key),
};

struct wifi_connect_req_params cnx_params = {
	.ssid = "allen",
	.ssid_length = strlen("allen"),

	/** Private key passwd for enterprise mode */
	.key_passwd = "test",
	/** Private key passwd length, max 128 */
	.key_passwd_length = strlen("test"),
	.eap_identity = "[email protected]",
	/** eap identity length, max 64 */
	.eap_id_length = strlen("[email protected]"),
	/** Password string for EAP. */
	.eap_password = "password",
	/** eap passwd length, max 128 */
	.eap_passwd_length = strlen("password"),
	.channel = WIFI_CHANNEL_ANY,
	.security = WIFI_SECURITY_TYPE_EAP, // WIFI_SECURITY_TYPE_EAP_TTLS_MSCHAPV2 WIFI_SECURITY_TYPE_PSK
	.timeout = SYS_FOREVER_MS,
};

static struct net_mgmt_event_callback wifi_cb;
static void wifi_event_handler(struct net_mgmt_event_callback *cb,
							   uint32_t mgmt_event, struct net_if *iface)
{
	struct wifi_status *status;

	if (mgmt_event == NET_EVENT_WIFI_CONNECT_RESULT)
	{
		status = (struct wifi_status *)cb->info;
		if (status->status)
		{
			LOG_ERR("Wi-Fi connection failed error code: %d", status->status);
			wifi_connected = false;
		}
		else
		{
			LOG_INF("Wi-Fi connect success");
			wifi_connected = true;
		}
	}
	else if (mgmt_event == NET_EVENT_WIFI_DISCONNECT_RESULT)
	{
		LOG_INF("Wi-Fi disconnect");
		wifi_connected = false;
	}
	else if (mgmt_event == NET_EVENT_WIFI_SCAN_RESULT)
	{
		struct wifi_scan_result *scan_result = (struct wifi_scan_result *)cb->info;
		LOG_INF("SSID: %s, Signal: %d dBm, Security: %d",
				scan_result->ssid, scan_result->rssi, scan_result->security);
	}
}

int main(void)
{
	k_sleep(K_SECONDS(1));

	struct net_if *iface = net_if_get_default();
	if (iface == NULL)
	{
		printk("No default network interface found.\n");
	}

	int ret = net_mgmt(NET_REQUEST_WIFI_ENTERPRISE_CREDS, iface, &enterprise_creds_params, sizeof(enterprise_creds_params));
	if (ret)
	{
		printk("Failed to set Wi-Fi enterprise credentials: %d\n", ret);
	}

	k_sleep(K_SECONDS(1));

	net_mgmt_init_event_callback(&wifi_cb, wifi_event_handler,
								 NET_EVENT_WIFI_CONNECT_RESULT |
									 NET_EVENT_WIFI_DISCONNECT_RESULT |
									 NET_EVENT_WIFI_SCAN_RESULT);
	net_mgmt_add_event_callback(&wifi_cb);

	// net_mgmt(NET_REQUEST_WIFI_SCAN, iface, NULL, 0);
	int ret1 = net_mgmt(NET_REQUEST_WIFI_CONNECT, iface, &cnx_params, sizeof(struct wifi_connect_req_params));
	if (ret1)
	{
		printk("Failed to send Wi-Fi connection request! %d\n", ret);
	}
	else
	{
		printk("Wi-Fi connection request sent...\n");
	}

	return 0;
}

6201.prj.conf

overlay-enterprise.conf

Parents
  • Hi, 

    Could you test samples/net/wifi with overlay-enterprise.conf? See the detail in the Enterprise security documentation. 

    Regards,
    Amanda H.

  • Hi, 

    I've tried this sample, the Freeradius server has received the access request, and sent access challenge, and didn't show any error, but it seens that the client or ap didn't reply. So the two messages,"receive access request" and "sent access challenge", keep looping on the server. Client still printed "connection failed". I don't know whether the problem is on the WIFI ap or nrf7002 sample.

    nrf7002 output

    *** Booting nRF Connect SDK v2.8.0-a2386bfc8401 ***
    
    *** Using Zephyr OS v3.7.99-0bc3393fb112 ***
    
    [00:00:00.708,221] <dbg> wpa_supp: wpa_printf_impl: wpa_supplicant v2.11-devel
    
    [00:00:00.709,442] <inf> wifi_supplicant: wpa_supplicant initialized
    
    [00:00:00.710,784] <dbg> wifi_supplicant: add_interface: Adding interface wlan0 [1] (0x20000c80)
    
    [00:00:00.710,906] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: interface_add, argc: 5
    
    [00:00:00.710,998] <dbg> wpa_supp: wpa_printf_impl: argv[0]: interface_add
    
    [00:00:00.711,059] <dbg> wpa_supp: wpa_printf_impl: argv[1]: wlan0
    
    [00:00:00.711,151] <dbg> wpa_supp: wpa_printf_impl: argv[2]: zephyr
    
    [00:00:00.711,212] <dbg> wpa_supp: wpa_printf_impl: argv[3]: zephyr
    
    [00:00:00.711,303] <dbg> wpa_supp: wpa_printf_impl: argv[4]: zephyr
    
    [00:00:00.712,097] <dbg> wpa_supp: wpa_printf_impl: RX global ctrl_iface - hexdump_ascii(len=71):
    
    [00:00:00.712,158] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       49 4e 54 45 52 46 41 43  45 5f 41 44 44 20 77 6c |INTERFAC E_ADD wl
    
                                       61 6e 30 09 7a 65 70 68  79 72 09 7a 65 70 68 79 |an0.zeph yr.zephy
    
                                       72 09 7a 65 70 68 79 72  09 09 09 09 20 77 6c 61 |r.zephyr .... wla
    
                                       6e 30 20 7a 65 70 68 79  72 20 7a 65 70 68 79 72 |n0 zephy r zephyr
    
                                       20 7a 65 70 68 79 72                             | zephyr
    
    [00:00:00.712,249] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE GLOBAL INTERFACE_ADD 'wlan0       zephyr  zephyr  zephyr                           wlan0 zephyr zephyr zephyr'
    
    [00:00:00.712,738] <dbg> wpa_supp: wpa_printf_impl: Initializing interface 'wlan0' conf 'zephyr' driver 'zephyr' ctrl_interface 'zephyr' bridge 'N/A'
    
    [00:00:00.716,552] <dbg> wpa_supp: wpa_printf_impl: Add interface wlan0 to a new radio N/A
    
    [00:00:00.721,496] <dbg> wpa_supp: wpa_printf_impl: wpa_supp: Added 802.11b mode based on 802.11g information
    
    [00:00:00.721,801] <dbg> wpa_supp: wpa_printf_impl: l2_packet_init: iface wlan0 ifindex 1
    
    [00:00:00.722,045] <dbg> wpa_supp: wpa_printf_impl: wlan0: Own MAC address: f4:ce:36:00:1f:e8
    
    [00:00:00.722,259] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 0 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.725,219] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 1 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.728,668] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 2 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.731,445] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 3 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.734,252] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 4 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.736,907] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 5 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.740,631] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: flushing PMKID list in the driver
    
    [00:00:00.740,814] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: DISCONNECTED -> INACTIVE
    
    [00:00:00.803,802] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state DISCONNECTED
    
    [00:00:00.803,894] <dbg> wpa_supp: wpa_printf_impl: EAPOL: Supplicant port status: Unauthorized
    
    [00:00:00.815,826] <dbg> wpa_supp: wpa_printf_impl: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
    
    [00:00:00.815,917] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state INITIALIZE
    
    [00:00:00.815,979] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state DISABLED
    
    [00:00:00.817,321] <dbg> wpa_supp: wpa_printf_impl: MBO: Update non-preferred channels, non_pref_chan=N/A
    
    [00:00:00.817,657] <dbg> wpa_supp: wpa_printf_impl: wlan0: Added interface wlan0
    
    [00:00:00.817,810] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: INACTIVE -> DISCONNECTED
    
    [00:00:01.816,253] <dbg> wpa_supp: wpa_printf_impl: EAPOL: disable timer tick
    
    uart:~$ wifi connect -s allen -k 7 -a anon -K test
    
    wifi connect -s allen -k 7 -a anon -K test
    
    Connection requested
    
    [00:09:11.564,575] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: remove_network, argc: 2
    
    [00:09:11.564,666] <dbg> wpa_supp: wpa_printf_impl: argv[0]: remove_network
    
    [00:09:11.564,727] <dbg> wpa_supp: wpa_printf_impl: argv[1]: all
    
    [00:09:11.565,399] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'REMOVE_NETWORK all'
    
    [00:09:11.565,551] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: REMOVE_NETWORK all
    
    [00:09:11.566,314] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'ADD_NETWORK'
    
    [00:09:11.566,436] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: ADD_NETWORK
    
    [00:09:11.567,108] <dbg> wpa_supp: wpa_printf_impl: Received len: 26, msg_len:26 - CTRL-EVENT-NETWORK-ADDED 0->END
    
    [00:09:11.567,504] <dbg> wpa_supp: wpa_printf_impl: NET added: 0
    
    [00:09:11.567,626] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.567,687] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.567,779] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.567,840] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ssid
    
    [00:09:11.567,932] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "allen"
    
    [00:09:11.568,603] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.568,756] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ssid'
    
    [00:09:11.568,847] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=7): [REMOVED]
    
    [00:09:11.568,969] <dbg> wpa_supp: wpa_printf_impl: ssid - hexdump_ascii(len=5):
    
    [00:09:11.569,030] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6c 6c 65 6e                                   |allen
    
    [00:09:11.569,366] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.569,427] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.569,519] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.569,580] <dbg> wpa_supp: wpa_printf_impl: argv[2]: scan_ssid
    
    [00:09:11.569,641] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 1
    
    [00:09:11.570,343] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.570,495] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='scan_ssid'
    
    [00:09:11.570,617] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
    
    [00:09:11.570,709] <dbg> wpa_supp: wpa_printf_impl: scan_ssid=1 (0x1)
    
    [00:09:11.571,075] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.571,136] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.571,197] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.571,289] <dbg> wpa_supp: wpa_printf_impl: argv[2]: key_mgmt
    
    [00:09:11.571,350] <dbg> wpa_supp: wpa_printf_impl: argv[3]: NONE
    
    [00:09:11.572,052] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.572,204] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
    
    [00:09:11.572,296] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.572,418] <dbg> wpa_supp: wpa_printf_impl: key_mgmt: 0x4
    
    [00:09:11.572,784] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.572,845] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.572,937] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.572,998] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ieee80211w
    
    [00:09:11.573,089] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 0
    
    [00:09:11.573,760] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.573,913] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ieee80211w'
    
    [00:09:11.574,035] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
    
    [00:09:11.574,188] <dbg> wpa_supp: wpa_printf_impl: ieee80211w=0 (0x0)
    
    [00:09:11.574,554] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.574,615] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.574,676] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.574,768] <dbg> wpa_supp: wpa_printf_impl: argv[2]: proto
    
    [00:09:11.574,829] <dbg> wpa_supp: wpa_printf_impl: argv[3]: RSN
    
    [00:09:11.575,500] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.575,683] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='proto'
    
    [00:09:11.575,775] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
    
    [00:09:11.575,897] <dbg> wpa_supp: wpa_printf_impl: proto: 0x2
    
    [00:09:11.576,263] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.576,324] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.576,416] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.576,477] <dbg> wpa_supp: wpa_printf_impl: argv[2]: key_mgmt
    
    [00:09:11.576,568] <dbg> wpa_supp: wpa_printf_impl: argv[3]: WPA-EAP
    
    [00:09:11.577,239] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.577,392] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
    
    [00:09:11.577,514] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=7): [REMOVED]
    
    [00:09:11.577,636] <dbg> wpa_supp: wpa_printf_impl: key_mgmt: 0x1
    
    [00:09:11.578,002] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set, argc: 3
    
    [00:09:11.578,063] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set
    
    [00:09:11.578,155] <dbg> wpa_supp: wpa_printf_impl: argv[1]: openssl_ciphers
    
    [00:09:11.578,216] <dbg> wpa_supp: wpa_printf_impl: argv[2]: "DEFAULT:!EXP:!LOW"
    
    [00:09:11.578,948] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET openssl_ciphers "DEFAULT:!EXP:!LOW"'
    
    [00:09:11.579,101] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE SET 'openssl_ciphers'='"DEFAULT:!EXP:!LOW"'
    
    [00:09:11.579,254] <dbg> wpa_supp: wpa_printf_impl: openssl_ciphers='"DEFAULT:!EXP:!LOW"'
    
    [00:09:11.579,620] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.579,681] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.579,772] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.579,833] <dbg> wpa_supp: wpa_printf_impl: argv[2]: group
    
    [00:09:11.579,895] <dbg> wpa_supp: wpa_printf_impl: argv[3]: CCMP
    
    [00:09:11.580,596] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.580,749] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='group'
    
    [00:09:11.580,871] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.580,963] <dbg> wpa_supp: wpa_printf_impl: group: 0x10
    
    [00:09:11.581,329] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.581,420] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.581,481] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.581,573] <dbg> wpa_supp: wpa_printf_impl: argv[2]: pairwise
    
    [00:09:11.581,634] <dbg> wpa_supp: wpa_printf_impl: argv[3]: CCMP
    
    [00:09:11.582,305] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.582,489] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='pairwise'
    
    [00:09:11.582,580] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.582,702] <dbg> wpa_supp: wpa_printf_impl: pairwise: 0x10
    
    [00:09:11.583,068] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.583,160] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.583,221] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.583,312] <dbg> wpa_supp: wpa_printf_impl: argv[2]: group_mgmt
    
    [00:09:11.583,374] <dbg> wpa_supp: wpa_printf_impl: argv[3]: AES-128-CMAC
    
    [00:09:11.584,075] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.584,228] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='group_mgmt'
    
    [00:09:11.584,350] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=12): [REMOVED]
    
    [00:09:11.584,472] <dbg> wpa_supp: wpa_printf_impl: group_mgmt: 0x20
    
    [00:09:11.584,838] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.584,930] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.584,991] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.585,052] <dbg> wpa_supp: wpa_printf_impl: argv[2]: proto
    
    [00:09:11.585,144] <dbg> wpa_supp: wpa_printf_impl: argv[3]: RSN
    
    [00:09:11.585,815] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.585,968] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='proto'
    
    [00:09:11.586,090] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
    
    [00:09:11.586,486] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.586,547] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.586,639] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.586,700] <dbg> wpa_supp: wpa_printf_impl: argv[2]: eap
    
    [00:09:11.586,761] <dbg> wpa_supp: wpa_printf_impl: argv[3]: TLS
    
    [00:09:11.587,463] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.587,615] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='eap'
    
    [00:09:11.587,707] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
    
    [00:09:11.588,104] <dbg> wpa_supp: wpa_printf_impl: eap methods - hexdump(len=16): 00 00 00 00 0d 00 00 00 00 00 00 00 00 00 00 00
    
    [00:09:11.588,500] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.588,592] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.588,653] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.588,714] <dbg> wpa_supp: wpa_printf_impl: argv[2]: anonymous_identity
    
    [00:09:11.588,806] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "anon"
    
    [00:09:11.589,508] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.589,660] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='anonymous_identity'
    
    [00:09:11.589,782] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=6): [REMOVED]
    
    [00:09:11.589,904] <dbg> wpa_supp: wpa_printf_impl: anonymous_identity - hexdump_ascii(len=4):
    
    [00:09:11.589,965] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6e 6f 6e                                      |anon
    
    [00:09:11.590,728] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.590,789] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.590,881] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.590,942] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ca_cert
    
    [00:09:11.591,033] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://ca_cert"
    
    [00:09:11.591,705] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.591,888] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ca_cert'
    
    [00:09:11.591,979] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=16): [REMOVED]
    
    [00:09:11.592,132] <dbg> wpa_supp: wpa_printf_impl: ca_cert - hexdump_ascii(len=14):
    
    [00:09:11.592,163] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  61 5f 63 65 72 74       |blob://c a_cert
    
    [00:09:11.592,926] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.592,987] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.593,078] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.593,139] <dbg> wpa_supp: wpa_printf_impl: argv[2]: client_cert
    
    [00:09:11.593,231] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://client_cert"
    
    [00:09:11.593,933] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.594,085] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='client_cert'
    
    [00:09:11.594,207] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=20): [REMOVED]
    
    [00:09:11.594,329] <dbg> wpa_supp: wpa_printf_impl: client_cert - hexdump_ascii(len=18):
    
    [00:09:11.594,390] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  6c 69 65 6e 74 5f 63 65 |blob://c lient_ce
    
                                       72 74                                            |rt  
    
    [00:09:11.595,275] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.595,336] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.595,428] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.595,489] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key
    
    [00:09:11.595,581] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://private_key"
    
    [00:09:11.596,282] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.596,435] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key'
    
    [00:09:11.596,557] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=20): [REMOVED]
    
    [00:09:11.596,710] <dbg> wpa_supp: wpa_printf_impl: private_key - hexdump_ascii(len=18):
    
    [00:09:11.596,740] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 70  72 69 76 61 74 65 5f 6b |blob://p rivate_k
    
                                       65 79                                            |ey  
    
    [00:09:11.597,106] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.597,167] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.597,259] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.597,320] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key_passwd
    
    [00:09:11.597,412] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "test"
    
    [00:09:11.598,083] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.598,266] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key_passwd'
    
    [00:09:11.598,358] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=6): [REMOVED]
    
    [00:09:11.598,510] <dbg> wpa_supp: wpa_printf_impl: private_key_passwd - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.599,334] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.599,395] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.599,456] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.599,548] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ca_cert2
    
    [00:09:11.599,639] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://ca_cert2"
    
    [00:09:11.600,311] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.600,494] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ca_cert2'
    
    [00:09:11.600,585] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=17): [REMOVED]
    
    [00:09:11.600,738] <dbg> wpa_supp: wpa_printf_impl: ca_cert2 - hexdump_ascii(len=15):
    
    [00:09:11.600,799] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  61 5f 63 65 72 74 32    |blob://c a_cert2
    
    [00:09:11.601,531] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.601,593] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.601,684] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.601,745] <dbg> wpa_supp: wpa_printf_impl: argv[2]: client_cert2
    
    [00:09:11.601,837] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://client_cert2"
    
    [00:09:11.602,539] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.602,722] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='client_cert2'
    
    [00:09:11.602,813] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=21): [REMOVED]
    
    [00:09:11.602,966] <dbg> wpa_supp: wpa_printf_impl: client_cert2 - hexdump_ascii(len=19):
    
    [00:09:11.603,027] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  6c 69 65 6e 74 5f 63 65 |blob://c lient_ce
    
                                       72 74 32                                         |rt2 
    
    [00:09:11.603,912] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.603,973] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.604,034] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.604,125] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key2
    
    [00:09:11.604,217] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://private_key2"
    
    [00:09:11.604,919] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.605,072] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key2'
    
    [00:09:11.605,194] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=21): [REMOVED]
    
    [00:09:11.605,346] <dbg> wpa_supp: wpa_printf_impl: private_key2 - hexdump_ascii(len=19):
    
    [00:09:11.605,377] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 70  72 69 76 61 74 65 5f 6b |blob://p rivate_k
    
                                       65 79 32                                         |ey2 
    
    [00:09:11.605,743] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.605,834] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.605,895] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.605,987] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key2_passwd
    
    [00:09:11.606,048] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "(null)"
    
    [00:09:11.606,750] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.606,933] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key2_passwd'
    
    [00:09:11.607,025] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=8): [REMOVED]
    
    [00:09:11.607,177] <dbg> wpa_supp: wpa_printf_impl: private_key2_passwd - hexdump_ascii(len=6): [REMOVED]
    
    [00:09:11.607,543] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.607,635] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.607,696] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.607,788] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ieee80211w
    
    [00:09:11.607,849] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 1
    
    [00:09:11.608,520] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.608,703] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ieee80211w'
    
    [00:09:11.608,795] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
    
    [00:09:11.608,947] <dbg> wpa_supp: wpa_printf_impl: ieee80211w=1 (0x1)
    
    [00:09:11.609,313] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: enable_network, argc: 2
    
    [00:09:11.609,405] <dbg> wpa_supp: wpa_printf_impl: argv[0]: enable_network
    
    [00:09:11.609,466] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.610,137] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'ENABLE_NETWORK 0'
    
    [00:09:11.610,290] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: ENABLE_NETWORK id=0
    
    [00:09:11.610,473] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 0.000000 sec
    
    [00:09:11.610,900] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: DISCONNECTED -> SCANNING
    
    [00:09:11.611,022] <dbg> wpa_supp: wpa_printf_impl: Scan SSID - hexdump_ascii(len=5):
    
    [00:09:11.611,083] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6c 6c 65 6e                                   |allen
    
    [00:09:11.611,206] <dbg> wpa_supp: wpa_printf_impl: wlan0: Include wildcard SSID in the scan request
    
    [00:09:11.611,633] <dbg> wpa_supp: wpa_printf_impl: wlan0: Add radio work 'scan'@0x2003fe68
    
    [00:09:11.611,877] <dbg> wpa_supp: wpa_printf_impl: wlan0: First radio work item in the queue - schedule start immediately
    
    [00:09:11.612,365] <dbg> wpa_supp: wpa_printf_impl: wlan0: Starting radio work 'scan'@0x2003fe68 after 0.000427 second wait
    
    [00:09:11.613,494] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: select_network, argc: 2
    
    [00:09:11.613,555] <dbg> wpa_supp: wpa_printf_impl: argv[0]: select_network
    
    [00:09:11.613,647] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.623,901] <dbg> wpa_supp: wpa_printf_impl: wpa_drv_zep_scan2: Scan requested - scan timeout 35 seconds
    
    [00:09:11.624,725] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SELECT_NETWORK 0'
    
    [00:09:11.624,847] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SELECT_NETWORK id=0
    
    [00:09:11.625,030] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 0.000000 sec
    
    [00:09:11.625,457] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:11.625,671] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:11.626,098] <dbg> wifi_supplicant: event_socket_handler: Passing message 47 to wpa_supplicant
    
    [00:09:11.626,251] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event SCAN_STARTED (47) received
    
    [00:09:11.626,495] <dbg> wpa_supp: wpa_printf_impl: wlan0: Own scan request started a scan in 0.002014 seconds
    
    [00:09:11.626,983] <dbg> wpa_supp: wpa_printf_impl: Received len: 24, msg_len:24 - CTRL-EVENT-SCAN-STARTED ->END
    
    [00:09:12.626,129] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:12.626,342] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:13.626,708] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:13.626,922] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:14.627,288] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:14.627,502] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:15.522,521] <dbg> wifi_supplicant: event_socket_handler: Passing message 3 to wpa_supplicant
    
    [00:09:15.522,674] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event SCAN_RESULTS (3) received
    
    [00:09:15.522,888] <dbg> wpa_supp: wpa_printf_impl: wlan0: Scan completed in 3.896423 seconds
    
    [00:09:15.527,221] <dbg> wpa_supp: wpa_printf_impl: Sorted scan results
    
    [00:09:15.527,465] <dbg> wpa_supp: wpa_printf_impl: 58:11:22:13:0b:bc freq=5220 qual=0 noise=-92~ level=-29 snr=63* flags=0xb age=2825 est=390001
    
    [00:09:15.532,012] <dbg> wpa_supp: wpa_printf_impl: IEs - hexdump(len=328): 00 05 61 6c 6c 65 6e 01 08 8c 12 98 24 b0 48 60 6c 05 04 00 01 00 00 23 02 19 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 38 00 00 46 05 32 00 00 00 00 2d 1a ef 09 17 ff ff 00 00 00 00 00 00 00
    
    [00:09:15.536,590] <dbg> wpa_supp: wpa_printf_impl: Beacon IEs - hexdump(len=328): 00 05 61 6c 6c 65 6e 01 08 8c 12 98 24 b0 48 60 6c 05 04 00 01 00 00 23 02 19 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 38 00 00 46 05 32 00 00 00 00 2d 1a ef 09 17 ff ff 00 00 00 00 00
    
    [00:09:15.536,926] <dbg> wpa_supp: wpa_printf_impl: 58:11:22:13:0b:b8 freq=2452 qual=0 noise=-89~ level=-28 snr=61* flags=0xb age=3446 est=65000
    
    [00:09:15.541,717] <dbg> wpa_supp: wpa_printf_impl: IEs - hexdump(len=355): 00 05 61 6c 6c 65 6e 01 08 82 84 8b 96 24 30 48 6c 03 01 09 05 04 00 01 00 00 07 06 55 53 04 01 0b 17 23 02 18 00 2a 01 04 32 04 0c 12 18 60 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 22 00 00 46
    
    [00:09:15.546,630] <dbg> wpa_supp: wpa_printf_impl: Beacon IEs - hexdump(len=355): 00 05 61 6c 6c 65 6e 01 08 82 84 8b 96 24 30 48 6c 03 01 09 05 04 00 01 00 00 07 06 55 53 04 01 0b 17 23 02 18 00 2a 01 04 32 04 0c 12 18 60 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 22 00
    
    [00:09:15.546,936] <dbg> wpa_supp: wpa_printf_impl: wlan0: BSS: Start scan result update 1
    
    [00:09:15.547,515] <dbg> wpa_supp: wpa_printf_impl: wlan0: BSS: Add new id 0 BSSID 58:11:22:13:0b:bc SSID 'allen' freq 5220
    
    [00:09:15.548,339] <dbg> wpa_supp: wpa_printf_impl: wlan0: BSS: Add new id 1 BSSID 58:11:22:13:0b:b8 SSID 'allen' freq 2452
    
    [00:09:15.548,675] <dbg> wpa_supp: wpa_printf_impl: BSS: last_scan_res_used=2/32
    
    [00:09:15.548,858] <dbg> wpa_supp: wpa_printf_impl: wlan0: New scan results available (own=1 ext=0)
    
    [00:09:15.549,285] <dbg> wpa_supp: wpa_printf_impl: wlan0: Radio work 'scan'@0x2003fe68 done in 3.936951 seconds
    
    [00:09:15.549,560] <dbg> wpa_supp: wpa_printf_impl: wlan0: radio_work_free('scan'@0x2003fe68): num_active_works --> 0
    
    [00:09:15.549,774] <dbg> wpa_supp: wpa_printf_impl: wlan0: Scan results matching the currently selected network
    
    [00:09:15.550,323] <dbg> wpa_supp: wpa_printf_impl: wlan0: 0: 58:11:22:13:0b:bc freq=5220 level=-29 snr=63 est_throughput=390001
    
    [00:09:15.550,842] <dbg> wpa_supp: wpa_printf_impl: wlan0: 1: 58:11:22:13:0b:b8 freq=2452 level=-28 snr=61 est_throughput=65000
    
    [00:09:15.551,025] <dbg> wpa_supp: wpa_printf_impl: wlan0: Selecting BSS from priority group 0
    
    [00:09:15.551,544] <dbg> wpa_supp: wpa_printf_impl: wlan0: 0: 58:11:22:13:0b:bc ssid='allen' wpa_ie_len=22 rsn_ie_len=20 caps=0x1011 level=-29 freq=5220
    
    [00:09:15.551,788] <dbg> wpa_supp: wpa_printf_impl: wlan0:    selected based on RSN IE
    
    [00:09:15.552,124] <dbg> wpa_supp: wpa_printf_impl: wlan0:    selected BSS 58:11:22:13:0b:bc ssid='allen'
    
    [00:09:15.552,856] <dbg> wpa_supp: wpa_printf_impl: wlan0: Considering connect request: reassociate: 1  selected: 58:11:22:13:0b:bc  bssid: 00:00:00:00:00:00  pending: 00:00:00:00:00:00  wpa_state: SCANNING  ssid=0x20041ea8  current_ssid=0x20041ea8
    
    [00:09:15.553,131] <dbg> wpa_supp: wpa_printf_impl: wlan0: Request association with 58:11:22:13:0b:bc
    
    [00:09:15.553,375] <dbg> wpa_supp: wpa_printf_impl: wlan0: No ongoing scan/p2p-scan found to abort
    
    [00:09:15.553,619] <dbg> wpa_supp: wpa_printf_impl: wlan0: Add radio work 'sme-connect'@0x20040758
    
    [00:09:15.553,863] <dbg> wpa_supp: wpa_printf_impl: wlan0: First radio work item in the queue - schedule start immediately
    
    [00:09:15.554,229] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: added PMKSA cache candidate 58:11:22:13:0b:bc prio 1000
    
    [00:09:15.554,412] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: processing PMKSA candidate list
    
    [00:09:15.554,626] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: not in suitable state for new pre-authentication
    
    [00:09:15.554,962] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: added PMKSA cache candidate 58:11:22:13:0b:b8 prio 1000
    
    [00:09:15.555,145] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: processing PMKSA candidate list
    
    [00:09:15.555,358] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: not in suitable state for new pre-authentication
    
    [00:09:15.555,847] <dbg> wpa_supp: wpa_printf_impl: wlan0: Starting radio work 'sme-connect'@0x20040758 after 0.001923 second wait
    
    [00:09:15.556,030] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: clearing own WPA/RSN IE
    
    [00:09:15.556,182] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: clearing own RSNXE
    
    [00:09:15.556,365] <dbg> wpa_supp: wpa_printf_impl: wlan0: Automatic auth_alg selection: 0x1
    
    [00:09:15.556,549] <dbg> wpa_supp: wpa_printf_impl: RSN: PMKSA cache search - network_ctx=0x20041ea8 try_opportunistic=0 akmp=0x0
    
    [00:09:15.556,671] <dbg> wpa_supp: wpa_printf_impl: RSN: Search for BSSID 58:11:22:13:0b:bc
    
    [00:09:15.556,762] <dbg> wpa_supp: wpa_printf_impl: RSN: No PMKSA cache entry found
    
    [00:09:15.556,915] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: using IEEE 802.11i/D9.0
    
    [00:09:15.557,189] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 1 proto 2
    
    [00:09:15.557,373] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Selected mgmt group cipher 32
    
    [00:09:15.557,830] <dbg> wpa_supp: wpa_printf_impl: WPA: set AP WPA IE - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 04 01 00 00 50 f2 04 01 00 00 50 f2 01
    
    [00:09:15.558,258] <dbg> wpa_supp: wpa_printf_impl: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00
    
    [00:09:15.558,441] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: clearing AP RSNXE
    
    [00:09:15.558,685] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP group 0x10 network profile group 0x10; available group 0x10
    
    [00:09:15.558,837] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: using GTK CCMP
    
    [00:09:15.559,143] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP pairwise 0x10 network profile pairwise 0x10; available pairwise 0x10
    
    [00:09:15.559,295] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: using PTK CCMP
    
    [00:09:15.559,570] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP key_mgmt 0x1 network profile key_mgmt 0x1; available key_mgmt 0x1
    
    [00:09:15.559,722] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: using KEY_MGMT 802.1X
    
    [00:09:15.560,028] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP mgmt_group_cipher 0x20 network profile mgmt_group_cipher 0x20; available mgmt_group_cipher 0x0
    
    [00:09:15.560,211] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: not using MGMT group cipher
    
    [00:09:15.560,668] <dbg> wpa_supp: wpa_printf_impl: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00
    
    [00:09:15.560,821] <dbg> wpa_supp: wpa_printf_impl: RSN: Set own RSNXE default - hexdump(len=0):
    
    [00:09:15.560,882] <dbg> wpa_supp: wpa_printf_impl: WPA: No current PMKSA - clear PMK
    
    [00:09:15.561,035] <dbg> wpa_supp: wpa_printf_impl: RRM: Determining whether RRM can be used - device support: 0x50
    
    [00:09:15.561,096] <dbg> wpa_supp: wpa_printf_impl: RRM: Adding RRM IE to Association Request
    
    [00:09:15.562,286] <dbg> wpa_supp: wpa_printf_impl: Added supported operating classes IE - hexdump(len=10): 3b 08 80 51 52 73 76 79 7c 7d
    
    [00:09:15.562,469] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - EAP success=0
    
    [00:09:15.562,561] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - EAP fail=0
    
    [00:09:15.562,683] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portControl=Auto
    
    [00:09:15.562,835] <dbg> wpa_supp: wpa_printf_impl: wlan0: Cancelling scan request
    
    [00:09:15.563,171] <inf> wpa_supp: wlan0: SME: Trying to authenticate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)
    
    [00:09:15.563,354] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portValid=0
    
    [00:09:15.563,537] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: SCANNING -> AUTHENTICATING
    
    [00:09:15.570,007] <dbg> wpa_supp: wpa_printf_impl: Received len: 40, msg_len:40 - CTRL-EVENT-BSS-ADDED 0 58:11:22:13:0b:bc->END
    
    [00:09:15.570,343] <dbg> wpa_supp: wpa_printf_impl: Received len: 40, msg_len:40 - CTRL-EVENT-BSS-ADDED 1 58:11:22:13:0b:b8->END
    
    [00:09:15.570,678] <dbg> wpa_supp: wpa_printf_impl: Received len: 24, msg_len:24 - CTRL-EVENT-SCAN-RESULTS ->END
    
    [00:09:15.571,014] <dbg> wpa_supp: wpa_printf_impl: Received len: 79, msg_len:79 - SME: Trying to authenticate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)->END
    
    [00:09:15.924,652] <dbg> wifi_supplicant: event_socket_handler: Passing message 10 to wpa_supplicant
    
    [00:09:15.924,804] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event AUTH (10) received
    
    [00:09:15.925,201] <dbg> wpa_supp: wpa_printf_impl: wlan0: SME: Authentication response: peer=58:11:22:13:0b:bc auth_type=0 auth_transaction=2 status_code=0
    
    [00:09:15.925,506] <dbg> wpa_supp: wpa_printf_impl: SME: Authentication response IEs - hexdump(len=11): dd 09 00 10 18 02 00 00 9c 00 00
    
    [00:09:15.926,361] <dbg> wpa_supp: wpa_printf_impl: SME: Association Request IEs - hexdump(len=52): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00 7f 0b 00 00 0a 02 00 40 40 00 00 00 20 46 05 70 00 00 00 00 3b 08 80 51 52 73 76 79 7c 7d
    
    [00:09:15.926,727] <inf> wpa_supp: wlan0: Trying to associate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)
    
    [00:09:15.926,971] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: AUTHENTICATING -> ASSOCIATING
    
    [00:09:15.927,459] <dbg> wpa_supp: wpa_printf_impl: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00
    
    [00:09:15.927,612] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: clearing own RSNXE
    
    [00:09:15.933,319] <dbg> wpa_supp: wpa_printf_impl: Received len: 71, msg_len:71 - Trying to associate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)->END
    
    [00:09:15.939,788] <dbg> wifi_supplicant: event_socket_handler: Passing message 0 to wpa_supplicant
    
    [00:09:15.939,910] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event ASSOC (0) received
    
    [00:09:15.940,093] <dbg> wpa_supp: wpa_printf_impl: wlan0: Association info event
    
    [00:09:15.943,359] <dbg> wpa_supp: wpa_printf_impl: req_ies - hexdump(len=178): 00 05 61 6c 6c 65 6e 01 08 0c 12 18 24 30 48 60 6c 21 02 00 17 5a 03 24 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00 c7 01 00 2d 1a 0c 88 1e ff 00 00 00 00 00 00 00 00 00 00 00 01 00 00 00 00 00 00 00
    
    [00:09:15.946,350] <dbg> wpa_supp: wpa_printf_impl: resp_ies - hexdump(len=201): 01 08 8c 12 98 24 b0 48 60 6c 46 05 32 00 00 00 00 2d 1a ef 09 17 ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 2c 05 16 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 09 04 00 08 00 0
    
    [00:09:15.946,624] <dbg> wpa_supp: wpa_printf_impl: IEEE 802.11 element parsing ignored unknown element extension (ext_id=38 elen=13)
    
    [00:09:15.946,777] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:10:18 len=9)
    
    [00:09:15.946,929] <dbg> wpa_supp: wpa_printf_impl: IEEE 802.11 element parsing ignored unknown element extension (ext_id=38 elen=13)
    
    [00:09:15.947,082] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:10:18 len=9)
    
    [00:09:15.947,204] <dbg> wpa_supp: wpa_printf_impl: wlan0: freq=5220 MHz
    
    [00:09:15.947,509] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:10:18 len=9)
    
    [00:09:15.947,937] <dbg> wpa_supp: wpa_printf_impl: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00
    
    [00:09:15.948,150] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: clearing own RSNXE
    
    [00:09:15.948,333] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: ASSOCIATING -> ASSOCIATED
    
    [00:09:15.948,638] <dbg> wpa_supp: wpa_printf_impl: wlan0: Associated to a new BSS: BSSID=58:11:22:13:0b:bc
    
    [00:09:15.948,760] <dbg> wpa_supp: wpa_printf_impl: wpa_drv_zep_get_ssid: SSID size: 5
    
    [00:09:15.949,005] <inf> wpa_supp: wlan0: Associated with 58:11:22:13:0b:bc
    
    [00:09:15.949,249] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Association event - clear replay counter
    
    [00:09:15.949,401] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Clear old PTK
    
    [00:09:15.949,584] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portEnabled=0
    
    [00:09:15.949,676] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portValid=0
    
    [00:09:15.949,798] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portEnabled=1
    
    [00:09:15.949,890] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state CONNECTING
    
    [00:09:15.949,951] <dbg> wpa_supp: wpa_printf_impl: EAPOL: enable timer tick
    
    [00:09:15.950,042] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state IDLE
    
    [00:09:15.950,134] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state INITIALIZE
    
    [00:09:15.950,195] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDLE
    
    [00:09:15.950,408] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting authentication timeout: 10 sec 0 usec
    
    [00:09:15.950,592] <dbg> wpa_supp: wpa_printf_impl: wlan0: Cancelling scan request
    
    [00:09:15.950,805] <inf> wpa_supp: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
    
    [00:09:15.951,293] <dbg> wpa_supp: wpa_printf_impl: Received len: 33, msg_len:33 - Associated with 58:11:22:13:0b:bc->END
    
    [00:09:15.951,507] <dbg> wpa_supp: wpa_printf_impl: Received len: 40, msg_len:40 - CTRL-EVENT-SUBNET-STATUS-UPDATE status=0->END
    
    [00:09:15.951,690] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
    
    [00:09:15.954,193] <dbg> wpa_supp: wpa_printf_impl: wlan0: RX EAPOL from 58:11:22:13:0b:bc
    
    [00:09:15.954,437] <dbg> wpa_supp: wpa_printf_impl: RX EAPOL - hexdump(len=9): 02 00 00 05 01 09 00 05 01
    
    [00:09:15.954,650] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting authentication timeout: 70 sec 0 usec
    
    [00:09:15.954,803] <dbg> wpa_supp: wpa_printf_impl: EAPOL: Received EAP-Packet frame
    
    [00:09:15.954,895] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state RESTART
    
    [00:09:15.954,956] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state INITIALIZE
    
    [00:09:15.955,047] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDLE
    
    [00:09:15.955,139] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state AUTHENTICATING
    
    [00:09:15.955,230] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state REQUEST
    
    [00:09:15.955,291] <dbg> wpa_supp: wpa_printf_impl: EAPOL: getSuppRsp
    
    [00:09:15.955,352] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state RECEIVED
    
    [00:09:15.955,627] <dbg> wpa_supp: wpa_printf_impl: EAP: Received EAP-Request id=9 method=1 vendor=0 vendorMethod=0
    
    [00:09:15.955,688] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDENTITY
    
    [00:09:15.955,871] <inf> wpa_supp: wlan0: CTRL-EVENT-EAP-STARTED EAP authentication started
    
    [00:09:15.956,024] <dbg> wpa_supp: wpa_printf_impl: EAP: Status notification: started (param=)
    
    [00:09:15.956,298] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP-Request Identity data - hexdump_ascii(len=0):
    
    [00:09:15.956,329] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
    [00:09:15.956,420] <dbg> wpa_supp: wpa_printf_impl: EAP: using anonymous identity - hexdump_ascii(len=4):
    
    [00:09:15.956,451] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6e 6f 6e                                      |anon
    
    [00:09:15.956,542] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state SEND_RESPONSE
    
    [00:09:15.956,634] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDLE
    
    [00:09:15.956,726] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state RESPONSE
    
    [00:09:15.956,787] <dbg> wpa_supp: wpa_printf_impl: EAPOL: txSuppRsp
    
    [00:09:15.956,909] <dbg> wpa_supp: wpa_printf_impl: TX EAPOL: dst=58:11:22:13:0b:bc
    
    [00:09:15.957,183] <dbg> wpa_supp: wpa_printf_impl: TX EAPOL - hexdump(len=13): 01 00 00 09 02 09 00 09 01 61 6e 6f 6e
    
    [00:09:15.958,068] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state RECEIVE
    
    [00:09:15.959,442] <dbg> wpa_supp: wpa_printf_impl: Received len: 49, msg_len:49 - CTRL-EVENT-EAP-STARTED EAP authentication started->END
    
    [00:09:15.959,625] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-EAP-STARTED EAP authentication started
    
    [00:09:15.959,869] <dbg> wpa_supp: wpa_printf_impl: Received len: 51, msg_len:51 - CTRL-EVENT-EAP-STATUS status='started' parameter=''->END
    
    [00:09:15.960,052] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-EAP-STATUS status='started' parameter=''
    
    [00:09:17.950,378] <dbg> wpa_supp: wpa_printf_impl: EAPOL: startWhen --> 0
    
    Connection request failed (1)

    radius server output

    ap ouput

    Regards,

    Allen

Reply
  • Hi, 

    I've tried this sample, the Freeradius server has received the access request, and sent access challenge, and didn't show any error, but it seens that the client or ap didn't reply. So the two messages,"receive access request" and "sent access challenge", keep looping on the server. Client still printed "connection failed". I don't know whether the problem is on the WIFI ap or nrf7002 sample.

    nrf7002 output

    *** Booting nRF Connect SDK v2.8.0-a2386bfc8401 ***
    
    *** Using Zephyr OS v3.7.99-0bc3393fb112 ***
    
    [00:00:00.708,221] <dbg> wpa_supp: wpa_printf_impl: wpa_supplicant v2.11-devel
    
    [00:00:00.709,442] <inf> wifi_supplicant: wpa_supplicant initialized
    
    [00:00:00.710,784] <dbg> wifi_supplicant: add_interface: Adding interface wlan0 [1] (0x20000c80)
    
    [00:00:00.710,906] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: interface_add, argc: 5
    
    [00:00:00.710,998] <dbg> wpa_supp: wpa_printf_impl: argv[0]: interface_add
    
    [00:00:00.711,059] <dbg> wpa_supp: wpa_printf_impl: argv[1]: wlan0
    
    [00:00:00.711,151] <dbg> wpa_supp: wpa_printf_impl: argv[2]: zephyr
    
    [00:00:00.711,212] <dbg> wpa_supp: wpa_printf_impl: argv[3]: zephyr
    
    [00:00:00.711,303] <dbg> wpa_supp: wpa_printf_impl: argv[4]: zephyr
    
    [00:00:00.712,097] <dbg> wpa_supp: wpa_printf_impl: RX global ctrl_iface - hexdump_ascii(len=71):
    
    [00:00:00.712,158] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       49 4e 54 45 52 46 41 43  45 5f 41 44 44 20 77 6c |INTERFAC E_ADD wl
    
                                       61 6e 30 09 7a 65 70 68  79 72 09 7a 65 70 68 79 |an0.zeph yr.zephy
    
                                       72 09 7a 65 70 68 79 72  09 09 09 09 20 77 6c 61 |r.zephyr .... wla
    
                                       6e 30 20 7a 65 70 68 79  72 20 7a 65 70 68 79 72 |n0 zephy r zephyr
    
                                       20 7a 65 70 68 79 72                             | zephyr
    
    [00:00:00.712,249] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE GLOBAL INTERFACE_ADD 'wlan0       zephyr  zephyr  zephyr                           wlan0 zephyr zephyr zephyr'
    
    [00:00:00.712,738] <dbg> wpa_supp: wpa_printf_impl: Initializing interface 'wlan0' conf 'zephyr' driver 'zephyr' ctrl_interface 'zephyr' bridge 'N/A'
    
    [00:00:00.716,552] <dbg> wpa_supp: wpa_printf_impl: Add interface wlan0 to a new radio N/A
    
    [00:00:00.721,496] <dbg> wpa_supp: wpa_printf_impl: wpa_supp: Added 802.11b mode based on 802.11g information
    
    [00:00:00.721,801] <dbg> wpa_supp: wpa_printf_impl: l2_packet_init: iface wlan0 ifindex 1
    
    [00:00:00.722,045] <dbg> wpa_supp: wpa_printf_impl: wlan0: Own MAC address: f4:ce:36:00:1f:e8
    
    [00:00:00.722,259] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 0 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.725,219] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 1 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.728,668] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 2 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.731,445] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 3 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.734,252] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 4 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.736,907] <dbg> wpa_supp: wpa_printf_impl: _wpa_drv_zep_set_key: priv:0x20006058 alg 0 addr 0 key_idx 5 set_tx 0 seq 0 seq_len 0 key 0 key_len 0 key_flag 10
    
    [00:00:00.740,631] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: flushing PMKID list in the driver
    
    [00:00:00.740,814] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: DISCONNECTED -> INACTIVE
    
    [00:00:00.803,802] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state DISCONNECTED
    
    [00:00:00.803,894] <dbg> wpa_supp: wpa_printf_impl: EAPOL: Supplicant port status: Unauthorized
    
    [00:00:00.815,826] <dbg> wpa_supp: wpa_printf_impl: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
    
    [00:00:00.815,917] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state INITIALIZE
    
    [00:00:00.815,979] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state DISABLED
    
    [00:00:00.817,321] <dbg> wpa_supp: wpa_printf_impl: MBO: Update non-preferred channels, non_pref_chan=N/A
    
    [00:00:00.817,657] <dbg> wpa_supp: wpa_printf_impl: wlan0: Added interface wlan0
    
    [00:00:00.817,810] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: INACTIVE -> DISCONNECTED
    
    [00:00:01.816,253] <dbg> wpa_supp: wpa_printf_impl: EAPOL: disable timer tick
    
    uart:~$ wifi connect -s allen -k 7 -a anon -K test
    
    wifi connect -s allen -k 7 -a anon -K test
    
    Connection requested
    
    [00:09:11.564,575] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: remove_network, argc: 2
    
    [00:09:11.564,666] <dbg> wpa_supp: wpa_printf_impl: argv[0]: remove_network
    
    [00:09:11.564,727] <dbg> wpa_supp: wpa_printf_impl: argv[1]: all
    
    [00:09:11.565,399] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'REMOVE_NETWORK all'
    
    [00:09:11.565,551] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: REMOVE_NETWORK all
    
    [00:09:11.566,314] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'ADD_NETWORK'
    
    [00:09:11.566,436] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: ADD_NETWORK
    
    [00:09:11.567,108] <dbg> wpa_supp: wpa_printf_impl: Received len: 26, msg_len:26 - CTRL-EVENT-NETWORK-ADDED 0->END
    
    [00:09:11.567,504] <dbg> wpa_supp: wpa_printf_impl: NET added: 0
    
    [00:09:11.567,626] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.567,687] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.567,779] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.567,840] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ssid
    
    [00:09:11.567,932] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "allen"
    
    [00:09:11.568,603] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.568,756] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ssid'
    
    [00:09:11.568,847] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=7): [REMOVED]
    
    [00:09:11.568,969] <dbg> wpa_supp: wpa_printf_impl: ssid - hexdump_ascii(len=5):
    
    [00:09:11.569,030] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6c 6c 65 6e                                   |allen
    
    [00:09:11.569,366] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.569,427] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.569,519] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.569,580] <dbg> wpa_supp: wpa_printf_impl: argv[2]: scan_ssid
    
    [00:09:11.569,641] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 1
    
    [00:09:11.570,343] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.570,495] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='scan_ssid'
    
    [00:09:11.570,617] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
    
    [00:09:11.570,709] <dbg> wpa_supp: wpa_printf_impl: scan_ssid=1 (0x1)
    
    [00:09:11.571,075] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.571,136] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.571,197] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.571,289] <dbg> wpa_supp: wpa_printf_impl: argv[2]: key_mgmt
    
    [00:09:11.571,350] <dbg> wpa_supp: wpa_printf_impl: argv[3]: NONE
    
    [00:09:11.572,052] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.572,204] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
    
    [00:09:11.572,296] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.572,418] <dbg> wpa_supp: wpa_printf_impl: key_mgmt: 0x4
    
    [00:09:11.572,784] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.572,845] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.572,937] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.572,998] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ieee80211w
    
    [00:09:11.573,089] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 0
    
    [00:09:11.573,760] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.573,913] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ieee80211w'
    
    [00:09:11.574,035] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
    
    [00:09:11.574,188] <dbg> wpa_supp: wpa_printf_impl: ieee80211w=0 (0x0)
    
    [00:09:11.574,554] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.574,615] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.574,676] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.574,768] <dbg> wpa_supp: wpa_printf_impl: argv[2]: proto
    
    [00:09:11.574,829] <dbg> wpa_supp: wpa_printf_impl: argv[3]: RSN
    
    [00:09:11.575,500] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.575,683] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='proto'
    
    [00:09:11.575,775] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
    
    [00:09:11.575,897] <dbg> wpa_supp: wpa_printf_impl: proto: 0x2
    
    [00:09:11.576,263] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.576,324] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.576,416] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.576,477] <dbg> wpa_supp: wpa_printf_impl: argv[2]: key_mgmt
    
    [00:09:11.576,568] <dbg> wpa_supp: wpa_printf_impl: argv[3]: WPA-EAP
    
    [00:09:11.577,239] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.577,392] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
    
    [00:09:11.577,514] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=7): [REMOVED]
    
    [00:09:11.577,636] <dbg> wpa_supp: wpa_printf_impl: key_mgmt: 0x1
    
    [00:09:11.578,002] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set, argc: 3
    
    [00:09:11.578,063] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set
    
    [00:09:11.578,155] <dbg> wpa_supp: wpa_printf_impl: argv[1]: openssl_ciphers
    
    [00:09:11.578,216] <dbg> wpa_supp: wpa_printf_impl: argv[2]: "DEFAULT:!EXP:!LOW"
    
    [00:09:11.578,948] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET openssl_ciphers "DEFAULT:!EXP:!LOW"'
    
    [00:09:11.579,101] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE SET 'openssl_ciphers'='"DEFAULT:!EXP:!LOW"'
    
    [00:09:11.579,254] <dbg> wpa_supp: wpa_printf_impl: openssl_ciphers='"DEFAULT:!EXP:!LOW"'
    
    [00:09:11.579,620] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.579,681] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.579,772] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.579,833] <dbg> wpa_supp: wpa_printf_impl: argv[2]: group
    
    [00:09:11.579,895] <dbg> wpa_supp: wpa_printf_impl: argv[3]: CCMP
    
    [00:09:11.580,596] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.580,749] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='group'
    
    [00:09:11.580,871] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.580,963] <dbg> wpa_supp: wpa_printf_impl: group: 0x10
    
    [00:09:11.581,329] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.581,420] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.581,481] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.581,573] <dbg> wpa_supp: wpa_printf_impl: argv[2]: pairwise
    
    [00:09:11.581,634] <dbg> wpa_supp: wpa_printf_impl: argv[3]: CCMP
    
    [00:09:11.582,305] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.582,489] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='pairwise'
    
    [00:09:11.582,580] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.582,702] <dbg> wpa_supp: wpa_printf_impl: pairwise: 0x10
    
    [00:09:11.583,068] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.583,160] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.583,221] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.583,312] <dbg> wpa_supp: wpa_printf_impl: argv[2]: group_mgmt
    
    [00:09:11.583,374] <dbg> wpa_supp: wpa_printf_impl: argv[3]: AES-128-CMAC
    
    [00:09:11.584,075] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.584,228] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='group_mgmt'
    
    [00:09:11.584,350] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=12): [REMOVED]
    
    [00:09:11.584,472] <dbg> wpa_supp: wpa_printf_impl: group_mgmt: 0x20
    
    [00:09:11.584,838] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.584,930] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.584,991] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.585,052] <dbg> wpa_supp: wpa_printf_impl: argv[2]: proto
    
    [00:09:11.585,144] <dbg> wpa_supp: wpa_printf_impl: argv[3]: RSN
    
    [00:09:11.585,815] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.585,968] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='proto'
    
    [00:09:11.586,090] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
    
    [00:09:11.586,486] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.586,547] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.586,639] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.586,700] <dbg> wpa_supp: wpa_printf_impl: argv[2]: eap
    
    [00:09:11.586,761] <dbg> wpa_supp: wpa_printf_impl: argv[3]: TLS
    
    [00:09:11.587,463] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.587,615] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='eap'
    
    [00:09:11.587,707] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=3): [REMOVED]
    
    [00:09:11.588,104] <dbg> wpa_supp: wpa_printf_impl: eap methods - hexdump(len=16): 00 00 00 00 0d 00 00 00 00 00 00 00 00 00 00 00
    
    [00:09:11.588,500] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.588,592] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.588,653] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.588,714] <dbg> wpa_supp: wpa_printf_impl: argv[2]: anonymous_identity
    
    [00:09:11.588,806] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "anon"
    
    [00:09:11.589,508] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.589,660] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='anonymous_identity'
    
    [00:09:11.589,782] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=6): [REMOVED]
    
    [00:09:11.589,904] <dbg> wpa_supp: wpa_printf_impl: anonymous_identity - hexdump_ascii(len=4):
    
    [00:09:11.589,965] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6e 6f 6e                                      |anon
    
    [00:09:11.590,728] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.590,789] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.590,881] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.590,942] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ca_cert
    
    [00:09:11.591,033] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://ca_cert"
    
    [00:09:11.591,705] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.591,888] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ca_cert'
    
    [00:09:11.591,979] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=16): [REMOVED]
    
    [00:09:11.592,132] <dbg> wpa_supp: wpa_printf_impl: ca_cert - hexdump_ascii(len=14):
    
    [00:09:11.592,163] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  61 5f 63 65 72 74       |blob://c a_cert
    
    [00:09:11.592,926] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.592,987] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.593,078] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.593,139] <dbg> wpa_supp: wpa_printf_impl: argv[2]: client_cert
    
    [00:09:11.593,231] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://client_cert"
    
    [00:09:11.593,933] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.594,085] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='client_cert'
    
    [00:09:11.594,207] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=20): [REMOVED]
    
    [00:09:11.594,329] <dbg> wpa_supp: wpa_printf_impl: client_cert - hexdump_ascii(len=18):
    
    [00:09:11.594,390] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  6c 69 65 6e 74 5f 63 65 |blob://c lient_ce
    
                                       72 74                                            |rt  
    
    [00:09:11.595,275] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.595,336] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.595,428] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.595,489] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key
    
    [00:09:11.595,581] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://private_key"
    
    [00:09:11.596,282] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.596,435] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key'
    
    [00:09:11.596,557] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=20): [REMOVED]
    
    [00:09:11.596,710] <dbg> wpa_supp: wpa_printf_impl: private_key - hexdump_ascii(len=18):
    
    [00:09:11.596,740] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 70  72 69 76 61 74 65 5f 6b |blob://p rivate_k
    
                                       65 79                                            |ey  
    
    [00:09:11.597,106] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.597,167] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.597,259] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.597,320] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key_passwd
    
    [00:09:11.597,412] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "test"
    
    [00:09:11.598,083] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.598,266] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key_passwd'
    
    [00:09:11.598,358] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=6): [REMOVED]
    
    [00:09:11.598,510] <dbg> wpa_supp: wpa_printf_impl: private_key_passwd - hexdump_ascii(len=4): [REMOVED]
    
    [00:09:11.599,334] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.599,395] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.599,456] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.599,548] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ca_cert2
    
    [00:09:11.599,639] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://ca_cert2"
    
    [00:09:11.600,311] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.600,494] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ca_cert2'
    
    [00:09:11.600,585] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=17): [REMOVED]
    
    [00:09:11.600,738] <dbg> wpa_supp: wpa_printf_impl: ca_cert2 - hexdump_ascii(len=15):
    
    [00:09:11.600,799] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  61 5f 63 65 72 74 32    |blob://c a_cert2
    
    [00:09:11.601,531] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.601,593] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.601,684] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.601,745] <dbg> wpa_supp: wpa_printf_impl: argv[2]: client_cert2
    
    [00:09:11.601,837] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://client_cert2"
    
    [00:09:11.602,539] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.602,722] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='client_cert2'
    
    [00:09:11.602,813] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=21): [REMOVED]
    
    [00:09:11.602,966] <dbg> wpa_supp: wpa_printf_impl: client_cert2 - hexdump_ascii(len=19):
    
    [00:09:11.603,027] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 63  6c 69 65 6e 74 5f 63 65 |blob://c lient_ce
    
                                       72 74 32                                         |rt2 
    
    [00:09:11.603,912] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.603,973] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.604,034] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.604,125] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key2
    
    [00:09:11.604,217] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "blob://private_key2"
    
    [00:09:11.604,919] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.605,072] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key2'
    
    [00:09:11.605,194] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=21): [REMOVED]
    
    [00:09:11.605,346] <dbg> wpa_supp: wpa_printf_impl: private_key2 - hexdump_ascii(len=19):
    
    [00:09:11.605,377] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       62 6c 6f 62 3a 2f 2f 70  72 69 76 61 74 65 5f 6b |blob://p rivate_k
    
                                       65 79 32                                         |ey2 
    
    [00:09:11.605,743] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.605,834] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.605,895] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.605,987] <dbg> wpa_supp: wpa_printf_impl: argv[2]: private_key2_passwd
    
    [00:09:11.606,048] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "(null)"
    
    [00:09:11.606,750] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.606,933] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='private_key2_passwd'
    
    [00:09:11.607,025] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=8): [REMOVED]
    
    [00:09:11.607,177] <dbg> wpa_supp: wpa_printf_impl: private_key2_passwd - hexdump_ascii(len=6): [REMOVED]
    
    [00:09:11.607,543] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4
    
    [00:09:11.607,635] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network
    
    [00:09:11.607,696] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.607,788] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ieee80211w
    
    [00:09:11.607,849] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 1
    
    [00:09:11.608,520] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SET_NETWORK [REMOVED]'
    
    [00:09:11.608,703] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ieee80211w'
    
    [00:09:11.608,795] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
    
    [00:09:11.608,947] <dbg> wpa_supp: wpa_printf_impl: ieee80211w=1 (0x1)
    
    [00:09:11.609,313] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: enable_network, argc: 2
    
    [00:09:11.609,405] <dbg> wpa_supp: wpa_printf_impl: argv[0]: enable_network
    
    [00:09:11.609,466] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.610,137] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'ENABLE_NETWORK 0'
    
    [00:09:11.610,290] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: ENABLE_NETWORK id=0
    
    [00:09:11.610,473] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 0.000000 sec
    
    [00:09:11.610,900] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: DISCONNECTED -> SCANNING
    
    [00:09:11.611,022] <dbg> wpa_supp: wpa_printf_impl: Scan SSID - hexdump_ascii(len=5):
    
    [00:09:11.611,083] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6c 6c 65 6e                                   |allen
    
    [00:09:11.611,206] <dbg> wpa_supp: wpa_printf_impl: wlan0: Include wildcard SSID in the scan request
    
    [00:09:11.611,633] <dbg> wpa_supp: wpa_printf_impl: wlan0: Add radio work 'scan'@0x2003fe68
    
    [00:09:11.611,877] <dbg> wpa_supp: wpa_printf_impl: wlan0: First radio work item in the queue - schedule start immediately
    
    [00:09:11.612,365] <dbg> wpa_supp: wpa_printf_impl: wlan0: Starting radio work 'scan'@0x2003fe68 after 0.000427 second wait
    
    [00:09:11.613,494] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: select_network, argc: 2
    
    [00:09:11.613,555] <dbg> wpa_supp: wpa_printf_impl: argv[0]: select_network
    
    [00:09:11.613,647] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0
    
    [00:09:11.623,901] <dbg> wpa_supp: wpa_printf_impl: wpa_drv_zep_scan2: Scan requested - scan timeout 35 seconds
    
    [00:09:11.624,725] <dbg> wpa_supp: wpa_printf_impl: wlan0: Control interface command 'SELECT_NETWORK 0'
    
    [00:09:11.624,847] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SELECT_NETWORK id=0
    
    [00:09:11.625,030] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 0.000000 sec
    
    [00:09:11.625,457] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:11.625,671] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:11.626,098] <dbg> wifi_supplicant: event_socket_handler: Passing message 47 to wpa_supplicant
    
    [00:09:11.626,251] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event SCAN_STARTED (47) received
    
    [00:09:11.626,495] <dbg> wpa_supp: wpa_printf_impl: wlan0: Own scan request started a scan in 0.002014 seconds
    
    [00:09:11.626,983] <dbg> wpa_supp: wpa_printf_impl: Received len: 24, msg_len:24 - CTRL-EVENT-SCAN-STARTED ->END
    
    [00:09:12.626,129] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:12.626,342] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:13.626,708] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:13.626,922] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:14.627,288] <dbg> wpa_supp: wpa_printf_impl: wlan0: Already scanning - Reschedule the incoming scan req
    
    [00:09:14.627,502] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting scan request: 1.000000 sec
    
    [00:09:15.522,521] <dbg> wifi_supplicant: event_socket_handler: Passing message 3 to wpa_supplicant
    
    [00:09:15.522,674] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event SCAN_RESULTS (3) received
    
    [00:09:15.522,888] <dbg> wpa_supp: wpa_printf_impl: wlan0: Scan completed in 3.896423 seconds
    
    [00:09:15.527,221] <dbg> wpa_supp: wpa_printf_impl: Sorted scan results
    
    [00:09:15.527,465] <dbg> wpa_supp: wpa_printf_impl: 58:11:22:13:0b:bc freq=5220 qual=0 noise=-92~ level=-29 snr=63* flags=0xb age=2825 est=390001
    
    [00:09:15.532,012] <dbg> wpa_supp: wpa_printf_impl: IEs - hexdump(len=328): 00 05 61 6c 6c 65 6e 01 08 8c 12 98 24 b0 48 60 6c 05 04 00 01 00 00 23 02 19 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 38 00 00 46 05 32 00 00 00 00 2d 1a ef 09 17 ff ff 00 00 00 00 00 00 00
    
    [00:09:15.536,590] <dbg> wpa_supp: wpa_printf_impl: Beacon IEs - hexdump(len=328): 00 05 61 6c 6c 65 6e 01 08 8c 12 98 24 b0 48 60 6c 05 04 00 01 00 00 23 02 19 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 38 00 00 46 05 32 00 00 00 00 2d 1a ef 09 17 ff ff 00 00 00 00 00
    
    [00:09:15.536,926] <dbg> wpa_supp: wpa_printf_impl: 58:11:22:13:0b:b8 freq=2452 qual=0 noise=-89~ level=-28 snr=61* flags=0xb age=3446 est=65000
    
    [00:09:15.541,717] <dbg> wpa_supp: wpa_printf_impl: IEs - hexdump(len=355): 00 05 61 6c 6c 65 6e 01 08 82 84 8b 96 24 30 48 6c 03 01 09 05 04 00 01 00 00 07 06 55 53 04 01 0b 17 23 02 18 00 2a 01 04 32 04 0c 12 18 60 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 22 00 00 46
    
    [00:09:15.546,630] <dbg> wpa_supp: wpa_printf_impl: Beacon IEs - hexdump(len=355): 00 05 61 6c 6c 65 6e 01 08 82 84 8b 96 24 30 48 6c 03 01 09 05 04 00 01 00 00 07 06 55 53 04 01 0b 17 23 02 18 00 2a 01 04 32 04 0c 12 18 60 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00 0b 05 00 00 22 00
    
    [00:09:15.546,936] <dbg> wpa_supp: wpa_printf_impl: wlan0: BSS: Start scan result update 1
    
    [00:09:15.547,515] <dbg> wpa_supp: wpa_printf_impl: wlan0: BSS: Add new id 0 BSSID 58:11:22:13:0b:bc SSID 'allen' freq 5220
    
    [00:09:15.548,339] <dbg> wpa_supp: wpa_printf_impl: wlan0: BSS: Add new id 1 BSSID 58:11:22:13:0b:b8 SSID 'allen' freq 2452
    
    [00:09:15.548,675] <dbg> wpa_supp: wpa_printf_impl: BSS: last_scan_res_used=2/32
    
    [00:09:15.548,858] <dbg> wpa_supp: wpa_printf_impl: wlan0: New scan results available (own=1 ext=0)
    
    [00:09:15.549,285] <dbg> wpa_supp: wpa_printf_impl: wlan0: Radio work 'scan'@0x2003fe68 done in 3.936951 seconds
    
    [00:09:15.549,560] <dbg> wpa_supp: wpa_printf_impl: wlan0: radio_work_free('scan'@0x2003fe68): num_active_works --> 0
    
    [00:09:15.549,774] <dbg> wpa_supp: wpa_printf_impl: wlan0: Scan results matching the currently selected network
    
    [00:09:15.550,323] <dbg> wpa_supp: wpa_printf_impl: wlan0: 0: 58:11:22:13:0b:bc freq=5220 level=-29 snr=63 est_throughput=390001
    
    [00:09:15.550,842] <dbg> wpa_supp: wpa_printf_impl: wlan0: 1: 58:11:22:13:0b:b8 freq=2452 level=-28 snr=61 est_throughput=65000
    
    [00:09:15.551,025] <dbg> wpa_supp: wpa_printf_impl: wlan0: Selecting BSS from priority group 0
    
    [00:09:15.551,544] <dbg> wpa_supp: wpa_printf_impl: wlan0: 0: 58:11:22:13:0b:bc ssid='allen' wpa_ie_len=22 rsn_ie_len=20 caps=0x1011 level=-29 freq=5220
    
    [00:09:15.551,788] <dbg> wpa_supp: wpa_printf_impl: wlan0:    selected based on RSN IE
    
    [00:09:15.552,124] <dbg> wpa_supp: wpa_printf_impl: wlan0:    selected BSS 58:11:22:13:0b:bc ssid='allen'
    
    [00:09:15.552,856] <dbg> wpa_supp: wpa_printf_impl: wlan0: Considering connect request: reassociate: 1  selected: 58:11:22:13:0b:bc  bssid: 00:00:00:00:00:00  pending: 00:00:00:00:00:00  wpa_state: SCANNING  ssid=0x20041ea8  current_ssid=0x20041ea8
    
    [00:09:15.553,131] <dbg> wpa_supp: wpa_printf_impl: wlan0: Request association with 58:11:22:13:0b:bc
    
    [00:09:15.553,375] <dbg> wpa_supp: wpa_printf_impl: wlan0: No ongoing scan/p2p-scan found to abort
    
    [00:09:15.553,619] <dbg> wpa_supp: wpa_printf_impl: wlan0: Add radio work 'sme-connect'@0x20040758
    
    [00:09:15.553,863] <dbg> wpa_supp: wpa_printf_impl: wlan0: First radio work item in the queue - schedule start immediately
    
    [00:09:15.554,229] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: added PMKSA cache candidate 58:11:22:13:0b:bc prio 1000
    
    [00:09:15.554,412] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: processing PMKSA candidate list
    
    [00:09:15.554,626] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: not in suitable state for new pre-authentication
    
    [00:09:15.554,962] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: added PMKSA cache candidate 58:11:22:13:0b:b8 prio 1000
    
    [00:09:15.555,145] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: processing PMKSA candidate list
    
    [00:09:15.555,358] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: not in suitable state for new pre-authentication
    
    [00:09:15.555,847] <dbg> wpa_supp: wpa_printf_impl: wlan0: Starting radio work 'sme-connect'@0x20040758 after 0.001923 second wait
    
    [00:09:15.556,030] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: clearing own WPA/RSN IE
    
    [00:09:15.556,182] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: clearing own RSNXE
    
    [00:09:15.556,365] <dbg> wpa_supp: wpa_printf_impl: wlan0: Automatic auth_alg selection: 0x1
    
    [00:09:15.556,549] <dbg> wpa_supp: wpa_printf_impl: RSN: PMKSA cache search - network_ctx=0x20041ea8 try_opportunistic=0 akmp=0x0
    
    [00:09:15.556,671] <dbg> wpa_supp: wpa_printf_impl: RSN: Search for BSSID 58:11:22:13:0b:bc
    
    [00:09:15.556,762] <dbg> wpa_supp: wpa_printf_impl: RSN: No PMKSA cache entry found
    
    [00:09:15.556,915] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: using IEEE 802.11i/D9.0
    
    [00:09:15.557,189] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 1 proto 2
    
    [00:09:15.557,373] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Selected mgmt group cipher 32
    
    [00:09:15.557,830] <dbg> wpa_supp: wpa_printf_impl: WPA: set AP WPA IE - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 04 01 00 00 50 f2 04 01 00 00 50 f2 01
    
    [00:09:15.558,258] <dbg> wpa_supp: wpa_printf_impl: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 0d 00
    
    [00:09:15.558,441] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: clearing AP RSNXE
    
    [00:09:15.558,685] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP group 0x10 network profile group 0x10; available group 0x10
    
    [00:09:15.558,837] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: using GTK CCMP
    
    [00:09:15.559,143] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP pairwise 0x10 network profile pairwise 0x10; available pairwise 0x10
    
    [00:09:15.559,295] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: using PTK CCMP
    
    [00:09:15.559,570] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP key_mgmt 0x1 network profile key_mgmt 0x1; available key_mgmt 0x1
    
    [00:09:15.559,722] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: using KEY_MGMT 802.1X
    
    [00:09:15.560,028] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: AP mgmt_group_cipher 0x20 network profile mgmt_group_cipher 0x20; available mgmt_group_cipher 0x0
    
    [00:09:15.560,211] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: not using MGMT group cipher
    
    [00:09:15.560,668] <dbg> wpa_supp: wpa_printf_impl: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00
    
    [00:09:15.560,821] <dbg> wpa_supp: wpa_printf_impl: RSN: Set own RSNXE default - hexdump(len=0):
    
    [00:09:15.560,882] <dbg> wpa_supp: wpa_printf_impl: WPA: No current PMKSA - clear PMK
    
    [00:09:15.561,035] <dbg> wpa_supp: wpa_printf_impl: RRM: Determining whether RRM can be used - device support: 0x50
    
    [00:09:15.561,096] <dbg> wpa_supp: wpa_printf_impl: RRM: Adding RRM IE to Association Request
    
    [00:09:15.562,286] <dbg> wpa_supp: wpa_printf_impl: Added supported operating classes IE - hexdump(len=10): 3b 08 80 51 52 73 76 79 7c 7d
    
    [00:09:15.562,469] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - EAP success=0
    
    [00:09:15.562,561] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - EAP fail=0
    
    [00:09:15.562,683] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portControl=Auto
    
    [00:09:15.562,835] <dbg> wpa_supp: wpa_printf_impl: wlan0: Cancelling scan request
    
    [00:09:15.563,171] <inf> wpa_supp: wlan0: SME: Trying to authenticate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)
    
    [00:09:15.563,354] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portValid=0
    
    [00:09:15.563,537] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: SCANNING -> AUTHENTICATING
    
    [00:09:15.570,007] <dbg> wpa_supp: wpa_printf_impl: Received len: 40, msg_len:40 - CTRL-EVENT-BSS-ADDED 0 58:11:22:13:0b:bc->END
    
    [00:09:15.570,343] <dbg> wpa_supp: wpa_printf_impl: Received len: 40, msg_len:40 - CTRL-EVENT-BSS-ADDED 1 58:11:22:13:0b:b8->END
    
    [00:09:15.570,678] <dbg> wpa_supp: wpa_printf_impl: Received len: 24, msg_len:24 - CTRL-EVENT-SCAN-RESULTS ->END
    
    [00:09:15.571,014] <dbg> wpa_supp: wpa_printf_impl: Received len: 79, msg_len:79 - SME: Trying to authenticate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)->END
    
    [00:09:15.924,652] <dbg> wifi_supplicant: event_socket_handler: Passing message 10 to wpa_supplicant
    
    [00:09:15.924,804] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event AUTH (10) received
    
    [00:09:15.925,201] <dbg> wpa_supp: wpa_printf_impl: wlan0: SME: Authentication response: peer=58:11:22:13:0b:bc auth_type=0 auth_transaction=2 status_code=0
    
    [00:09:15.925,506] <dbg> wpa_supp: wpa_printf_impl: SME: Authentication response IEs - hexdump(len=11): dd 09 00 10 18 02 00 00 9c 00 00
    
    [00:09:15.926,361] <dbg> wpa_supp: wpa_printf_impl: SME: Association Request IEs - hexdump(len=52): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00 7f 0b 00 00 0a 02 00 40 40 00 00 00 20 46 05 70 00 00 00 00 3b 08 80 51 52 73 76 79 7c 7d
    
    [00:09:15.926,727] <inf> wpa_supp: wlan0: Trying to associate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)
    
    [00:09:15.926,971] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: AUTHENTICATING -> ASSOCIATING
    
    [00:09:15.927,459] <dbg> wpa_supp: wpa_printf_impl: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00
    
    [00:09:15.927,612] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: clearing own RSNXE
    
    [00:09:15.933,319] <dbg> wpa_supp: wpa_printf_impl: Received len: 71, msg_len:71 - Trying to associate with 58:11:22:13:0b:bc (SSID='allen' freq=5220 MHz)->END
    
    [00:09:15.939,788] <dbg> wifi_supplicant: event_socket_handler: Passing message 0 to wpa_supplicant
    
    [00:09:15.939,910] <dbg> wpa_supp: wpa_printf_impl: wlan0: Event ASSOC (0) received
    
    [00:09:15.940,093] <dbg> wpa_supp: wpa_printf_impl: wlan0: Association info event
    
    [00:09:15.943,359] <dbg> wpa_supp: wpa_printf_impl: req_ies - hexdump(len=178): 00 05 61 6c 6c 65 6e 01 08 0c 12 18 24 30 48 60 6c 21 02 00 17 5a 03 24 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00 c7 01 00 2d 1a 0c 88 1e ff 00 00 00 00 00 00 00 00 00 00 00 01 00 00 00 00 00 00 00
    
    [00:09:15.946,350] <dbg> wpa_supp: wpa_printf_impl: resp_ies - hexdump(len=201): 01 08 8c 12 98 24 b0 48 60 6c 46 05 32 00 00 00 00 2d 1a ef 09 17 ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 2c 05 16 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 09 04 00 08 00 0
    
    [00:09:15.946,624] <dbg> wpa_supp: wpa_printf_impl: IEEE 802.11 element parsing ignored unknown element extension (ext_id=38 elen=13)
    
    [00:09:15.946,777] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:10:18 len=9)
    
    [00:09:15.946,929] <dbg> wpa_supp: wpa_printf_impl: IEEE 802.11 element parsing ignored unknown element extension (ext_id=38 elen=13)
    
    [00:09:15.947,082] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:10:18 len=9)
    
    [00:09:15.947,204] <dbg> wpa_supp: wpa_printf_impl: wlan0: freq=5220 MHz
    
    [00:09:15.947,509] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:10:18 len=9)
    
    [00:09:15.947,937] <dbg> wpa_supp: wpa_printf_impl: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 01 80 00
    
    [00:09:15.948,150] <dbg> wpa_supp: wpa_printf_impl: wlan0: RSN: clearing own RSNXE
    
    [00:09:15.948,333] <dbg> wpa_supp: wpa_printf_impl: wlan0: State: ASSOCIATING -> ASSOCIATED
    
    [00:09:15.948,638] <dbg> wpa_supp: wpa_printf_impl: wlan0: Associated to a new BSS: BSSID=58:11:22:13:0b:bc
    
    [00:09:15.948,760] <dbg> wpa_supp: wpa_printf_impl: wpa_drv_zep_get_ssid: SSID size: 5
    
    [00:09:15.949,005] <inf> wpa_supp: wlan0: Associated with 58:11:22:13:0b:bc
    
    [00:09:15.949,249] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Association event - clear replay counter
    
    [00:09:15.949,401] <dbg> wpa_supp: wpa_printf_impl: wlan0: WPA: Clear old PTK
    
    [00:09:15.949,584] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portEnabled=0
    
    [00:09:15.949,676] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portValid=0
    
    [00:09:15.949,798] <dbg> wpa_supp: wpa_printf_impl: EAPOL: External notification - portEnabled=1
    
    [00:09:15.949,890] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state CONNECTING
    
    [00:09:15.949,951] <dbg> wpa_supp: wpa_printf_impl: EAPOL: enable timer tick
    
    [00:09:15.950,042] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state IDLE
    
    [00:09:15.950,134] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state INITIALIZE
    
    [00:09:15.950,195] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDLE
    
    [00:09:15.950,408] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting authentication timeout: 10 sec 0 usec
    
    [00:09:15.950,592] <dbg> wpa_supp: wpa_printf_impl: wlan0: Cancelling scan request
    
    [00:09:15.950,805] <inf> wpa_supp: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
    
    [00:09:15.951,293] <dbg> wpa_supp: wpa_printf_impl: Received len: 33, msg_len:33 - Associated with 58:11:22:13:0b:bc->END
    
    [00:09:15.951,507] <dbg> wpa_supp: wpa_printf_impl: Received len: 40, msg_len:40 - CTRL-EVENT-SUBNET-STATUS-UPDATE status=0->END
    
    [00:09:15.951,690] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
    
    [00:09:15.954,193] <dbg> wpa_supp: wpa_printf_impl: wlan0: RX EAPOL from 58:11:22:13:0b:bc
    
    [00:09:15.954,437] <dbg> wpa_supp: wpa_printf_impl: RX EAPOL - hexdump(len=9): 02 00 00 05 01 09 00 05 01
    
    [00:09:15.954,650] <dbg> wpa_supp: wpa_printf_impl: wlan0: Setting authentication timeout: 70 sec 0 usec
    
    [00:09:15.954,803] <dbg> wpa_supp: wpa_printf_impl: EAPOL: Received EAP-Packet frame
    
    [00:09:15.954,895] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state RESTART
    
    [00:09:15.954,956] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state INITIALIZE
    
    [00:09:15.955,047] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDLE
    
    [00:09:15.955,139] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_PAE entering state AUTHENTICATING
    
    [00:09:15.955,230] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state REQUEST
    
    [00:09:15.955,291] <dbg> wpa_supp: wpa_printf_impl: EAPOL: getSuppRsp
    
    [00:09:15.955,352] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state RECEIVED
    
    [00:09:15.955,627] <dbg> wpa_supp: wpa_printf_impl: EAP: Received EAP-Request id=9 method=1 vendor=0 vendorMethod=0
    
    [00:09:15.955,688] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDENTITY
    
    [00:09:15.955,871] <inf> wpa_supp: wlan0: CTRL-EVENT-EAP-STARTED EAP authentication started
    
    [00:09:15.956,024] <dbg> wpa_supp: wpa_printf_impl: EAP: Status notification: started (param=)
    
    [00:09:15.956,298] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP-Request Identity data - hexdump_ascii(len=0):
    
    [00:09:15.956,329] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
    [00:09:15.956,420] <dbg> wpa_supp: wpa_printf_impl: EAP: using anonymous identity - hexdump_ascii(len=4):
    
    [00:09:15.956,451] <dbg> wpa_supp: _wpa_hexdump_ascii:
    
                                       61 6e 6f 6e                                      |anon
    
    [00:09:15.956,542] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state SEND_RESPONSE
    
    [00:09:15.956,634] <dbg> wpa_supp: wpa_printf_impl: EAP: EAP entering state IDLE
    
    [00:09:15.956,726] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state RESPONSE
    
    [00:09:15.956,787] <dbg> wpa_supp: wpa_printf_impl: EAPOL: txSuppRsp
    
    [00:09:15.956,909] <dbg> wpa_supp: wpa_printf_impl: TX EAPOL: dst=58:11:22:13:0b:bc
    
    [00:09:15.957,183] <dbg> wpa_supp: wpa_printf_impl: TX EAPOL - hexdump(len=13): 01 00 00 09 02 09 00 09 01 61 6e 6f 6e
    
    [00:09:15.958,068] <dbg> wpa_supp: wpa_printf_impl: EAPOL: SUPP_BE entering state RECEIVE
    
    [00:09:15.959,442] <dbg> wpa_supp: wpa_printf_impl: Received len: 49, msg_len:49 - CTRL-EVENT-EAP-STARTED EAP authentication started->END
    
    [00:09:15.959,625] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-EAP-STARTED EAP authentication started
    
    [00:09:15.959,869] <dbg> wpa_supp: wpa_printf_impl: Received len: 51, msg_len:51 - CTRL-EVENT-EAP-STATUS status='started' parameter=''->END
    
    [00:09:15.960,052] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-EAP-STATUS status='started' parameter=''
    
    [00:09:17.950,378] <dbg> wpa_supp: wpa_printf_impl: EAPOL: startWhen --> 0
    
    Connection request failed (1)

    radius server output

    ap ouput

    Regards,

    Allen

Children
No Data
Related