Skip site navigation (1)Skip section navigation (2)
Date:      Sat, 02 Feb 2019 22:15:53 +0100
From:      Christian Barthel <bch@online.de>
To:        freebsd-wireless@freebsd.org
Subject:   No association with WPA2 wireless lan sometimes (11.2)
Message-ID:  <877eehriwm.fsf@x230.onfire.org>

index | next in thread | raw e-mail

[-- Attachment #1 --]
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


[-- Attachment #2 --]
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

[-- Attachment #3 --]
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

[-- Attachment #4 --]
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

[-- Attachment #5 --]
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

[-- Attachment #6 --]
ctrl_interface=/var/run/wpa_supplicant
#eapol_version=1
ap_scan=1
fast_reauth=1

network={
        ssid="WLAN-108803"
        # proto=WPA RSN
        # bssid=
        # scan_ssid=1
        psk="xxxx"
        priority=5
}


[-- Attachment #7 --]
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 

[-- Attachment #8 --]
Copyright (c) 1992-2018 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
	The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 11.2-RELEASE-p5 #0: Tue Nov 27 09:33:52 UTC 2018
    root@amd64-builder.daemonology.net:/usr/obj/usr/src/sys/GENERIC amd64
FreeBSD clang version 6.0.0 (tags/RELEASE_600/final 326565) (based on LLVM 6.0.0)
VT(vga): resolution 640x480
info: [drm] Initialized drm 1.1.0 20060810
CPU: Intel(R) Core(TM) i5-3320M CPU @ 2.60GHz (2594.17-MHz K8-class CPU)
  Origin="GenuineIntel"  Id=0x306a9  Family=0x6  Model=0x3a  Stepping=9
  Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
  Features2=0x7fbae3ff<SSE3,PCLMULQDQ,DTES64,MON,DS_CPL,VMX,SMX,EST,TM2,SSSE3,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,x2APIC,POPCNT,TSCDLT,AESNI,XSAVE,OSXSAVE,AVX,F16C,RDRAND>
  AMD Features=0x28100800<SYSCALL,NX,RDTSCP,LM>
  AMD Features2=0x1<LAHF>
  Structured Extended Features=0x281<FSGSBASE,SMEP,ERMS>
  XSAVE Features=0x1<XSAVEOPT>
  VT-x: PAT,HLT,MTF,PAUSE,EPT,UG,VPID
  TSC: P-state invariant, performance statistics
real memory  = 17179869184 (16384 MB)
avail memory = 16253931520 (15500 MB)
Event timer "LAPIC" quality 600
ACPI APIC Table: <LENOVO TP-G2   >
FreeBSD/SMP: Multiprocessor System Detected: 4 CPUs
FreeBSD/SMP: 1 package(s) x 2 core(s) x 2 hardware threads
ioapic0 <Version 2.0> irqs 0-23 on motherboard
SMP: AP CPU #1 Launched!
SMP: AP CPU #3 Launched!
SMP: AP CPU #2 Launched!
Timecounter "TSC-low" frequency 1297084378 Hz quality 1000
random: entropy device external interface
kbd1 at kbdmux0
netmap: loaded module
module_register_init: MOD_LOAD (vesa, 0xffffffff80ff4580, 0) error 19
random: registering fast source Intel Secure Key RNG
random: fast provider: "Intel Secure Key RNG"
nexus0
vtvga0: <VT VGA driver> on motherboard
cryptosoft0: <software crypto> on motherboard
aesni0: <AES-CBC,AES-XTS,AES-GCM,AES-ICM> on motherboard
acpi0: <LENOVO TP-G2> on motherboard
acpi_ec0: <Embedded Controller: GPE 0x11, ECDT> port 0x62,0x66 on acpi0
acpi0: Power Button (fixed)
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
attimer0: <AT timer> port 0x40-0x43 irq 0 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
Event timer "i8254" frequency 1193182 Hz quality 100
hpet0: <High Precision Event Timer> iomem 0xfed00000-0xfed003ff on acpi0
Timecounter "HPET" frequency 14318180 Hz quality 950
Event timer "HPET" frequency 14318180 Hz quality 550
Event timer "HPET1" frequency 14318180 Hz quality 440
Event timer "HPET2" frequency 14318180 Hz quality 440
Event timer "HPET3" frequency 14318180 Hz quality 440
Event timer "HPET4" frequency 14318180 Hz quality 440
atrtc0: <AT realtime clock> port 0x70-0x71 irq 8 on acpi0
atrtc0: registered as a time-of-day clock, resolution 1.000000s
Event timer "RTC" frequency 32768 Hz quality 0
Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x408-0x40b on acpi0
acpi_lid0: <Control Method Lid Switch> on acpi0
acpi_button0: <Sleep Button> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
vgapci0: <VGA-compatible display> port 0x6000-0x603f mem 0xf0000000-0xf03fffff,0xe0000000-0xefffffff irq 16 at device 2.0 on pci0
drmn0: <Intel IvyBridge (M)> on vgapci0
info: [drm] Memory usable by graphics device = 2048M
info: [drm] MTRR allocation failed.  Graphics performance may suffer.
intel_iicbb0 on drmn0
iicbus0: <Philips I2C bus> on iicbb0 addr 0xff
iic0: <I2C generic I/O> on iicbus0
iicbus1: <Philips I2C bus> on intel_gmbus0
iic1: <I2C generic I/O> on iicbus1
intel_iicbb1 on drmn0
iicbus2: <Philips I2C bus> on iicbb1 addr 0xff
iic2: <I2C generic I/O> on iicbus2
iicbus3: <Philips I2C bus> on intel_gmbus1
iic3: <I2C generic I/O> on iicbus3
intel_iicbb2 on drmn0
iicbus4: <Philips I2C bus> on iicbb2 addr 0xff
iic4: <I2C generic I/O> on iicbus4
iicbus5: <Philips I2C bus> on intel_gmbus2
iic5: <I2C generic I/O> on iicbus5
intel_iicbb3 on drmn0
iicbus6: <Philips I2C bus> on iicbb3 addr 0xff
iic6: <I2C generic I/O> on iicbus6
iicbus7: <Philips I2C bus> on intel_gmbus3
iic7: <I2C generic I/O> on iicbus7
intel_iicbb4 on drmn0
iicbus8: <Philips I2C bus> on iicbb4 addr 0xff
iic8: <I2C generic I/O> on iicbus8
iicbus9: <Philips I2C bus> on intel_gmbus4
iic9: <I2C generic I/O> on iicbus9
intel_iicbb5 on drmn0
iicbus10: <Philips I2C bus> on iicbb5 addr 0xff
iic10: <I2C generic I/O> on iicbus10
iicbus11: <Philips I2C bus> on intel_gmbus5
iic11: <I2C generic I/O> on iicbus11
info: [drm] MSI enabled 1 message(s)
info: [drm] Supports vblank timestamp caching Rev 1 (10.10.2010).
info: [drm] Driver supports precise vblank timestamp query.
intel_sdvo_ddc_proxy921920 on drmn0
info: [drm] GMBUS [i915 gmbus dpb] timed out, falling back to bit banging on pin 5
intel_sdvo_ddc_proxy921920: detached
drm_iic_dp_aux0 on drmn0
drm_iic_dp_aux1 on drmn0
drm_iic_dp_aux2 on drmn0
drmn0: taking over the fictitious range 0xe0000000-0xf0000000
info: [drm] Connector LVDS-1: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.LVDS-1
info: [drm]   - kern.vt.fb.default_mode
info: [drm] Connector VGA-1: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.VGA-1
info: [drm]   - kern.vt.fb.default_mode
info: [drm] Connector HDMI-A-1: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.HDMI-A-1
info: [drm]   - kern.vt.fb.default_mode
info: [drm] Connector DP-1: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.DP-1
info: [drm]   - kern.vt.fb.default_mode
info: [drm] Connector HDMI-A-2: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.HDMI-A-2
info: [drm]   - kern.vt.fb.default_mode
info: [drm] Connector HDMI-A-3: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.HDMI-A-3
info: [drm]   - kern.vt.fb.default_mode
info: [drm] Connector DP-2: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.DP-2
info: [drm]   - kern.vt.fb.default_mode
info: [drm] Connector DP-3: get mode from tunables:
info: [drm]   - kern.vt.fb.modes.DP-3
info: [drm]   - kern.vt.fb.default_mode
fbd0 on drmn0
VT: Replacing driver "vga" with new "fb".
info: [drm] Initialized i915 1.6.0 20080730 for drmn0 on minor 0
vgapci0: Boot video device
xhci0: <Intel Panther Point USB 3.0 controller> mem 0xf2520000-0xf252ffff irq 16 at device 20.0 on pci0
xhci0: 32 bytes context size, 64-bit DMA
xhci0: Port routing mask set to 0xffffffff
usbus0 on xhci0
usbus0: 5.0Gbps Super Speed USB v3.0
pci0: <simple comms> at device 22.0 (no driver attached)
uart2: <Intel Panther Point KT Controller> port 0x60b0-0x60b7 mem 0xf253c000-0xf253cfff irq 19 at device 22.3 on pci0
em0: <Intel(R) PRO/1000 Network Connection 7.6.1-k> port 0x6080-0x609f mem 0xf2500000-0xf251ffff,0xf253b000-0xf253bfff irq 20 at device 25.0 on pci0
em0: Using an MSI interrupt
em0: Ethernet address: 3c:97:0e:b8:13:e1
em0: netmap queues/slots: TX 1/1024, RX 1/1024
ehci0: <Intel Panther Point USB 2.0 controller> mem 0xf253a000-0xf253a3ff irq 16 at device 26.0 on pci0
usbus1: EHCI version 1.0
usbus1 on ehci0
usbus1: 480Mbps High Speed USB v2.0
hdac0: <Intel Panther Point HDA Controller> mem 0xf2530000-0xf2533fff irq 22 at device 27.0 on pci0
pcib1: <ACPI PCI-PCI bridge> irq 16 at device 28.0 on pci0
pcib1: [GIANT-LOCKED]
pci1: <ACPI PCI bus> on pcib1
sdhci_pci0: <RICOH R5CE823 SD> mem 0xf1d00000-0xf1d000ff irq 16 at device 0.0 on pci1
sdhci_pci0: 1 slot(s) allocated
mmc0: <MMC/SD bus> on sdhci_pci0
pcib2: <ACPI PCI-PCI bridge> irq 17 at device 28.1 on pci0
pci2: <ACPI PCI bus> on pcib2
iwn0: <Intel Centrino Advanced-N 6205> mem 0xf1c00000-0xf1c01fff irq 17 at device 0.0 on pci2
pcib3: <ACPI PCI-PCI bridge> irq 18 at device 28.2 on pci0
pcib3: [GIANT-LOCKED]
ehci1: <Intel Panther Point USB 2.0 controller> mem 0xf2539000-0xf25393ff irq 23 at device 29.0 on pci0
usbus2: EHCI version 1.0
usbus2 on ehci1
usbus2: 480Mbps High Speed USB v2.0
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
ahci0: <Intel Panther Point AHCI SATA controller> port 0x60a8-0x60af,0x60bc-0x60bf,0x60a0-0x60a7,0x60b8-0x60bb,0x6060-0x607f mem 0xf2538000-0xf25387ff irq 19 at device 31.2 on pci0
ahci0: AHCI v1.30 with 6 6Gbps ports, Port Multiplier not supported
ahcich0: <AHCI channel> at channel 0 on ahci0
ahcich1: <AHCI channel> at channel 1 on ahci0
ahcich4: <AHCI channel> at channel 4 on ahci0
ahciem0: <AHCI enclosure management bridge> on ahci0
acpi_dock0: <ACPI Docking Station> on acpi0
acpi_tz0: <Thermal Zone> on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: [GIANT-LOCKED]
psm0: model Generic PS/2 mouse, device ID 0
battery0: <ACPI Control Method Battery> on acpi0
acpi_acad0: <AC Adapter> on acpi0
acpi_ibm0: <IBM ThinkPad ACPI Extras> on acpi0
orm0: <ISA Option ROM> at iomem 0xc0000-0xcffff on isa0
ppc0: cannot reserve I/O port range
est0: <Enhanced SpeedStep Frequency Control> on cpu0
est1: <Enhanced SpeedStep Frequency Control> on cpu1
est2: <Enhanced SpeedStep Frequency Control> on cpu2
est3: <Enhanced SpeedStep Frequency Control> on cpu3
ZFS filesystem version: 5
ZFS storage pool version: features support (5000)
Timecounters tick every 1.000 msec
hdacc0: <Realtek ALC269 HDA CODEC> at cad 0 on hdac0
hdaa0: <Realtek ALC269 Audio Function Group> at nid 1 on hdacc0
pcm0: <Realtek ALC269 (Analog 2.0+HP/2.0)> at nid 20,21 and 24 on hdaa0
pcm1: <Realtek ALC269 (Internal Analog Mic)> at nid 18 on hdaa0
hdacc1: <Intel Panther Point HDA CODEC> at cad 3 on hdac0
hdaa1: <Intel Panther Point Audio Function Group> at nid 1 on hdacc1
pcm2: <Intel Panther Point (HDMI/DP 8ch)> at nid 5 on hdaa1
pcm3: <Intel Panther Point (HDMI/DP 8ch)> at nid 6 on hdaa1
pcm4: <Intel Panther Point (HDMI/DP 8ch)> at nid 7 on hdaa1
ugen0.1: <0x8086 XHCI root HUB> at usbus0
ugen2.1: <Intel EHCI root HUB> at usbus2
ugen1.1: <Intel EHCI root HUB> at usbus1
uhub1: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus1
uhub2: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus2
uhub0: <0x8086 XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
ses0 at ahciem0 bus 0 scbus3 target 0 lun 0
ses0: <AHCI SGPIO Enclosure 1.00 0001> SEMB S-E-S 2.00 device
ses0: SEMB SES Device
ada0 at ahcich0 bus 0 scbus0 target 0 lun 0
ada0: <SanDisk SDSSDH32000G X61170RL> ACS-4 ATA SATA 3.x device
ada0: Serial Number 183399800123
ada0: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 512bytes)
ada0: Command Queueing enabled
ada0: 1907729MB (3907029168 512 byte sectors)
GEOM_ELI: Device ada0p3.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: hardware
mmcsd0: 32GB <SDHC SE32G 8.0 SN 92DE4723 MFG 07/2016 by 3 SD> at mmc0 50.0MHz/4bit/65535-block
Trying to mount root from zfs:zroot/ROOT/default []...
Root mount waiting for: usbus2 usbus1 usbus0
uhub0: 8 ports with 8 removable, self powered
info: [drm] Enabling RC6 states: RC6 on, RC6p on, RC6pp off
Root mount waiting for: usbus2 usbus1 usbus0
ugen0.2: <Realtek 802.11n NIC> at usbus0
uhub1: 3 ports with 3 removable, self powered
uhub2: 3 ports with 3 removable, self powered
Root mount waiting for: usbus2 usbus1
ugen2.2: <vendor 0x8087 product 0x0024> at usbus2
uhub3 on uhub2
uhub3: <vendor 0x8087 product 0x0024, class 9/0, rev 2.00/0.00, addr 2> on usbus2
ugen1.2: <vendor 0x8087 product 0x0024> at usbus1
uhub4 on uhub1
uhub4: <vendor 0x8087 product 0x0024, class 9/0, rev 2.00/0.00, addr 2> on usbus1
uhub4: 6 ports with 6 removable, self powered
Root mount waiting for: usbus2 usbus1
uhub3: 8 ports with 8 removable, self powered
ugen1.3: <Broadcom Corp BCM20702A0> at usbus1
Root mount waiting for: usbus1
ugen1.4: <Chicony Electronics Co., Ltd. Integrated Camera> at usbus1
GEOM_PART: integrity check failed (zvol/zroot/vm/ktestp4, BSD)
GEOM_PART: integrity check failed (zvol/zroot/vm/ktest@20190124p4, BSD)
GEOM_PART: integrity check failed (zvol/zroot/vm/ktest@20181224p4, BSD)
GEOM_PART: integrity check failed (gpt/OpenBSD%20Area, BSD)
GEOM_ELI: Device ada0p2.eli created.
GEOM_ELI: Encryption: AES-XTS 128
GEOM_ELI:     Crypto: hardware
random: unblocking device.
coretemp0: <CPU On-Die Thermal Sensors> on cpu0
coretemp1: <CPU On-Die Thermal Sensors> on cpu1
coretemp2: <CPU On-Die Thermal Sensors> on cpu2
coretemp3: <CPU On-Die Thermal Sensors> on cpu3
wlan0: Ethernet address: 6c:88:14:dd:02:d0
iwn0: iwn_read_firmware: ucode rev=0x12a80601
urtwn0 on uhub0
urtwn0: <Realtek 802.11n NIC, class 0/0, rev 2.00/0.00, addr 1> on usbus0
ubt0 on uhub4
ubt0: <Broadcom Corp BCM20702A0, rev 2.00/1.12, addr 3> on usbus1
urtwn0: MAC/BB RTL8188EU, RF 6052 1T1R
urtwn0: enabling 11n
WARNING: attempt to domain_add(bluetooth) after domainfinalize()
WARNING: attempt to domain_add(netgraph) after domainfinalize()
Accounting enabled
help

Want to link to this message? Use this
URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?877eehriwm.fsf>