Hello, I am using FreeBSD 11.2 on a Thinkpad X230 (dmesg attached). I am using a WPA2 wireless lan with iwn and wpa_supplicant.conf. This configuration works very well - sometimes. But at other times, I can't associate with the access point and I don't understand the reason why it fails.
I've tested this with iwn0/wlan0 and attached a verbose log (wpa.debug.iwn0.txt) while wpa_supplicant tried to authenticate. I don't know why the authentication timed out? Other clients (Android, Linux) are working. Attached is also the "ifconfig wlan0 list scan" listing. To rule out a damaged iwn chip on the notebook, I tried the same with an USB dongle (urtwn0) - but the result was the same. It doesn't associate and the authentication times out. Attached is a verbose log of wpa_supplicant.conf (wpa.debug.urtwn0.txt). As mentioned earlier, the Access Point works with other clients (Android) and even the same configuration runs fine for hours on some days. The configuration of wpa_supplicant.debug.conf is attached. Interestingly enough, when I am turning on the "Wifi Bridge" on an Android phone, the WPA2 connection to the phone worked always. On the other hand, I've seen similar authentication failures on other APs also. Has anyone similar issues when using FreeBSD and wifi? Am I missing something in my wpa_supplicant.conf? How can I resolve or debug this further? Am I missing something in the wpa_supplicant log? Thanks, -- Christian Barthel
wpa_supplicant v2.5
Successfully initialized wpa_supplicant
Initializing interface 'wlan0' conf '/etc/wpa_supplicant.debug.conf' driver
'default' ctrl_interface 'N/A' bridge 'N/A'
Configuration file '/etc/wpa_supplicant.debug.conf' ->
'/etc/wpa_supplicant.debug.conf'
Reading configuration file '/etc/wpa_supplicant.debug.conf'
ctrl_interface='/var/run/wpa_supplicant'
eapol_version=2
ap_scan=1
fast_reauth=1
Line: 6 - start of a new network block
ssid - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
scan_ssid=1 (0x1)
PSK (ASCII passphrase) - hexdump_ascii(len=16): [REMOVED]
priority=5 (0x5)
PSK (from passphrase) - hexdump(len=32): [REMOVED]
Priority group 5
id=0 ssid='WLAN-108803'
wpa_driver_bsd_capa: drivercaps=0x0581e201,cryptocaps=0x00000000
Add interface wlan0 to a new radio N/A
wlan0: Own MAC address: 6c:88:14:dd:02:d0
bsd_set_key: alg=0 addr=0x0 key_idx=0 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=0
bsd_set_key: alg=0 addr=0x0 key_idx=1 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=1
bsd_set_key: alg=0 addr=0x0 key_idx=2 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=2
bsd_set_key: alg=0 addr=0x0 key_idx=3 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=3
wpa_driver_bsd_set_countermeasures: enabled=0
wlan0: RSN: flushing PMKID list in the driver
wlan0: Setting scan request: 0.100000 sec
wlan0: WPS: UUID based on MAC address: 10dc295d-49d2-509a-af4c-4f7531c8e3f2
ENGINE: Loading dynamic engine
ENGINE: Loading dynamic engine
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: Supplicant port status: Unauthorized
EAPOL: KEY_RX entering state NO_KEY_RECEIVE
EAPOL: SUPP_BE entering state INITIALIZE
EAP: EAP entering state DISABLED
Using existing control interface directory.
wlan0: Added interface wlan0
wlan0: State: DISCONNECTED -> DISCONNECTED
wlan0: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan0: Starting AP scan for wildcard SSID
wlan0: Add radio work 'scan'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'scan'@0x801ce7000 after 0.000048 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
EAPOL: disable timer tick
wlan0: Event SCAN_RESULTS (3) received
Received 0 bytes of scan results (0 BSSes)
wlan0: BSS: Start scan result update 1
BSS: last_scan_res_used=0/0
wlan0: New scan results available (own=0 ext=0)
wlan0: Radio work 'scan'@0x801ce7000 done in 2.083587 seconds
wlan0: No suitable network found
wlan0: Setting scan request: 5.000000 sec
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan0: Starting AP scan for wildcard SSID
wlan0: Add radio work 'scan'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'scan'@0x801ce7000 after 0.000031 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wlan0: Event SCAN_RESULTS (3) received
Received 672 bytes of scan results (2 BSSes)
Sorted scan results
d4:21:22:3f:50:35 freq=5180 qual=33 noise=-95 level=-79 flags=0x0 age=0 est=1000
IEs - hexdump(len=384): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 08 8c 12 98
24 b0 48 60 6c 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 08 8c 12 98
24 b0 48 60 6c 07 34 44 45 20 24 01 17 28 01 17 2c 01 17 30 01 17 34 01 17 38
01 17 3c 01 17 40 01 17 64 01 1e 68 01 1e 6c 01 1e 70 01 1e 74 01 1e 84 01 1e
88 01 1e 8c 01 1e 00 20 01 00 23 02 0f 00 30 14 01 00 00 0f ac 04 01 00 00 0f
ac 04 01 00 00 0f ac 02 0c 00 0b 05 02 00 01 00 00 2d 1a ef 09 1b ff ff ff 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 24 05 16 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 03 00 00 08 bf 0c b2 49
82 0f ea ff 00 00 ea ff 00 00 c0 05 01 2a 00 00 00 dd 80 00 50 f2 04 10 4a 00
01 10 10 44 00 01 02 10 3b 00 01 03 10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45
3e 3e 9b fe 41 9a 10 21 00 08 42 72 6f 61 64 63 6f 6d 10 23 00 08 42 72 6f 61
64 63 6f 6d 10 24 00 06 31 32 33 34 35 36 10 42 00 04 31 32 33 34 10 54 00 08
00 06 00 50 f2 04 00 01 10 11 00 0a 42 72 6f 61 64 63 6f 6d 41 50 10 08 00 02
01 06 10 3c 00 01 03 10 49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 1c
00 00 dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32
2f 00
d4:21:22:3f:50:36 freq=5180 qual=33 noise=-95 level=-79 flags=0x0 age=0 est=1000
IEs - hexdump(len=232): 00 0b 54 65 6c 65 6b 6f 6d 5f 46 4f 4e 01 08 8c 12 98
24 b0 48 60 6c 2a 01 00 00 0b 54 65 6c 65 6b 6f 6d 5f 46 4f 4e 01 08 8c 12 98
24 b0 48 60 6c 07 34 44 45 20 24 01 17 28 01 17 2c 01 17 30 01 17 34 01 17 38
01 17 3c 01 17 40 01 17 64 01 1e 68 01 1e 6c 01 1e 70 01 1e 74 01 1e 84 01 1e
88 01 1e 8c 01 1e 00 20 01 00 23 02 0f 00 0b 05 00 00 01 00 00 2d 1a ef 09 1b
ff ff ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 24
05 16 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 03 00 00 08
bf 0c b2 49 82 0f ea ff 00 00 ea ff 00 00 c0 05 01 2a 00 00 00 dd 09 00 10 18
02 00 00 1c 00 00 dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43
5e 00 62 32 2f 00
wlan0: BSS: Start scan result update 2
wlan0: BSS: Add new id 0 BSSID d4:21:22:3f:50:35 SSID 'WLAN-108803' freq 5180
wlan0: BSS: Add new id 1 BSSID d4:21:22:3f:50:36 SSID 'Telekom_FON' freq 5180
BSS: last_scan_res_used=2/32
Add randomness: count=1 entropy=0
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
Add randomness: count=2 entropy=1
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan0: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP d4:21:22:3f:50:35 type 0 added
WPS: AP[0] d4:21:22:3f:50:35 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
wlan0: Radio work 'scan'@0x801ce7000 done in 2.273503 seconds
wlan0: Selecting BSS from priority group 5
wlan0: 0: d4:21:22:3f:50:35 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-79 freq=5180 wps
wlan0: selected based on RSN IE
wlan0: selected BSS d4:21:22:3f:50:35 ssid='WLAN-108803'
wlan0: Considering connect request: reassociate: 0 selected: d4:21:22:3f:50:35
bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING
ssid=0x801c3d000 current_ssid=0x0
wlan0: Request association with d4:21:22:3f:50:35
wlan0: Add radio work 'connect'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'connect'@0x801ce7000 after 0.000023 second wait
wlan0: Trying to associate with d4:21:22:3f:50:35 (SSID='WLAN-108803' freq=5180
MHz)
FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
wlan0: Cancelling scan request
wlan0: WPA: clearing own WPA/RSN IE
wlan0: Automatic auth_alg selection: 0x1
RSN: PMKSA cache search - network_ctx=0x801c3d000 try_opportunistic=0
RSN: Search for BSSID d4:21:22:3f:50:35
RSN: No PMKSA cache entry found
wlan0: RSN: using IEEE 802.11i/D9.0
wlan0: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
wlan0: WPA: clearing AP WPA IE
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 02 0c 00
wlan0: WPA: using GTK CCMP
wlan0: WPA: using PTK CCMP
wlan0: WPA: using KEY_MGMT WPA-PSK
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 02 00 00
wlan0: State: SCANNING -> ASSOCIATING
Limit connection to BSSID d4:21:22:3f:50:35 freq=5180 MHz based on scan results
(bssid_set=0)
wpa_driver_bsd_associate: ssid 'WLAN-108803' wpa ie len 22 pairwise 16 group 16
key mgmt 2
wpa_driver_bsd_set_drop_unencrypted: enabled=1
bsd_set_opt_ie: set WPA+RSN ie (len 22)
wpa_driver_bsd_associate: set PRIVACY 1
wlan0: Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
wlan0: Event ASSOC (0) received
wlan0: State: ASSOCIATING -> ASSOCIATED
wlan0: Associated to a new BSS: BSSID=d4:21:22:3f:50:35
Add randomness: count=3 entropy=2
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=6): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan0: Associated with d4:21:22:3f:50:35
wlan0: WPA: Association event - clear replay counter
wlan0: WPA: Clear old PTK
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
EAPOL: External notification - portEnabled=1
EAPOL: SUPP_PAE entering state CONNECTING
EAPOL: enable timer tick
EAPOL: SUPP_BE entering state IDLE
wlan0: Setting authentication timeout: 10 sec 0 usec
wlan0: Cancelling scan request
EAPOL: startWhen --> 0
EAPOL: disable timer tick
EAPOL: SUPP_PAE entering state CONNECTING
EAPOL: enable timer tick
EAPOL: txStart
WPA: drop TX EAPOL in non-IEEE 802.1X mode (type=1 len=0)
wlan0: Event DISASSOC (1) received
wlan0: Disassociation notification
wlan0: CTRL-EVENT-DISCONNECTED bssid=d4:21:22:3f:50:35 reason=0
wlan0: Auto connect enabled: try to reconnect (wps=0/0 wpa_state=6)
wlan0: Setting scan request: 0.100000 sec
wlan0: Radio work 'connect'@0x801ce7000 done in 8.030933 seconds
Added BSSID d4:21:22:3f:50:35 into blacklist
wlan0: Blacklist count 1 --> request scan in 100 ms
wlan0: Ignore new scan request for 0.100000 sec since an earlier request is
scheduled to trigger sooner
wlan0: WPA: Clear old PMK and PTK
wlan0: Disconnect event - remove keys
wlan0: State: ASSOCIATED -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: Supplicant port status: Unauthorized
EAPOL: SUPP_BE entering state INITIALIZE
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
wlan0: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan0: Starting AP scan for wildcard SSID
wlan0: Add radio work 'scan'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'scan'@0x801ce7000 after 0.000023 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wlan0: Event SCAN_RESULTS (3) received
Received 672 bytes of scan results (2 BSSes)
Sorted scan results
d4:21:22:3f:50:35 freq=5180 qual=33 noise=-95 level=-79 flags=0x0 age=0 est=1000
IEs - hexdump(len=384): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 08 8c 12 98
24 b0 48 60 6c 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 08 8c 12 98
24 b0 48 60 6c 07 34 44 45 20 24 01 17 28 01 17 2c 01 17 30 01 17 34 01 17 38
01 17 3c 01 17 40 01 17 64 01 1e 68 01 1e 6c 01 1e 70 01 1e 74 01 1e 84 01 1e
88 01 1e 8c 01 1e 00 20 01 00 23 02 0f 00 30 14 01 00 00 0f ac 04 01 00 00 0f
ac 04 01 00 00 0f ac 02 0c 00 0b 05 02 00 01 00 00 2d 1a ef 09 1b ff ff ff 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 24 05 16 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 03 00 00 08 bf 0c b2 49
82 0f ea ff 00 00 ea ff 00 00 c0 05 01 2a 00 00 00 dd 80 00 50 f2 04 10 4a 00
01 10 10 44 00 01 02 10 3b 00 01 03 10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45
3e 3e 9b fe 41 9a 10 21 00 08 42 72 6f 61 64 63 6f 6d 10 23 00 08 42 72 6f 61
64 63 6f 6d 10 24 00 06 31 32 33 34 35 36 10 42 00 04 31 32 33 34 10 54 00 08
00 06 00 50 f2 04 00 01 10 11 00 0a 42 72 6f 61 64 63 6f 6d 41 50 10 08 00 02
01 06 10 3c 00 01 03 10 49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 1c
00 00 dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32
2f 00
d4:21:22:3f:50:36 freq=5180 qual=33 noise=-95 level=-79 flags=0x0 age=0 est=1000
IEs - hexdump(len=232): 00 0b 54 65 6c 65 6b 6f 6d 5f 46 4f 4e 01 08 8c 12 98
24 b0 48 60 6c 2a 01 00 00 0b 54 65 6c 65 6b 6f 6d 5f 46 4f 4e 01 08 8c 12 98
24 b0 48 60 6c 07 34 44 45 20 24 01 17 28 01 17 2c 01 17 30 01 17 34 01 17 38
01 17 3c 01 17 40 01 17 64 01 1e 68 01 1e 6c 01 1e 70 01 1e 74 01 1e 84 01 1e
88 01 1e 8c 01 1e 00 20 01 00 23 02 0f 00 0b 05 00 00 01 00 00 2d 1a ef 09 1b
ff ff ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 24
05 16 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 03 00 00 08
bf 0c b2 49 82 0f ea ff 00 00 ea ff 00 00 c0 05 01 2a 00 00 00 dd 09 00 10 18
02 00 00 1c 00 00 dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43
5e 00 62 32 2f 00
wlan0: BSS: Start scan result update 3
BSS: last_scan_res_used=2/32
Add randomness: count=4 entropy=3
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
Add randomness: count=5 entropy=4
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan0: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP[0] d4:21:22:3f:50:35 type=0 tries=0 last_attempt=-1 sec ago blacklist=1
wlan0: Radio work 'scan'@0x801ce7000 done in 0.001053 seconds
wlan0: Selecting BSS from priority group 5
wlan0: 0: d4:21:22:3f:50:35 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-79 freq=5180 wps
wlan0: skip - blacklisted (count=1 limit=0)
wlan0: 1: d4:21:22:3f:50:36 ssid='Telekom_FON' wpa_ie_len=0 rsn_ie_len=0
caps=0x1 level=-79 freq=5180
wlan0: skip - SSID mismatch
wlan0: No APs found - clear blacklist and try again
Removed BSSID d4:21:22:3f:50:35 from blacklist (clear)
wlan0: Selecting BSS from priority group 5
wlan0: 0: d4:21:22:3f:50:35 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-79 freq=5180 wps
wlan0: selected based on RSN IE
wlan0: selected BSS d4:21:22:3f:50:35 ssid='WLAN-108803'
wlan0: Considering connect request: reassociate: 0 selected: d4:21:22:3f:50:35
bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING
ssid=0x801c3d000 current_ssid=0x0
wlan0: Request association with d4:21:22:3f:50:35
wlan0: Re-association to the same ESS
wlan0: Add radio work 'connect'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'connect'@0x801ce7000 after 0.000023 second wait
wlan0: Trying to associate with d4:21:22:3f:50:35 (SSID='WLAN-108803' freq=5180
MHz)
FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
wlan0: Cancelling scan request
wlan0: WPA: clearing own WPA/RSN IE
wlan0: Automatic auth_alg selection: 0x1
RSN: PMKSA cache search - network_ctx=0x801c3d000 try_opportunistic=0
RSN: Search for BSSID d4:21:22:3f:50:35
RSN: No PMKSA cache entry found
wlan0: RSN: using IEEE 802.11i/D9.0
wlan0: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
wlan0: WPA: clearing AP WPA IE
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 02 0c 00
wlan0: WPA: using GTK CCMP
wlan0: WPA: using PTK CCMP
wlan0: WPA: using KEY_MGMT WPA-PSK
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 02 00 00
wlan0: State: SCANNING -> ASSOCIATING
Limit connection to BSSID d4:21:22:3f:50:35 freq=5180 MHz based on scan results
(bssid_set=0)
wpa_driver_bsd_associate: ssid 'WLAN-108803' wpa ie len 22 pairwise 16 group 16
key mgmt 2
wpa_driver_bsd_set_drop_unencrypted: enabled=1
bsd_set_opt_ie: set WPA+RSN ie (len 22)
wpa_driver_bsd_associate: set PRIVACY 1
wlan0: Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
wlan0: Authentication with d4:21:22:3f:50:35 timed out.
Added BSSID d4:21:22:3f:50:35 into blacklist
wlan0: WPA: Clear old PMK and PTK
wlan0: Request to deauthenticate - bssid=00:00:00:00:00:00
pending_bssid=d4:21:22:3f:50:35 reason=3 state=ASSOCIATING
wlan0: Event DEAUTH (12) received
wlan0: Deauthentication notification
wlan0: * reason 3 (locally generated)
Deauthentication frame IE(s) - hexdump(len=0): [NULL]
wlan0: CTRL-EVENT-DISCONNECTED bssid=d4:21:22:3f:50:35 reason=3
locally_generated=1
wlan0: Auto connect enabled: try to reconnect (wps=0/0 wpa_state=5)
wlan0: Setting scan request: 0.100000 sec
wlan0: Radio work 'connect'@0x801ce7000 done in 10.003011 seconds
BSSID d4:21:22:3f:50:35 blacklist count incremented to 2
wlan0: Blacklist count 3 --> request scan in 1000 ms
wlan0: Ignore new scan request for 1.000000 sec since an earlier request is
scheduled to trigger sooner
wlan0: WPA: Clear old PMK and PTK
wlan0: Disconnect event - remove keys
wlan0: State: ASSOCIATING -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
wlan0: State: DISCONNECTED -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
wlan0: Ignore new scan request for 1.000000 sec since an earlier request is
scheduled to trigger sooner
wlan0: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan0: Starting AP scan for wildcard SSID
wlan0: Add radio work 'scan'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'scan'@0x801ce7000 after 0.000046 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wlan0: Event SCAN_RESULTS (3) received
Received 296 bytes of scan results (1 BSSes)
Sorted scan results
d4:21:22:3f:50:33 freq=2412 qual=39 noise=-95 level=-76 flags=0x0 age=0 est=1000
IEs - hexdump(len=272): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 0c 82 84 8b
96 24 30 48 6c 0c 12 18 60 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01
08 82 84 8b 96 24 30 48 6c 03 01 01 05 04 01 02 00 00 07 06 44 45 20 01 0d 14
2a 01 00 2f 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 02
0c 00 32 04 0c 12 18 60 0b 05 02 00 06 00 00 2d 1a fe 19 1b ff ff 00 00 01 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 05 16 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4a 0e 14 00 0a 00 2c 01 c8 00 14
00 05 00 19 00 7f 03 01 00 08 dd 31 00 50 f2 04 10 4a 00 01 10 10 44 00 01 02
10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45 3e 3e 9b fe 41 9a 10 3c 00 01 03 10
49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 0c 00 00 dd 18 00 50 f2 02
01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00
wlan0: BSS: Start scan result update 4
wlan0: BSS: Add new id 2 BSSID d4:21:22:3f:50:33 SSID 'WLAN-108803' freq 2412
BSS: last_scan_res_used=1/32
Add randomness: count=6 entropy=5
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan0: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP d4:21:22:3f:50:33 type 0 added
WPS: AP[0] d4:21:22:3f:50:35 type=0 tries=0 last_attempt=-1 sec ago blacklist=2
WPS: AP[1] d4:21:22:3f:50:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
wlan0: Radio work 'scan'@0x801ce7000 done in 2.309596 seconds
wlan0: Selecting BSS from priority group 5
wlan0: 0: d4:21:22:3f:50:33 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-76 freq=2412 wps
wlan0: selected based on RSN IE
wlan0: selected BSS d4:21:22:3f:50:33 ssid='WLAN-108803'
wlan0: Considering connect request: reassociate: 1 selected: d4:21:22:3f:50:33
bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING
ssid=0x801c3d000 current_ssid=0x0
wlan0: Request association with d4:21:22:3f:50:33
wlan0: Re-association to the same ESS
wlan0: Add radio work 'connect'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'connect'@0x801ce7000 after 0.000040 second wait
wlan0: Trying to associate with d4:21:22:3f:50:33 (SSID='WLAN-108803' freq=2412
MHz)
FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
wlan0: Cancelling scan request
wlan0: WPA: clearing own WPA/RSN IE
wlan0: Automatic auth_alg selection: 0x1
RSN: PMKSA cache search - network_ctx=0x801c3d000 try_opportunistic=0
RSN: Search for BSSID d4:21:22:3f:50:33
RSN: No PMKSA cache entry found
wlan0: RSN: using IEEE 802.11i/D9.0
wlan0: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
wlan0: WPA: clearing AP WPA IE
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 02 0c 00
wlan0: WPA: using GTK CCMP
wlan0: WPA: using PTK CCMP
wlan0: WPA: using KEY_MGMT WPA-PSK
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 02 00 00
wlan0: State: SCANNING -> ASSOCIATING
Limit connection to BSSID d4:21:22:3f:50:33 freq=2412 MHz based on scan results
(bssid_set=0)
wpa_driver_bsd_associate: ssid 'WLAN-108803' wpa ie len 22 pairwise 16 group 16
key mgmt 2
wpa_driver_bsd_set_drop_unencrypted: enabled=1
bsd_set_opt_ie: set WPA+RSN ie (len 22)
wpa_driver_bsd_associate: set PRIVACY 1
wlan0: Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
wlan0: Authentication with d4:21:22:3f:50:33 timed out.
Added BSSID d4:21:22:3f:50:33 into blacklist
wlan0: WPA: Clear old PMK and PTK
wlan0: Request to deauthenticate - bssid=00:00:00:00:00:00
pending_bssid=d4:21:22:3f:50:33 reason=3 state=ASSOCIATING
wlan0: Event DEAUTH (12) received
wlan0: Deauthentication notification
wlan0: * reason 3 (locally generated)
Deauthentication frame IE(s) - hexdump(len=0): [NULL]
wlan0: CTRL-EVENT-DISCONNECTED bssid=d4:21:22:3f:50:33 reason=3
locally_generated=1
wlan0: Auto connect enabled: try to reconnect (wps=0/0 wpa_state=5)
wlan0: Setting scan request: 0.100000 sec
wlan0: Radio work 'connect'@0x801ce7000 done in 10.002666 seconds
BSSID d4:21:22:3f:50:33 blacklist count incremented to 2
wlan0: Blacklist count 3 --> request scan in 1000 ms
wlan0: Ignore new scan request for 1.000000 sec since an earlier request is
scheduled to trigger sooner
wlan0: WPA: Clear old PMK and PTK
wlan0: Disconnect event - remove keys
wlan0: State: ASSOCIATING -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
wlan0: State: DISCONNECTED -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
wlan0: Ignore new scan request for 1.000000 sec since an earlier request is
scheduled to trigger sooner
wlan0: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan0: Starting AP scan for wildcard SSID
wlan0: Add radio work 'scan'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'scan'@0x801ce7000 after 0.000039 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
EAPOL: startWhen --> 0
EAPOL: disable timer tick
wlan0: Event SCAN_RESULTS (3) received
Received 968 bytes of scan results (3 BSSes)
Sorted scan results
d4:21:22:3f:50:35 freq=5180 qual=31 noise=-95 level=-80 flags=0x0 age=0 est=1000
IEs - hexdump(len=384): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 08 8c 12 98
24 b0 48 60 6c 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 08 8c 12 98
24 b0 48 60 6c 07 34 44 45 20 24 01 17 28 01 17 2c 01 17 30 01 17 34 01 17 38
01 17 3c 01 17 40 01 17 64 01 1e 68 01 1e 6c 01 1e 70 01 1e 74 01 1e 84 01 1e
88 01 1e 8c 01 1e 00 20 01 00 23 02 0f 00 30 14 01 00 00 0f ac 04 01 00 00 0f
ac 04 01 00 00 0f ac 02 0c 00 0b 05 02 00 02 00 00 2d 1a ef 09 1b ff ff ff 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 24 05 16 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 03 00 00 08 bf 0c b2 49
82 0f ea ff 00 00 ea ff 00 00 c0 05 01 2a 00 00 00 dd 80 00 50 f2 04 10 4a 00
01 10 10 44 00 01 02 10 3b 00 01 03 10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45
3e 3e 9b fe 41 9a 10 21 00 08 42 72 6f 61 64 63 6f 6d 10 23 00 08 42 72 6f 61
64 63 6f 6d 10 24 00 06 31 32 33 34 35 36 10 42 00 04 31 32 33 34 10 54 00 08
00 06 00 50 f2 04 00 01 10 11 00 0a 42 72 6f 61 64 63 6f 6d 41 50 10 08 00 02
01 06 10 3c 00 01 03 10 49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 1c
00 00 dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32
2f 00
d4:21:22:3f:50:33 freq=2412 qual=40 noise=-95 level=-75 flags=0x0 age=0 est=1000
IEs - hexdump(len=272): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 0c 82 84 8b
96 24 30 48 6c 0c 12 18 60 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01
08 82 84 8b 96 24 30 48 6c 03 01 01 05 04 00 02 01 00 07 06 44 45 20 01 0d 14
2a 01 00 2f 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 02
0c 00 32 04 0c 12 18 60 0b 05 02 00 06 00 00 2d 1a fe 19 1b ff ff 00 00 01 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 05 16 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4a 0e 14 00 0a 00 2c 01 c8 00 14
00 05 00 19 00 7f 03 01 00 08 dd 31 00 50 f2 04 10 4a 00 01 10 10 44 00 01 02
10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45 3e 3e 9b fe 41 9a 10 3c 00 01 03 10
49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 0c 00 00 dd 18 00 50 f2 02
01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00
d4:21:22:3f:50:36 freq=5180 qual=31 noise=-95 level=-80 flags=0x0 age=0 est=1000
IEs - hexdump(len=232): 00 0b 54 65 6c 65 6b 6f 6d 5f 46 4f 4e 01 08 8c 12 98
24 b0 48 60 6c 2a 01 00 00 0b 54 65 6c 65 6b 6f 6d 5f 46 4f 4e 01 08 8c 12 98
24 b0 48 60 6c 07 34 44 45 20 24 01 17 28 01 17 2c 01 17 30 01 17 34 01 17 38
01 17 3c 01 17 40 01 17 64 01 1e 68 01 1e 6c 01 1e 70 01 1e 74 01 1e 84 01 1e
88 01 1e 8c 01 1e 00 20 01 00 23 02 0f 00 0b 05 00 00 02 00 00 2d 1a ef 09 1b
ff ff ff 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 24
05 16 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7f 03 00 00 08
bf 0c b2 49 82 0f ea ff 00 00 ea ff 00 00 c0 05 01 2a 00 00 00 dd 09 00 10 18
02 00 00 1c 00 00 dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43
5e 00 62 32 2f 00
wlan0: BSS: Start scan result update 5
BSS: last_scan_res_used=3/32
Add randomness: count=7 entropy=6
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
Add randomness: count=8 entropy=7
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
Add randomness: count=9 entropy=8
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan0: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP[0] d4:21:22:3f:50:35 type=0 tries=0 last_attempt=-1 sec ago blacklist=2
WPS: AP[1] d4:21:22:3f:50:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=2
wlan0: Radio work 'scan'@0x801ce7000 done in 2.318672 seconds
wlan0: Selecting BSS from priority group 5
wlan0: 0: d4:21:22:3f:50:35 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-80 freq=5180 wps
wlan0: skip - blacklisted (count=2 limit=0)
wlan0: 1: d4:21:22:3f:50:33 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-75 freq=2412 wps
wlan0: skip - blacklisted (count=2 limit=0)
wlan0: 2: d4:21:22:3f:50:36 ssid='Telekom_FON' wpa_ie_len=0 rsn_ie_len=0
caps=0x1 level=-80 freq=5180
wlan0: skip - SSID mismatch
wlan0: No APs found - clear blacklist and try again
Removed BSSID d4:21:22:3f:50:33 from blacklist (clear)
Removed BSSID d4:21:22:3f:50:35 from blacklist (clear)
wlan0: Selecting BSS from priority group 5
wlan0: 0: d4:21:22:3f:50:35 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-80 freq=5180 wps
wlan0: selected based on RSN IE
wlan0: selected BSS d4:21:22:3f:50:35 ssid='WLAN-108803'
wlan0: Considering connect request: reassociate: 1 selected: d4:21:22:3f:50:35
bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING
ssid=0x801c3d000 current_ssid=0x0
wlan0: Request association with d4:21:22:3f:50:35
wlan0: Re-association to the same ESS
wlan0: Add radio work 'connect'@0x801ce7000
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'connect'@0x801ce7000 after 0.000024 second wait
wlan0: Trying to associate with d4:21:22:3f:50:35 (SSID='WLAN-108803' freq=5180
MHz)
FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
wlan0: Cancelling scan request
wlan0: WPA: clearing own WPA/RSN IE
wlan0: Automatic auth_alg selection: 0x1
RSN: PMKSA cache search - network_ctx=0x801c3d000 try_opportunistic=0
RSN: Search for BSSID d4:21:22:3f:50:35
RSN: No PMKSA cache entry found
wlan0: RSN: using IEEE 802.11i/D9.0
wlan0: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
wlan0: WPA: clearing AP WPA IE
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 02 0c 00
wlan0: WPA: using GTK CCMP
wlan0: WPA: using PTK CCMP
wlan0: WPA: using KEY_MGMT WPA-PSK
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 02 00 00
wlan0: State: SCANNING -> ASSOCIATING
Limit connection to BSSID d4:21:22:3f:50:35 freq=5180 MHz based on scan results
(bssid_set=0)
wpa_driver_bsd_associate: ssid 'WLAN-108803' wpa ie len 22 pairwise 16 group 16
key mgmt 2
wpa_driver_bsd_set_drop_unencrypted: enabled=1
bsd_set_opt_ie: set WPA+RSN ie (len 22)
wpa_driver_bsd_associate: set PRIVACY 1
wlan0: Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
wlan0: Event ASSOC (0) received
wlan0: State: ASSOCIATING -> ASSOCIATED
wlan0: Associated to a new BSS: BSSID=d4:21:22:3f:50:35
Add randomness: count=10 entropy=9
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=6): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan0: Associated with d4:21:22:3f:50:35
wlan0: WPA: Association event - clear replay counter
wlan0: WPA: Clear old PTK
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
EAPOL: External notification - portEnabled=1
EAPOL: SUPP_PAE entering state CONNECTING
EAPOL: enable timer tick
EAPOL: SUPP_BE entering state IDLE
wlan0: Setting authentication timeout: 10 sec 0 usec
wlan0: Cancelling scan request
wlan0: RX EAPOL from d4:21:22:3f:50:35
RX EAPOL - hexdump(len=121): 02 03 00 75 02 00 8a 00 10 00 00 00 00 00 00 00 00
50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41 98 79 94 1c 58 38 27 b9 31 60
75 9f 09 3a 59 5e 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 16 dd 14 00 0f ac 04 32 96 7a 41 01 b8 1c 4b 30 e1 45 52 ae ee cf 53
wlan0: Setting authentication timeout: 10 sec 0 usec
wlan0: IEEE 802.1X RX: version=2 type=3 length=117
WPA: RX EAPOL-Key - hexdump(len=121): 02 03 00 75 02 00 8a 00 10 00 00 00 00 00
00 00 00 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41 98 79 94 1c 58 38 27
b9 31 60 75 9f 09 3a 59 5e 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 16 dd 14 00 0f ac 04 32 96 7a 41 01 b8 1c 4b 30 e1 45 52 ae
ee cf 53
wlan0: EAPOL-Key type=2
wlan0: key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack)
wlan0: key_length=16 key_data_length=22
replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 00
key_nonce - hexdump(len=32): 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41
98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5e
key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00
key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00
key_mic - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
wlan0: State: ASSOCIATED -> 4WAY_HANDSHAKE
wlan0: WPA: RX message 1 of 4-Way Handshake from d4:21:22:3f:50:35 (ver=2)
RSN: msg 1/4 key data - hexdump(len=22): dd 14 00 0f ac 04 32 96 7a 41 01 b8 1c
4b 30 e1 45 52 ae ee cf 53
WPA: PMKID in EAPOL-Key - hexdump(len=22): dd 14 00 0f ac 04 32 96 7a 41 01 b8
1c 4b 30 e1 45 52 ae ee cf 53
RSN: PMKID from Authenticator - hexdump(len=16): 32 96 7a 41 01 b8 1c 4b 30 e1
45 52 ae ee cf 53
wlan0: RSN: no matching PMKID found
Get randomness: len=32 entropy=10
random from os_get_random - hexdump(len=32): [REMOVED]
random_mix_pool - hexdump(len=20): [REMOVED]
random from internal pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=20): [REMOVED]
random from internal pool - hexdump(len=16): [REMOVED]
mixed random - hexdump(len=32): [REMOVED]
WPA: Renewed SNonce - hexdump(len=32): 0e d5 dd 06 6f 60 ef bf 81 1d 22 d4 12
d6 fd 0e 68 4d 8f 6b 08 f3 ea f6 eb e6 64 ac f3 98 67 bd
WPA: PTK derivation - A1=6c:88:14:dd:02:d0 A2=d4:21:22:3f:50:35
WPA: Nonce1 - hexdump(len=32): 0e d5 dd 06 6f 60 ef bf 81 1d 22 d4 12 d6 fd 0e
68 4d 8f 6b 08 f3 ea f6 eb e6 64 ac f3 98 67 bd
WPA: Nonce2 - hexdump(len=32): 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41
98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5e
WPA: PMK - hexdump(len=32): [REMOVED]
WPA: PTK - hexdump(len=48): [REMOVED]
WPA: KCK - hexdump(len=16): [REMOVED]
WPA: KEK - hexdump(len=16): [REMOVED]
WPA: TK - hexdump(len=16): [REMOVED]
WPA: WPA IE for msg 2/4 - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f
ac 04 01 00 00 0f ac 02 00 00
WPA: Replay Counter - hexdump(len=8): 00 00 00 00 00 00 00 00
wlan0: WPA: Sending EAPOL-Key 2/4
WPA: KCK - hexdump(len=16): [REMOVED]
WPA: Derived Key MIC - hexdump(len=16): bb b4 69 31 3d 82 41 1d fd 24 eb 88 c9
fc db 83
WPA: TX EAPOL-Key - hexdump(len=121): 02 03 00 75 02 01 0a 00 00 00 00 00 00 00
00 00 00 0e d5 dd 06 6f 60 ef bf 81 1d 22 d4 12 d6 fd 0e 68 4d 8f 6b 08 f3 ea
f6 eb e6 64 ac f3 98 67 bd 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 bb b4 69 31 3d 82 41 1d fd 24 eb
88 c9 fc db 83 00 16 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac
02 00 00
wlan0: RX EAPOL from d4:21:22:3f:50:35
RX EAPOL - hexdump(len=121): 02 03 00 75 02 00 8a 00 10 00 00 00 00 00 00 00 01
50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41 98 79 94 1c 58 38 27 b9 31 60
75 9f 09 3a 59 5e 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 16 dd 14 00 0f ac 04 32 96 7a 41 01 b8 1c 4b 30 e1 45 52 ae ee cf 53
wlan0: IEEE 802.1X RX: version=2 type=3 length=117
WPA: RX EAPOL-Key - hexdump(len=121): 02 03 00 75 02 00 8a 00 10 00 00 00 00 00
00 00 01 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41 98 79 94 1c 58 38 27
b9 31 60 75 9f 09 3a 59 5e 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 16 dd 14 00 0f ac 04 32 96 7a 41 01 b8 1c 4b 30 e1 45 52 ae
ee cf 53
wlan0: EAPOL-Key type=2
wlan0: key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack)
wlan0: key_length=16 key_data_length=22
replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 01
key_nonce - hexdump(len=32): 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41
98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5e
key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00
key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00
key_mic - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
wlan0: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE
wlan0: WPA: RX message 1 of 4-Way Handshake from d4:21:22:3f:50:35 (ver=2)
RSN: msg 1/4 key data - hexdump(len=22): dd 14 00 0f ac 04 32 96 7a 41 01 b8 1c
4b 30 e1 45 52 ae ee cf 53
WPA: PMKID in EAPOL-Key - hexdump(len=22): dd 14 00 0f ac 04 32 96 7a 41 01 b8
1c 4b 30 e1 45 52 ae ee cf 53
RSN: PMKID from Authenticator - hexdump(len=16): 32 96 7a 41 01 b8 1c 4b 30 e1
45 52 ae ee cf 53
wlan0: RSN: no matching PMKID found
WPA: PTK derivation - A1=6c:88:14:dd:02:d0 A2=d4:21:22:3f:50:35
WPA: Nonce1 - hexdump(len=32): 0e d5 dd 06 6f 60 ef bf 81 1d 22 d4 12 d6 fd 0e
68 4d 8f 6b 08 f3 ea f6 eb e6 64 ac f3 98 67 bd
WPA: Nonce2 - hexdump(len=32): 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41
98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5e
WPA: PMK - hexdump(len=32): [REMOVED]
WPA: PTK - hexdump(len=48): [REMOVED]
WPA: KCK - hexdump(len=16): [REMOVED]
WPA: KEK - hexdump(len=16): [REMOVED]
WPA: TK - hexdump(len=16): [REMOVED]
WPA: WPA IE for msg 2/4 - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f
ac 04 01 00 00 0f ac 02 00 00
WPA: Replay Counter - hexdump(len=8): 00 00 00 00 00 00 00 01
wlan0: WPA: Sending EAPOL-Key 2/4
WPA: KCK - hexdump(len=16): [REMOVED]
WPA: Derived Key MIC - hexdump(len=16): 0f 87 2a 29 a7 03 4f 46 7f ff b6 b4 4c
c8 3b 51
WPA: TX EAPOL-Key - hexdump(len=121): 02 03 00 75 02 01 0a 00 00 00 00 00 00 00
00 00 01 0e d5 dd 06 6f 60 ef bf 81 1d 22 d4 12 d6 fd 0e 68 4d 8f 6b 08 f3 ea
f6 eb e6 64 ac f3 98 67 bd 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 0f 87 2a 29 a7 03 4f 46 7f ff b6
b4 4c c8 3b 51 00 16 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac
02 00 00
wlan0: RX EAPOL from d4:21:22:3f:50:35
RX EAPOL - hexdump(len=155): 02 03 00 97 02 13 ca 00 10 00 00 00 00 00 00 00 02
50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41 98 79 94 1c 58 38 27 b9 31 60
75 9f 09 3a 59 5e 98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5f 91 1b 03 00
00 00 00 00 00 00 00 00 00 00 00 00 8a 98 6c a6 30 de 81 78 0a 71 74 dd b8 20
54 35 00 38 ab 55 17 d7 40 fa d2 26 95 a3 1e f8 c9 7f 45 3b cd 1b 5f ae a5 a6
5a f7 7d 0d b6 94 04 3d 8f d1 c9 e4 7f 03 6b 37 5c 9e 68 e0 38 2d 42 33 05 95
02 70 bb f8 bb 0f 49 00
wlan0: IEEE 802.1X RX: version=2 type=3 length=151
WPA: RX EAPOL-Key - hexdump(len=155): 02 03 00 97 02 13 ca 00 10 00 00 00 00 00
00 00 02 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41 98 79 94 1c 58 38 27
b9 31 60 75 9f 09 3a 59 5e 98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5f 91
1b 03 00 00 00 00 00 00 00 00 00 00 00 00 00 8a 98 6c a6 30 de 81 78 0a 71 74
dd b8 20 54 35 00 38 ab 55 17 d7 40 fa d2 26 95 a3 1e f8 c9 7f 45 3b cd 1b 5f
ae a5 a6 5a f7 7d 0d b6 94 04 3d 8f d1 c9 e4 7f 03 6b 37 5c 9e 68 e0 38 2d 42
33 05 95 02 70 bb f8 bb 0f 49 00
wlan0: EAPOL-Key type=2
wlan0: key_info 0x13ca (ver=2 keyidx=0 rsvd=0 Pairwise Install Ack MIC Secure
Encr)
wlan0: key_length=16 key_data_length=56
replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 02
key_nonce - hexdump(len=32): 50 27 04 5b c6 b2 a4 de bc 5e 66 13 26 56 a2 41
98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5e
key_iv - hexdump(len=16): 98 79 94 1c 58 38 27 b9 31 60 75 9f 09 3a 59 5f
key_rsc - hexdump(len=8): 91 1b 03 00 00 00 00 00
key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00
key_mic - hexdump(len=16): 8a 98 6c a6 30 de 81 78 0a 71 74 dd b8 20 54 35
RSN: encrypted key data - hexdump(len=56): ab 55 17 d7 40 fa d2 26 95 a3 1e f8
c9 7f 45 3b cd 1b 5f ae a5 a6 5a f7 7d 0d b6 94 04 3d 8f d1 c9 e4 7f 03 6b 37
5c 9e 68 e0 38 2d 42 33 05 95 02 70 bb f8 bb 0f 49 00
WPA: decrypted EAPOL-Key key data - hexdump(len=48): [REMOVED]
wlan0: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE
wlan0: WPA: RX message 3 of 4-Way Handshake from d4:21:22:3f:50:35 (ver=2)
WPA: IE KeyData - hexdump(len=48): 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01
00 00 0f ac 02 0c 00 dd 16 00 0f ac 01 01 00 14 83 80 0e 65 d3 79 4c c0 5e 4e
81 87 ca 4e c2 dd 00
WPA: RSN IE in EAPOL-Key - hexdump(len=22): 30 14 01 00 00 0f ac 04 01 00 00 0f
ac 04 01 00 00 0f ac 02 0c 00
WPA: GTK in EAPOL-Key - hexdump(len=24): [REMOVED]
wlan0: WPA: Sending EAPOL-Key 4/4
WPA: KCK - hexdump(len=16): [REMOVED]
WPA: Derived Key MIC - hexdump(len=16): ea 33 d9 d4 f2 60 92 f5 aa b7 a2 5d 29
da e6 2d
WPA: TX EAPOL-Key - hexdump(len=99): 02 03 00 5f 02 03 0a 00 00 00 00 00 00 00
00 00 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ea 33 d9 d4 f2 60 92 f5 aa b7 a2
5d 29 da e6 2d 00 00
wlan0: WPA: Installing PTK to the driver
bsd_set_key: alg=3 addr=0x801c5a2a0 key_idx=0 set_tx=1 seq_len=6 key_len=16
EAPOL: External notification - portValid=1
wlan0: State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE
RSN: received GTK in pairwise handshake - hexdump(len=18): [REMOVED]
WPA: Group Key - hexdump(len=16): [REMOVED]
wlan0: WPA: Installing GTK to the driver (keyidx=1 tx=0 len=16)
WPA: RSC - hexdump(len=6): 91 1b 03 00 00 00
bsd_set_key: alg=3 addr=0x496fc4 key_idx=1 set_tx=0 seq_len=6 key_len=16
wlan0: WPA: Key negotiation completed with d4:21:22:3f:50:35 [PTK=CCMP GTK=CCMP]
wlan0: Cancelling authentication timeout
wlan0: State: GROUP_HANDSHAKE -> COMPLETED
wlan0: Radio work 'connect'@0x801ce7000 done in 1.104060 seconds
wlan0: CTRL-EVENT-CONNECTED - Connection to d4:21:22:3f:50:35 completed [id=0
id_str=]
EAPOL: External notification - portValid=1
EAPOL: External notification - EAP success=1
EAPOL: SUPP_PAE entering state AUTHENTICATING
EAPOL: SUPP_BE entering state SUCCESS
EAP: EAP entering state DISABLED
EAPOL: SUPP_PAE entering state AUTHENTICATED
EAPOL: Supplicant port status: Authorized
EAPOL: SUPP_BE entering state IDLE
EAPOL authentication completed - result=SUCCESS
EAPOL: startWhen --> 0
EAPOL: disable timer tick
wpa_supplicant v2.5
Successfully initialized wpa_supplicant
Initializing interface 'wlan1' conf '/etc/wpa_supplicant.debug.conf' driver
'default' ctrl_interface 'N/A' bridge 'N/A'
Configuration file '/etc/wpa_supplicant.debug.conf' ->
'/etc/wpa_supplicant.debug.conf'
Reading configuration file '/etc/wpa_supplicant.debug.conf'
ctrl_interface='/var/run/wpa_supplicant'
eapol_version=2
ap_scan=1
fast_reauth=1
Line: 6 - start of a new network block
ssid - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
scan_ssid=1 (0x1)
PSK (ASCII passphrase) - hexdump_ascii(len=16): [REMOVED]
priority=5 (0x5)
PSK (from passphrase) - hexdump(len=32): [REMOVED]
Priority group 5
id=0 ssid='WLAN-108803'
wpa_driver_bsd_capa: drivercaps=0x0591c541,cryptocaps=0x0000000b
Add interface wlan1 to a new radio N/A
wlan1: Own MAC address: f4:f2:6d:11:ed:92
bsd_set_key: alg=0 addr=0x0 key_idx=0 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=0
bsd_set_key: alg=0 addr=0x0 key_idx=1 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=1
bsd_set_key: alg=0 addr=0x0 key_idx=2 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=2
bsd_set_key: alg=0 addr=0x0 key_idx=3 set_tx=0 seq_len=0 key_len=0
bsd_del_key: key_idx=3
wpa_driver_bsd_set_countermeasures: enabled=0
wlan1: RSN: flushing PMKID list in the driver
wlan1: Setting scan request: 0.100000 sec
wlan1: WPS: UUID based on MAC address: 1318c2c7-022f-52f9-8d59-7a94abc9279e
ENGINE: Loading dynamic engine
ENGINE: Loading dynamic engine
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: Supplicant port status: Unauthorized
EAPOL: KEY_RX entering state NO_KEY_RECEIVE
EAPOL: SUPP_BE entering state INITIALIZE
EAP: EAP entering state DISABLED
Using existing control interface directory.
ctrl_iface bind(PF_UNIX) failed: Address already in use
ctrl_iface exists, but does not allow connections - assuming it was leftover
from forced program termination
Successfully replaced leftover ctrl_iface socket '/var/run/wpa_supplicant/wlan1'
wlan1: Added interface wlan1
wlan1: State: DISCONNECTED -> DISCONNECTED
wlan1: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan1: Starting AP scan for wildcard SSID
wlan1: Add radio work 'scan'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'scan'@0x801ced000 after 0.000025 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
EAPOL: disable timer tick
wlan1: Event SCAN_RESULTS (3) received
Received 296 bytes of scan results (1 BSSes)
Sorted scan results
d4:21:22:3f:50:33 freq=2412 qual=29 noise=-95 level=-81 flags=0x0 age=0 est=1000
IEs - hexdump(len=272): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 0c 82 84 8b
96 24 30 48 6c 0c 12 18 60 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01
08 82 84 8b 96 24 30 48 6c 03 01 01 05 04 01 02 00 00 07 06 44 45 20 01 0d 14
2a 01 00 2f 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 02
0c 00 32 04 0c 12 18 60 0b 05 02 00 06 00 00 2d 1a fe 19 1b ff ff 00 00 01 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 05 16 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4a 0e 14 00 0a 00 2c 01 c8 00 14
00 05 00 19 00 7f 03 01 00 08 dd 31 00 50 f2 04 10 4a 00 01 10 10 44 00 01 02
10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45 3e 3e 9b fe 41 9a 10 3c 00 01 03 10
49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 0c 00 00 dd 18 00 50 f2 02
01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00
wlan1: BSS: Start scan result update 1
wlan1: BSS: Add new id 0 BSSID d4:21:22:3f:50:33 SSID 'WLAN-108803' freq 2412
BSS: last_scan_res_used=1/32
Add randomness: count=1 entropy=0
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan1: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP d4:21:22:3f:50:33 type 0 added
WPS: AP[0] d4:21:22:3f:50:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
wlan1: Radio work 'scan'@0x801ced000 done in 3.811858 seconds
wlan1: Selecting BSS from priority group 5
wlan1: 0: d4:21:22:3f:50:33 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-81 freq=2412 wps
wlan1: selected based on RSN IE
wlan1: selected BSS d4:21:22:3f:50:33 ssid='WLAN-108803'
wlan1: Considering connect request: reassociate: 0 selected: d4:21:22:3f:50:33
bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING
ssid=0x801c3d000 current_ssid=0x0
wlan1: Request association with d4:21:22:3f:50:33
wlan1: Add radio work 'connect'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'connect'@0x801ced000 after 0.000024 second wait
wlan1: Trying to associate with d4:21:22:3f:50:33 (SSID='WLAN-108803' freq=2412
MHz)
FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
wlan1: Cancelling scan request
wlan1: WPA: clearing own WPA/RSN IE
wlan1: Automatic auth_alg selection: 0x1
RSN: PMKSA cache search - network_ctx=0x801c3d000 try_opportunistic=0
RSN: Search for BSSID d4:21:22:3f:50:33
RSN: No PMKSA cache entry found
wlan1: RSN: using IEEE 802.11i/D9.0
wlan1: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
wlan1: WPA: clearing AP WPA IE
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 02 0c 00
wlan1: WPA: using GTK CCMP
wlan1: WPA: using PTK CCMP
wlan1: WPA: using KEY_MGMT WPA-PSK
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 02 00 00
wlan1: State: SCANNING -> ASSOCIATING
Limit connection to BSSID d4:21:22:3f:50:33 freq=2412 MHz based on scan results
(bssid_set=0)
wpa_driver_bsd_associate: ssid 'WLAN-108803' wpa ie len 22 pairwise 16 group 16
key mgmt 2
wpa_driver_bsd_set_drop_unencrypted: enabled=1
bsd_set_opt_ie: set WPA+RSN ie (len 22)
wpa_driver_bsd_associate: set PRIVACY 1
wlan1: Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
wlan1: Authentication with d4:21:22:3f:50:33 timed out.
Added BSSID d4:21:22:3f:50:33 into blacklist
wlan1: WPA: Clear old PMK and PTK
wlan1: Request to deauthenticate - bssid=00:00:00:00:00:00
pending_bssid=d4:21:22:3f:50:33 reason=3 state=ASSOCIATING
wlan1: Event DEAUTH (12) received
wlan1: Deauthentication notification
wlan1: * reason 3 (locally generated)
Deauthentication frame IE(s) - hexdump(len=0): [NULL]
wlan1: CTRL-EVENT-DISCONNECTED bssid=d4:21:22:3f:50:33 reason=3
locally_generated=1
wlan1: Auto connect enabled: try to reconnect (wps=0/0 wpa_state=5)
wlan1: Setting scan request: 0.100000 sec
wlan1: Radio work 'connect'@0x801ced000 done in 10.000787 seconds
BSSID d4:21:22:3f:50:33 blacklist count incremented to 2
wlan1: Blacklist count 2 --> request scan in 500 ms
wlan1: Ignore new scan request for 0.500000 sec since an earlier request is
scheduled to trigger sooner
wlan1: WPA: Clear old PMK and PTK
wlan1: Disconnect event - remove keys
wlan1: State: ASSOCIATING -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
wlan1: State: DISCONNECTED -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
wlan1: Ignore new scan request for 1.000000 sec since an earlier request is
scheduled to trigger sooner
wlan1: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan1: Starting AP scan for wildcard SSID
wlan1: Add radio work 'scan'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'scan'@0x801ced000 after 0.000039 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wlan1: Event SCAN_RESULTS (3) received
Received 296 bytes of scan results (1 BSSes)
Sorted scan results
d4:21:22:3f:50:33 freq=2412 qual=25 noise=-95 level=-83 flags=0x0 age=0 est=1000
IEs - hexdump(len=272): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 0c 82 84 8b
96 24 30 48 6c 0c 12 18 60 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01
08 82 84 8b 96 24 30 48 6c 03 01 01 05 04 01 02 00 00 07 06 44 45 20 01 0d 14
2a 01 00 2f 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 02
0c 00 32 04 0c 12 18 60 0b 05 02 00 06 00 00 2d 1a fe 19 1b ff ff 00 00 01 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 05 16 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4a 0e 14 00 0a 00 2c 01 c8 00 14
00 05 00 19 00 7f 03 01 00 08 dd 31 00 50 f2 04 10 4a 00 01 10 10 44 00 01 02
10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45 3e 3e 9b fe 41 9a 10 3c 00 01 03 10
49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 0c 00 00 dd 18 00 50 f2 02
01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00
wlan1: BSS: Start scan result update 2
BSS: last_scan_res_used=1/32
Add randomness: count=2 entropy=1
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan1: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP[0] d4:21:22:3f:50:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=2
wlan1: Radio work 'scan'@0x801ced000 done in 2.199136 seconds
wlan1: Selecting BSS from priority group 5
wlan1: 0: d4:21:22:3f:50:33 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-83 freq=2412 wps
wlan1: skip - blacklisted (count=2 limit=0)
wlan1: No APs found - clear blacklist and try again
Removed BSSID d4:21:22:3f:50:33 from blacklist (clear)
wlan1: Selecting BSS from priority group 5
wlan1: 0: d4:21:22:3f:50:33 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-83 freq=2412 wps
wlan1: selected based on RSN IE
wlan1: selected BSS d4:21:22:3f:50:33 ssid='WLAN-108803'
wlan1: Considering connect request: reassociate: 1 selected: d4:21:22:3f:50:33
bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING
ssid=0x801c3d000 current_ssid=0x0
wlan1: Request association with d4:21:22:3f:50:33
wlan1: Re-association to the same ESS
wlan1: Add radio work 'connect'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'connect'@0x801ced000 after 0.000021 second wait
wlan1: Trying to associate with d4:21:22:3f:50:33 (SSID='WLAN-108803' freq=2412
MHz)
FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
wlan1: Cancelling scan request
wlan1: WPA: clearing own WPA/RSN IE
wlan1: Automatic auth_alg selection: 0x1
RSN: PMKSA cache search - network_ctx=0x801c3d000 try_opportunistic=0
RSN: Search for BSSID d4:21:22:3f:50:33
RSN: No PMKSA cache entry found
wlan1: RSN: using IEEE 802.11i/D9.0
wlan1: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
wlan1: WPA: clearing AP WPA IE
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 02 0c 00
wlan1: WPA: using GTK CCMP
wlan1: WPA: using PTK CCMP
wlan1: WPA: using KEY_MGMT WPA-PSK
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 02 00 00
wlan1: State: SCANNING -> ASSOCIATING
Limit connection to BSSID d4:21:22:3f:50:33 freq=2412 MHz based on scan results
(bssid_set=0)
wpa_driver_bsd_associate: ssid 'WLAN-108803' wpa ie len 22 pairwise 16 group 16
key mgmt 2
wpa_driver_bsd_set_drop_unencrypted: enabled=1
bsd_set_opt_ie: set WPA+RSN ie (len 22)
wpa_driver_bsd_associate: set PRIVACY 1
wlan1: Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
wlan1: Authentication with d4:21:22:3f:50:33 timed out.
Added BSSID d4:21:22:3f:50:33 into blacklist
wlan1: WPA: Clear old PMK and PTK
wlan1: Request to deauthenticate - bssid=00:00:00:00:00:00
pending_bssid=d4:21:22:3f:50:33 reason=3 state=ASSOCIATING
wlan1: Event DEAUTH (12) received
wlan1: Deauthentication notification
wlan1: * reason 3 (locally generated)
Deauthentication frame IE(s) - hexdump(len=0): [NULL]
wlan1: CTRL-EVENT-DISCONNECTED bssid=d4:21:22:3f:50:33 reason=3
locally_generated=1
wlan1: Auto connect enabled: try to reconnect (wps=0/0 wpa_state=5)
wlan1: Setting scan request: 0.100000 sec
wlan1: Radio work 'connect'@0x801ced000 done in 10.001814 seconds
BSSID d4:21:22:3f:50:33 blacklist count incremented to 2
Continuous association failures - consider temporary network disabling
wlan1: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="WLAN-108803" auth_failures=1
duration=10 reason=CONN_FAILED
wlan1: Blacklist count 4 --> request scan in 5000 ms
wlan1: Ignore new scan request for 5.000000 sec since an earlier request is
scheduled to trigger sooner
wlan1: WPA: Clear old PMK and PTK
wlan1: Disconnect event - remove keys
wlan1: State: ASSOCIATING -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
wlan1: State: DISCONNECTED -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
wlan1: Ignore new scan request for 1.000000 sec since an earlier request is
scheduled to trigger sooner
wlan1: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan1: Starting AP scan for wildcard SSID
wlan1: Add radio work 'scan'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'scan'@0x801ced000 after 0.000019 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wlan1: Event SCAN_RESULTS (3) received
Received 296 bytes of scan results (1 BSSes)
Sorted scan results
d4:21:22:3f:50:33 freq=2412 qual=29 noise=-95 level=-81 flags=0x0 age=0 est=1000
IEs - hexdump(len=272): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 0c 82 84 8b
96 24 30 48 6c 0c 12 18 60 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01
08 82 84 8b 96 24 30 48 6c 03 01 01 05 04 01 02 00 00 07 06 44 45 20 01 0d 14
2a 01 00 2f 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 02
0c 00 32 04 0c 12 18 60 0b 05 02 00 06 00 00 2d 1a fe 19 1b ff ff 00 00 01 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 05 16 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4a 0e 14 00 0a 00 2c 01 c8 00 14
00 05 00 19 00 7f 03 01 00 08 dd 31 00 50 f2 04 10 4a 00 01 10 10 44 00 01 02
10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45 3e 3e 9b fe 41 9a 10 3c 00 01 03 10
49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 0c 00 00 dd 18 00 50 f2 02
01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00
wlan1: BSS: Start scan result update 3
BSS: last_scan_res_used=1/32
Add randomness: count=3 entropy=2
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan1: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP[0] d4:21:22:3f:50:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=2
wlan1: Radio work 'scan'@0x801ced000 done in 2.184118 seconds
wlan1: Postpone network selection by 7 seconds since all networks are disabled
wlan1: Try to associate due to network getting re-enabled
Fast associate: Old scan results
wlan1: Setting scan request: 0.000000 sec
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan1: Starting AP scan for wildcard SSID
wlan1: Add radio work 'scan'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'scan'@0x801ced000 after 0.000028 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wlan1: Event SCAN_RESULTS (3) received
Received 296 bytes of scan results (1 BSSes)
Sorted scan results
d4:21:22:3f:50:33 freq=2412 qual=29 noise=-95 level=-81 flags=0x0 age=0 est=1000
IEs - hexdump(len=272): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 0c 82 84 8b
96 24 30 48 6c 0c 12 18 60 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01
08 82 84 8b 96 24 30 48 6c 03 01 01 05 04 01 02 00 00 07 06 44 45 20 01 0d 14
2a 01 00 2f 01 00 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 02
0c 00 32 04 0c 12 18 60 0b 05 02 00 06 00 00 2d 1a fe 19 1b ff ff 00 00 01 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 05 16 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 4a 0e 14 00 0a 00 2c 01 c8 00 14
00 05 00 19 00 7f 03 01 00 08 dd 31 00 50 f2 04 10 4a 00 01 10 10 44 00 01 02
10 47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45 3e 3e 9b fe 41 9a 10 3c 00 01 03 10
49 00 06 00 37 2a 00 01 20 dd 09 00 10 18 02 02 00 0c 00 00 dd 18 00 50 f2 02
01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00
wlan1: BSS: Start scan result update 4
BSS: last_scan_res_used=1/32
Add randomness: count=4 entropy=3
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan1: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP[0] d4:21:22:3f:50:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=2
wlan1: Radio work 'scan'@0x801ced000 done in 0.000982 seconds
wlan1: CTRL-EVENT-SSID-REENABLED id=0 ssid="WLAN-108803"
wlan1: Selecting BSS from priority group 5
wlan1: 0: d4:21:22:3f:50:33 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-81 freq=2412 wps
wlan1: skip - blacklisted (count=2 limit=0)
wlan1: No APs found - clear blacklist and try again
Removed BSSID d4:21:22:3f:50:33 from blacklist (clear)
wlan1: Selecting BSS from priority group 5
wlan1: 0: d4:21:22:3f:50:33 ssid='WLAN-108803' wpa_ie_len=0 rsn_ie_len=20
caps=0x11 level=-81 freq=2412 wps
wlan1: selected based on RSN IE
wlan1: selected BSS d4:21:22:3f:50:33 ssid='WLAN-108803'
wlan1: Considering connect request: reassociate: 1 selected: d4:21:22:3f:50:33
bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING
ssid=0x801c3d000 current_ssid=0x0
wlan1: Request association with d4:21:22:3f:50:33
wlan1: Re-association to the same ESS
wlan1: Add radio work 'connect'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'connect'@0x801ced000 after 0.000050 second wait
wlan1: Trying to associate with d4:21:22:3f:50:33 (SSID='WLAN-108803' freq=2412
MHz)
FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
wlan1: Cancelling scan request
wlan1: WPA: clearing own WPA/RSN IE
wlan1: Automatic auth_alg selection: 0x1
RSN: PMKSA cache search - network_ctx=0x801c3d000 try_opportunistic=0
RSN: Search for BSSID d4:21:22:3f:50:33
RSN: No PMKSA cache entry found
wlan1: RSN: using IEEE 802.11i/D9.0
wlan1: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
wlan1: WPA: clearing AP WPA IE
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 02 0c 00
wlan1: WPA: using GTK CCMP
wlan1: WPA: using PTK CCMP
wlan1: WPA: using KEY_MGMT WPA-PSK
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 02 00 00
wlan1: State: SCANNING -> ASSOCIATING
Limit connection to BSSID d4:21:22:3f:50:33 freq=2412 MHz based on scan results
(bssid_set=0)
wpa_driver_bsd_associate: ssid 'WLAN-108803' wpa ie len 22 pairwise 16 group 16
key mgmt 2
wpa_driver_bsd_set_drop_unencrypted: enabled=1
bsd_set_opt_ie: set WPA+RSN ie (len 22)
wpa_driver_bsd_associate: set PRIVACY 1
wlan1: Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
wlan1: Authentication with d4:21:22:3f:50:33 timed out.
Added BSSID d4:21:22:3f:50:33 into blacklist
wlan1: WPA: Clear old PMK and PTK
wlan1: Request to deauthenticate - bssid=00:00:00:00:00:00
pending_bssid=d4:21:22:3f:50:33 reason=3 state=ASSOCIATING
wlan1: Event DEAUTH (12) received
wlan1: Deauthentication notification
wlan1: * reason 3 (locally generated)
Deauthentication frame IE(s) - hexdump(len=0): [NULL]
wlan1: CTRL-EVENT-DISCONNECTED bssid=d4:21:22:3f:50:33 reason=3
locally_generated=1
wlan1: Auto connect enabled: try to reconnect (wps=0/0 wpa_state=5)
wlan1: Setting scan request: 0.100000 sec
wlan1: Radio work 'connect'@0x801ced000 done in 10.002300 seconds
BSSID d4:21:22:3f:50:33 blacklist count incremented to 2
Continuous association failures - consider temporary network disabling
wlan1: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="WLAN-108803" auth_failures=2
duration=31 reason=CONN_FAILED
wlan1: Blacklist count 6 --> request scan in 10000 ms
wlan1: Ignore new scan request for 10.000000 sec since an earlier request is
scheduled to trigger sooner
wlan1: WPA: Clear old PMK and PTK
wlan1: Disconnect event - remove keys
wlan1: State: ASSOCIATING -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
wlan1: State: DISCONNECTED -> DISCONNECTED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
wlan1: Ignore new scan request for 1.000000 sec since an earlier request is
scheduled to trigger sooner
wlan1: State: DISCONNECTED -> SCANNING
Scan SSID - hexdump_ascii(len=11):
57 4c 41 4e 2d 31 30 38 38 30 33 WLAN-108803
wlan1: Starting AP scan for wildcard SSID
wlan1: Add radio work 'scan'@0x801ced000
wlan1: First radio work item in the queue - schedule start immediately
wlan1: Starting radio work 'scan'@0x801ced000 after 0.000021 second wait
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wlan1: Event SCAN_RESULTS (3) received
Received 368 bytes of scan results (1 BSSes)
Sorted scan results
d4:21:22:3f:50:33 freq=2412 qual=31 noise=-95 level=-80 flags=0x0 age=0 est=1000
IEs - hexdump(len=345): 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01 0c 82 84 8b
96 24 30 48 6c 0c 12 18 60 2a 01 00 00 0b 57 4c 41 4e 2d 31 30 38 38 30 33 01
08 82 84 8b 96 24 30 48 6c 03 01 01 07 06 44 45 20 01 0d 14 2a 01 00 2f 01 00
30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ac 02 0c 00 32 04 0c 12
18 60 0b 05 02 00 06 00 00 2d 1a fe 19 1b ff ff 00 00 01 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 3d 16 01 05 16 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 4a 0e 14 00 0a 00 2c 01 c8 00 14 00 05 00 19 00 7f
03 01 00 08 dd 80 00 50 f2 04 10 4a 00 01 10 10 44 00 01 02 10 3b 00 01 03 10
47 00 10 70 3d 79 1d fc 2c 5e d4 1b 45 3e 3e 9b fe 41 9a 10 21 00 08 42 72 6f
61 64 63 6f 6d 10 23 00 08 42 72 6f 61 64 63 6f 6d 10 24 00 06 31 32 33 34 35
36 10 42 00 04 31 32 33 34 10 54 00 08 00 06 00 50 f2 04 00 01 10 11 00 0a 42
72 6f 61 64 63 6f 6d 41 50 10 08 00 02 01 06 10 3c 00 01 03 10 49 00 06 00 37
2a 00 01 20 dd 09 00 10 18 02 02 00 0c 00 00 dd 18 00 50 f2 02 01 01 80 00 03
a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00
wlan1: BSS: Start scan result update 5
BSS: last_scan_res_used=1/32
Add randomness: count=5 entropy=4
random pool - hexdump(len=128): [REMOVED]
random_mix_pool - hexdump(len=16): [REMOVED]
random_mix_pool - hexdump(len=5): [REMOVED]
random pool - hexdump(len=128): [REMOVED]
wlan1: New scan results available (own=0 ext=0)
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: attr type=0x104a len=1
WPS: attr type=0x1044 len=1
WPS: attr type=0x103b len=1
WPS: attr type=0x1047 len=16
WPS: attr type=0x1021 len=8
WPS: attr type=0x1023 len=8
WPS: attr type=0x1024 len=6
WPS: attr type=0x1042 len=4
WPS: attr type=0x1054 len=8
WPS: attr type=0x1011 len=10
WPS: attr type=0x1008 len=2
WPS: attr type=0x103c len=1
WPS: attr type=0x1049 len=6
WPS: WFA subelement id=0 len=1
WPS: AP[0] d4:21:22:3f:50:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=2
wlan1: Radio work 'scan'@0x801ced000 done in 2.238586 seconds
wlan1: Postpone network selection by 29 seconds since all networks are disabled
SSID/MESH ID BSSID CHAN RATE S:N INT CAPS WLAN-108803 d4:21:22:3f:50:33 1 54M -75:-95 100 EP RSN BSSLOAD HTCAP WPS WME WLAN-108803 d4:21:22:3f:50:35 36 54M -80:-95 100 EP RSN BSSLOAD HTCAP VHTCAP VHTOPMODE WPS WME Telekom_FON d4:21:22:3f:50:36 36 54M -80:-95 100 E BSSLOAD HTCAP VHTCAP VHTOPMODE WME
SSID/MESH ID BSSID CHAN RATE S:N INT CAPS WLAN-108803 d4:21:22:3f:50:33 1 54M -80:-95 100 EP RSN BSSLOAD HTCAP WPS WME
wpa_supplicant.debug.conf
Description: Binary data
wlan1: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> metric 0 mtu 1500
ether f4:f2:6d:11:ed:92
hwaddr f4:f2:6d:11:ed:92
nd6 options=29<PERFORMNUD,IFDISABLED,AUTO_LINKLOCAL>
media: IEEE 802.11 Wireless Ethernet autoselect (autoselect)
status: no carrier
ssid "" channel 3 (2422 MHz 11g)
regdomain ETSI country DE ecm authmode WPA1+WPA2/802.11i privacy ON
deftxkey UNDEF txpower 30 bmiss 7 scanvalid 60 protmode CTS wme
roaming MANUAL
groups: wlan
dmesg.boot
Description: Binary data
_______________________________________________ freebsd-wireless@freebsd.org mailing list https://lists.freebsd.org/mailman/listinfo/freebsd-wireless To unsubscribe, send any mail to "freebsd-wireless-unsubscr...@freebsd.org"
