pbell# /usr/sbin/wpa_supplicant -d -i wlan0 -D bsd -P /var/run/wpa_supplicant/wlan0.pid -c /etc/wpa_supplicant.conf
wpa_supplicant v2.9
Successfully initialized wpa_supplicant
Initializing interface 'wlan0' conf '/etc/wpa_supplicant.conf' driver 'bsd' ctrl_interface 'N/A' bridge 'N/A'
Configuration file '/etc/wpa_supplicant.conf' -> '/etc/wpa_supplicant.conf'
Reading configuration file '/etc/wpa_supplicant.conf'
ctrl_interface='/var/run/wpa_supplicant'
eapol_version=1
ap_scan=1
fast_reauth=1
Priority group 0
   id=0 ssid='swlanw'
wpa_driver_bsd_capa: drivercaps=0xcf8def41,cryptocaps=0x0000001f
Add interface wlan0 to a new radio N/A
wlan0: Failed to attach pkt_type filter
wlan0: Own MAC address: 90:48:9a:3f:f7:5f
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: 8d04e790-9874-5789-abce-460cb21e1973
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
wlan0: Starting AP scan for wildcard SSID
wlan0: Add radio work 'scan'@0x800c80c00
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'scan'@0x800c80c00 after 0.000066 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 2468 bytes of scan results (6 BSSes)
wlan0: BSS: Start scan result update 1
wlan0: BSS: Add new id 0 BSSID dc:39:6f:f9:f7:ec SSID 'Holz' freq 2412
wlan0: BSS: Add new id 1 BSSID e0:28:6d:31:f3:61 SSID 'FRITZ!Box 7430 TH' freq 2437
wlan0: BSS: Add new id 2 BSSID 3a:10:d5:2a:60:4d SSID 'LiMaSa Gast' freq 2437
wlan0: BSS: Add new id 3 BSSID 64:cc:22:19:18:c6 SSID 'WLAN-VM7KUB' freq 2462
wlan0: BSS: Add new id 4 BSSID 38:10:d5:2a:60:4d SSID 'LiMaSa Home' freq 2437
wlan0: BSS: Add new id 5 BSSID 98:9b:cb:c3:f0:f2 SSID 'Holz' freq 2412
BSS: last_scan_res_used=6/32
wlan0: New scan results available (own=0 ext=0)
WPS: AP dc:39:6f:f9:f7:ec type 0 added
WPS: AP e0:28:6d:31:f3:61 type 0 added
WPS: AP 3a:10:d5:2a:60:4d type 0 added
WPS: AP 64:cc:22:19:18:c6 type 0 added
WPS: AP 38:10:d5:2a:60:4d type 0 added
WPS: AP 98:9b:cb:c3:f0:f2 type 0 added
WPS: AP[0] dc:39:6f:f9:f7:ec type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[1] e0:28:6d:31:f3:61 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[2] 3a:10:d5:2a:60:4d type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[3] 64:cc:22:19:18:c6 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[4] 38:10:d5:2a:60:4d type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[5] 98:9b:cb:c3:f0:f2 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
wlan0: Radio work 'scan'@0x800c80c00 done in 2.429926 seconds
wlan0: radio_work_free('scan'@0x800c80c00): num_active_works --> 0
wlan0: Selecting BSS from priority group 0
wlan0: 0: dc:39:6f:f9:f7:ec ssid='Holz' wpa_ie_len=0 rsn_ie_len=20 caps=0x31 level=41 freq=2412  wps
wlan0:    skip - SSID mismatch
wlan0: 1: e0:28:6d:31:f3:61 ssid='FRITZ!Box 7430 TH' wpa_ie_len=0 rsn_ie_len=20 caps=0x31 level=28 freq=2437  wps
wlan0:    skip - SSID mismatch
wlan0: 2: 3a:10:d5:2a:60:4d ssid='LiMaSa Gast' wpa_ie_len=0 rsn_ie_len=20 caps=0x31 level=23 freq=2437  wps
wlan0:    skip - SSID mismatch
wlan0: 3: 64:cc:22:19:18:c6 ssid='WLAN-VM7KUB' wpa_ie_len=0 rsn_ie_len=20 caps=0x11 level=19 freq=2462  wps
wlan0:    skip - SSID mismatch
wlan0: 4: 38:10:d5:2a:60:4d ssid='LiMaSa Home' wpa_ie_len=0 rsn_ie_len=20 caps=0x31 level=17 freq=2437  wps
wlan0:    skip - SSID mismatch
wlan0: 5: 98:9b:cb:c3:f0:f2 ssid='Holz' wpa_ie_len=22 rsn_ie_len=20 caps=0x31 level=16 freq=2412  wps
wlan0:    skip - SSID mismatch
wlan0: No suitable network found
wlan0: Setting scan request: 5.000000 sec
wlan0: Starting AP scan for wildcard SSID
wlan0: Add radio work 'scan'@0x800c80c00
wlan0: First radio work item in the queue - schedule start immediately
wlan0: Starting radio work 'scan'@0x800c80c00 after 0.000066 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 4104 bytes of scan results (10 BSSes)
wlan0: BSS: Start scan result update 2
wlan0: BSS: Add new id 6 BSSID dc:39:6f:7d:a0:f4 SSID 'swlanw' freq 2412
wlan0: BSS: Add new id 7 BSSID dc:39:6f:1b:a1:cc SSID 'FRITZ!Box 7530 HN' freq 2437
wlan0: BSS: Add new id 8 BSSID 14:cc:20:e8:de:a7 SSID 'WLAN-413537' freq 2462
wlan0: BSS: Add new id 9 BSSID 08:96:d7:3a:95:43 SSID 'jessihome' freq 2427
BSS: last_scan_res_used=10/32
wlan0: New scan results available (own=0 ext=0)
WPS: AP dc:39:6f:7d:a0:f4 type 0 added
WPS: AP dc:39:6f:1b:a1:cc type 0 added
WPS: AP 14:cc:20:e8:de:a7 type 0 added
WPS: AP 08:96:d7:3a:95:43 type 0 added
WPS: AP[0] dc:39:6f:f9:f7:ec type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[1] e0:28:6d:31:f3:61 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[2] 3a:10:d5:2a:60:4d type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[3] 64:cc:22:19:18:c6 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[4] 38:10:d5:2a:60:4d type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[5] 98:9b:cb:c3:f0:f2 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[6] dc:39:6f:7d:a0:f4 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[7] dc:39:6f:1b:a1:cc type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[8] 14:cc:20:e8:de:a7 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
WPS: AP[9] 08:96:d7:3a:95:43 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
wlan0: Radio work 'scan'@0x800c80c00 done in 2.473168 seconds
wlan0: radio_work_free('scan'@0x800c80c00): num_active_works --> 0
wlan0: Selecting BSS from priority group 0
wlan0: 0: dc:39:6f:f9:f7:ec ssid='Holz' wpa_ie_len=0 rsn_ie_len=20 caps=0x31 level=41 freq=2412  wps
wlan0:    skip - SSID mismatch
wlan0: 1: dc:39:6f:7d:a0:f4 ssid='swlanw' wpa_ie_len=0 rsn_ie_len=20 caps=0x31 level=35 freq=2412  wps
wlan0:    selected based on RSN IE
wlan0:    selected BSS dc:39:6f:7d:a0:f4 ssid='swlanw'
wlan0: Considering connect request: reassociate: 0  selected: dc:39:6f:7d:a0:f4  bssid: 00:00:00:00:00:00  pending: 00:00:00:00:00:00  wpa_state: SCANNING  ssid=0x800a1a100  current_ssid=0x0
wlan0: Request association with dc:39:6f:7d:a0:f4
wlan0: No ongoing scan/p2p-scan found to abort
wlan0: Add radio work 'connect'@0x800c80c00
wlan0: First radio work item in the queue - schedule start immediately
RSN: Ignored PMKID candidate without preauth flag
wlan0: Starting radio work 'connect'@0x800c80c00 after 0.000105 second wait
wlan0: Trying to associate with dc:39:6f:7d:a0:f4 (SSID='swlanw' 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
RSN: PMKSA cache search - network_ctx=0x800a1a100 try_opportunistic=0 akmp=0x0
RSN: Search for BSSID dc:39:6f:7d:a0:f4
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 00 00
wlan0: WPA: AP group 0x10 network profile group 0x18; available group 0x10
wlan0: WPA: using GTK CCMP
wlan0: WPA: AP pairwise 0x10 network profile pairwise 0x18; available pairwise 0x10
wlan0: WPA: using PTK CCMP
wlan0: WPA: AP key_mgmt 0x2 network profile key_mgmt 0x3; available key_mgmt 0x2
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
WPA: Set PMK based on external data - hexdump(len=32): [REMOVED]
wlan0: Automatic auth_alg selection: 0x1
Failed to add supported operating classes IE
wlan0: State: SCANNING -> ASSOCIATING
Limit connection to BSSID dc:39:6f:7d:a0:f4 freq=2412 MHz based on scan results (bssid_set=0 wps=0)
wpa_driver_bsd_associate: ssid 'swlanw' 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
Not configuring frame filtering - BSS 00:00:00:00:00:00 is not a Hotspot 2.0 network
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=dc:39:6f:7d:a0:f4
wlan0: Associated with dc:39:6f:7d:a0:f4
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 dc:39:6f:7d:a0:f4
wlan0: Setting authentication timeout: 10 sec 0 usec
wlan0: IEEE 802.1X RX: version=2 type=3 length=95
wlan0:   EAPOL-Key type=2
wlan0:   key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack)
wlan0:   key_length=16 key_data_length=0
  replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 01
  key_nonce - hexdump(len=32): b1 86 3c 82 03 22 5d 44 a9 8c bb 19 6b 4f 8e cd 38 ca d3 c4 32 20 5d 24 06 49 10 9f ce 33 2b 45
  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 dc:39:6f:7d:a0:f4 (ver=2)
