Preventing wifi interface from shutting down
212 views
Skip to first unread message
Elvis Dowson
Sep 27, 2010, 7:26:10 AM9/27/10
to android-porting
Hi,
I have an issue with android-rowboat-froyo-2.2, running on the
Gumstix Overo (TI OMAP3503) + Palo43 expansion board (nearly
equivalent to the BeagleBoard design), whereby the wifi connection
drops in under a minute. I am using the android-rowboat-eclair-2.6.32
kernel branch, and in my defconfig, I have disabled CONFIG_PM_SUSPEND.
There was a system property in android, can't recall where, but I saw
it while going through the sources, that specified that the board
should not use power management. This is not for a mobile application,
and the requirement is to keep the wifi connection always on.
I am using a Ralink RT3070STA usb wifi module.
Is there anyway to force the wifi to stay connected? I've noticed that
after it drops the connection, if I click on a link in the browser, it
doesn't attempt to automatically re-establish the network connection.
Best regards,
Elvis Dowson
I have an issue with android-rowboat-froyo-2.2, running on the
Gumstix Overo (TI OMAP3503) + Palo43 expansion board (nearly
equivalent to the BeagleBoard design), whereby the wifi connection
drops in under a minute. I am using the android-rowboat-eclair-2.6.32
kernel branch, and in my defconfig, I have disabled CONFIG_PM_SUSPEND.
There was a system property in android, can't recall where, but I saw
it while going through the sources, that specified that the board
should not use power management. This is not for a mobile application,
and the requirement is to keep the wifi connection always on.
I am using a Ralink RT3070STA usb wifi module.
Is there anyway to force the wifi to stay connected? I've noticed that
after it drops the connection, if I click on a link in the browser, it
doesn't attempt to automatically re-establish the network connection.
Best regards,
Elvis Dowson
Elvis Dowson
Sep 27, 2010, 7:28:07 AM9/27/10
to android-porting
Here is the log output, to the point where the network shuts down
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
SYNC - send NULL Frame @24 Mbps...
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
BEACON lost > 512 msec with TxOkCnt=0 -> CQI=0
MMCHK - No BEACON. Dead CQI. Auto Recovery attempt #0
!!! LINK DOWN !!!
!!! LINK DOWN 2!!!
BAOriSessionTearDown===>Wcid=1.TID=0
===>Idx = 1, Wcid=1.TID=0, ORI_BA_Status = 3
==> MlmeDELBAAction(), Initiator(1)
BA - MlmeDELBAAction() . Send BAR to refresh peer reordering buffer
BA - MlmeDELBAAction() . 3 DELBA sent. Initiator(1)
BATableFreeOriEntry numAsOriginator= 1
BARecSessionTearDown===>Wcid=1.TID=0
===>Idx = 1, Wcid=1.TID=0, REC_BA_Status = 3
==> MlmeDELBAAction(), Initiator(0)
BA - MlmeDELBAAction() . Send BAR to refresh peer reordering buffer
BA - MlmeDELBAAction() . 3 DELBA sent. Initiator(0)
MacTableDeleteEntry1 - Total= 0
CmdThread : CMDTHREAD_SET_ASIC_WCID : WCID = 1, SetTid = ffffffff,
DeleteTid = ffffffff.
1-MACValue= 0,
AsicSetEdcaParm
2-MACValue= 10000,
CmdThread : CMDTHREAD_SET_ASIC_WCID : WCID = 1, SetTid = ffffffff,
DeleteTid = 10000.
1-MACValue= 0,
2-MACValue= 0,
RTMPSetLED::Mode=1,HighByte=0x20,LowByte=0x01
--->Disable TSF synchronization
LinkDownCleanMlmeAux.ExtCapInfo!
D/wpa_supplicant( 1088): RTM_NEWAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
LINK: operstate=1 ifi_flags=0x11Driver auto reconnect to last
OID_802_11_SSID setting - Olympus2, len - 8
043 ([UP][RUNNING][LOWER_UP])
D WCIDAttri = 0x1
/wpa_supplicant( 1088): RTM_NEWLCntlOidSsidProc():CNTL - 0 BSS of 0
BSS match the desire INK, IFLA_IFNAME: Interface
'wlaAsicRemovePairwiseKeyEntry : Wcid #1
n0' added
D/wpa_supplicant( 108(8)SSID - Olympus2
8): Wireless event: cmd=0x8b15 lCntlOidSsidProc():CNTL - No matching
BSS, start a new scan
en=20
D/wpa_supplicant( 1088): AsicRemoveSharedKeyEntry: #0
Wireless event: new AP: 00:00:00SCANNING, suspend MSDU
transmission ...
:00:00:00
D/wpa_supplicant( 108Write: SHARED_KEY_MODE_BASE at this Bss[0] =
0x300
8): Setting scan request: 0 sec rt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8001)
100000 usec
D/wpa_supplicant( 1SYNC - BBP R4 to 20MHz.l
088): Added BSSID 68:7f:74:1c:e4AsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
:7c into blacklist
I/wpa_suppli WCIDAttri = 0x1
cant( 1088): CTRL-EVENT-DISCONNEAsicRemovePairwiseKeyEntry : Wcid #1
CTED - Disconnect event - removeAsicRemoveSharedKeyEntry: #1
keys
V/WifiMonitor( 959): EveWrite: SHARED_KEY_MODE_BASE at this Bss[0] =
0x300
nt [CTRL-EVENT-DISCONNECTED - Dirt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8002)
sconnect event - remove keys]
DAsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
/wpa_supplicant( 1088): wpa_drivAsicSwitchChannel#1(RF=5, Pwr0=17,
Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
er_wext_set_key: alg=0 key_idx=0 WCIDAttri = 0x1
set_tx=0 seq_len=0 key_len=0
VAsicRemovePairwiseKeyEntry : Wcid #1
/WifiStateTracker( 959): New neAsicRemoveSharedKeyEntry: #2
twork state is DISCONNECTED
I/eWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
thernet( 959): recvmsg get datart_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8003)
I/ethernet( 959): event :16 AsicUpdateWcidAttributeEntry : WCID #1,
KeyIndex #0, Alg=none
found
I/ethernet( 959): the d WCIDAttri = 0x1
evice flag :11043
I/ethernet( AsicRemovePairwiseKeyEntry : Wcid #1
959): Done parsing
I/ethernet( AsicRemoveSharedKeyEntry: #3
959): poll state :, left:4096
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
I/ethernet( 959): Poll events frt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8004)
rom ethernet devices
I/EthernetAsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0,
Alg=none
Monitor( 959): get event
I/Et WCIDAttri = 0x1
hernetMonitor( 959): go poll evAsicRemovePairwiseKeyEntry : Wcid #1
ents
I/ethernet( 959): recvmsgAsicRemoveSharedKeyEntry: #0
get data
I/ethernet( 959): eWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
vent :16 found
I/ethernet( 95rt_ioctl_siwencodeext::Remove all keys!(encoding->flags
= 8001)
9): the device flag :11043
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, leAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
ft:4096
I/ethernet( 959): Poll events from ethernet devices
I WCIDAttri = 0x1
/EthernetMonitor( 959): get eveAsicRemovePairwiseKeyEntry : Wcid #1
nt
I/EthernetMonitor( 959): gAsicRemoveSharedKeyEntry: #0
o poll events
D/wpa_supplicant(Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
1088): wpa_driver_wext_set_key:rt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8001)
alg=0 key_idx=1 set_tx=0 seq_leAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
n=0 key_len=0
D/wpa_supplicant( WCIDAttri = 0x1
1088): wpa_driver_wext_set_key:AsicRemovePairwiseKeyEntry : Wcid #1
alg=0 key_idx=2 set_tx=0 seq_leAsicRemoveSharedKeyEntry: #1
n=0 key_len=0
D/wpa_supplicant(Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
1088): wpa_driver_wext_set_key:AsicSwitchChannel#2(RF=5, Pwr0=17,
Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
alg=0 key_idx=3 set_tx=0 seq_lert_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8002)
n=0 key_len=0
D/wpa_supplicant( 1088):
wpa_driver_wext_set_key:AsicUpdateWcidAttributeEntry : WCID #1,
KeyIndex #0, Alg=none
alg=0 key_idx=0 set_tx=0 seq_le WCIDAttri = 0x1
n=0 key_len=0
D/wpa_supplicant(AsicRemovePairwiseKeyEntry : Wcid #1
1088): State: COMPLETED -> DISCAsicRemoveSharedKeyEntry: #2
ONNECTED
I/wpa_supplicant( 1088Write: SHARED_KEY_MODE_BASE at this Bss[0] =
0x0
): CTRL-EVENT-STATE-CHANGE id=0 rt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8003)
state=0
V/WifiMonitor( 959): EAsicUpdateWcidAttributeEntry : WCID #1,
KeyIndex #0, Alg=none
vent [CTRL-EVENT-STATE-CHANGE id WCIDAttri = 0x1
=0 state=0]
V/WifiStateTracker(AsicRemovePairwiseKeyEntry : Wcid #1
959): Changing supplicant statAsicRemoveSharedKeyEntry: #3
e: COMPLETED ==> DISCONNECTED
DWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
/wpa_supplicant( 1088): wpa_drivrt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8004)
er_wext_set_operstate: operstateAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
1->0 (DORMANT)
D/wpa_supplican WCIDAttri = 0x1
t( 1088): WEXT: Operstate: linkmAsicRemovePairwiseKeyEntry : Wcid #1
ode=-1, operstate=5
D/wpa_supplAsicRemoveSharedKeyEntry: #0
icant( 1088): EAPOL: External noWrite: SHARED_KEY_MODE_BASE at this
Bss[0] = 0x0
tification - portEnabled=0
D/wprt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8001)
a_supplicant( 1088): EAPOL: SUPP_PAE entering state DISCONNECTED
D/wpa_supplicant( 1088): EAPOL: SUPP_BE entering state INITIAL!!! MLME
busy, reset MLME state machine !!!
IZE
D/wpa_supplicant( 1088): EAAsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5,
1T), N=0xF2, K=0x02, R=0x02
POL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification !!! reset MLME
state machine !!!
- EAP success=0
D/wpa_supplicanMlmeRestartStateMachine
t( 1088): RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING]
[LOWER_UP])
D/wpa_supplicantAsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T),
N=0xF3, K=0x07, R=0x02
( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
D/wpSCAN done, resume MSDU transmission ...
a_supplicant( 1088): Wireless evSCANNING, suspend MSDU
transmission ...
ent: cmd=0x8b15 len=20
I/ethernSYNC - BBP R4 to 20MHz.l
et( 959): recvmsg get data
D/wpa_supplicant( 1088): Wireless event: new AP: 00:00:00:00:00:00
I/ethernet( 959): event :16 found
D/wpa_supplicant( 1088): AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5,
1T), N=0xF1, K=0x02, R=0x02
Added BSSID 00:00:00:00:00:00 into blacklist
I/wpa_supplicant( 1088): CTRL-EVENT-DISCONNECTED - Disconnect event -
remove keys
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
I/ethernet( 959): the device flag :11003
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
V/WifiMonitor( 959): Event [CTRL-EVENT-DISCONNECTED - Disconnect
event - remove keys]
V/WifiStateTracker( 959): New network state is DISCONNECTED
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=1
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=2
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=3
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): State: DISCONNECTED -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
DISCONNECTED
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): RTM_NEWLINK: operstAsicSwitchChannel#2(RF=5,
Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
ate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): State: DISCONNECTED -> SCANNING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=2
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=2]
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
SCANNING
D/wpa_supplicant( 1088): Scan requested (ret=0) - scan timeout 5
seconds
AsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x02, R=0x02
AsicSwitchChannel#4(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x07, R=0x02
AsicSwitchChannel#5(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x02, R=0x02
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
AsicSwitchChannel#8(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x07, R=0x02
AsicSwitchChannel#9(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF5, K=0x02, R=0x02
AsicSwitchChannel#10(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF5, K=0x07,
R=0x02
AsicSwitchChannel#11(RF=5, Pwr0=16, Pwr1=5, 1T), N=0xF6, K=0x02,
R=0x02
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
SYNC - End of SCAN, restore to channel 6, Total BSS[01]
D/wpa_supplicant( 1088): AWEXT: SCAN done, resume MSDU
transmission ...
wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
D/WifiStateTracker( 959): Reset connections and stopping DHCP
D/dhcpcd ( 1215): received SIGTERM, stopping
D/dhcpcd ( 1215): deleting route 0.0.0.0/0 via 192.168.1.1
D/dhcpcd ( 1215): deleting IP address 192.168.1.106/24
D/dhcpcd ( 1215): executing `/system/etc/dhcpcd/dhcpcd-run-hooks',
reason STOP
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :21 found
I/ethernet( 959): the device flag :10008
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
===>rt_ioctl_giwscan. 1(1) BSS returned, data->length = 308
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wprt_ioctl_siwauth::IW_AUTH_80211_AUTH_ALG - param->value = 1!
a_supplicant( 1088): Received 30rt_ioctl_siwauth::IW_AUTH_WPA_VERSION
- param->value = 1!
8 bytes of scan results (1 BSSes===>Set_NetworkType_Proc::(INFRA)
)
D/wpa_supplicant( 1088): ScanSet_NetworkType_Proc::(NetworkType=1)
results: 1
I/wpa_supplicant( 1===> rt_ioctl_siwgenie
088): CTRL-EVENT-SCAN-RESULTS Rrt_ioctl_siwauth::IW_AUTH_WPA_VERSION
- param->value = 4!
eady
D/wpa_supplicant( 1088): Selecting BSS from priority group 1
D/wpa_supplicant( 1088): Tryrt_ioctl_siwauth::IW_AUTH_CIPHER_PAIRWISE
- param->value = 8!
to find WPA-enabled AP
D/wpa_srt_ioctl_siwauth::IW_AUTH_CIPHER_GROUP - param->value = 4!
upplicant( 1088): 0: 68:7f:74:1crt_ioctl_siwauth::IW_AUTH_KEY_MGMT -
param->value = 2!
:e4:7c ssid='Olympus2'
wpa_ie_lert_ioctl_siwauth::IW_AUTH_PRIVACY_INVOKED - param->value = 1!
n=30 rsn_ie_len=26 caps=0x11
D/==>rt_ioctl_siwfreq::SIOCSIWFREQ[cmd=0x8b04] (Channel=1)
wpa_supplicant( 1088): selectSet_SSID_Proc::(Len=8,Ssid=Olympus2)
ed based on RSN IE
D/wpa_suppliCntlOidSsidProc():CNTL - 1 BSS of 1 BSS match the desire
cant( 1088): selected WPA AP IOCTL::SIOCSIWAP 68:7f:74:1c:e4:7c
68:7f:74:1c:e4:7c ssid='Olympus2(8)SSID - Olympus2
'
D/wpa_supplicant( 1088): Try CNTL - iterate BSS 0 of 1
to find non-WPA AP
I/wpa_suppliSYNC - MlmeJoinReqAction(BSS #0)
cant( 1088): Trying to associate with 68:7f:74:1c:e4:7c
(SSID='Olympus2' freq=2437 MHz)
D/wpa_sSYNC - BBP R4 to 20MHz.l
upplicant( 1088): Cancelling scan request
D/wpa_supplicant( 1088): WPA: clearing own WPA/RSN IE
D/wpa_supplicant( 1088): Automatic auth_alg selection: 0x1
D/wpa_supplicant( 1088): RSN: usinAsicSwitchChannel#6(RF=5, Pwr0=17,
Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
g IEEE 802.11i/D9.0
D/wpa_supplicant( 1088): WPA: Selected ciphSYNC - Switch to ch 6, Wait
BEACON from 68:7f:74:1c:e4:7c
er suites: group 8 pairwise 24 key_mgmt 2 proto 2
D/wpa_supplicant( 1088): WPA: using GTK TKIP
D/wpa_supplicant( 1088): WPA: using PTK CCMP
D/wpa_supplicant( 1088): WPA: using KEY_MGMT WPA-PSK
D/wpa_supplicant( 1088): No keys have been configured - skip key
clearing
D/wpa_supplicant( 1088): wpa_driver_awext_set_drop_unencrypted
D/wpa_supplicant( 1088): State: SCANNING -> ASSOCIATING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=3
D/wpa_supplicant( 1088):SYNC - receive desired BEACON at
JoinWaitBeacon... Channel = 6
wpa_driver_wext_set_operstate: MlmeAux.ExtCapInfo=0
operstate 0->0 (DORMANT)
D/wpa_RTMPCheckHt:: HtCapInfo.ChannelWidth=0, RecomWidth=0,
DesiredHtPhy.ChannelWidth=1, BW40MAvailForA/G=0/0, PhyMode=9
supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/PeerBeaconAtJoinAction! (MpduDensity=0, MaxRAmpduFactor=0, BW=0)
wpa_supplicant( 1088): wpa_driver_awext_associate
I/ethernet( PeerBeaconAtJoinAction HT===>Central Channel = 6, Control
Channel = 6, .
959): recvmsg get data
I/ethernRTMPUpdateMlmeRate ==> MlmeTransmit = 0x0
et( 959): event :16 found
I/SYNC - after JOIN, SupRateLen=8, ExtRateLen=4
ethernet( 959): the device flag :11003
I/ethernet( 959): DoneAsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T),
N=0xF3, K=0x07, R=0x02
parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
I/EthernetMonitor( !!! 20MHz !!!
959): get event
I/EthernetMoniAUTH - Send AUTH request seq#1 (Alg=0)...
tor( 959): go poll events
I/etAUTH - Receive AUTH_RSP seq#2 to me (Alg=0, Status=0)
CNTL - AUTH OK recvmsg get data
I/ethernet( 959): event :16 ASSOC - Send ASSOC request...
found
I/ethernet( 959): the device flag :11003
I/ethernet( 9PeerAssocRspAction():ASSOC - receive ASSOC_RSP to me
(status=0)
59): Done parsing
I/ethernet( 959): poll state :, left:4096
IPeerAssocRspAction():MacTable [255].AMsduSize = 1. ClientStatusFlags
= 0x30
/ethernet( 959): Poll events frRTMPCheckHt::
HtCapInfo.ChannelWidth=0, RecomWidth=0, DesiredHtPhy.ChannelWidth=1,
BW40MAvailForA/G=0/0, PhyMode=9
om ethernet devices
I/EthernetMAssocPostProc===> AP.AMsduSize = 1. ClientStatusFlags =
0x30
onitor( 959): get event
I/EthAssocPostProc===> (Mmps=3, AmsduSize=1, )
ernetMonitor( 959): go poll eveAssocPostProc===> Store RSN_IE for
WPA2 SM negotiation
nts
D/wpa_supplicant( 1088): SeRSN_IE: d09c4674, len = 26
tting authentication timeout: 100x0000 : sec 0 usec
D/wpa_supplicant( 130 088): EAPOL: External notificati18 on - EAP
success=0
D/wpa_suppli01 cant( 1088): EAPOL: External not00 ification - EAP
fail=0
D/wpa_su00 pplicant( 1088): EAPOL: External0f notification -
portControl=Autoac
D/wpa_supplicant( 1088): RTM_N02 EWLINK: operstate=0 ifi_flags=0x02
11003 ([UP][LOWER_UP])
D/wpa_su00 pplicant( 1088): RTM_NEWLINK, IF00 LA_IFNAME: Interface
'wlan0' add0f ed
D/wpa_supplicant( 1088): Wirac eless event: cmd=0x8b06 len=8
D04 /wpa_supplicant( 1088): RTM_NEWL00 INK: operstate=0
ifi_flags=0x1100f 03 ([UP][LOWER_UP])
D/wpa_suppl
ac nt( 1088): RTM_NEWLINK, IFLA_0x0010 : IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): Wirele02 ss event: cmd=0x8b04 len=12
V/W01 ifiMonitor( 959): Event [Trying00 to associate with 68:7f:
74:1c:e00 4:7c (SSID='Olympus2' freq=2437 0f MHz)]
V/WifiMonitor( 959): Eveac nt [CTRL-EVENT-STATE-CHANGE id=002
state=3]
D/wpa_supplicant( 1080c 8): RTM_NEWLINK: operstate=0 ifi00
_flags=0x11003 ([UP][LOWER_UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): Wireless event: cmd=0x8b1a===> rt28xx_close
len=16
I/ethernet( 959): recvPeerAddBAReqAction ==> (Wcid = 255)
msg get data
I/ethernet( 959):!!!Infra LINK UP !!!
event :16 found
I/ethernet( !!! LINK UP !!! (BssType=1, AID=3, ssid=Olympus2,
Channel=6, CentralChannel = 6)
959): the device flag :11003
IRT28xxUsbMlmeRadioOFF()
/ethernet( 959): Done parsing
ASSOC - Send DISASSOC request[BSSID::68:7f:74:1c:e4:7c (Reason=8)
I/ethernet( 959): poll state :,!!! LINK UP !!! (Density =6, )
left:4096
I/ethernet( 959): P==============> AsicSetBssid 68:7f:74:1c:e4:7c
oll events from ethernet devicesEDCA [#0]: AIFSN CWmin CWmax
TXOP(us) ACM
I/EthernetMonitor( 959): get AC_BE 3 4 10
0 0
event
I/EthernetMonitor( 959)!!! LINK DOWN !!!
: go poll events
D/wpa_supplica!!! LINK DOWN 2!!!
nt( 1088): RTM_NEWLINK: operstat AC_BK 7 4
10 0 0
e=0 ifi_flags=0x11003 ([UP][LOWE AC_VI 2 3 4
3008 0
R_UP])
D/wpa_supplicant( 1088):AsicSetEdcaParm
RTM_NEWLINK, IFLA_IFNAME: Inter AC_VO 2 2 3
1504 0
face 'wlan0' added
D/wpa_suppliRTMPSetLED::Mode=1,HighByte=0x20,LowByte=0x01
cant( 1088): Wireless event: cmd--->Disable TSF synchronization
=0x8c07 len=50
I/ethernet( 959LinkDownCleanMlmeAux.ExtCapInfo!
): recvmsg get data
I/ethernet(RTMPWPARemoveAllKeys(AuthMode=7, WepStatus=6)
959): event :16 found
I/ethAsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
ernet( 959): the device flag :1 WCIDAttri = 0x1
1003
I/ethernet( 959): Done paAsicRemovePairwiseKeyEntry : Wcid #1
rsing
I/ethernet( 959): poll sremove none key #0
tate :, left:4096
I/EthernetMonitor( 959): get event
I/ethernet( 959): Poll events from ethAsicRemoveSharedKeyEntry: #0
ernet devices
D/wpa_supplicant(Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
1088): RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_Uremove
none key #1
P])
D/wpa_supplicant( 1088): RTAsicRemoveSharedKeyEntry: #1
M_NEWLINK, IFLA_IFNAME:
InterfacRTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x01
e 'wlan0' added
D/wpa_supplicanWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
t( 1088): Wireless event: cmd=0xremove none key #2
8b15 len=20
D/wpa_supplicant( 1AsicRemoveSharedKeyEntry: #2
088): Wireless event: new AP: 68Write: SHARED_KEY_MODE_BASE at this
Bss[0] = 0x0
:7f:74:1c:e4:7c
D/wpa_supplican==> MlmeHalt
t( 1088): Association info event--->Disable TSF synchronization
D/wpa_supplicant( 1088): WPA: remove none key #3
clearing AP WPA IE
D/wpa_suppliAsicRemoveSharedKeyEntry: #3
cant( 1088): WPA: clearing AP RSWrite: SHARED_KEY_MODE_BASE at this
Bss[0] = 0x0
N IE
D/wpa_supplicant( 1088): SComposePsPoll
RTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x00
I/wpa_supplicant( 1088): CTRL-E--->AsicEnableBssSync(INFRA mode)
VENT-STATE-CHANGE id=0 state=4
!!! LINK UP !!! ClientStatusFlags=0)
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate:
operstatMlmeUpdateTxRates[MaxSupport = 54] = MaxDesire 54 Mbps
e 0->0 (DORMANT)
D/wpa_supplica MlmeUpdateTxRates (MaxDesire=54, MaxSupport=54,
MaxTxRate=54, MinRate=1, Rate Switching =1)
nt( 1088): WEXT: Operstate: link<== MlmeHalt
mode=-1, operstate=5
V/WifiMoniMacTableReset
tor( 959): Event [CTRL-EVENT-ST MlmeUpdateTxRates (TxRate=24,
RtsRate=1, BasicRateBitmap=0x0150)
ATE-CHANGE id=0 state=4]
D/wpa_MacTableDeleteEntry1 - Total= 0
supplicant( 1088): Associated toMlmeUpdateTxRates (MlmeTransmit=0x0,
MinHTPhyMode=0, MaxHTPhyMode=0x0, HTPhyMode=0x0)
a new BSS: BSSID=68:7f:74:1c:e4:7c
D/wpa_supplicant( 1088): NoMlmeUpdateHtTxRates===>
keys have been configured - ski MlmeUpdateHtTxRates<---.AMsduSize =
0
p key clearing
I/wpa_supplicant( 1088): Associated with 68:7f:7TX: MCS[0] = ff
(choose 7), BW = 1, ShortGI = 1, MODE = 2,
4:1c:e4:7c
D/wpa_supplicant( 10MlmeUpdateHtTxRates<===
88): WPA: Association event - clear replay counter
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: Exter!!! LINK UP !!
(StaActive.bHtEnable =0, )
nal notification - portValid=0
NDIS_STATUS_MEDIA_CONNECT Event B!.BACapability = 3034040.
ClientStatusFlags = 0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): EAPOL: External notification -
pRTMPSetLED::Mode=1,HighByte=0x60,LowByte=0x01
ortEnabled=1
D/wpa_supplicant( 1088): EAPOL: SUPP_PAE entering state CONNECTING
D/wpa_supplicant( 1088): EAPOL: SUPP_BE enteriTxburst 2
ng state IDLE
D/wpa_supplicant(!!!pAd->bNextDisableRxBA= 0
1088): Setting authentication timeout: 10 sec 0 usec
D/wpa_supplicant( 1088): Cancelling scan CNTL - Association successful
on BSS #0
request
D/WifiStateTracker( 959): Disabling interface
I/EthernetMonitor( 959): go poll event--->RTUSBCancelPendingBulkInIRP
s
I/ethernet( 959): recvmsg ge<---RTUSBCancelPendingBulkInIRP
t data
I/ethernet( 959): even<---MlmeThread
t :16 found
I/ethernet( 959):<---RTUSBCmdThread
the device flag :11003
I/ether<---RtmpTimerQThread
net( 959): Done parsing
I/ethe---> RTMPFreeTxRxRingMemory
rnet( 959): poll state :, left:<--- RTMPFreeTxRxRingMemory
4096
I/EthernetMonitor( 959): <=== rt28xx_close
get event
V/WifiMonitor( 959): Event [Associated with 68:7f:7INFO::Network is
down!
4:1c:e4:7c]
I/ethernet( 959): Poll events from ethernet deviceINFO::Network is
down!
s
I/EthernetMonitor( 959): go poll events
D/wpa_supplicant( 1088): RTM_NEWLINK: operstate=0 iINFO::Network is
down!
fi_flags=0x1002 ()
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
INFO::Network is down!
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :INFO::Network is down!
16 found
I/ethernet( 959): the device flag :1002
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096INFO::Network is down!
I/ethernet( 959): Poll events from ethernet devices
D/wpa_suINFO::Network is down!
pplicant( 1088): RTM_NEWLINK: opINFO::Network is down!
erstate=0 ifi_flags=0x1003 ([UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant(INFO::Network is down!
1088): Wireless event: cmd=0x8b15 len=20
D/wpa_supplicant( 108INFO::Network is down!
8): Wireless event: new AP: 00:00:00:00:00:00
D/wpa_supplicant( 1088): Setting scan request: 0 sec 100000 usec
I/EthernetMonitor( 959): get event
I/EtherneINFO::Network is down!
tMonitor( 959): go poll events
I//system/bin/wpa_supplicant( 1083): l2_packet_receive - recvfrom:
Network is down
D/wpa_supplicant( 1088): BSSID 68:7f:74:1c:e4:7c blacklist count
incremented to 2
I/wpa_supplicant( 1088): CTRL-EVENT-DISCONNECTED - Disconnect event -
remove keys
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
V/WifiMonitor( 959): Event [CTRL-EVENT-DISCONNECTED - Disconnect
event - remove keys]
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :16 found
I/ethernet( 959): the device flag :1003
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :16 found
I/ethernet( 959): the device flag :1003
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=1
set_tx=0 seq_len=0 key_len=0
I/ethernet( 959): Poll events from ethernet devices
D/NetworkStateTracker( 959): setDetailed state, old =CONNECTED and
new state=DISCONNECTED
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
D/wpa_supplicant( did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=2
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=3
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
V/WifiStateTracker( 959): Changing supplicant state: SCANNING ==>
ASSOCIATING
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/NetworkStateTracker( 959): setDetailed state, old =DISCONNECTED and
new state=CONNECTING
V/WifiStateTracker( 959): Changing supplicant state: ASSOCIATING ==>
ASSOCIATED
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): State: ASSOCIATED -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: SUPP_PAE entering state DISCONNECTED
D/wpa_supplicant( 1088): EAPOL: SUPP_BE entering state INITIALIZE
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): RTM_NEWLINK: operstate=0 ifi_flags=0x1003
([UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): Wireless event: cmd=0x8b15 len=20
D/wpa_supplicant( 1088): Wireless event: new AP: 00:00:00:00:00:00
D/wpa_supplicant( 1088): BSSID 00:00:00:00:00:00 blacklist count
incremented to 2
I/wpa_supplicant( 1088): CTRL-EVENT-DISCONNECTED - Disconnect event -
remove keys
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
V/WifiMonitor( 959): Event [CTRL-EVENT-DISCONNECTED - Disconnect
event - remove keys]
D/NetworkStateTracker( 959): setDetailed state, old =CONNECTING and
new state=CONNECTING
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=1
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=2
set_tx=0 seq_len=0 key_len=0
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
V/WifiStateTracker( 959): New network state is DISCONNECTED
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=3
set_tx=0 seq_len=0 key_len=0
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
V/WifiStateTracker( 959): Changing supplicant state: ASSOCIATED ==>
DISCONNECTED
V/WifiStateTracker( 959): New network state is DISCONNECTED
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/ConnectivityService( 959): ConnectivityChange for WIFI: CONNECTING/
CONNECTING
D/ConnectivityService( 959): Dropping ConnectivityChange for WIFI:
CONNECTING/CONNECTING
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): State: DISCONNECTED -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
DISCONNECTED
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): State: DISCONNECTED -> SCANNING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=2
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=2]
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
SCANNING
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
D/wpa_supplicant( 1088): EAPOL: startWhen --> 0
D/WifiStateTracker( 959): Reset connections and stopping DHCP
INFO::Network is down!
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
D/wpa_supplicant( 1088): Scan timeout - try to get results
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
D/WifiStateTracker( 959): Disabling interface
D/NetworkStateTracker( 959): setDetailed state, old =CONNECTING and
new state=DISCONNECTED
D/ConnectivityService( 959): ConnectivityChange for WIFI:
DISCONNECTED/DISCONNECTED
D/ConnectivityService( 959): getMobileDataEnabled returning true
D/Tethering( 959): Tethering got CONNECTIVITY_ACTION
D/Tethering( 959): MasterInitialState.processMessage what=3
INFO::Network is down!9): setEthState from 2 to 2
E/HierarchicalStateMachine( 959): TetherMaster - unhandledMessage:
msg.what=3
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
I/wpa_supplicant( 1088): Authentication with 00:00:00:00:00:00
tINFO::Network is down!
imed out.
V/WifiMonitor( 959): Event [Authentication with 00:00:00:00:00:00
timed out.]
D/wpa_supplicant( 1088): BSSID 00:00:00:00:00:00 blacklist count
incremented to 3
D/wpa_supplicant( 1088): No keys have been configured - skip key
clearing
D/wpa_supplicant( 1088): State: SCANNING -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): Setting scan request: 0 sec 0 usec
D/wpa_supplicant( 1088): State: DISCONNECTED -> SCANNING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=-1 state=2
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
V/WifiStateTracker( 959): Changing supplicant state: SCANNING ==>
DISCONNECTED
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
SCANNING
D/dalvikvm( 1137): GC_EXPLICIT freed 3350 objects / 205728 bytes in
44ms
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
D/WifiStateTracker( 959): Reset connections and stopping DHCP
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
D/WifiStateTracker( 959): Disabling interface
D/NetworkStateTracker( 959): seINFO::Network is down!
tDetailed state, old =DISCONNECTED and new state=DISCONNECTED
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
D/wpa_supplicant( 1088): Scan timeout - try to get results
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
[1] Illegal instruction logcat
# INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
SYNC - send NULL Frame @24 Mbps...
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
BEACON lost > 512 msec with TxOkCnt=0 -> CQI=0
MMCHK - No BEACON. Dead CQI. Auto Recovery attempt #0
!!! LINK DOWN !!!
!!! LINK DOWN 2!!!
BAOriSessionTearDown===>Wcid=1.TID=0
===>Idx = 1, Wcid=1.TID=0, ORI_BA_Status = 3
==> MlmeDELBAAction(), Initiator(1)
BA - MlmeDELBAAction() . Send BAR to refresh peer reordering buffer
BA - MlmeDELBAAction() . 3 DELBA sent. Initiator(1)
BATableFreeOriEntry numAsOriginator= 1
BARecSessionTearDown===>Wcid=1.TID=0
===>Idx = 1, Wcid=1.TID=0, REC_BA_Status = 3
==> MlmeDELBAAction(), Initiator(0)
BA - MlmeDELBAAction() . Send BAR to refresh peer reordering buffer
BA - MlmeDELBAAction() . 3 DELBA sent. Initiator(0)
MacTableDeleteEntry1 - Total= 0
CmdThread : CMDTHREAD_SET_ASIC_WCID : WCID = 1, SetTid = ffffffff,
DeleteTid = ffffffff.
1-MACValue= 0,
AsicSetEdcaParm
2-MACValue= 10000,
CmdThread : CMDTHREAD_SET_ASIC_WCID : WCID = 1, SetTid = ffffffff,
DeleteTid = 10000.
1-MACValue= 0,
2-MACValue= 0,
RTMPSetLED::Mode=1,HighByte=0x20,LowByte=0x01
--->Disable TSF synchronization
LinkDownCleanMlmeAux.ExtCapInfo!
D/wpa_supplicant( 1088): RTM_NEWAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
LINK: operstate=1 ifi_flags=0x11Driver auto reconnect to last
OID_802_11_SSID setting - Olympus2, len - 8
043 ([UP][RUNNING][LOWER_UP])
D WCIDAttri = 0x1
/wpa_supplicant( 1088): RTM_NEWLCntlOidSsidProc():CNTL - 0 BSS of 0
BSS match the desire INK, IFLA_IFNAME: Interface
'wlaAsicRemovePairwiseKeyEntry : Wcid #1
n0' added
D/wpa_supplicant( 108(8)SSID - Olympus2
8): Wireless event: cmd=0x8b15 lCntlOidSsidProc():CNTL - No matching
BSS, start a new scan
en=20
D/wpa_supplicant( 1088): AsicRemoveSharedKeyEntry: #0
Wireless event: new AP: 00:00:00SCANNING, suspend MSDU
transmission ...
:00:00:00
D/wpa_supplicant( 108Write: SHARED_KEY_MODE_BASE at this Bss[0] =
0x300
8): Setting scan request: 0 sec rt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8001)
100000 usec
D/wpa_supplicant( 1SYNC - BBP R4 to 20MHz.l
088): Added BSSID 68:7f:74:1c:e4AsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
:7c into blacklist
I/wpa_suppli WCIDAttri = 0x1
cant( 1088): CTRL-EVENT-DISCONNEAsicRemovePairwiseKeyEntry : Wcid #1
CTED - Disconnect event - removeAsicRemoveSharedKeyEntry: #1
keys
V/WifiMonitor( 959): EveWrite: SHARED_KEY_MODE_BASE at this Bss[0] =
0x300
nt [CTRL-EVENT-DISCONNECTED - Dirt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8002)
sconnect event - remove keys]
DAsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
/wpa_supplicant( 1088): wpa_drivAsicSwitchChannel#1(RF=5, Pwr0=17,
Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
er_wext_set_key: alg=0 key_idx=0 WCIDAttri = 0x1
set_tx=0 seq_len=0 key_len=0
VAsicRemovePairwiseKeyEntry : Wcid #1
/WifiStateTracker( 959): New neAsicRemoveSharedKeyEntry: #2
twork state is DISCONNECTED
I/eWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
thernet( 959): recvmsg get datart_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8003)
I/ethernet( 959): event :16 AsicUpdateWcidAttributeEntry : WCID #1,
KeyIndex #0, Alg=none
found
I/ethernet( 959): the d WCIDAttri = 0x1
evice flag :11043
I/ethernet( AsicRemovePairwiseKeyEntry : Wcid #1
959): Done parsing
I/ethernet( AsicRemoveSharedKeyEntry: #3
959): poll state :, left:4096
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
I/ethernet( 959): Poll events frt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8004)
rom ethernet devices
I/EthernetAsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0,
Alg=none
Monitor( 959): get event
I/Et WCIDAttri = 0x1
hernetMonitor( 959): go poll evAsicRemovePairwiseKeyEntry : Wcid #1
ents
I/ethernet( 959): recvmsgAsicRemoveSharedKeyEntry: #0
get data
I/ethernet( 959): eWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
vent :16 found
I/ethernet( 95rt_ioctl_siwencodeext::Remove all keys!(encoding->flags
= 8001)
9): the device flag :11043
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, leAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
ft:4096
I/ethernet( 959): Poll events from ethernet devices
I WCIDAttri = 0x1
/EthernetMonitor( 959): get eveAsicRemovePairwiseKeyEntry : Wcid #1
nt
I/EthernetMonitor( 959): gAsicRemoveSharedKeyEntry: #0
o poll events
D/wpa_supplicant(Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
1088): wpa_driver_wext_set_key:rt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8001)
alg=0 key_idx=1 set_tx=0 seq_leAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
n=0 key_len=0
D/wpa_supplicant( WCIDAttri = 0x1
1088): wpa_driver_wext_set_key:AsicRemovePairwiseKeyEntry : Wcid #1
alg=0 key_idx=2 set_tx=0 seq_leAsicRemoveSharedKeyEntry: #1
n=0 key_len=0
D/wpa_supplicant(Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
1088): wpa_driver_wext_set_key:AsicSwitchChannel#2(RF=5, Pwr0=17,
Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
alg=0 key_idx=3 set_tx=0 seq_lert_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8002)
n=0 key_len=0
D/wpa_supplicant( 1088):
wpa_driver_wext_set_key:AsicUpdateWcidAttributeEntry : WCID #1,
KeyIndex #0, Alg=none
alg=0 key_idx=0 set_tx=0 seq_le WCIDAttri = 0x1
n=0 key_len=0
D/wpa_supplicant(AsicRemovePairwiseKeyEntry : Wcid #1
1088): State: COMPLETED -> DISCAsicRemoveSharedKeyEntry: #2
ONNECTED
I/wpa_supplicant( 1088Write: SHARED_KEY_MODE_BASE at this Bss[0] =
0x0
): CTRL-EVENT-STATE-CHANGE id=0 rt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8003)
state=0
V/WifiMonitor( 959): EAsicUpdateWcidAttributeEntry : WCID #1,
KeyIndex #0, Alg=none
vent [CTRL-EVENT-STATE-CHANGE id WCIDAttri = 0x1
=0 state=0]
V/WifiStateTracker(AsicRemovePairwiseKeyEntry : Wcid #1
959): Changing supplicant statAsicRemoveSharedKeyEntry: #3
e: COMPLETED ==> DISCONNECTED
DWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
/wpa_supplicant( 1088): wpa_drivrt_ioctl_siwencodeext::Remove all keys!
(encoding->flags = 8004)
er_wext_set_operstate: operstateAsicUpdateWcidAttributeEntry : WCID
#1, KeyIndex #0, Alg=none
1->0 (DORMANT)
D/wpa_supplican WCIDAttri = 0x1
t( 1088): WEXT: Operstate: linkmAsicRemovePairwiseKeyEntry : Wcid #1
ode=-1, operstate=5
D/wpa_supplAsicRemoveSharedKeyEntry: #0
icant( 1088): EAPOL: External noWrite: SHARED_KEY_MODE_BASE at this
Bss[0] = 0x0
tification - portEnabled=0
D/wprt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8001)
a_supplicant( 1088): EAPOL: SUPP_PAE entering state DISCONNECTED
D/wpa_supplicant( 1088): EAPOL: SUPP_BE entering state INITIAL!!! MLME
busy, reset MLME state machine !!!
IZE
D/wpa_supplicant( 1088): EAAsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5,
1T), N=0xF2, K=0x02, R=0x02
POL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification !!! reset MLME
state machine !!!
- EAP success=0
D/wpa_supplicanMlmeRestartStateMachine
t( 1088): RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING]
[LOWER_UP])
D/wpa_supplicantAsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T),
N=0xF3, K=0x07, R=0x02
( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
D/wpSCAN done, resume MSDU transmission ...
a_supplicant( 1088): Wireless evSCANNING, suspend MSDU
transmission ...
ent: cmd=0x8b15 len=20
I/ethernSYNC - BBP R4 to 20MHz.l
et( 959): recvmsg get data
D/wpa_supplicant( 1088): Wireless event: new AP: 00:00:00:00:00:00
I/ethernet( 959): event :16 found
D/wpa_supplicant( 1088): AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5,
1T), N=0xF1, K=0x02, R=0x02
Added BSSID 00:00:00:00:00:00 into blacklist
I/wpa_supplicant( 1088): CTRL-EVENT-DISCONNECTED - Disconnect event -
remove keys
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
I/ethernet( 959): the device flag :11003
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
V/WifiMonitor( 959): Event [CTRL-EVENT-DISCONNECTED - Disconnect
event - remove keys]
V/WifiStateTracker( 959): New network state is DISCONNECTED
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=1
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=2
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=3
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): State: DISCONNECTED -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
DISCONNECTED
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): RTM_NEWLINK: operstAsicSwitchChannel#2(RF=5,
Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
ate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): State: DISCONNECTED -> SCANNING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=2
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=2]
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
SCANNING
D/wpa_supplicant( 1088): Scan requested (ret=0) - scan timeout 5
seconds
AsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x02, R=0x02
AsicSwitchChannel#4(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x07, R=0x02
AsicSwitchChannel#5(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x02, R=0x02
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
AsicSwitchChannel#8(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x07, R=0x02
AsicSwitchChannel#9(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF5, K=0x02, R=0x02
AsicSwitchChannel#10(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF5, K=0x07,
R=0x02
AsicSwitchChannel#11(RF=5, Pwr0=16, Pwr1=5, 1T), N=0xF6, K=0x02,
R=0x02
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/wpa_supplicant( 1088): AWEXT: wpa_driver_priv_driver_cmd RSSI-
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
APPROX
D/wpa_supplicant( 1088): >>>. DRIVER AWEXT RSSI
SYNC - End of SCAN, restore to channel 6, Total BSS[01]
D/wpa_supplicant( 1088): AWEXT: SCAN done, resume MSDU
transmission ...
wpa_driver_priv_driver_cmd LINKSPEED
D/wpa_supplicant( 1088): Link Speed command
D/WifiStateTracker( 959): Reset connections and stopping DHCP
D/dhcpcd ( 1215): received SIGTERM, stopping
D/dhcpcd ( 1215): deleting route 0.0.0.0/0 via 192.168.1.1
D/dhcpcd ( 1215): deleting IP address 192.168.1.106/24
D/dhcpcd ( 1215): executing `/system/etc/dhcpcd/dhcpcd-run-hooks',
reason STOP
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :21 found
I/ethernet( 959): the device flag :10008
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
===>rt_ioctl_giwscan. 1(1) BSS returned, data->length = 308
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wprt_ioctl_siwauth::IW_AUTH_80211_AUTH_ALG - param->value = 1!
a_supplicant( 1088): Received 30rt_ioctl_siwauth::IW_AUTH_WPA_VERSION
- param->value = 1!
8 bytes of scan results (1 BSSes===>Set_NetworkType_Proc::(INFRA)
)
D/wpa_supplicant( 1088): ScanSet_NetworkType_Proc::(NetworkType=1)
results: 1
I/wpa_supplicant( 1===> rt_ioctl_siwgenie
088): CTRL-EVENT-SCAN-RESULTS Rrt_ioctl_siwauth::IW_AUTH_WPA_VERSION
- param->value = 4!
eady
D/wpa_supplicant( 1088): Selecting BSS from priority group 1
D/wpa_supplicant( 1088): Tryrt_ioctl_siwauth::IW_AUTH_CIPHER_PAIRWISE
- param->value = 8!
to find WPA-enabled AP
D/wpa_srt_ioctl_siwauth::IW_AUTH_CIPHER_GROUP - param->value = 4!
upplicant( 1088): 0: 68:7f:74:1crt_ioctl_siwauth::IW_AUTH_KEY_MGMT -
param->value = 2!
:e4:7c ssid='Olympus2'
wpa_ie_lert_ioctl_siwauth::IW_AUTH_PRIVACY_INVOKED - param->value = 1!
n=30 rsn_ie_len=26 caps=0x11
D/==>rt_ioctl_siwfreq::SIOCSIWFREQ[cmd=0x8b04] (Channel=1)
wpa_supplicant( 1088): selectSet_SSID_Proc::(Len=8,Ssid=Olympus2)
ed based on RSN IE
D/wpa_suppliCntlOidSsidProc():CNTL - 1 BSS of 1 BSS match the desire
cant( 1088): selected WPA AP IOCTL::SIOCSIWAP 68:7f:74:1c:e4:7c
68:7f:74:1c:e4:7c ssid='Olympus2(8)SSID - Olympus2
'
D/wpa_supplicant( 1088): Try CNTL - iterate BSS 0 of 1
to find non-WPA AP
I/wpa_suppliSYNC - MlmeJoinReqAction(BSS #0)
cant( 1088): Trying to associate with 68:7f:74:1c:e4:7c
(SSID='Olympus2' freq=2437 MHz)
D/wpa_sSYNC - BBP R4 to 20MHz.l
upplicant( 1088): Cancelling scan request
D/wpa_supplicant( 1088): WPA: clearing own WPA/RSN IE
D/wpa_supplicant( 1088): Automatic auth_alg selection: 0x1
D/wpa_supplicant( 1088): RSN: usinAsicSwitchChannel#6(RF=5, Pwr0=17,
Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
g IEEE 802.11i/D9.0
D/wpa_supplicant( 1088): WPA: Selected ciphSYNC - Switch to ch 6, Wait
BEACON from 68:7f:74:1c:e4:7c
er suites: group 8 pairwise 24 key_mgmt 2 proto 2
D/wpa_supplicant( 1088): WPA: using GTK TKIP
D/wpa_supplicant( 1088): WPA: using PTK CCMP
D/wpa_supplicant( 1088): WPA: using KEY_MGMT WPA-PSK
D/wpa_supplicant( 1088): No keys have been configured - skip key
clearing
D/wpa_supplicant( 1088): wpa_driver_awext_set_drop_unencrypted
D/wpa_supplicant( 1088): State: SCANNING -> ASSOCIATING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=3
D/wpa_supplicant( 1088):SYNC - receive desired BEACON at
JoinWaitBeacon... Channel = 6
wpa_driver_wext_set_operstate: MlmeAux.ExtCapInfo=0
operstate 0->0 (DORMANT)
D/wpa_RTMPCheckHt:: HtCapInfo.ChannelWidth=0, RecomWidth=0,
DesiredHtPhy.ChannelWidth=1, BW40MAvailForA/G=0/0, PhyMode=9
supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/PeerBeaconAtJoinAction! (MpduDensity=0, MaxRAmpduFactor=0, BW=0)
wpa_supplicant( 1088): wpa_driver_awext_associate
I/ethernet( PeerBeaconAtJoinAction HT===>Central Channel = 6, Control
Channel = 6, .
959): recvmsg get data
I/ethernRTMPUpdateMlmeRate ==> MlmeTransmit = 0x0
et( 959): event :16 found
I/SYNC - after JOIN, SupRateLen=8, ExtRateLen=4
ethernet( 959): the device flag :11003
I/ethernet( 959): DoneAsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T),
N=0xF3, K=0x07, R=0x02
parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
I/EthernetMonitor( !!! 20MHz !!!
959): get event
I/EthernetMoniAUTH - Send AUTH request seq#1 (Alg=0)...
tor( 959): go poll events
I/etAUTH - Receive AUTH_RSP seq#2 to me (Alg=0, Status=0)
CNTL - AUTH OK recvmsg get data
I/ethernet( 959): event :16 ASSOC - Send ASSOC request...
found
I/ethernet( 959): the device flag :11003
I/ethernet( 9PeerAssocRspAction():ASSOC - receive ASSOC_RSP to me
(status=0)
59): Done parsing
I/ethernet( 959): poll state :, left:4096
IPeerAssocRspAction():MacTable [255].AMsduSize = 1. ClientStatusFlags
= 0x30
/ethernet( 959): Poll events frRTMPCheckHt::
HtCapInfo.ChannelWidth=0, RecomWidth=0, DesiredHtPhy.ChannelWidth=1,
BW40MAvailForA/G=0/0, PhyMode=9
om ethernet devices
I/EthernetMAssocPostProc===> AP.AMsduSize = 1. ClientStatusFlags =
0x30
onitor( 959): get event
I/EthAssocPostProc===> (Mmps=3, AmsduSize=1, )
ernetMonitor( 959): go poll eveAssocPostProc===> Store RSN_IE for
WPA2 SM negotiation
nts
D/wpa_supplicant( 1088): SeRSN_IE: d09c4674, len = 26
tting authentication timeout: 100x0000 : sec 0 usec
D/wpa_supplicant( 130 088): EAPOL: External notificati18 on - EAP
success=0
D/wpa_suppli01 cant( 1088): EAPOL: External not00 ification - EAP
fail=0
D/wpa_su00 pplicant( 1088): EAPOL: External0f notification -
portControl=Autoac
D/wpa_supplicant( 1088): RTM_N02 EWLINK: operstate=0 ifi_flags=0x02
11003 ([UP][LOWER_UP])
D/wpa_su00 pplicant( 1088): RTM_NEWLINK, IF00 LA_IFNAME: Interface
'wlan0' add0f ed
D/wpa_supplicant( 1088): Wirac eless event: cmd=0x8b06 len=8
D04 /wpa_supplicant( 1088): RTM_NEWL00 INK: operstate=0
ifi_flags=0x1100f 03 ([UP][LOWER_UP])
D/wpa_suppl
ac nt( 1088): RTM_NEWLINK, IFLA_0x0010 : IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): Wirele02 ss event: cmd=0x8b04 len=12
V/W01 ifiMonitor( 959): Event [Trying00 to associate with 68:7f:
74:1c:e00 4:7c (SSID='Olympus2' freq=2437 0f MHz)]
V/WifiMonitor( 959): Eveac nt [CTRL-EVENT-STATE-CHANGE id=002
state=3]
D/wpa_supplicant( 1080c 8): RTM_NEWLINK: operstate=0 ifi00
_flags=0x11003 ([UP][LOWER_UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): Wireless event: cmd=0x8b1a===> rt28xx_close
len=16
I/ethernet( 959): recvPeerAddBAReqAction ==> (Wcid = 255)
msg get data
I/ethernet( 959):!!!Infra LINK UP !!!
event :16 found
I/ethernet( !!! LINK UP !!! (BssType=1, AID=3, ssid=Olympus2,
Channel=6, CentralChannel = 6)
959): the device flag :11003
IRT28xxUsbMlmeRadioOFF()
/ethernet( 959): Done parsing
ASSOC - Send DISASSOC request[BSSID::68:7f:74:1c:e4:7c (Reason=8)
I/ethernet( 959): poll state :,!!! LINK UP !!! (Density =6, )
left:4096
I/ethernet( 959): P==============> AsicSetBssid 68:7f:74:1c:e4:7c
oll events from ethernet devicesEDCA [#0]: AIFSN CWmin CWmax
TXOP(us) ACM
I/EthernetMonitor( 959): get AC_BE 3 4 10
0 0
event
I/EthernetMonitor( 959)!!! LINK DOWN !!!
: go poll events
D/wpa_supplica!!! LINK DOWN 2!!!
nt( 1088): RTM_NEWLINK: operstat AC_BK 7 4
10 0 0
e=0 ifi_flags=0x11003 ([UP][LOWE AC_VI 2 3 4
3008 0
R_UP])
D/wpa_supplicant( 1088):AsicSetEdcaParm
RTM_NEWLINK, IFLA_IFNAME: Inter AC_VO 2 2 3
1504 0
face 'wlan0' added
D/wpa_suppliRTMPSetLED::Mode=1,HighByte=0x20,LowByte=0x01
cant( 1088): Wireless event: cmd--->Disable TSF synchronization
=0x8c07 len=50
I/ethernet( 959LinkDownCleanMlmeAux.ExtCapInfo!
): recvmsg get data
I/ethernet(RTMPWPARemoveAllKeys(AuthMode=7, WepStatus=6)
959): event :16 found
I/ethAsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
ernet( 959): the device flag :1 WCIDAttri = 0x1
1003
I/ethernet( 959): Done paAsicRemovePairwiseKeyEntry : Wcid #1
rsing
I/ethernet( 959): poll sremove none key #0
tate :, left:4096
I/EthernetMonitor( 959): get event
I/ethernet( 959): Poll events from ethAsicRemoveSharedKeyEntry: #0
ernet devices
D/wpa_supplicant(Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
1088): RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_Uremove
none key #1
P])
D/wpa_supplicant( 1088): RTAsicRemoveSharedKeyEntry: #1
M_NEWLINK, IFLA_IFNAME:
InterfacRTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x01
e 'wlan0' added
D/wpa_supplicanWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
t( 1088): Wireless event: cmd=0xremove none key #2
8b15 len=20
D/wpa_supplicant( 1AsicRemoveSharedKeyEntry: #2
088): Wireless event: new AP: 68Write: SHARED_KEY_MODE_BASE at this
Bss[0] = 0x0
:7f:74:1c:e4:7c
D/wpa_supplican==> MlmeHalt
t( 1088): Association info event--->Disable TSF synchronization
D/wpa_supplicant( 1088): WPA: remove none key #3
clearing AP WPA IE
D/wpa_suppliAsicRemoveSharedKeyEntry: #3
cant( 1088): WPA: clearing AP RSWrite: SHARED_KEY_MODE_BASE at this
Bss[0] = 0x0
N IE
D/wpa_supplicant( 1088): SComposePsPoll
RTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x00
I/wpa_supplicant( 1088): CTRL-E--->AsicEnableBssSync(INFRA mode)
VENT-STATE-CHANGE id=0 state=4
!!! LINK UP !!! ClientStatusFlags=0)
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate:
operstatMlmeUpdateTxRates[MaxSupport = 54] = MaxDesire 54 Mbps
e 0->0 (DORMANT)
D/wpa_supplica MlmeUpdateTxRates (MaxDesire=54, MaxSupport=54,
MaxTxRate=54, MinRate=1, Rate Switching =1)
nt( 1088): WEXT: Operstate: link<== MlmeHalt
mode=-1, operstate=5
V/WifiMoniMacTableReset
tor( 959): Event [CTRL-EVENT-ST MlmeUpdateTxRates (TxRate=24,
RtsRate=1, BasicRateBitmap=0x0150)
ATE-CHANGE id=0 state=4]
D/wpa_MacTableDeleteEntry1 - Total= 0
supplicant( 1088): Associated toMlmeUpdateTxRates (MlmeTransmit=0x0,
MinHTPhyMode=0, MaxHTPhyMode=0x0, HTPhyMode=0x0)
a new BSS: BSSID=68:7f:74:1c:e4:7c
D/wpa_supplicant( 1088): NoMlmeUpdateHtTxRates===>
keys have been configured - ski MlmeUpdateHtTxRates<---.AMsduSize =
0
p key clearing
I/wpa_supplicant( 1088): Associated with 68:7f:7TX: MCS[0] = ff
(choose 7), BW = 1, ShortGI = 1, MODE = 2,
4:1c:e4:7c
D/wpa_supplicant( 10MlmeUpdateHtTxRates<===
88): WPA: Association event - clear replay counter
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: Exter!!! LINK UP !!
(StaActive.bHtEnable =0, )
nal notification - portValid=0
NDIS_STATUS_MEDIA_CONNECT Event B!.BACapability = 3034040.
ClientStatusFlags = 0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): EAPOL: External notification -
pRTMPSetLED::Mode=1,HighByte=0x60,LowByte=0x01
ortEnabled=1
D/wpa_supplicant( 1088): EAPOL: SUPP_PAE entering state CONNECTING
D/wpa_supplicant( 1088): EAPOL: SUPP_BE enteriTxburst 2
ng state IDLE
D/wpa_supplicant(!!!pAd->bNextDisableRxBA= 0
1088): Setting authentication timeout: 10 sec 0 usec
D/wpa_supplicant( 1088): Cancelling scan CNTL - Association successful
on BSS #0
request
D/WifiStateTracker( 959): Disabling interface
I/EthernetMonitor( 959): go poll event--->RTUSBCancelPendingBulkInIRP
s
I/ethernet( 959): recvmsg ge<---RTUSBCancelPendingBulkInIRP
t data
I/ethernet( 959): even<---MlmeThread
t :16 found
I/ethernet( 959):<---RTUSBCmdThread
the device flag :11003
I/ether<---RtmpTimerQThread
net( 959): Done parsing
I/ethe---> RTMPFreeTxRxRingMemory
rnet( 959): poll state :, left:<--- RTMPFreeTxRxRingMemory
4096
I/EthernetMonitor( 959): <=== rt28xx_close
get event
V/WifiMonitor( 959): Event [Associated with 68:7f:7INFO::Network is
down!
4:1c:e4:7c]
I/ethernet( 959): Poll events from ethernet deviceINFO::Network is
down!
s
I/EthernetMonitor( 959): go poll events
D/wpa_supplicant( 1088): RTM_NEWLINK: operstate=0 iINFO::Network is
down!
fi_flags=0x1002 ()
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
INFO::Network is down!
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :INFO::Network is down!
16 found
I/ethernet( 959): the device flag :1002
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096INFO::Network is down!
I/ethernet( 959): Poll events from ethernet devices
D/wpa_suINFO::Network is down!
pplicant( 1088): RTM_NEWLINK: opINFO::Network is down!
erstate=0 ifi_flags=0x1003 ([UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant(INFO::Network is down!
1088): Wireless event: cmd=0x8b15 len=20
D/wpa_supplicant( 108INFO::Network is down!
8): Wireless event: new AP: 00:00:00:00:00:00
D/wpa_supplicant( 1088): Setting scan request: 0 sec 100000 usec
I/EthernetMonitor( 959): get event
I/EtherneINFO::Network is down!
tMonitor( 959): go poll events
I//system/bin/wpa_supplicant( 1083): l2_packet_receive - recvfrom:
Network is down
D/wpa_supplicant( 1088): BSSID 68:7f:74:1c:e4:7c blacklist count
incremented to 2
I/wpa_supplicant( 1088): CTRL-EVENT-DISCONNECTED - Disconnect event -
remove keys
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
V/WifiMonitor( 959): Event [CTRL-EVENT-DISCONNECTED - Disconnect
event - remove keys]
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :16 found
I/ethernet( 959): the device flag :1003
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/ethernet( 959): Poll events from ethernet devices
I/ethernet( 959): recvmsg get data
I/ethernet( 959): event :16 found
I/ethernet( 959): the device flag :1003
I/ethernet( 959): Done parsing
I/ethernet( 959): poll state :, left:4096
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=1
set_tx=0 seq_len=0 key_len=0
I/ethernet( 959): Poll events from ethernet devices
D/NetworkStateTracker( 959): setDetailed state, old =CONNECTED and
new state=DISCONNECTED
I/EthernetMonitor( 959): get event
I/EthernetMonitor( 959): go poll events
D/wpa_supplicant( did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=2
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=3
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
V/WifiStateTracker( 959): Changing supplicant state: SCANNING ==>
ASSOCIATING
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/NetworkStateTracker( 959): setDetailed state, old =DISCONNECTED and
new state=CONNECTING
V/WifiStateTracker( 959): Changing supplicant state: ASSOCIATING ==>
ASSOCIATED
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): State: ASSOCIATED -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: SUPP_PAE entering state DISCONNECTED
D/wpa_supplicant( 1088): EAPOL: SUPP_BE entering state INITIALIZE
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): RTM_NEWLINK: operstate=0 ifi_flags=0x1003
([UP])
D/wpa_supplicant( 1088): RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0'
added
D/wpa_supplicant( 1088): Wireless event: cmd=0x8b15 len=20
D/wpa_supplicant( 1088): Wireless event: new AP: 00:00:00:00:00:00
D/wpa_supplicant( 1088): BSSID 00:00:00:00:00:00 blacklist count
incremented to 2
I/wpa_supplicant( 1088): CTRL-EVENT-DISCONNECTED - Disconnect event -
remove keys
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
V/WifiMonitor( 959): Event [CTRL-EVENT-DISCONNECTED - Disconnect
event - remove keys]
D/NetworkStateTracker( 959): setDetailed state, old =CONNECTING and
new state=CONNECTING
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=1
set_tx=0 seq_len=0 key_len=0
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=2
set_tx=0 seq_len=0 key_len=0
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
V/WifiStateTracker( 959): New network state is DISCONNECTED
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=3
set_tx=0 seq_len=0 key_len=0
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
V/WifiStateTracker( 959): Changing supplicant state: ASSOCIATED ==>
DISCONNECTED
V/WifiStateTracker( 959): New network state is DISCONNECTED
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): wpa_driver_wext_set_key: alg=0 key_idx=0
set_tx=0 seq_len=0 key_len=0
D/ConnectivityService( 959): ConnectivityChange for WIFI: CONNECTING/
CONNECTING
D/ConnectivityService( 959): Dropping ConnectivityChange for WIFI:
CONNECTING/CONNECTING
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): Driver did not support SIOCSIWENCODEEXT
D/wpa_supplicant( 1088): State: DISCONNECTED -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
DISCONNECTED
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWENCODEEXT]: Network
is down
D/wpa_supplicant( 1088): State: DISCONNECTED -> SCANNING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=2
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=2]
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
SCANNING
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
D/wpa_supplicant( 1088): EAPOL: startWhen --> 0
D/WifiStateTracker( 959): Reset connections and stopping DHCP
INFO::Network is down!
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
D/wpa_supplicant( 1088): Scan timeout - try to get results
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
D/WifiStateTracker( 959): Disabling interface
D/NetworkStateTracker( 959): setDetailed state, old =CONNECTING and
new state=DISCONNECTED
D/ConnectivityService( 959): ConnectivityChange for WIFI:
DISCONNECTED/DISCONNECTED
D/ConnectivityService( 959): getMobileDataEnabled returning true
D/Tethering( 959): Tethering got CONNECTIVITY_ACTION
D/Tethering( 959): MasterInitialState.processMessage what=3
INFO::Network is down!9): setEthState from 2 to 2
E/HierarchicalStateMachine( 959): TetherMaster - unhandledMessage:
msg.what=3
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
I/wpa_supplicant( 1088): Authentication with 00:00:00:00:00:00
tINFO::Network is down!
imed out.
V/WifiMonitor( 959): Event [Authentication with 00:00:00:00:00:00
timed out.]
D/wpa_supplicant( 1088): BSSID 00:00:00:00:00:00 blacklist count
incremented to 3
D/wpa_supplicant( 1088): No keys have been configured - skip key
clearing
D/wpa_supplicant( 1088): State: SCANNING -> DISCONNECTED
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=0 state=0
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=0 state=0]
D/wpa_supplicant( 1088): wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5
D/wpa_supplicant( 1088): EAPOL: External notification - portEnabled=0
D/wpa_supplicant( 1088): EAPOL: External notification - portValid=0
D/wpa_supplicant( 1088): EAPOL: External notification - EAP success=0
D/wpa_supplicant( 1088): Setting scan request: 0 sec 0 usec
D/wpa_supplicant( 1088): State: DISCONNECTED -> SCANNING
I/wpa_supplicant( 1088): CTRL-EVENT-STATE-CHANGE id=-1 state=2
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
V/WifiStateTracker( 959): Changing supplicant state: SCANNING ==>
DISCONNECTED
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
V/WifiMonitor( 959): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
V/WifiStateTracker( 959): Changing supplicant state: DISCONNECTED ==>
SCANNING
D/dalvikvm( 1137): GC_EXPLICIT freed 3350 objects / 205728 bytes in
44ms
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
D/WifiStateTracker( 959): Reset connections and stopping DHCP
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
D/WifiStateTracker( 959): Disabling interface
D/NetworkStateTracker( 959): seINFO::Network is down!
tDetailed state, old =DISCONNECTED and new state=DISCONNECTED
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan timeout - try to get results
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
D/wpa_supplicant( 1088): Setting scan request: 10 sec 0 usec
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCSIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Scan results: -1
D/wpa_supplicant( 1088): Failed to get scan results
D/wpa_supplicant( 1088): Failed to get scan results - try scanning
again
D/wpa_supplicant( 1088): Setting scan request: 1 sec 0 usec
D/wpa_supplicant( 1088): Scan timeout - try to get results
I//system/bin/wpa_supplicant( 1083): ioctl[SIOCGIWSCAN]: Network is
down
INFO::Network is down!
D/wpa_supplicant( 1088): Starting AP scan (broadcast SSID)
D/wpa_supplicant( 1088): Scan requested (ret=-1) - scan timeout 5
seconds
W/wpa_supplicant( 1088): Failed to initiate AP scan.
[1] Illegal instruction logcat
# INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
INFO::Network is down!
Horace
Sep 28, 2010, 4:08:51 AM9/28/10
to android-porting
Hello,
I'm not sure.
But according to your logcat message, the WiFi module seems to lose
the beacons.
MMCHK - No BEACON. Dead CQI. Auto Recovery attempt #0
!!! LINK DOWN !!!
!!! LINK DOWN 2!!!
If the module lost some beacons continuously, it can become into
disconnection state.
Regards,
Horace.
> D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5 ...
>
> 추가 정보 »
I'm not sure.
But according to your logcat message, the WiFi module seems to lose
the beacons.
MMCHK - No BEACON. Dead CQI. Auto Recovery attempt #0
!!! LINK DOWN !!!
!!! LINK DOWN 2!!!
disconnection state.
Regards,
Horace.
>
> 추가 정보 »
G2
Oct 31, 2010, 9:38:46 PM10/31/10
to android-porting, elvis....@gmail.com
I'm facing the exact same issue with Touch Book (OMAP3530) + USB
RT3070? Have you managed to find the culprit?
Grégoire
> D/wpa_supplicant( 1088): WEXT: Operstate: linkmode=-1, operstate=5 ...
>
> read more »
RT3070? Have you managed to find the culprit?
Grégoire
>
> read more »
G2
Nov 24, 2010, 1:38:46 AM11/24/10
to android-porting
I'm still getting the error. I managed to hack by doing this patch:
--- a/external/wpa_supplicant/src/drivers/driver_wext.c 2010-11-05
13:40:07.089582001 -0700
+++ b/external/wpa_supplicant/src/drivers/driver_wext.c 2010-11-05
13:39:11.901582003 -0700
@@ -539,8 +539,9 @@
if (!drv->skip_disconnect) {
drv->skip_disconnect = 1;
#endif
- wpa_supplicant_event(ctx, EVENT_DISASSOC,
- NULL);
+// wpa_supplicant_event(ctx, EVENT_DISASSOC,
+// NULL);
+wpa_printf(MSG_DEBUG, "Debug This is where disconnect occurs");
#ifdef ANDROID
}
#endif
then wifi doesn't disconnect. But it's not clean because it's
intercepting at wpa level while the wrong "disconnect" command is
coming from the Android upper stack.
Two comments:
- The skip_disconnect variable of wpa_supplicant introduced by Android
is really odd. Somebody at Google will have to explain me one day what
it is about. In any case, it shows that the Wifi framework is not
clean, from the wpa_supplicant point of view.
- the disconnection only occurs once, and it seems to be always after
300s (it appears at 300s in dmesg...). 300=5minutes. I have searched
and searched in the code for anything about that but I haven't found
anything,
Grégoire
> ...
>
> read more »
--- a/external/wpa_supplicant/src/drivers/driver_wext.c 2010-11-05
13:40:07.089582001 -0700
+++ b/external/wpa_supplicant/src/drivers/driver_wext.c 2010-11-05
13:39:11.901582003 -0700
@@ -539,8 +539,9 @@
if (!drv->skip_disconnect) {
drv->skip_disconnect = 1;
#endif
- wpa_supplicant_event(ctx, EVENT_DISASSOC,
- NULL);
+// wpa_supplicant_event(ctx, EVENT_DISASSOC,
+// NULL);
+wpa_printf(MSG_DEBUG, "Debug This is where disconnect occurs");
#ifdef ANDROID
}
#endif
then wifi doesn't disconnect. But it's not clean because it's
intercepting at wpa level while the wrong "disconnect" command is
coming from the Android upper stack.
Two comments:
- The skip_disconnect variable of wpa_supplicant introduced by Android
is really odd. Somebody at Google will have to explain me one day what
it is about. In any case, it shows that the Wifi framework is not
clean, from the wpa_supplicant point of view.
- the disconnection only occurs once, and it seems to be always after
300s (it appears at 300s in dmesg...). 300=5minutes. I have searched
and searched in the code for anything about that but I haven't found
anything,
Grégoire
>
> read more »
Reply all
Reply to author
Forward
0 new messages