Date: Fri, 9 Feb 2018 11:45:52 +1100 From: Trev <freebsd-wifi@sentry.org> To: freebsd-wireless@freebsd.org Subject: Re: Mac Mini late 2009 BCM4321 issues :) Message-ID: <52d64b1e-d9c4-ccca-426a-f36be3412e8b@sentry.org> In-Reply-To: <6e188362-fad7-4dee-967b-1280ebe8978e@sentry.org> References: <6e188362-fad7-4dee-967b-1280ebe8978e@sentry.org>
next in thread | previous in thread | raw e-mail | index | archive | help
Trev wrote on 09/03/2017 17:55:
> 1A, uname -a shows:
>=20
> FreeBSD citadel.sentry.org 11.0-STABLE FreeBSD 11.0-STABLE #0 \
> r314907M: Thu Mar=C2=A0 9 04:26:47 AEDT 2017 \
> root@citadel.sentry.org:/usr/obj/usr/src/sys/GENERIC=C2=A0 amd64
>=20
>=20
> 1B. dmesg shows:
>=20
> siba_bwn0: <Broadcom BCM4321 802.11a/b/g/n Wireless> \
> mem 0xd3200000-0xd3203fff at device 0.0 on pci3
> siba_bwn0: warn: multiple PCI(E) cores
> siba_bwn0: unsupported coreid (USB 1.1 Host)
> bwn0 on siba_bwn0
> bwn0: WLAN (chipid 0x4321 rev 12) PHY (analog 5 type 4 rev 2) \
> RADIO (manuf 0x17f ver 0x2055 rev 4)
> bwn0: DMA (64 bits)
> bwn0: Note: compiled with BWN_GPL_PHY; includes GPLv2 code
> bwn0: Using 1 MSI messages
>=20
>=20
> 2. wpa_supplicant.conf contains:
>=20
> =C2=A0=C2=A0 network=3D{
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 ssid=3D"WLAN24G"
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 psk=3D"my_password"
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 }
>=20
>=20
> 3, wlan0 is created with:
>=20
> ifconfig wlan0 create wlandev bwn0 wlanaddr 48:02:2a:63:4e:c1 \
> inet 192.168.1.99 channel 3
>=20
> Note: Unless I specify a wlanaddr then wlan0 is created with a mac=20
> address of ff:ff:ff:ff:ff:ff
>=20
>=20
> 4. ifconfig wlan0 shows:
>=20
> wlan0: flags=3D8c02<BROADCAST,OACTIVE,SIMPLEX,MULTICAST> metric 0 mtu 1=
500
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 ether 48:02:2a:63:4e:c1
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 inet 192.168.1.99 netmask 0=
xffffff00 broadcast 192.168.1.255
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 inet6 fe80::4a02:2aff:fe63:=
4ec1%wlan0 prefixlen 64 tentative=20
> scopeid 0x3
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 nd6 options=3D21<PERFORMNUD=
,AUTO_LINKLOCAL>
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 media: IEEE 802.11 Wireless=
Ethernet autoselect (autoselect)
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 status: no carrier
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 ssid "" channel 3 (2422 MHz=
11g)
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 regdomain FCC country US au=
thmode OPEN privacy OFF txpower 30=20
> bmiss 7
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 scanvalid 60 protmode CTS w=
me
> =C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 groups: wlan
>=20
>=20
> 5. ifconfig wlan0 scan shows (among others):
> SSID/MESH ID=C2=A0=C2=A0=C2=A0 BSSID=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=
=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 CHAN RATE=C2=A0=C2=A0=C2=A0 S:=
N=C2=A0=C2=A0=C2=A0=C2=A0 INT CAPS
> WLAN24G=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 34:31:c4:bc:d0:=
21=C2=A0=C2=A0=C2=A0 3=C2=A0=C2=A0 54M=C2=A0 -77:-95=C2=A0=C2=A0 100 EPS=C2=
=A0 HTCAP=20
> WME ATH RSN
>=20
>=20
> 5. wpa_supplicant -dd -i wlan0 -c /etc/wpa_supplicant.conf produces:
>=20
> wpa_supplicant v2.5
> Successfully initialized wpa_supplicant
> Initializing interface 'wlan0' conf '/etc/wpa_supplicant.conf' driver=20
> 'default' ctrl_interface 'N/A' bridge 'N/A'
> Configuration file '/etc/wpa_supplicant.conf' -> '/etc/wpa_supplicant.c=
onf'
> Reading configuration file '/etc/wpa_supplicant.conf'
> Line: 5 - start of a new network block
> ssid - hexdump_ascii(len=3D7):
> =C2=A0=C2=A0=C2=A0=C2=A0 57 4c 41 4e 32 34 47=C2=A0=C2=A0=C2=A0=C2=A0=C2=
=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=
=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0=C2=A0 =
WLAN24G
> PSK (ASCII passphrase) - hexdump_ascii(len=3D16): [REMOVED]
> PSK (from passphrase) - hexdump(len=3D32): [REMOVED]
> Priority group 0
> =C2=A0=C2=A0 id=3D0 ssid=3D'WLAN24G'
> wpa_driver_bsd_capa: drivercaps=3D0x0581e801,cryptocaps=3D0x00000000
> Add interface wlan0 to a new radio N/A
> wlan0: Own MAC address: 48:02:2a:63:4e:c1
> bsd_set_key: alg=3D0 addr=3D0x0 key_idx=3D0 set_tx=3D0 seq_len=3D0 key_=
len=3D0
> bsd_del_key: key_idx=3D0
> bsd_set_key: alg=3D0 addr=3D0x0 key_idx=3D1 set_tx=3D0 seq_len=3D0 key_=
len=3D0
> bsd_del_key: key_idx=3D1
> bsd_set_key: alg=3D0 addr=3D0x0 key_idx=3D2 set_tx=3D0 seq_len=3D0 key_=
len=3D0
> bsd_del_key: key_idx=3D2
> bsd_set_key: alg=3D0 addr=3D0x0 key_idx=3D3 set_tx=3D0 seq_len=3D0 key_=
len=3D0
> bsd_del_key: key_idx=3D3
> wpa_driver_bsd_set_countermeasures: enabled=3D0
> wlan0: RSN: flushing PMKID list in the driver
> wlan0: Setting scan request: 0.100000 sec
> wlan0: WPS: UUID based on MAC address: dbcf9172-a2c4-5074-bfc2-05bfaecc=
535f
> 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
> wlan0: Added interface wlan0
> wlan0: State: DISCONNECTED -> DISCONNECTED
> wlan0: State: DISCONNECTED -> SCANNING
> wlan0: Starting AP scan for wildcard SSID
> wlan0: Add radio work 'scan'@0x801ce4000
> wlan0: First radio work item in the queue - schedule start immediately
> wlan0: Starting radio work 'scan'@0x801ce4000 after 0.000012 second wai=
t
> wpa_driver_bsd_set_wpa: enabled=3D1
> wpa_driver_bsd_set_wpa_internal: wpa=3D3 privacy=3D1
> wlan0: Event SCAN_RESULTS (3) received
> Received 868 bytes of scan results (4 BSSes)
> wlan0: BSS: Start scan result update 1
> wlan0: BSS: Add new id 0 BSSID 48:02:2a:61:6a:24 SSID 'router-2' freq 2=
422
> wlan0: BSS: Add new id 1 BSSID 48:02:2a:63:4e:c0 SSID 'router-3' freq 2=
422
> wlan0: BSS: Add new id 2 BSSID 34:31:c4:bc:d0:21 SSID 'WLAN24G' freq 24=
22
> wlan0: BSS: Add new id 3 BSSID 44:33:4c:b5:d3:68 SSID 'router-4' freq 2=
422
> BSS: last_scan_res_used=3D4/32
> wlan0: New scan results available (own=3D0 ext=3D0)
> wlan0: Radio work 'scan'@0x801ce4000 done in 0.212149 seconds
> wlan0: Selecting BSS from priority group 0
> wlan0: 0: 48:02:2a:61:6a:24 ssid=3D'router-2' wpa_ie_len=3D0 rsn_ie_len=
=3D20=20
> caps=3D0x11 level=3D-66 freq=3D2422
> wlan0:=C2=A0=C2=A0=C2=A0 skip - SSID mismatch
> wlan0: 1: 48:02:2a:63:4e:c0 ssid=3D'router-3' wpa_ie_len=3D0 rsn_ie_len=
=3D20=20
> caps=3D0x11 level=3D-69 freq=3D2422
> wlan0:=C2=A0=C2=A0=C2=A0 skip - SSID mismatch
> wlan0: 2: 34:31:c4:bc:d0:21 ssid=3D'WLAN24G' wpa_ie_len=3D0 rsn_ie_len=3D=
20=20
> caps=3D0x31 level=3D-77 freq=3D2422
> wlan0:=C2=A0=C2=A0=C2=A0 selected based on RSN IE
> wlan0:=C2=A0=C2=A0=C2=A0 selected BSS 34:31:c4:bc:d0:21 ssid=3D'WLAN24G=
'
> wlan0: Considering connect request: reassociate: 0=C2=A0 selected:=20
> 34:31:c4:bc:d0:21=C2=A0 bssid: 00:00:00:00:00:00=C2=A0 pending: 00:00:0=
0:00:00:00=20
> wpa_state: SCANNING=C2=A0 ssid=3D0x801c45000=C2=A0 current_ssid=3D0x0
> wlan0: Request association with 34:31:c4:bc:d0:21
> wlan0: Add radio work 'connect'@0x801ce4000
> wlan0: First radio work item in the queue - schedule start immediately
> wlan0: Starting radio work 'connect'@0x801ce4000 after 0.000009 second =
wait
> wlan0: Trying to associate with 34:31:c4:bc:d0:21 (SSID=3D'WLAN24G'=20
> freq=3D2422 MHz)
> FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=3D=
0):
> wlan0: Cancelling scan request
> wlan0: WPA: clearing own WPA/RSN IE
> wlan0: Automatic auth_alg selection: 0x1
> RSN: PMKSA cache search - network_ctx=3D0x801c45000 try_opportunistic=3D=
0
> RSN: Search for BSSID 34:31:c4:bc:d0:21
> 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 pro=
to 2
> wlan0: WPA: clearing AP WPA IE
> WPA: set AP RSN IE - hexdump(len=3D22): 30 14 01 00 00 0f ac 04 01 00 0=
0=20
> 0f ac 04 01 00 00 0f ac 02 00 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=3D22): 30 14 01 00 00 0f ac 0=
4=20
> 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
> wlan0: State: SCANNING -> ASSOCIATING
> Limit connection to BSSID 34:31:c4:bc:d0:21 freq=3D2422 MHz based on sc=
an=20
> results (bssid_set=3D0)
> wpa_driver_bsd_associate: ssid 'WLAN24G' wpa ie len 22 pairwise 16 grou=
p=20
> 16 key mgmt 2
> wpa_driver_bsd_set_drop_unencrypted: enabled=3D1
> 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=3D0
> EAPOL: External notification - EAP fail=3D0
> EAPOL: External notification - portControl=3DAuto
> EAPOL: disable timer tick
> wlan0: Authentication with 34:31:c4:bc:d0:21 timed out.
> Added BSSID 34:31:c4:bc:d0:21 into blacklist
> wlan0: WPA: Clear old PMK and PTK
> wlan0: Request to deauthenticate - bssid=3D00:00:00:00:00:00=20
> pending_bssid=3D34:31:c4:bc:d0:21 reason=3D3 state=3DASSOCIATING
> wlan0: Event DEAUTH (12) received
> wlan0: Deauthentication notification
> wlan0:=C2=A0 * reason 3 (locally generated)
> Deauthentication frame IE(s) - hexdump(len=3D0): [NULL]
> wlan0: CTRL-EVENT-DISCONNECTED bssid=3D34:31:c4:bc:d0:21 reason=3D3=20
> locally_generated=3D1
> wlan0: Auto connect enabled: try to reconnect (wps=3D0/0 wpa_state=3D5)=
> wlan0: Setting scan request: 0.100000 sec
> wlan0: Radio work 'connect'@0x801ce4000 done in 10.022229 seconds
> [etc]
>=20
> and never manages to associate successfully.
>=20
> Any ideas?
As per Adrian's advice I updated to head via source (12.0-CURRENT #0=20
r315191M: Tue Mar 14 02:02:24 AEDT 2017)
However, the result was the same. No successful association.
Today I upgraded head via source to 12.0-CURRENT #0 r329009: Thu Feb 8=20
21:13:07 AEDT 2018 and I seem to be going backwards. The log file now sho=
ws:
Feb 9 11:32:40 citadel kernel: wlan0: Ethernet address: 00:26:b0:f7:a1:e=
c
Feb 9 11:32:40 citadel kernel: bwn0: ucode fw: ucode11
Feb 9 11:32:40 citadel kernel: bwn0: firmware version (rev 410 patch=20
2160 date 0x751a time 0x7c0a)
Feb 9 11:32:40 citadel kernel: bwn0: NVRAM variable txpid5ga0 unreadable=
: 2
Feb 9 11:32:40 citadel kernel: bwn0: PHY init failed
Feb 9 11:32:40 citadel kernel: bwn0: need multicast update callback
Feb 9 11:32:44 citadel kernel: bwn0: ucode fw: ucode11
Feb 9 11:32:45 citadel kernel: bwn0: firmware version (rev 410 patch=20
2160 date 0x751a time 0x7c0a)
Feb 9 11:32:45 citadel kernel: bwn0: NVRAM variable txpid5ga0 unreadable=
: 2
Feb 9 11:32:45 citadel kernel: bwn0: PHY init failed
Feb 9 11:33:32 citadel kernel: bwn0: ucode fw: ucode11
Feb 9 11:33:32 citadel kernel: bwn0: firmware version (rev 410 patch=20
2160 date 0x751a time 0x7c0a)
Feb 9 11:33:32 citadel kernel: bwn0: NVRAM variable txpid5ga0 unreadable=
: 2
Feb 9 11:33:32 citadel kernel: bwn0: PHY init failed
On the plus side, I no longer have to specify a MAC address as it is no=20
longer ff:ff:ff:ff:ff:ff :-)
Any further ideas?
Thanks,
TREV.
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?52d64b1e-d9c4-ccca-426a-f36be3412e8b>