RSN: msg 1/4 key data - hexdump(len=0):
WPA: Renewed SNonce - hexdump(len=32): e1 da 7e 08 60 ce 0b 89 b7 aa 60 bb 50 d5 ae 59 49 92 7d bd db 9c d0 e2 36 2b c5 15 83 97 63 88
WPA: PTK derivation using PRF(SHA1)
WPA: PTK derivation - A1=90:48:9a:3f:f7:5f A2=dc:39:6f:7d:a0:f4
WPA: Nonce1 - hexdump(len=32): e1 da 7e 08 60 ce 0b 89 b7 aa 60 bb 50 d5 ae 59 49 92 7d bd db 9c d0 e2 36 2b c5 15 83 97 63 88
WPA: Nonce2 - hexdump(len=32): b1 86 3c 82 03 22 5d 44 a9 8c bb 19 6b 4f 8e cd 38 ca d3 c4 32 20 5d 24 06 49 10 9f ce 33 2b 45
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: Send EAPOL-Key frame to dc:39:6f:7d:a0:f4 ver=2 mic_len=16 key_mgmt=0x2
WPA: EAPOL-Key MIC using HMAC-SHA1
WPA: KCK - hexdump(len=16): [REMOVED]
WPA: Derived Key MIC - hexdump(len=16): da 59 f7 3d e2 20 9a 03 7f 5d a9 54 8d 1c 99 b4
wlan0: RX EAPOL from dc:39:6f:7d:a0:f4
wlan0: IEEE 802.1X RX: version=2 type=3 length=151
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): b1 86 3c 82 03 22 5d 44 a9 8c bb 19 6b 4f 8e cd 38 ca d3 c4 32 20 5d 24 06 49 10 9f ce 33 2b 45
  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): a4 76 8d f6 ae 0d d0 dc b4 02 b5 39 73 e5 a9 91
