751588 – hard to connect to PEAP using intel wifi 5100

Bug 751588 - hard to connect to PEAP using intel wifi 5100

Summary: hard to connect to PEAP using intel wifi 5100

Keywords:
Status:	CLOSED DUPLICATE of bug 746744
Alias:	None
Product:	Fedora
Classification:	Fedora
Component:	NetworkManager
Sub Component:
Version:	16
Hardware:	Unspecified
OS:	Unspecified
Priority:	unspecified
Severity:	unspecified
Target Milestone:	---
Assignee:	Dan Williams
QA Contact:	Fedora Extras Quality Assurance
Docs Contact:
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+	depends on / blocked

Reported:	2011-11-06 00:32 UTC by lionghostshop
Modified:	2012-02-01 10:10 UTC (History)
CC List:	3 users (show)
Fixed In Version:
Clone Of:
Environment:
Last Closed:	2012-02-01 10:10:53 UTC
Type:	---
Embargoed:
Dependent Products:

Attachments	(Terms of Use)
logs (538.08 KB, application/x-compressed-tar) 2011-11-07 12:30 UTC, lionghostshop	no flags	Details
View All

Description lionghostshop 2011-11-06 00:32:36 UTC

Description of problem:


Version-Release number of selected component (if applicable):
0.9.1.90-5
How reproducible:


Steps to Reproduce:
1. try to connect AP with PEAP, inner authentication MSCHAPv2
2.
3.

Actual results:
cannot connect

Expected results:
connect

Additional info:
I've changed back kernel to 2.5.40, it still does not work. It used to work. 
lspci

00:00.0 Host bridge: Intel Corporation Mobile 945GME Express Memory Controller
Hub (rev 03)
00:02.0 VGA compatible controller: Intel Corporation Mobile 945GME Express
Integrated Graphics Controller (rev 03)
00:02.1 Display controller: Intel Corporation Mobile 945GM/GMS/GME, 943/940GML
Express Integrated Graphics Controller (rev 03)
00:1b.0 Audio device: Intel Corporation N10/ICH 7 Family High Definition Audio
Controller (rev 02)
00:1c.0 PCI bridge: Intel Corporation N10/ICH 7 Family PCI Express Port 1 (rev
02)
00:1c.2 PCI bridge: Intel Corporation N10/ICH 7 Family PCI Express Port 3 (rev
02)
00:1d.0 USB Controller: Intel Corporation N10/ICH 7 Family USB UHCI Controller
#1 (rev 02)
00:1d.1 USB Controller: Intel Corporation N10/ICH 7 Family USB UHCI Controller
#2 (rev 02)
00:1d.2 USB Controller: Intel Corporation N10/ICH 7 Family USB UHCI Controller
#3 (rev 02)
00:1d.3 USB Controller: Intel Corporation N10/ICH 7 Family USB UHCI Controller
#4 (rev 02)
00:1d.7 USB Controller: Intel Corporation N10/ICH 7 Family USB2 EHCI Controller
(rev 02)
00:1e.0 PCI bridge: Intel Corporation 82801 Mobile PCI Bridge (rev e2)
00:1f.0 ISA bridge: Intel Corporation 82801GBM (ICH7-M) LPC Interface Bridge
(rev 02)
00:1f.2 IDE interface: Intel Corporation 82801GBM/GHM (ICH7 Family) SATA IDE
Controller (rev 02)
00:1f.3 SMBus: Intel Corporation N10/ICH 7 Family SMBus Controller (rev 02)
02:00.0 Network controller: Intel Corporation WiFi Link 5100
03:00.0 Ethernet controller: Marvell Technology Group Ltd. 88E8040 PCI-E Fast
Ethernet Controller (rev 13)

Comment 1 Jirka Klimes 2011-11-07 12:15:44 UTC

Would you attach /var/log/messages and /var/log/wpa_supplicant.log, so that we can see the logs?

Comment 2 lionghostshop 2011-11-07 12:30:30 UTC

Created attachment 532031 [details]
logs

Some successful cases is for another AP with WPA

Comment 3 Jirka Klimes 2011-11-07 13:50:52 UTC

We need debug logs from wpa_supplicant. To get those please do:

1) add -dddt to wpa_supplicant Exec= command line in /usr/share/dbus-1/system-services/fi.w1.wpa_supplicant1.service
Exec=/usr/sbin/wpa_supplicant -c /etc/wpa_supplicant/wpa_supplicant.conf -B -u -f /var/log/wpa_supplicant.log -P /var/run/wpa_supplicant.pid -dddt

2) kill wpa_supplicant (it will be automatically re-executed)
# killall wpa_supplicant

3) in a terminal run as root:
# tail -f /var/log/wpa_supplicant

4) try to connect to the PEAP AP

5) attach output from command in 3)

(To restore normal logging, remove -dddt again)

Comment 4 lionghostshop 2011-11-07 15:38:53 UTC

1320680355.495092: dbus: fi.w1.wpa_supplicant1.Interface.Disconnect (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680355.495916: wpa_driver_nl80211_deauthenticate
1320680355.527040: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=0 set_tx=0 seq_len=0 key_len=0
1320680355.527317: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=1 set_tx=0 seq_len=0 key_len=0
1320680355.527604: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=2 set_tx=0 seq_len=0 key_len=0
1320680355.527810: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=3 set_tx=0 seq_len=0 key_len=0
1320680355.527974: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x9f5959c key_idx=0 set_tx=0 seq_len=0 key_len=0
1320680355.528050:    addr=00:23:89:71:e0:da
1320680355.528160: State: COMPLETED -> DISCONNECTED
1320680355.528221: wpa_driver_nl80211_set_operstate: operstate 1->0 (DORMANT)
1320680355.528278: netlink: Operstate: linkmode=-1, operstate=5
1320680355.529276: EAPOL: External notification - portEnabled=0
1320680355.529397: EAPOL: SUPP_PAE entering state DISCONNECTED
1320680355.529448: EAPOL: Supplicant port status: Unauthorized
1320680355.547209: EAPOL: SUPP_BE entering state INITIALIZE
1320680355.547657: EAPOL: Supplicant port status: Unauthorized
1320680355.548043: EAPOL: External notification - portValid=0
1320680355.552652: EAPOL: Supplicant port status: Unauthorized
1320680355.553182: EAPOL: External notification - EAP success=0
1320680355.553465: EAPOL: Supplicant port status: Unauthorized
1320680355.554781: dbus: fi.w1.wpa_supplicant1.Interface.RemoveNetwork (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680355.572707: dbus: Unregister network object '/fi/w1/wpa_supplicant1/Interfaces/1/Networks/0'
1320680355.573508: nl80211: Event message available
1320680355.588028: nl80211: MLME event 39
1320680355.588378: nl80211: MLME event frame - hexdump(len=26): c0 00 00 00 00 23 89 71 e0 da 00 16 ea 03 d8 42 00 23 89 71 e0 da 00 00 03 00
1320680355.598634: Deauthentication notification
1320680355.598775: Added BSSID 00:00:00:00:00:00 into blacklist
1320680355.598847: CTRL-EVENT-DISCONNECTED bssid=00:00:00:00:00:00 reason=3
1320680355.598902: Disconnect event - remove keys
1320680355.599013: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=0 set_tx=0 seq_len=0 key_len=0
1320680355.599222: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=1 set_tx=0 seq_len=0 key_len=0
1320680355.599401: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=2 set_tx=0 seq_len=0 key_len=0
1320680355.602682: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x80c878d key_idx=3 set_tx=0 seq_len=0 key_len=0
1320680355.602942: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x9f5959c key_idx=0 set_tx=0 seq_len=0 key_len=0
1320680355.603029:    addr=00:00:00:00:00:00
1320680355.603142: wpa_supplicant_event_disassoc: scheduled DISCONNECT spam handler
1320680355.603208: State: DISCONNECTED -> DISCONNECTED
1320680355.603262: wpa_driver_nl80211_set_operstate: operstate 0->0 (DORMANT)
1320680355.603316: netlink: Operstate: linkmode=-1, operstate=5
1320680355.603386: EAPOL: External notification - portEnabled=0
1320680355.605651: EAPOL: Supplicant port status: Unauthorized
1320680355.606006: EAPOL: External notification - portValid=0
1320680355.606261: EAPOL: Supplicant port status: Unauthorized
1320680355.606627: EAPOL: External notification - EAP success=0
1320680355.612829: EAPOL: Supplicant port status: Unauthorized
1320680355.613198: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1320680355.622822: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1320680355.623054: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1320680355.623262: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1320680355.623467: RTM_NEWLINK: operstate=0 ifi_flags=0x1043 ([UP][RUNNING])
1320680355.626771: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1320680355.627020: nl80211: Event message available
1320680355.627269: nl80211: Ignore disconnect event when using userspace SME
1320680355.627509: nl80211: Event message available
1320680355.627835: nl80211: Ignored unknown event (cmd=20)
1320680355.672905: dbus: fi.w1.wpa_supplicant1.Interface.Disconnect (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680355.673746: dbus: org.freedesktop.DBus.Properties.Set (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680355.696985: dbus: fi.w1.wpa_supplicant1.Interface.AddNetwork (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680355.697132: dbus: Register network object '/fi/w1/wpa_supplicant1/Interfaces/1/Networks/0'
1320680355.697624: password - hexdump_ascii(len=10): [REMOVED]
1320680355.697750: eap methods - hexdump(len=16): 00 00 00 00 19 00 00 00 00 00 00 00 00 00 00 00
1320680355.697835: phase2 - hexdump_ascii(len=13):
     61 75 74 68 3d 4d 53 43 48 41 50 56 32            auth=MSCHAPV2   
1320680355.703003: ssid - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680355.703371: key_mgmt: 0x1
1320680355.703703: identity - hexdump_ascii(len=7):
     79 75 65 71 69 6c 69                              yueqili         
1320680355.704075: scan_ssid=1 (0x1)
1320680355.704309: fragment_size=1300 (0x514)
1320680355.704582: proto: 0x3
1320680355.704903: bgscan - hexdump_ascii(len=17):
     73 69 6d 70 6c 65 3a 33 30 3a 2d 34 35 3a 33 30   simple:30:-45:30
     30                                                0               
1320680355.735153: dbus: fi.w1.wpa_supplicant1.Interface.SelectNetwork (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680355.735510: Setting scan request: 0 sec 0 usec
1320680355.736330: State: DISCONNECTED -> SCANNING
1320680355.736828: Scan SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680355.737178: Starting AP scan for wildcard SSID
1320680355.739707: nl80211: Scan SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680355.740134: nl80211: Scan SSID - hexdump_ascii(len=0): [NULL]
1320680355.741421: Scan requested (ret=0) - scan timeout 30 seconds
1320680355.741628: nl80211: Event message available
1320680355.741718: nl80211: Scan trigger
1320680355.741961: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1
1320680358.762809: nl80211: Event message available
1320680358.763127: nl80211: New scan results available
1320680358.763941: Received scan results (11 BSSes)
1320680358.764121: BSS: Start scan result update 4
1320680358.764499: BSS: Add new id 16 BSSID 00:23:eb:3a:81:20 SSID 'sMobileNet'
1320680358.764688: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/16'
1320680358.765694: BSS: Expire BSS 4 due to no match in scan
1320680358.765841: BSS: Remove id 4 BSSID 00:23:eb:3a:10:c0 SSID 'sMobileNet'
1320680358.765938: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/4'
1320680358.766187: BSS: Expire BSS 6 due to no match in scan
1320680358.766279: BSS: Remove id 6 BSSID 00:23:eb:0a:cc:00 SSID 'sMobileNet'
1320680358.766377: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/6'
1320680358.766677: New scan results available
1320680358.766977: Selecting BSS from priority group 0
1320680358.767078: Try to find WPA-enabled AP
1320680358.767163: 0: 00:23:89:71:e0:da ssid='Fedora Linux Wifi' wpa_ie_len=22 rsn_ie_len=0 caps=0x411
1320680358.767261:    skip - SSID mismatch
1320680358.767345: 1: 00:23:eb:3a:0f:90 ssid='sMobileNet' wpa_ie_len=24 rsn_ie_len=20 caps=0x431
1320680358.767533:    selected based on RSN IE
1320680358.767692:    selected WPA AP 00:23:eb:3a:0f:90 ssid='sMobileNet'
1320680358.767798: Automatic auth_alg selection: 0x1
1320680358.767906: RSN: using IEEE 802.11i/D9.0
1320680358.767990: WPA: Selected cipher suites: group 8 pairwise 16 key_mgmt 1 proto 2
1320680358.768079: WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 01 00 00
1320680358.768210: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 28 00
1320680358.768339: WPA: using GTK TKIP
1320680358.768430: WPA: using PTK CCMP
1320680358.768520: WPA: using KEY_MGMT 802.1X
1320680358.768669: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 00 00
1320680358.768797: Cancelling scan request
1320680358.768900: Trying to authenticate with 00:23:eb:3a:0f:90 (SSID='sMobileNet' freq=2437 MHz)
1320680358.768985: No keys have been configured - skip key clearing
1320680358.769069: State: SCANNING -> AUTHENTICATING
1320680358.769150: wpa_supplicant_set_state: canceling DISCONNECT spam handler
1320680358.769449: EAPOL: External notification - EAP success=0
1320680358.769660: EAPOL: Supplicant port status: Unauthorized
1320680358.770159: EAPOL: External notification - EAP fail=0
1320680358.770277: EAPOL: Supplicant port status: Unauthorized
1320680358.770508: EAPOL: External notification - portControl=Auto
1320680358.770684: EAPOL: Supplicant port status: Unauthorized
1320680358.771040: nl80211: Authenticate (ifindex=3)
1320680358.771168:   * bssid=00:23:eb:3a:0f:90
1320680358.771257:   * freq=2437
1320680358.771334:   * SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680358.771483:   * IEs - hexdump(len=0): [NULL]
1320680358.771622:   * Auth Type 0
1320680358.772832: nl80211: Authentication request send successfully
1320680358.773026: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1
1320680358.773341: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1320680358.773435: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1320680358.773509: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/0
1320680358.774134: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/1
1320680358.774965: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/3
1320680358.775392: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/5
1320680358.775846: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/14
1320680358.776197: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/10
1320680358.776599: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/12
1320680358.776938: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/11
1320680358.794994: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/0)
1320680358.797724: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/1)
1320680358.802884: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/2)
1320680358.803975: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/3)
1320680358.812396: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/5)
1320680358.814259: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/7)
1320680358.815452: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/8)
1320680358.816578: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/9)
1320680358.821454: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/10)
1320680358.822848: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/11)
1320680358.835432: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/12)
1320680358.837617: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/13)
1320680358.839800: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/14)
1320680358.841247: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/15)
1320680358.849227: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/16)
1320680359.380597: nl80211: Event message available
1320680359.380836: nl80211: MLME event 37; timeout with 00:23:eb:3a:0f:90
1320680359.380930: SME: Authentication timed out
1320680359.381015: Setting scan request: 5 sec 0 usec
1320680364.386225: Scan SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680364.386439: Starting AP scan for wildcard SSID
1320680364.386847: nl80211: Scan SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680364.387032: nl80211: Scan SSID - hexdump_ascii(len=0): [NULL]
1320680364.388518: Scan requested (ret=0) - scan timeout 30 seconds
1320680364.388743: nl80211: Event message available
1320680364.388871: nl80211: Scan trigger
1320680364.391937: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1
1320680367.536793: nl80211: Event message available
1320680367.537045: nl80211: New scan results available
1320680367.537867: Received scan results (13 BSSes)
1320680367.538026: BSS: Start scan result update 5
1320680367.538340: BSS: Add new id 17 BSSID 00:23:eb:3a:10:c0 SSID 'sMobileNet'
1320680367.538470: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/17'
1320680367.539429: BSS: Expire BSS 2 due to no match in scan
1320680367.539637: BSS: Remove id 2 BSSID 00:23:eb:3a:8a:d0 SSID 'sMobileNet'
1320680367.539730: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/2'
1320680367.539980: BSS: Expire BSS 8 due to no match in scan
1320680367.540069: BSS: Remove id 8 BSSID 28:93:fe:f4:04:05 SSID 'Universities WiFi'
1320680367.540165: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/8'
1320680367.540401: BSS: Expire BSS 9 due to no match in scan
1320680367.540488: BSS: Remove id 9 BSSID 00:02:a8:d2:1d:44 SSID ''
1320680367.540730: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/9'
1320680367.540991: BSS: Expire BSS 15 due to no match in scan
1320680367.541090: BSS: Remove id 15 BSSID 28:93:fe:f4:04:04 SSID 'PCCW'
1320680367.541191: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/15'
1320680367.541425: BSS: Expire BSS 13 due to no match in scan
1320680367.541518: BSS: Remove id 13 BSSID 28:93:fe:f4:04:02 SSID 'Y5ZONE'
1320680367.541684: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/13'
1320680367.541933: New scan results available
1320680367.542222: RSN: Ignored PMKID candidate without preauth flag
1320680367.542318: RSN: Ignored PMKID candidate without preauth flag
1320680367.542405: RSN: Ignored PMKID candidate without preauth flag
1320680367.542490: RSN: Ignored PMKID candidate without preauth flag
1320680367.542705: RSN: Ignored PMKID candidate without preauth flag
1320680367.542784: RSN: Ignored PMKID candidate without preauth flag
1320680367.542853: RSN: Ignored PMKID candidate without preauth flag
1320680367.542925: RSN: Ignored PMKID candidate without preauth flag
1320680367.542995: Selecting BSS from priority group 0
1320680367.543107: Try to find WPA-enabled AP
1320680367.543153: 0: 00:23:89:71:e0:da ssid='Fedora Linux Wifi' wpa_ie_len=22 rsn_ie_len=0 caps=0x411
1320680367.543207:    skip - SSID mismatch
1320680367.543253: 1: 00:23:eb:3a:0f:90 ssid='sMobileNet' wpa_ie_len=24 rsn_ie_len=20 caps=0x431
1320680367.543307:    selected based on RSN IE
1320680367.543351:    selected WPA AP 00:23:eb:3a:0f:90 ssid='sMobileNet'
1320680367.543412: Automatic auth_alg selection: 0x1
1320680367.543671: RSN: using IEEE 802.11i/D9.0
1320680367.543880: WPA: Selected cipher suites: group 8 pairwise 16 key_mgmt 1 proto 2
1320680367.544079: WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 01 00 00
1320680367.547319: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 28 00
1320680367.548897: WPA: using GTK TKIP
1320680367.549182: WPA: using PTK CCMP
1320680367.549360: WPA: using KEY_MGMT 802.1X
1320680367.549533: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 00 00
1320680367.549801: Cancelling scan request
1320680367.549977: Trying to authenticate with 00:23:eb:3a:0f:90 (SSID='sMobileNet' freq=2437 MHz)
1320680367.550149: No keys have been configured - skip key clearing
1320680367.550311: State: AUTHENTICATING -> AUTHENTICATING
1320680367.550483: EAPOL: External notification - EAP success=0
1320680367.550686: EAPOL: Supplicant port status: Unauthorized
1320680367.550993: EAPOL: External notification - EAP fail=0
1320680367.551175: EAPOL: Supplicant port status: Unauthorized
1320680367.551434: EAPOL: External notification - portControl=Auto
1320680367.551658: EAPOL: Supplicant port status: Unauthorized
1320680367.551963: nl80211: Authenticate (ifindex=3)
1320680367.552153:   * bssid=00:23:eb:3a:0f:90
1320680367.552318:   * freq=2437
1320680367.552485:   * SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680367.552827:   * IEs - hexdump(len=0): [NULL]
1320680367.553000:   * Auth Type 0
1320680367.553246: nl80211: Authentication request send successfully
1320680367.553462: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1
1320680367.553959: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1320680367.554165: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1320680367.554369: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/0
1320680367.554779: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/1
1320680367.555244: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/3
1320680367.555835: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/7
1320680367.556251: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/10
1320680367.556673: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/12
1320680367.596094: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/0)
1320680367.596857: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/1)
1320680367.597476: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/3)
1320680367.598059: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/5)
1320680367.601914: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/7)
1320680367.607453: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/10)
1320680367.608927: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/11)
1320680367.610313: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/12)
1320680367.615463: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/14)
1320680367.616815: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/16)
1320680367.621176: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/17)
1320680368.158648: nl80211: Event message available
1320680368.158877: nl80211: MLME event 37; timeout with 00:23:eb:3a:0f:90
1320680368.158969: SME: Authentication timed out
1320680368.159053: Setting scan request: 5 sec 0 usec
1320680373.159654: Scan SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680373.159879: Starting AP scan for wildcard SSID
1320680373.160191: nl80211: Scan SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680373.160365: nl80211: Scan SSID - hexdump_ascii(len=0): [NULL]
1320680373.161821: Scan requested (ret=0) - scan timeout 30 seconds
1320680373.162005: nl80211: Event message available
1320680373.162130: nl80211: Scan trigger
1320680373.165278: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1
1320680376.310899: nl80211: Event message available
1320680376.311241: nl80211: New scan results available
1320680376.311944: Received scan results (11 BSSes)
1320680376.312135: BSS: Start scan result update 6
1320680376.313079: BSS: Add new id 18 BSSID 28:93:fe:f4:04:00 SSID 'sMobileNet'
1320680376.313249: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/18'
1320680376.314207: New scan results available
1320680376.314619: RSN: Ignored PMKID candidate without preauth flag
1320680376.314727: RSN: Ignored PMKID candidate without preauth flag
1320680376.314802: RSN: Ignored PMKID candidate without preauth flag
1320680376.314877: RSN: Ignored PMKID candidate without preauth flag
1320680376.314950: RSN: Ignored PMKID candidate without preauth flag
1320680376.315030: RSN: Ignored PMKID candidate without preauth flag
1320680376.315112: RSN: Ignored PMKID candidate without preauth flag
1320680376.315195: RSN: Ignored PMKID candidate without preauth flag
1320680376.315269: Selecting BSS from priority group 0
1320680376.315343: Try to find WPA-enabled AP
1320680376.315422: 0: 00:23:89:71:e0:da ssid='Fedora Linux Wifi' wpa_ie_len=22 rsn_ie_len=0 caps=0x411
1320680376.315519:    skip - SSID mismatch
1320680376.315670: 1: 00:23:eb:3a:0f:90 ssid='sMobileNet' wpa_ie_len=24 rsn_ie_len=20 caps=0x431
1320680376.315770:    selected based on RSN IE
1320680376.315853:    selected WPA AP 00:23:eb:3a:0f:90 ssid='sMobileNet'
1320680376.315959: Automatic auth_alg selection: 0x1
1320680376.316062: RSN: using IEEE 802.11i/D9.0
1320680376.316147: WPA: Selected cipher suites: group 8 pairwise 16 key_mgmt 1 proto 2
1320680376.316238: WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 01 00 00
1320680376.316368: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 28 00
1320680376.316497: WPA: using GTK TKIP
1320680376.316640: WPA: using PTK CCMP
1320680376.316729: WPA: using KEY_MGMT 802.1X
1320680376.316813: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 00 00
1320680376.316942: Cancelling scan request
1320680376.317046: Trying to authenticate with 00:23:eb:3a:0f:90 (SSID='sMobileNet' freq=2437 MHz)
1320680376.317132: No keys have been configured - skip key clearing
1320680376.317214: State: AUTHENTICATING -> AUTHENTICATING
1320680376.317304: EAPOL: External notification - EAP success=0
1320680376.317390: EAPOL: Supplicant port status: Unauthorized
1320680376.317722: EAPOL: External notification - EAP fail=0
1320680376.317835: EAPOL: Supplicant port status: Unauthorized
1320680376.318060: EAPOL: External notification - portControl=Auto
1320680376.318225: EAPOL: Supplicant port status: Unauthorized
1320680376.318772: nl80211: Authenticate (ifindex=3)
1320680376.318911:   * bssid=00:23:eb:3a:0f:90
1320680376.319004:   * freq=2437
1320680376.319090:   * SSID - hexdump_ascii(len=10):
     73 4d 6f 62 69 6c 65 4e 65 74                     sMobileNet      
