Hi,
I'm currently facing with wifi not working after restarting it from the android 2.2/2.2.1 settings wifi control panel.
I applied the driver-awext.c patch and I'm using wpa_supplicant 0.5.x with a Ralink RT3070USB wifi module.
When I first connect wifi, it can scan the AP and obtain its SSID.
My AP is secured so I type the WPA key and it obtains the IP address and works when I try to use the browser.
If I Turn Off Wifi from the settings control panel and turn it back on, it cannot connect.
Is it because the SIOCGIWSTATS ioctl is not implemented in the Ralink driver?
The strange thing is that it obtains the SSID and connects to it in the first place, but doesn't working on restarting wifi.
SCAN done, resume MSDU transmission ...
CNTL - BSSID not found. reply NDIS_STATUS_NOT_ACCEPTED
CNTL - BSSID not found. start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AYNC - InvalidStateWhenScan(state=2). Reset SYNC machine
SCAN done, resume MSDU transmission ...
===> rt28xx_close
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHINFO::Network is down!
ANGE id=0 state=0]
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCSIWSCAN]: Network is down
V/WifiStateTracker( 969): Changing supplicant state: ASSOCIATING ==> DISCONNECTED
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
V/WifiStateTracker( 969): Changing supplicant state: DISCONNECTED ==> SCANNING
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
rt28xx_get_wireless_stats --->
INFO::Network is down!
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
D/dalvikvm( 1198): GC_FOR_MALLOC freed 9817 objects / 545496 bytes in 62ms hsize: 16777216
INFO::Network is down!
INFO::Network is down!
D/WifiStateTracker( 969): Reset connections and stopping DHCP
W/wpa_supplicant( 1397): Failed to initiate AP scan.
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSCAN]: Network is down
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCSIWSCAN]: Network is down
D/WifiStateTracker( 969): Disabling interface
D/NetworkStateTracker( 969): setDetailed state, old =CONNECTING and new state=DISCONNECTED
rt28xx_get_wireless_stats --->
INFO::Network is down!
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
D/ConnectivityService( 969): ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED
D/DataConnectionTracker( 1056): enableApnType(default), isApnTypeActive = false and state = IDLE
D/DataConnectionTracker( 1056): type not available
D/ConnectivityService( 969): getMobileDataEnabled returning true
D/Tethering( 969): Tethering got CONNECTIVITY_ACTION
D/Tethering( 969): MasterInitialState.processMessage what=3
E/HierarchicalStateMachine( 969): TetherMaster - unhandledMessage: msg.what=3
INFO::Network is down!
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSCAN]: Network is down
INFO::Network is down!
W/wpa_supplicant( 1397): Failed to initiate AP scan.
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCSIWSCAN]: Network is down
D/dalvikvm( 1152): GC_EXPLICIT freed 1525 objects / 69984 bytes in 45ms hsize: 16777216
The full log from start to finish (start wifi, browse, stop wifi and restart) is given below:
I/WifiHW ( 969): Loading WiFi modules
I/WifiHW ( 969): WIFI DRIVER_MODULE_NAME := rt3070sta,
I/WifiHW ( 969): WIFI DRIVER_MODULE_TAG := rt3070sta ,
I/WifiHW ( 969): WIFI DRIVER_MODULE_PATH := /system/lib/modules/rt3070sta.ko,
E/WifiHW ( 969): driver rt3070sta has NOT been installed
rtusb init --->
===>rt2870_probe()!
--> RTMPAllocAdapterBlock
=== pAd = d0962000, size = 500648 ===
<-- RTMPAllocAdapterBlock, Status=0
NumEndpoints=7
BULK IN MaxPacketSize = 512
EP address = 0x81
BULK OUT MaxPacketSize = 512
EP address = 0x 1
BULK OUT MaxPacketSize = 512
EP address = 0x 2
BULK OUT MaxPacketSize = 512
EP address = 0x 3
BULK OUT MaxPacketSize = 512
EP address = 0x 4
BULK OUT MaxPacketSize = 512
EP address = 0x 5
BULK OUT MaxPacketSize = 512
EP address = 0x 6
STA Driver version-2.3.0.4
NVM is EEPROM
Allocate a net device with private data size=0!
Allocate net device ops success!
The name of the new wlan interface is wlan0...
RtmpOSNetDevAttach()--->
<---RtmpOSNetDevAttach(), ret=0
<===rt2870_probe()!
D/Tethering( 969): wlan0 is not a tetherable iface, ignoring
usbcore: registered new interface driver rt2870
Allocate 8192 memory for BA reordering
MAC_CSR0 [ Ver:Rev=0x30700201]
<=== RtmpAsicLoadFirmware (status=0)
--> RTMPAllocTxRxRingMemory
--> NICInitTransmit
MGMT Ring: total 32 entry allocated
<-- NICInitTransmit(Status=0)
--> NICInitRecv
<-- NICInitRecv(Status=0)
<-- RTMPAllocTxRxRingMemory, Status=0
--> MLME Initialize
<-- MLME Initialize
--> UserCfgInit
--> UserCfgInit. BACapability = 0x3024040
<-- UserCfgInit
--> NICInitializeAdapter
<== DMA offset 0x208 = 0x0
--> NICInitializeAsic
MAC_CSR0 [ Ver:Rev=0x30700201]
-->RTUSBVenderReset
<--RTUSBVenderReset
BBP version = 60
--->Disable TSF synchronization
<-- NICInitializeAsic
<-- NICInitializeAdapter
1. Phy Mode = 0
2. Phy Mode = 0
--> NICReadEEPROMParameters
--> E2PROM_CSR = 0x20408
--> EEPROMAddressNum = 6
Initialize MAC Address from E2PROM
E2PROM MAC: =00:08:10:74:b5:da
Use the MAC address what is assigned from EEPROM.
Current MAC: =00:08:10:74:b5:da
E2PROM: Version = 1, FAE release #1
NICReadEEPROMParameters: RxPath = 1, TxPath = 1
Chip specific bbpRegTbSize=0!
E2PROM: G Tssi[-4 .. +4] = 255 255 255 255 - 255 -255 255 255 255, step=255, tuning=0
E2PROM: A Tssi[-4 .. +4] = 0 0 0 0 - 0 -0 0 0 0, step=0, tuning=0
E2PROM: RF FreqOffset=0x29
RTMPSetPhyMode : PhyMode=0, channel=0
country code=128/128, RFIC=5, PHY mode=0, support 11 channels
BuildChannel # 1 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 2 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 3 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 4 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 5 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 6 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 7 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 8 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 9 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 10 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 11 :: Pwr0 = 16, Pwr1 =5,
RTMPSetPhyMode: channel is out of range, use first channel=1
Txpower per Rate
Gpwrdelta = 0, Apwrdelta = 0 .
20MHz BW, 2.4G band-aaaa6666, Adata = aaaa6666, Gdata = aaaa6666
20MHz BW, 2.4G band-aaaa6688, Adata = aaaa6688, Gdata = aaaa6688
20MHz BW, 2.4G band-aaaa6688, Adata = aaaa6688, Gdata = aaaa6688
20MHz BW, 2.4G band-aaaa6688, Adata = aaaa6688, Gdata = aaaa6688
20MHz BW, 2.4G band-ffff6688, Adata = ffff6688, Gdata = ffff6688
<-- NICReadEEPROMParameters
3. Phy Mode = 0
--> NICInitAsicFromEEPROM
AsicSetRxAnt, switch to main antenna
RTMPFilterCalibration - CaliBW20RfR24=0xa, CaliBW40RfR24=0x28
RTMPSetLED::Mode=1,HighByte=0x20,LowByte=0x01
Use Hw Radio Control Pin=0; if used Pin=0;
TxPath = 1, RxPath = 1, RFIC=5, Polar+LED mode=1
<-- NICInitAsicFromEEPROM
RTMPSetPhyMode : PhyMode=0, channel=1
country code=128/128, RFIC=5, PHY mode=0, support 11 channels
BuildChannel # 1 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 2 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 3 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 4 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 5 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 6 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 7 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 8 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 9 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 10 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 11 :: Pwr0 = 16, Pwr1 =5,
MCS Set = 00 00 00 00 00
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
NDIS_STATUS_MEDIA_DISCONNECT Event B!
RTUSBBulkReceive!
<==== rt28xx_init, Status=0
==> RTMPEnableRxTx
<== WRITE DMA offset 0x208 = 0x45
<== RTMPEnableRxTx
0x1300 = 00073200
STAMlmePeriodicExec():CNTL - ScanTab.BssNr==0, start a new ACTIVE scan SSID[]
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/WifiHW ( 969): Wi-Fi is runnAsicSwitchChannel#8(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x07, R=0x02
ing
D/WifiService( 969): ACTION_BATTERY_CHANGED pluggedType: 1
I/WifiHW ( 969): Interface directory = /data/system/wpa_supplicant
I/WifiHW ( 969): Interface name = /data/system/wpa_supplicant/wlan0
E/WifiHW ( 969): Unable to open connection to supplicant on "/data/system/wpa_supplicant/wlan0": No such file or directory
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
===> rt_ioctl_siwpmksa
rt_ioctl_siwpmksa - IW_PMKSA_FLUSH
===>Set_NetworkType_Proc::(INFRA)
Set_NetworkType_Proc::(NetworkType=1)
===>rt_ioctl_giwrange
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
rt_ioctl_siwauth::IW_AUTH_WPA_ENABLED - Driver supports WPA!(param->value = 1)
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #0
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8001)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #1
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8002)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #2
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8003)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #3
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8004)
rt_ioctl_siwauth::IW_AUTH_WPA_VERSION - param->value = 1!
rt_ioctl_giwscan:: Still scanning
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=-1 state=2
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
I/power ( 969): *** set_screert_ioctl_giwscan:: Still scanning
n_state 1
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x02, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#4(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x07, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#5(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x02, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#8(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x07, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#9(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF5, K=0x02, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#10(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF5, K=0x07, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#11(RF=5, Pwr0=16, Pwr1=5, 1T), N=0xF6, K=0x02, R=0x02
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
rt_ioctl_giwscan:: Still scanning
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
rt_ioctl_giwscan:: Still scanning
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
===>rt_ioctl_giwscan. 1(1) BSS returned, data->length = 200
SCANNING, suspend MSDU transmission ...
I/wpa_supplicant( 1292): CTRL-EVSYNC - BBP R4 to 20MHz.l
ENT-SCAN-RESULTS Ready
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
I/WifiHW ( 969): Interface directory = /data/system/wpa_supplicant
I/WifiHW ( 969): Interface name = /data/system/wpa_supplrt28xx_get_wireless_stats --->
icant/wlan0
I/WifiHW ( 969): <--- rt28xx_get_wireless_stats
connect to supplicant done
V/WifiStateTracker( 969): Connection to supplicant established, state=SCANNING
D/NetworkStateTracker( 969): setDetailed state, old =IDLE and new state=SCANNING
D/ConnectivityService( 969): ConnectivityChange for WIFI: DISCONNECTED/SCANNING
D/ConnectivityService( 969): getMobileDataEnabled returning true
D/DataConnectionTracker( 1056): enableApnType(default), isApnTypeActive = false and state = IDLE
D/DataConnectionTracker( 1056): type not available
D/Tethering( 969): Tethering got CONNECTIVITY_ACTION
D/Tethering( 969): MasterInitialState.processMessage what=3
E/HierarchicalStateMachine( 969): TetherMaster - unhandledMessage: msg.what=3
===>rt_ioctl_giwscan. 1(1) BSS returned, data->length = 200
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=-1 state=1
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=1]
V/WifiStateTracker( 969): Changing supplicant state: SCANNING ==> INACTIVE
D/NetworkStateTracker( 969): setDetailed state, old =SCANNING and new state=IDLE
D/ConnectivityService( 969): Dropping ConnectivityChange for WIFI: DISCONNECTED/IDLE
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/power ( 969): *** set_screen_state 1
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[02]
SCAN done, resume MSDU transmission ...
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/ActivityManager( 969): Starting activity: Intent { act=android.intent.action.MAIN cmp=com.android.settings/.wifi.WifiSettings }
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 2 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
!!! reset MLME state machine !!!
MlmeRestartStateMachine
!!! MLME busy, reset MLME state machine !!!
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=-1 state=2
V/WifiMonitor( 969): Event [CTRAsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
L-EVENT-STATE-CHANGE id=-1 state=2]
V/WifiStateTracker( 969): Changing supplicant state: INACTIVE =SCAN done, resume MSDU transmission ...
=> SCANNING
D/NetworkStateTracker( 969): seSCANNING, suspend MSDU transmission ...
tDetailed state, old =IDLE and new state=SCANNING
SYNC - BBP R4 to 20MHz.l
D/ConnectivityService( 969): Dropping ConnectivityChange for WIFI: DISCONNECTED/SCANNING
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
I/dalvikvm( 969): Jit: resizing JitTable from 4096 to 8192
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
I/ActivityManager( 969): Displayed activity com.android.settings/.wifi.WifiSettings: 539 ms (total 539 ms)
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[02]
SCAN done, resume MSDU transmission ...
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 2 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
I/power ( 969): *** set_screen_state 1
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
!!! MLME busy, reset MLME state machine !!!
!!! reset MLME state machine !!!
MlmeRestartStateMachine
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[02]
SCAN done, resume MSDU transmission ...
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/ARMAssembler( 969): generated scanline__00000077:03515104_00000000_00000000 [ 33 ipp] (47 ins) at [0x2bd2e8:0x2bd3a4] in 244141 ns
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
D/dalvikvm( 1198): GC_FOR_MALLOC freed 5597 objects / 289872 bytes in 57ms hsize: 16777216
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 2 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
!!! reset MLME state machine !!!
MlmeRestartStateMachine
!!! MLME busy, reset MLME state machine !!!
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
D/dalvikvm( 1048): GC_FOR_MALLOC freed 4230 objects / 265728 bytes in 130ms hsize: 16777216
AsicSwitchChannel#11(RF=5, Pwr0=16, Pwr1=5, 1T), N=0xF6, K=0x02, R=0x02
D/dalvikvm( 1048): GC_EXTERNAL_ALLOC freed 886 objects / 39280 bytes in 72ms hsize: 16777216
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[02]
SCAN done, resume MSDU transmission ...
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
W/KeyCharacterMap( 1198): No keyboard for id 0
W/KeyCharacterMap( 1198): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 2 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
AsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x02, R=0x02
!!! reset MLME state machine !!!
MlmeRestartStateMachine
!!! MLME busy, reset MLME state machine !!!
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/power ( 969): *** set_screen_state 1
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
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[02]
SCAN done, resume MSDU transmission ...
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
E/NetworkManagmentService( 969): Unexpected response code 600
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 2 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
!!! MLME busy, reset MLME state machine !!!
!!! reset MLME state machine !!!
MlmeRestartStateMachine
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/power ( 969): *** set_screen_state 1
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[02]
SCAN done, resume MSDU transmission ...
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 2 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
!!! reset MLME state machine !!!
!!! MLME busy, reset MLME state machine !!!
MlmeRestartStateMachine
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screeAsicSwitchChannel#5(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x02, R=0x02
n_state 1
I/power ( 969): *** set_screen_state 1
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[02]
SCAN done, resume MSDU transmission ...
I/power ( 969): *** set_screen_state 1
D/dalvikvm( 969): GC_FOR_MALLOC freed 9018 objects / 478800 bytes in 98ms hsize: 16777216
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
CntlOidSsidProc():CNTL - 0 BSS of 2 BSS match the desire (0)SSID -
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
I/power ( 969): *** set_screen_state 1
AsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x02, R=0x02
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
AsicSwitchChannel#4(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x07, R=0x02
!!! reset MLME state machine !!!
!!! MLME busy, reset MLME state machine !!!
MlmeRestartStateMachine
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/power ( 969): *** set_screen_state 1
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
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
!!! reset MLME state machine !!!
MlmeRestartStateMachine
!!! MLME busy, reset MLME state machine !!!
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=-1 state=2
V/WifiMonitor( 969): Event [CTRAsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
L-EVENT-STATE-CHANGE id=-1 state=2]
SCAN done, resume MSDU transmission ...
V/WifiStateTracker( 969): ChangSCANNING, suspend MSDU transmission ...
ing supplicant state: SCANNING ==> SCANNING
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
I/dalvikvm( 1198): Jit: resizing JitTable from 4096 to 8192
===>rt_ioctl_giwscan. 1(1) BSS returned, data->length = 200
I/wpa_supplicant( 1292): CTRL-EVrt_ioctl_siwauth::IW_AUTH_80211_AUTH_ALG - param->value = 1!
ENT-SCAN-RESULTS Ready
rt_ioctl_siwauth::IW_AUTH_WPA_VERSION - param->value = 1!
I/wpa_supplicant( 1292): Trying ===>Set_NetworkType_Proc::(INFRA)
to associate with 68:7f:74:1c:e4Set_NetworkType_Proc::(NetworkType=1)
:7c (SSID='Olympus2' freq=2437 M===> rt_ioctl_siwgenie
Hz)
I/wpa_supplicant( 1292): CTrt_ioctl_siwauth::IW_AUTH_WPA_VERSION - param->value = 4!
RL-EVENT-STATE-CHANGE id=-1 statrt_ioctl_siwauth::IW_AUTH_CIPHER_PAIRWISE - param->value = 8!
e=3
rt_ioctl_siwauth::IW_AUTH_CIPHER_GROUP - param->value = 4!
rt_ioctl_siwauth::IW_AUTH_KEY_MGMT - param->value = 2!
rt_ioctl_siwauth::IW_AUTH_PRIVACY_INVOKED - param->value = 1!
==>rt_ioctl_siwfreq::SIOCSIWFREQ[cmd=0x8b04] (Channel=1)
Set_SSID_Proc::(Len=8,Ssid=Olympus2)
CntlOidSsidProc():CNTL - 1 BSS of 1 BSS match the desire (8)SSID - Olympus2
IOCTL::SIOCSIWAP 68:7f:74:1c:e4:7c
CNTL - iterate BSS 0 of 1
SYNC - MlmeJoinReqAction(BSS #0)
SYNC - BBP R4 to 20MHz.l
V/WifiMonitor( 969): Event [Trying to associate with 68:7f:74:1AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
c:e4:7c (SSID='Olympus2' freq=2437 MHz)]
SYNC - Switch to ch 6, Wait BEACON from 68:7f:74:1c:e4:7c
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=3]
V/WifiStateTracker( 969): Changing supplicant state: SCANNING ==> ASSOCIATING
SYNC - receive desired BEACON at JoinWaitBeacon... Channel = 6
MlmeAux.ExtCapInfo=0
RTMPUpdateMlmeRate ==> MlmeTransmit = 0x0
SYNC - after JOIN, SupRateLen=8, ExtRateLen=4
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
!!! 20MHz !!!
D/NetworkStateTracker( 969): seAUTH - Send AUTH request seq#1 (Alg=0)...
tDetailed state, old =SCANNING and new state=CONNECTING
AUTH - Receive AUTH_RSP seq#2 to me (Alg=0, Status=0)
D/ConnectivityService( 969): CoCNTL - AUTH OK
nnectivityChange for WIFI: CONNECTING/CONNECTING
ASSOC - Send ASSOC request...
PeerAssocRspAction():ASSOC - receive ASSOC_RSP to me (status=0)
PeerAssocRspAction():MacTable [255].AMsduSize = 0. ClientStatusFlags = 0x0
AssocPostProc===> AP.AMsduSize = 0. ClientStatusFlags = 0x0
AssocPostProc===> (Mmps=0, AmsduSize=0, )
AssocPostProc===> Store RSN_IE for WPA2 SM negotiation
RSN_IE: d09c4674, len = 26
0x0000 : 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f
0x0010 : ac 02 01 00 00 0f ac 02 0c 00
I/wpa_supplicant( 1292): CTRL-EV!!!Infra LINK UP !!!
ENT-STATE-CHANGE id=0 state=4
I/wpa_supplicant( 1292): Associa!!! LINK UP !!! (BssType=1, AID=1, ssid=Olympus2, Channel=6, CentralChannel = 6)
ted with 68:7f:74:1c:e4:7c
V/WifiMonitor( 969): Event [CTR!!! LINK UP !!! (Density =0, )
L-EVENT-STATE-CHANGE id=0 state=4]
V/WifiStateTracker( 969): C==============> AsicSetBssid 68:7f:74:1c:e4:7c
hanging supplicant state: ASSOCIAsicSetEdcaParm
ATING ==> ASSOCIATED
D/NetworkStateTracker( 969): setDetailed NDIS_STATUS_MEDIA_DISCONNECT Event AA!
state, old =CONNECTING and new sRTMPWPARemoveAllKeys(AuthMode=7, WepStatus=6)
tate=CONNECTING
V/WifiMonitor( 969): Event [Associated with 68:7f:74:1c:e4:7c]
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
remove none key #0
AsicRemoveSharedKeyEntry: #0
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
remove none key #1
AsicRemoveSharedKeyEntry: #1
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
remove none key #2
AsicRemoveSharedKeyEntry: #2
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
remove none key #3
AsicRemoveSharedKeyEntry: #3
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
ComposePsPoll
--->AsicEnableBssSync(INFRA mode)
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
!!! LINK UP !!! ClientStatusFlags=0)
MlmeUpdateTxRates[MaxSupport = 54] = MaxDesire 54 Mbps
MlmeUpdateTxRates (MaxDesire=54, MaxSupport=54, MaxTxRate=54, MinRate=1, Rate Switching =1)
MlmeUpdateTxRates (TxRate=24, RtsRate=24, BasicRateBitmap=0x015f)
MlmeUpdateTxRates (MlmeTransmit=0x0, MinHTPhyMode=0, MaxHTPhyMode=0x4004, HTPhyMode=0x4004)
MlmeUpdateHtTxRates===>
!!! LINK UP !! (StaActive.bHtEnable =0, )
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
NDIS_STATUS_MEDIA_CONNECT Event B!.BACapability = 3024040. ClientStatusFlags = 0
RTMPSetLED::Mode=1,HighByte=0x60,LowByte=0x01
Txburst 2
!!!pAd->bNextDisableRxBA= 0
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
not supports 20/40 BSS COEX !!!
pAd->CommonCfg.bBssCoexEnable 1 !!!
pAd->CommonCfg.Channel 6 !!!
pAd->StaActive.SupportedHtPhy.bHtEnable 0 !!!
pAd->MlmeAux.ExtCapInfo.BssCoexstSup 0 !!!
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
pAd->CommonCfg.CentralChannel 6 !!!
pAd->CommonCfg.PhyMode 0 !!!
CNTL - Association successful on BSS #0
SYNC - AP changed N OperaionMode to 3
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/power ( 969): *** set_screen_state 1
Receive EAPOL-Key frame, TYPE = 3, Length = 117
MediaState is connected
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=0 state=5
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 969): Changing supplicant state: ASSOCIATED ==> FOUR_WAY_HANDSHAKE
D/NetworkStateTracker( 969): setDetailed state, old =CONNECTING anReceive EAPOL-Key frame, TYPE = 3, Length = 175
d new state=AUTHENTICATING
D/Cort_ioctl_siwencodeext::DefaultKeyId = 0
nnectivityService( 969): Dropping ConnectivityChange for WIFI: AsicAddSharedKeyEntry BssIndex=0, KeyIdx=0
CONNECTING/AUTHENTICATING
I/wpaAsicAddSharedKeyEntry: AES key #0
_supplicant( 1292): CTRL-EVENT-S Key = 68:d6:0e:2e:83:68:6f:06:4f:85:5d:9c:4c:4f:23:6b
TATE-CHANGE id=0 state=5
V/Wifi Rx MIC Key = 00:00:00:00:00:00:00:00
Monitor( 969): Event [CTRL-EVEN Tx MIC Key = 00:00:00:00:00:00:00:00
T-STATE-CHANGE id=0 state=5]
V/Read: SHARED_KEY_MODE_BASE at this Bss[0] KeyIdx[0]= 0x0
WifiStateTracker( 969): ChanginWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x4
g supplicant state: FOUR_WAY_HANAsicUpdateWCIDIVEIV: wcid(1) 0x20000001, 0x00000000
DSHAKE ==> FOUR_WAY_HANDSHAKE
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=AES
WCIDAttri = 0x8
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=0 state=6
rt_ioctl_siwencodeext::IW_ENCODE_ALG_TKIP - keyIdx = 2, ext->key_len = 32
V/WifiMonitor( 969): Event [CTRAsicAddSharedKeyEntry BssIndex=0, KeyIdx=2
L-EVENT-STATE-CHANGE id=0 state=AsicAddSharedKeyEntry: TKIP key #2
6]
V/WifiStateTracker( 969): C Key = a6:07:f3:8b:11:37:bf:1e:bb:10:f8:be:03:a1:82:b1
hanging supplicant state: FOUR_W Rx MIC Key = da:42:4b:7d:6a:82:cb:86
AY_HANDSHAKE ==> GROUP_HANDSHAKE Tx MIC Key = 6d:8f:18:80:a1:0b:4a:1b
Read: SHARED_KEY_MODE_BASE at this Bss[0] KeyIdx[2]= 0x4
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x304
I/wpa_supplicant( 1292): WPA: Key negotiation completed with 68:rt28xx_get_wireless_stats --->
7f:74:1c:e4:7c [PTK=CCMP GTK=TKIP]
V/WifiMonitor( 969): Event [WPA: Key negotiation completed <--- rt28xx_get_wireless_stats
with 68:7f:74:1c:e4:7c [PTK=CCMP GTK=TKIP]]
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=0 state=7
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHANGE id=0 state=7]
I/wpa_supplicant( 1292): CTRL-EVENT-CONNECTED - Connection to 68:7f:74:1c:e4:7c completed (auth) [id=0 id_str=]
V/WifiMonitor( 969): Event [CTRL-EVENT-CONNECTED - Connection to 68:7f:74:1c:e4:7c completed (auth) [id=0 id_str=]]
D/NetworkStateTracker( 969): setDetailed state, old =AUTHENTICATING and new state=AUTHENTICATING
V/WifiStateTracker( 969): Changing supplicant state: GROUP_HANDSHAKE ==> COMPLETED
V/WifiStateTracker( 969): New network state is CONNECTED
D/WifiStateTracker( 969): DhcpHandler: DHCP request started
D/dhcp_utils( 969): dhcp_do_request
D/NetworkStateTracker( 969): setDetailed state, old =AUTHENTICATING and new state=OBTAINING_IPADDR
D/ConnectivityService( 969): Dropping ConnectivityChange for WIFI: CONNECTING/OBTAINING_IPADDR
D/dalvikvm( 1198): GC_FOR_MALLOC freed 9867 objects / 523176 bytes in 111ms hsize: 16777216
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/dhcpcd ( 1301): dhcpcd 4.0.15 starting
D/dhcpcd ( 1301): hardware address = 00:08:10:74:b5:da
D/dhcpcd ( 1301): executing `/system/etc/dhcpcd/dhcpcd-run-hooks', reason PREINIT
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
SCANNING, suspend MSDU transmission ...
MlmeScanReqAction -- Send PSM Data frame for off channel RM, SCAN_IN_PROGRESS=1!
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
I//system/bin/dhcpcd( 1300): [: not found
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
AsicSwitchChannel#3(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF2, K=0x02, R=0x02
D/dhcpcd ( 1301): host does not support a monotonic clock - timing can skew
D/dhcpcd ( 1301): broadcasting for a lease
D/dhcpcd ( 1301): sending DHCP_DISCOVER with xid 0x92e3848e, next in 4.04 seconds
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
ScanNextChannel():Send PWA NullData frame to notify the associated AP!
ScanTimeoutAction():Send PWS NullData frame to notify the associated AP!
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
SYNC - End of SCAN, restore to channel 6, Total BSS[01]
ScanNextChannel -- Send PSM Data frame
bFastRoamingScan ~~~~~~~~~~~~~ Get back to send data ~~~~~~~~~~~~~
SCAN done, resume MSDU transmission ...
bImprovedScan ............. Resume for bImprovedScan, SCAN_PENDING ..............
SCANNING, suspend MSDU transmission ...
MlmeScanReqAction -- Send PSM Data frame for off channel RM, SCAN_IN_PROGRESS=1!
SYNC - BBP R4 to 20MHz.l
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
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
SYNC - End of SCAN, restore to channel 6, Total BSS[02]
ScanNextChannel -- Send PSM Data frame
D/dhcpcd ( 1301): offered 192.1SCAN done, resume MSDU transmission ...
68.1.102 from 192.168.1.1
D/dhcpcd ( 1301): sending DHCP_REQUEST with xid 0x92e3848e, next in 3.17 seconds
D/dhcpcd ( 1301): acknowledged 192.168.1.102 from 192.168.1.1
D/dhcpcd ( 1301): checking 192.168.1.102 is available on attached networks
D/dhcpcd ( 1301): sending ARP probe (1 of 3), next in 1.22 seconds
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/dhcpcd ( 1301): sending ARP probe (2 of 3), next in 1.25 seconds
D/dhcpcd ( 1301): sending ARP probe (3 of 3), next in 2.00 seconds
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
SCANNING, suspend MSDU transmission ...
MlmeScanReqAction -- Send PSM Data frame for off channel RM, SCAN_IN_PROGRESS=1!
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
D/dhcpcd ( 1301): leased 192.168.1.102 for 86400 seconds
D/dhcpcd ( 1301): adding IP address 192.168.1.102/24
D/dhcpcd ( 1301): adding route to 0.0.0.0/0 via 192.168.1.1
D/dhcpcd ( 1301): executing `/system/etc/dhcpcd/dhcpcd-run-hooks', reason BOUND
I//system/bin/dhcpcd( 1300): [: not found
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
ScanNextChannel():Send PWA NullData frame to notify the associated AP!
ScanTimeoutAction():Send PWS NullData frame to notify the associated AP!
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
SYNC - End of SCAN, restore to channel 6, Total BSS[01]
ScanNextChannel -- Send PSM Data frame
bFastRoamingScan ~~~~~~~~~~~~~ Get back to send data ~~~~~~~~~~~~~
SCAN done, resume MSDU transmission ...
bImprovedScan ............. Resume for bImprovedScan, SCAN_PENDING ..............
SCANNING, suspend MSDU transmission ...
MlmeScanReqAction -- Send PSM Data frame for off channel RM, SCAN_IN_PROGRESS=1!
SYNC - BBP R4 to 20MHz.l
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/dhcp_utils( 969): dhcp ok1: wlan0 169.110.52.173 169.110.52.173
D/dhcp_utils( 969): dhcp ok2: wlan0 213.132.63.25 213.132.63.25
V/WifiStateTracker( 969): DhcpHandler: DHCP request succeeded
D/NetworkStateTracker( 969): setDetailed state, old =OBTAINING_IPADDR and new state=CONNECTED
V/WifiStateTracker( 969): IP configuration: ipaddr 192.168.1.102 gateway 192.168.1.1 netmask 255.255.255.0 dns1 192.168.1.1 dns2 213.132.63.25 DHCP server 192.168.1.1 lease 86400 seconds
V/NetworkStateTracker( 969): Setting TCP values: [4095,87380,110208,4096,16384,110208] which comes from [net.tcp.buffersize.wifi]
D/ConnectivityService( 969): ConnectivityChange for WIFI: CONNECTED/CONNECTED
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
SYNC - End of SCAN, restore to channel 6, Total BSS[02]
ScanNextChannel -- Send PSM Data frame
SCAN done, resume MSDU transmission ...
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
E/NetworkStateTracker( 969): Can't set tcp buffer sizes:java.iort28xx_get_wireless_stats --->
.FileNotFoundException: /sys/ker<--- rt28xx_get_wireless_stats
nel/ipv4/tcp_rmem_min (Permission denied)
D/ConnectivityService( 969): adding dns 192.168.1.1 for WIFI
D/ConnectivityService( 969): adding dns 213.132.63.25 for WIFI
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/WifiWatchdogService( 969): (android.server.ServerThread) Olympus2 (68:7f:74:1c:e4:7c) does not require the watchdog
D/Tethering( 969): Tethering got CONNECTIVITY_ACTION
D/Tethering( 969): MasterInitialState.processMessage what=3
E/HierarchicalStateMachine( 969): TetherMaster - unhandledMessage: msg.what=3
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/dhcpcd ( 1301): sending ARP announce (1 of 2), next in 2.00 seconds
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
SCANNING, suspend MSDU transmission ...
MlmeScanReqAction -- Send PSM Data frame for off channel RM, SCAN_IN_PROGRESS=1!
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
D/dhcpcd ( 1301): sending ARP announce (2 of 2)
D/dhcpcd ( 1301): renew in 43196 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
ScanNextChannel():Send PWA NullData frame to notify the associated AP!
ScanTimeoutAction():Send PWS NullData frame to notify the associated AP!
AsicSwitchChannel#7(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF4, K=0x02, R=0x02
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
SYNC - End of SCAN, restore to channel 6, Total BSS[01]
ScanNextChannel -- Send PSM Data frame
bFastRoamingScan ~~~~~~~~~~~~~ Get back to send data ~~~~~~~~~~~~~
SCAN done, resume MSDU transmission ...
bImprovedScan ............. Resume for bImprovedScan, SCAN_PENDING ..............
SCANNING, suspend MSDU transmission ...
MlmeScanReqAction -- Send PSM Data frame for off channel RM, SCAN_IN_PROGRESS=1!
SYNC - BBP R4 to 20MHz.l
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
AsicSwitchChannel#6(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF3, K=0x07, R=0x02
SYNC - End of SCAN, restore to channel 6, Total BSS[02]
ScanNextChannel -- Send PSM Data frame
SCAN done, resume MSDU transmission ...
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
W/KeyCharacterMap( 1198): No keyboard for id 0
W/KeyCharacterMap( 1198): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
SYNC - send NULL Frame @24 Mbps...
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 324
I/wpa_supplicant( 1292): CTRL-EVENT-SCAN-RESULTS Ready
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
D/dalvikvm( 1110): GC_EXTERNAL_ALLOC freed 2535 objects / 118424 bytes in 64ms hsize: 16777216
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
D/dalvikvm( 1152): GC_EXPLICIT freed 2931 objects / 187072 bytes in 109ms hsize: 16777216
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/ActivityManager( 969): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.android.browser/.BrowserActivity }
I/ActivityManager( 969): Start proc com.android.browser for activity com.android.browser/.BrowserActivity: pid=1331 uid=10012 gids={3003, 1015}
D/installd( 914): DexInv: --- BEGIN '/system/app/Browser.apk' ---
D/dalvikvm( 1339): creating instr width table
D/dalvikvm( 1339): DexOpt: load 74ms, verify 318ms, opt 12ms
D/installd( 914): DexInv: --- END '/system/app/Browser.apk' (success) ---
I/ActivityThread( 1331): Publishing provider browser: com.android.browser.BrowserProvider
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
I/BrowserSettings( 1331): Selected search engine: ActivitySearchEngine{android.app.SearchableInfo@43e55990}
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331)SYNC - send NULL Frame @24 Mbps...
: Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
E/ActivityThread( 1331): Failed to find provider info for com.google.settings
I/Database( 1331): sqlite returned: error code = 1, msg = no such table: IconDatabaseInfo
I/ActivityManager( 969): Displayed activity com.android.browser/.BrowserActivity: 3094 ms (total 3094 ms)
D/dalvikvm( 1331): GC_FOR_MALLOC freed 4087 objects / 274744 bytes in 69ms hsize: 16777216
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/power ( 969): *** set_screen_state 1
D/dalvikvm( 1331): GC_EXTERNAL_ALLOC freed 2457 objects / 267168 bytes in 61ms hsize: 16777216
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
D/dalvikvm( 1110): GC_EXPLICIT freed 987 objects / 49208 bytes in 55ms hsize: 16777216
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
SYNC - send NULL Frame @24 Mbps...
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
W/KeyCharacterMap( 1331): No keyboard for id 0
W/KeyCharacterMap( 1331): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/ActivityManager( 969): moveTaskToBack: 5
W/InputManagerService( 969): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@43ecb9b0 (uid=10012 pid=1331)
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/ActivityManager( 969): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.android.settings/.Settings }
I/ActivityManager( 969): Displayed activity com.android.settings/.Settings: 312 ms (total 312 ms)
I/power ( 969): *** set_screen_state 1
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/ActivityManager( 969): Starting activity: Intent { act=android.intent.action.MAIN cmp=com.android.settings/.WirelessSettings }
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
rt28xx_get_wireless_stats --->
<--- rt28xx_get_wireless_stats
I/ActivityManager( 969): Displayed activity com.android.settings/.WirelessSettings: 247 ms (total 247 ms)
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
====> rt_ioctl_siwmlme
====> rt_ioctl_siwmlme - IW_MLME_DEAUTH
I/wpa_supplicant( 1292): CTRL-EVENT-TERMINATING - signal 15 received
I/wpa_supplicant( 1292): CAUTH - Send DE-AUTH request (Reason=3)...
TRL-EVENT-TERMINATING - signal 0 received
I/wpa_supplicant( 1292): CTRL-EVENT-STATE-CHANGE id=0!!! LINK DOWN !!!
state=0
V/WifiMonitor( 969): !!! LINK DOWN 2!!!
Event [CTRL-EVENT-TERMINATING - signal 15 received]
V/WifiStateTracker( 969): Connection to suMacTableDeleteEntry1 - Total= 0
pplicant lost
CmdThread : CMDTHREAD_SET_ASIC_WCID : WCID = 1, SetTid = ffffffff, DeleteTid = ffffffff.
1-MACValue= 0,
2-MACValue= 0,
AsicSetEdcaParm
CNTL - Illegal message in CntlIdleProc(MsgType=36)
RTMPSetLED::Mode=1,HighByte=0x20,LowByte=0x01
D/NetworkStateTracker( 969): setDetailed state, old =CONNECTED --->Disable TSF synchronization
and new state=DISCONNECTED
D/ConnectivityService( 969): ConnectivityChange for WIFI: DISCONNECLinkDownCleanMlmeAux.ExtCapInfo!
TED/DISCONNECTED
D/ConnectivityService( 969): getMobileDataEnabled returning true
D/WifiStateTracker( 969): Reset connections and stopping DHCP
D/DataConneAsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
ctionTracker( 1056): enableApnType(default), isApnTypeActive = false and state = IDLE
D/DataCon WCIDAttri = 0x1
nectionTracker( 1056): type not available
D/Tethering( 969): TAsicRemovePairwiseKeyEntry : Wcid #1
ethering got CONNECTIVITY_ACTIONAsicRemoveSharedKeyEntry: #0
D/Tethering( 969): MasterInitialState.processMessage what=3
E/HierarchicalStateMachine( 969): TetherMaster - unhandledMessaWrite: SHARED_KEY_MODE_BASE at this Bss[0] = 0x300
ge: msg.what=3
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8001)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #1
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x300
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8002)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #2
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8003)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #3
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8004)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #0
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8001)
D/dhcpcd ( 1301): received SIGTERM, stopping
D/dhcpcd ( 1301): deleting route 0.0.0.0/0 via 1rt_ioctl_siwauth::IW_AUTH_WPA_ENABLED - Driver supports WPA!(param->value = 0)
92.168.1.1
D/dhcpcd ( 1301): deleting IP address 192.168.1.102/24
D/dhcpcd ( 1301): executinrt_ioctl_siwauth::IW_AUTH_WPA_VERSION - param->value = 0!
g `/system/etc/dhcpcd/dhcpcd-run-hooks', reason STOP
init: untracked pid 1301 exited
===> rt28xx_close
RT28xxUsbMlmeRadioOFF()
D/WifiStateTracker( 969): Disabling interface
RTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x01
==> MlmeHalt
--->Disable TSF synchronization
RTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x00
<== MlmeHalt
MacTableReset
--->RTUSBCancelPendingBulkInIRP
<---RTUSBCancelPendingBulkInIRP
<---MlmeThread
<---RTUSBCmdThread
<---RtmpTimerQThread
---> RTMPFreeTxRxRingMemory
<--- RTMPFreeTxRxRingMemory
<=== rt28xx_close
INFO::Network is down!
init: untracked pid 1292 exited
usbcore: deregistering interface driver rt2870
rtusb_disconnect: unregister usbnet usb-musb_hdrc-1
RtmpOSNetDevDetach(): RtmpOSNetDeviceDetach(), dev->name=wlan0!
E/Tethering( 969): attempting to remove unknown iface (wlan0), ignoring
RTUSB disconnect successfully
<--- rtusb exit
E/WifiHW ( 969): cannot find driver rt3070sta in proc
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
D/dalvikvm( 969): GC_FOR_MALLOC freed 9782 objects / 476104 bytes in 92ms hsize: 16777216
I/power ( 969): *** set_screen_state 1
I/power ( 969): *** set_screen_state 1
==> Restarting wifi (turn off and turn back on from wifi settings control panel)
I/WifiHW ( 969): Loading WiFi modules
I/WifiHW ( 969): WIFI DRIVER_MODULE_NAME := rt3070sta,
I/WifiHW ( 969): WIFI DRIVER_MODULE_TAG := rt3070sta ,
I/WifiHW ( 969): WIFI DRIVER_MODULE_PATH := /system/lib/modules/rt3070sta.ko,
E/WifiHW ( 969): driver rt3070sta has NOT been installed
rtusb init --->
===>rt2870_probe()!
--> RTMPAllocAdapterBlock
=== pAd = d1402000, size = 500648 ===
<-- RTMPAllocAdapterBlock, Status=0
NumEndpoints=7
BULK IN MaxPacketSize = 512
EP address = 0x81
BULK OUT MaxPacketSize = 512
EP address = 0x 1
BULK OUT MaxPacketSize = 512
EP address = 0x 2
BULK OUT MaxPacketSize = 512
EP address = 0x 3
BULK OUT MaxPacketSize = 512
EP address = 0x 4
BULK OUT MaxPacketSize = 512
EP address = 0x 5
BULK OUT MaxPacketSize = 512
EP address = 0x 6
STA Driver version-2.3.0.4
NVM is EEPROM
Allocate a net device with private data size=0!
Allocate net device ops success!
The name of the new wlan interface is wlan0...
RtmpOSNetDevAttach()--->
<---RtmpOSNetDevAttach(), ret=0
<===rt2870_probe()!
D/Tethering( 969): wlan0 is notusbcore: registered new interface driver rt2870
a tetherable iface, ignoring
Allocate 8192 memory for BA reordering
MAC_CSR0 [ Ver:Rev=0x30700201]
<=== RtmpAsicLoadFirmware (status=0)
--> RTMPAllocTxRxRingMemory
--> NICInitTransmit
MGMT Ring: total 32 entry allocated
<-- NICInitTransmit(Status=0)
--> NICInitRecv
<-- NICInitRecv(Status=0)
<-- RTMPAllocTxRxRingMemory, Status=0
--> MLME Initialize
<-- MLME Initialize
--> UserCfgInit
--> UserCfgInit. BACapability = 0x3024040
<-- UserCfgInit
--> NICInitializeAdapter
<== DMA offset 0x208 = 0x0
--> NICInitializeAsic
MAC_CSR0 [ Ver:Rev=0x30700201]
-->RTUSBVenderReset
<--RTUSBVenderReset
BBP version = 60
--->Disable TSF synchronization
<-- NICInitializeAsic
<-- NICInitializeAdapter
1. Phy Mode = 0
2. Phy Mode = 0
--> NICReadEEPROMParameters
--> E2PROM_CSR = 0x20408
--> EEPROMAddressNum = 6
Initialize MAC Address from E2PROM
E2PROM MAC: =00:08:10:74:b5:da
Use the MAC address what is assigned from EEPROM.
Current MAC: =00:08:10:74:b5:da
E2PROM: Version = 1, FAE release #1
NICReadEEPROMParameters: RxPath = 1, TxPath = 1
Chip specific bbpRegTbSize=0!
E2PROM: G Tssi[-4 .. +4] = 255 255 255 255 - 255 -255 255 255 255, step=255, tuning=0
E2PROM: A Tssi[-4 .. +4] = 0 0 0 0 - 0 -0 0 0 0, step=0, tuning=0
E2PROM: RF FreqOffset=0x29
RTMPSetPhyMode : PhyMode=0, channel=0
country code=128/128, RFIC=5, PHY mode=0, support 11 channels
BuildChannel # 1 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 2 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 3 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 4 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 5 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 6 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 7 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 8 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 9 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 10 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 11 :: Pwr0 = 16, Pwr1 =5,
RTMPSetPhyMode: channel is out of range, use first channel=1
Txpower per Rate
Gpwrdelta = 0, Apwrdelta = 0 .
20MHz BW, 2.4G band-aaaa6666, Adata = aaaa6666, Gdata = aaaa6666
20MHz BW, 2.4G band-aaaa6688, Adata = aaaa6688, Gdata = aaaa6688
20MHz BW, 2.4G band-aaaa6688, Adata = aaaa6688, Gdata = aaaa6688
20MHz BW, 2.4G band-aaaa6688, Adata = aaaa6688, Gdata = aaaa6688
20MHz BW, 2.4G band-ffff6688, Adata = ffff6688, Gdata = ffff6688
<-- NICReadEEPROMParameters
3. Phy Mode = 0
--> NICInitAsicFromEEPROM
AsicSetRxAnt, switch to main antenna
RTMPFilterCalibration - CaliBW20RfR24=0x9, CaliBW40RfR24=0x27
RTMPSetLED::Mode=1,HighByte=0x20,LowByte=0x01
Use Hw Radio Control Pin=0; if used Pin=0;
TxPath = 1, RxPath = 1, RFIC=5, Polar+LED mode=1
<-- NICInitAsicFromEEPROM
RTMPSetPhyMode : PhyMode=0, channel=1
country code=128/128, RFIC=5, PHY mode=0, support 11 channels
BuildChannel # 1 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 2 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 3 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 4 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 5 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 6 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 7 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 8 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 9 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 10 :: Pwr0 = 17, Pwr1 =5,
BuildChannel # 11 :: Pwr0 = 16, Pwr1 =5,
MCS Set = 00 00 00 00 00
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
NDIS_STATUS_MEDIA_DISCONNECT Event B!
RTUSBBulkReceive!
<==== rt28xx_init, Status=0
==> RTMPEnableRxTx
<== WRITE DMA offset 0x208 = 0x45
<== RTMPEnableRxTx
0x1300 = 000a4200
STAMlmePeriodicExec():CNTL - ScanTab.BssNr==0, start a new ACTIVE scan SSID[]
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AsicSwitchChannel#2(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x07, R=0x02
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
I/WifiHW ( 969): Wi-Fi is running
D/WifiService( 969): ACTION_BATTERY_CHANGED pluggedType: 1
I/WifiHW ( 969): Interface directory = /data/system/wpa_supplicant
I/WifiHW ( 969): Interface name = /data/system/wpa_supplicant/wlan0
E/WifiHW ( 969): Unable to open connection to supplicant on "/data/system/wpa_supplicant/wlan0": No such file or directory
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
D/WifiStateTracker( 969): Reset connections and stopping DHCP
===> rt_ioctl_siwpmksa
rt_ioctl_siwpmksa - IW_PMKSA_FLUSH
===>Set_NetworkType_Proc::(INFRA)
Set_NetworkType_Proc::(NetworkType=1)
===>rt_ioctl_giwrange
rt_ioctl_siwauth::IW_AUTH_WPA_ENABLED - Driver supports WPA!(param->value = 1)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SYNC - End of SCAN, restore to channel 1, Total BSS[01]
SCAN done, resume MSDU transmission ...
AsicRemoveSharedKeyEntry: #0
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8001)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #1
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8002)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #2
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8003)
AsicUpdateWcidAttributeEntry : WCID #1, KeyIndex #0, Alg=none
WCIDAttri = 0x1
AsicRemovePairwiseKeyEntry : Wcid #1
AsicRemoveSharedKeyEntry: #3
Write: SHARED_KEY_MODE_BASE at this Bss[0] = 0x0
rt_ioctl_siwencodeext::Remove all keys!(encoding->flags = 8004)
rt_ioctl_siwauth::IW_AUTH_WPA_VERSION - param->value = 1!
Driver auto reconnect to last OID_802_11_SSID setting - , len - 0
===>rt_ioctl_giwscan. 1(1) BSS returned, data->length = 200
rt_ioctl_siwauth::IW_AUTH_80211_AUTH_ALG - param->value = 1!
I/wpa_supplicant( 1397): CTRL-EVCntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire ENT-STATE-CHANGE id=-1 state=2
(0)SSID -
I/wpa_supplicant( 1397): CTRL-EVCntlOidSsidProc():CNTL - No matching BSS, start a new scan
ENT-SCAN-RESULTS Ready
I/wpa_sSCANNING, suspend MSDU transmission ...
upplicant( 1397): Trying to assort_ioctl_siwauth::IW_AUTH_WPA_VERSION - param->value = 1!
ciate with 68:7f:74:1c:e4:7c (SSSYNC - BBP R4 to 20MHz.l
ID='Olympus2' freq=2437 MHz)
===>Set_NetworkType_Proc::(INFRA)
I/wpa_supplicant( 1397): CTRL-EVSet_NetworkType_Proc::(NetworkType=1)
ENT-STATE-CHANGE id=-1 state=3
===> rt_ioctl_siwgenie
rt_ioctl_siwauth::IW_AUTH_WPA_VERSION - param->value = 4!
rt_ioctl_siwauth::IW_AUTH_CIPHER_PAIRWISE - param->value = 8!
rt_ioctl_siwauth::IW_AUTH_CIPHER_GROUP - param->value = 4!
rt_ioctl_siwauth::IW_AUTH_KEY_MGMT - param->value = 2!
rt_ioctl_siwauth::IW_AUTH_PRIVACY_INVOKED - param->value = 1!
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
==>rt_ioctl_siwfreq::SIOCSIWFREQ[cmd=0x8b04] (Channel=1)
!!! MLME busy, reset MLME state machine !!!
Set_SSID_Proc::(Len=8,Ssid=Olympus2)
!!! MLME busy, reset MLME state machine !!!
!!! reset MLME state machine !!!
MlmeRestartStateMachine
IOCTL::SIOCSIWAP 68:7f:74:1c:e4:7c
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
CntlOidSsidProc():CNTL - 0 BSS of 0 BSS match the desire (8)SSID - Olympus2
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
!!! reset MLME state machine !!!
MlmeRestartStateMachine
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
SCAN done, resume MSDU transmission ...
CNTL - BSSID not found. reply NDIS_STATUS_NOT_ACCEPTED
CNTL - BSSID not found. start a new scan
SCANNING, suspend MSDU transmission ...
SYNC - BBP R4 to 20MHz.l
AsicSwitchChannel#1(RF=5, Pwr0=17, Pwr1=5, 1T), N=0xF1, K=0x02, R=0x02
AYNC - InvalidStateWhenScan(state=2). Reset SYNC machine
SCAN done, resume MSDU transmission ...
===> rt28xx_close
RT28xxUsbMlmeRadioOFF()
D/WifiStateTracker( 969): Disabling interface
RTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x01
==> MlmeHalt
--->Disable TSF synchronization
RTMPSetLED::Mode=1,HighByte=0x00,LowByte=0x00
<== MlmeHalt
MacTableReset
--->RTUSBCancelPendingBulkInIRP
<---RTUSBCancelPendingBulkInIRP
<---MlmeThread
<---RTUSBCmdThread
<---RtmpTimerQThread
---> RTMPFreeTxRxRingMemory
<--- RTMPFreeTxRxRingMemory
<=== rt28xx_close
I//system/bin/wpa_supplicant( 1396): l2_packet_receive - recvfrom: Network is down
I/power ( 969): *** set_screen_state 1
I/WifiHW ( 969): Interface directory = /data/system/wpa_supplicant
I/WifiHW ( 969): Interface name = /data/system/wpa_supplrt28xx_get_wireless_stats --->
icant/wlan0
I/WifiHW ( 969): INFO::Network is down!
connect to supplicant done
V/WifiStateTracker( 969): Connection to supplicant established, state=ASSOCIATING
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
D/NetworkStateTracker( 969): setDetailed state, old =DISCONNECTED and new state=CONNECTING
D/ConnectivityService( 969): ConnectivityChange for WIFI: CONNECTING/CONNECTING
I/wpa_supplicant( 1397): AuthentINFO::Network is down!
ication with 68:7f:74:1c:e4:7c timed out.
I/wpa_supplicant( 1397): CTRL-EVENT-STATE-CHANGE id=0 state=0
I/wpa_supplicant( 1397): CTRL-EVENT-STATE-CHANGE id=-1 state=2
W/wpa_supplicant( 1397): Failed to initiate AP scan.
V/WifiMonitor( 969): Event [Authentication with 68:7f:74:1c:e4:rt28xx_get_wireless_stats --->
7c timed out.]
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHINFO::Network is down!
ANGE id=0 state=0]
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCSIWSCAN]: Network is down
V/WifiStateTracker( 969): Changing supplicant state: ASSOCIATING ==> DISCONNECTED
V/WifiMonitor( 969): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
V/WifiStateTracker( 969): Changing supplicant state: DISCONNECTED ==> SCANNING
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
rt28xx_get_wireless_stats --->
INFO::Network is down!
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
D/dalvikvm( 1198): GC_FOR_MALLOC freed 9817 objects / 545496 bytes in 62ms hsize: 16777216
INFO::Network is down!
INFO::Network is down!
D/WifiStateTracker( 969): Reset connections and stopping DHCP
W/wpa_supplicant( 1397): Failed to initiate AP scan.
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSCAN]: Network is down
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCSIWSCAN]: Network is down
D/WifiStateTracker( 969): Disabling interface
D/NetworkStateTracker( 969): setDetailed state, old =CONNECTING and new state=DISCONNECTED
rt28xx_get_wireless_stats --->
INFO::Network is down!
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
D/ConnectivityService( 969): ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED
D/DataConnectionTracker( 1056): enableApnType(default), isApnTypeActive = false and state = IDLE
D/DataConnectionTracker( 1056): type not available
D/ConnectivityService( 969): getMobileDataEnabled returning true
D/Tethering( 969): Tethering got CONNECTIVITY_ACTION
D/Tethering( 969): MasterInitialState.processMessage what=3
E/HierarchicalStateMachine( 969): TetherMaster - unhandledMessage: msg.what=3
INFO::Network is down!
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSCAN]: Network is down
INFO::Network is down!
W/wpa_supplicant( 1397): Failed to initiate AP scan.
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCSIWSCAN]: Network is down
D/dalvikvm( 1152): GC_EXPLICIT freed 1525 objects / 69984 bytes in 45ms hsize: 16777216
Best regards,
Elvis Dowson
Hi Holger,
On Nov 16, 2010, at 4:04 PM, Holger Schurig wrote:
> Android doesn't work well with upstream groups. They made their own ecosystem,
> both in kernel-space and much more in user-space. They also usualy use
> outdated software, e.g. ancient kernel version.
Tell me about it! :-) The current version that I'm working on is 2.6.32.
> You're therefore encouraged to use android-specific mailing-lists or forums to
> solve your problems.
I had a feeling I might get this response, since this was not kernel wireless driver
specific issue. There are no android wireless equivalent mailing-list or forums, like
there is for linux. The android-porting groups list, I didn't get any response for
a whole month. Its pretty fragmented.
> That said, the interface isn't up, contrary to your belief:
This is not true. You probably read the last few sections of the log file. On
first start and connect, wifi works and I'm able to use the wlan0 interface
and browse the internet.
After turning off wifi and turning it back on from the control panel, it doesnt
connect, and you see the following message.
>
> V/WifiStateTracker( 969): Changing supplicant state: DISCONNECTED ==>
> SCANNING
> I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not
> supported on transport endpoint
> I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
>
> So something in restarting the wifi link forgot Android's equivalent
> of "ifconfig $interface up". If the interface isn't up, it won't scan. Without
> current scan results and an "up"-interface, it cannot associate.
In my init.rc file, I have the following entry, which is intended to bring wlan0 up
service ifcfg_ralink /system/bin/ifconfig wlan0 up
group system wifi
disabled
oneshot
which probably gets called in the following code fragment from libhardware_legacy/wifi/wifi.c for wifi_load_driver()
diff --git a/wifi/wifi.c b/wifi/wifi.c
index 3f8708d..7533a64 100644
--- a/wifi/wifi.c
+++ b/wifi/wifi.c
@@ -188,8 +188,10 @@ int wifi_load_driver()
sched_yield();
while (count-- > 0) {
if (property_get(DRIVER_PROP_NAME, driver_status, NULL)) {
- if (strcmp(driver_status, "ok") == 0)
+ if (strcmp(driver_status, "ok") == 0) {
+ property_set("ctl.start", "ifcfg_ralink");
return 0;
+ }
else if (strcmp(DRIVER_PROP_NAME, "failed") == 0) {
wifi_unload_driver();
return -1;
Best regards,
Elvis Dowson
Elvis Dowson
> This is not true. You probably read the last few sections of the log file.
> On first start and connect, wifi works and I'm able to use the wlan0
> interface and browse the internet.
>
> After turning off wifi and turning it back on from the control panel, it
> doesnt connect, and you see the following message.
Oh, I stand corrected.
BTW: one of the problems of Android is that no-one turns off useless debug
messages. Your log is full of stuff that isn't really important here that it's
certainly not easy to see what is important. I'd say more than 70% of all
lines in your log are completely unrelated or nonsensical.
>From the rest, I gather that the scan didn't work as expected:
I/wpa_supplicant( 1397): CTRL-EVCntlOidSsidProc():CNTL - 0 BSS of 1 BSS match the desire ENT-STATE-CHANGE id=-1 state=2
I/wpa_supplicant( 1397): CTRL-EVCntlOidSsidProc():CNTL - No matching BSS, start a new scan
and later:
SCAN done, resume MSDU transmission ...
CntlOidSsidProc():CNTL - 0 BSS of 0 BSS match the desire (8)SSID - Olympus2
CntlOidSsidProc():CNTL - No matching BSS, start a new scan
Maybe some upper-levels want's to scan for this specific SSID, but
the driver doesn't allow this?
Maybe it's so borked that a "rmmod rt3070sta" after downing the
interface would help?
Also, it's not clear to me why wpa_supplicant says that no BSSID
matched, but then two lines later it says:
"Trying to assortiate with 68:7f:74:1c:e4:7c"
--
Homepage: http://www.holgerschurig.de
Android doesn't work well with upstream groups. They made their own ecosystem,
both in kernel-space and much more in user-space. They also usualy use
outdated software, e.g. ancient kernel version.
You're therefore encouraged to use android-specific mailing-lists or forums to
solve your problems.
That said, the interface isn't up, contrary to your belief:
V/WifiStateTracker( 969): Changing supplicant state: DISCONNECTED ==>
SCANNING
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWSTATS]: Operation not
supported on transport endpoint
I//system/bin/wpa_supplicant( 1396): ioctl[SIOCGIWRATE]: Network is down
So something in restarting the wifi link forgot Android's equivalent
of "ifconfig $interface up". If the interface isn't up, it won't scan. Without
current scan results and an "up"-interface, it cannot associate.
--
Homepage: http://www.holgerschurig.de