WPA: EAPOL-Key MIC using HMAC-SHA1
RSN: encrypted key data - hexdump(len=56): dc af f6 18 d0 72 eb 31 1b 9a 14 b6 73 50 eb 51 a7 7b 4b 23 91 a3 70 bf db ff 10 71 4b af 79 06 bf f4 91 5a 8f 0c 63 b9 4b 3d aa 96 93 06 84 ae d1 f7 88 4c 2e 3d ed c5
WPA: Decrypt Key Data using AES-UNWRAP (KEK length 16)
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 dc:39:6f:7d:a0:f4 (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 00 00 dd 16 00 0f ac 01 01 00 fe 1a 2a 77 a0 4b 42 1d b4 07 5c f2 6a b3 a0 ab 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 00 00
WPA: GTK in EAPOL-Key - hexdump(len=24): [REMOVED]
wlan0: WPA: Sending EAPOL-Key 4/4
WPA: Send EAPOL-Key frame to dc:39:6f:7d:a0:f4 ver=2 mic_len=16 key_mgmt=0x2
WPA: EAPOL-Key MIC using HMAC-SHA1
WPA: KCK - hexdump(len=16): [REMOVED]
WPA: Derived Key MIC - hexdump(len=16): d0 50 61 d5 33 f7 87 a1 27 09 a6 a1 38 4b 1d 1e
wlan0: WPA: Installing PTK to the driver
bsd_set_key: alg=3 addr=0x800a8c4f8 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): 00 00 00 00 00 00
bsd_set_key: alg=3 addr=0x4b13fc key_idx=1 set_tx=0 seq_len=6 key_len=16
wlan0: WPA: Key negotiation completed with dc:39:6f:7d:a0:f4 [PTK=CCMP GTK=CCMP]
wlan0: Cancelling authentication timeout
wlan0: State: GROUP_HANDSHAKE -> COMPLETED
wlan0: Radio work 'connect'@0x800c80c00 done in 0.636775 seconds
wlan0: radio_work_free('connect'@0x800c80c00): num_active_works --> 0
wlan0: CTRL-EVENT-CONNECTED - Connection to dc:39:6f:7d:a0:f4 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