1320680376.319239:   * IEs - hexdump(len=0): [NULL]
1320680376.319324:   * Auth Type 0
1320680376.319626: nl80211: Authentication request send successfully
1320680376.319904: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1320680376.320215: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1320680376.320333: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1
1320680376.321034: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/0
1320680376.321942: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/1
1320680376.324932: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/3
1320680376.325610: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/17
1320680376.326085: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/16
1320680376.326524: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/7
1320680376.326916: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1/BSSs/10
1320680376.335616: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/0)
1320680376.344869: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/1)
1320680376.345710: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/3)
1320680376.352017: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/5)
1320680376.353049: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/7)
1320680376.364195: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/10)
1320680376.370042: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/11)
1320680376.376527: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/12)
1320680376.378733: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/14)
1320680376.380837: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/16)
1320680376.384827: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/17)
1320680376.386978: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1/BSSs/18)
1320680376.926623: nl80211: Event message available
1320680376.926836: nl80211: MLME event 37; timeout with 00:23:eb:3a:0f:90
1320680376.926929: SME: Authentication timed out
1320680376.927013: Setting scan request: 5 sec 0 usec
1320680380.785041: dbus: fi.w1.wpa_supplicant1.Interface.Disconnect (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680380.785224: No keys have been configured - skip key clearing
1320680380.785301: State: AUTHENTICATING -> DISCONNECTED
1320680380.785379: wpa_driver_nl80211_set_operstate: operstate 0->0 (DORMANT)
1320680380.785458: netlink: Operstate: linkmode=-1, operstate=5
1320680380.785864: EAPOL: External notification - portEnabled=0
1320680380.785978: EAPOL: Supplicant port status: Unauthorized
1320680380.786244: EAPOL: External notification - portValid=0
1320680380.786355: EAPOL: Supplicant port status: Unauthorized
1320680380.788401: dbus: fi.w1.wpa_supplicant1.Interface.RemoveNetwork (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680380.788665: dbus: Unregister network object '/fi/w1/wpa_supplicant1/Interfaces/1/Networks/0'
1320680380.791064: dbus: fi.w1.wpa_supplicant1.Interface.Disconnect (/fi/w1/wpa_supplicant1/Interfaces/1)
1320680381.928351: State: DISCONNECTED -> DISCONNECTED
1320680381.928484: wpa_driver_nl80211_set_operstate: operstate 0->0 (DORMANT)
1320680381.928570: netlink: Operstate: linkmode=-1, operstate=5

Comment 5 Jirka Klimes 2011-11-08 11:20:14 UTC

Hmm, it looks like a driver problem.
Does swcrypto=1 option help as suggested in bug 697706?

CCing sgruszka. Stanislaw, could you look at the problem?

Comment 6 lionghostshop 2011-11-08 11:26:53 UTC

As long as I remember, swcrypto=1 will make the wifi card not able to turn on

Comment 7 Stanislaw Gruszka 2011-11-08 12:13:56 UTC

Ehh, we have opened bug 746744, where we put blame on NetworkManager. 

Option swcrypto=1 should work, option swcrypto50=1 is no longer available and it prevent iwlagn module to load.

Comment 8 lionghostshop 2011-11-08 12:27:25 UTC

swcrypto=1, module can be loaded, but still cannot connect

Comment 9 Stanislaw Gruszka 2011-11-08 12:42:40 UTC

I think the key for solving this problem is finding out what happened here:
https://bugzilla.redhat.com/show_bug.cgi?id=697706#c4

Comment 10 lionghostshop 2012-02-01 01:53:52 UTC

The problem still persist in kernel 3.2.2-1. Would you try to fix it? Thank you

Comment 11 Jirka Klimes 2012-02-01 07:44:41 UTC

Kernel 3.2.2-1 broke some wireless drivers.

Please see bug 785239 and try a build from
https://bugzilla.redhat.com/show_bug.cgi?id=785239#c10

Comment 12 lionghostshop 2012-02-01 07:48:12 UTC

It was already broken in 3.1

Comment 13 Stanislaw Gruszka 2012-02-01 10:10:53 UTC


*** This bug has been marked as a duplicate of bug 746744 ***

Note You need to log in before you can comment on or make changes to this bug.