about android wifi dhcp
35 views
Skip to first unread message
tommy tommy
Dec 22, 2009, 9:07:32 PM12/22/09
to android...@googlegroups.com, 0xlab...@googlegroups.com
hi,all!
I use rt3070 in android-cupcake ,ARM11,wifi obtain address failed(DHCP),but if use wpa_supplicant to connect server mannual,it is successfull connected,and dhcpcd wlan0 mannual ,also successful,but use wifi plugin to connnect automatical,it is failed.
W/System.err( 2270): at com.OF.Fring.comm.p.run(WriterBase.java:145)
D/gsm_mux ( 2305): >> AT+CSCLK=1
I/ActivityThread( 2386): Publishing provider calendar: com.android.providers.calendar.CalendarProvider
W/GoogleLoginService( 2314): Device has no accounts: sending Intent { action=android.accounts.LOGIN_ACCOUNTS_MISSING }
I/GoogleLoginService.PasswordEncrypter( 2314): no public key available, using default
I/ActivityManager( 2183): Stopping service: com.google.android.googleapps/.GoogleLoginService
I/ActivityManager( 2183): Stopping service: com.android.calendar/.AlertService
D/gsm_mux ( 2305): >> AT+CMUX=0,0,5,127
E/WifiHW ( 2183): Supplicant not running, cannot connect
E/gsm_mux ( 2305): start_muxer_on_phy() failed
D/gsm_mux ( 2402): >> AT
D/gsm_mux ( 2402): >> AT
D/gsm_mux ( 2402): >> AT
D/gsm_mux ( 2402): >> ATZ
D/gsm_mux ( 2402): >> ATE0
E/WifiHW ( 2183): Supplicant not running, cannot connect
V/WifiStateTracker( 2183): Supplicant died unexpectedly
D/gsm_mux ( 2402): >> AT+CSCLK=1
I/vold ( 2161): add@/module/rt3070sta
I/vold ( 2161): ACTION=add
I/vold ( 2161): DEVPATH=/module/rt3070sta
I/vold ( 2161): SUBSYSTEM=module
I/vold ( 2161): SEQNUM=1054
D/vold ( 2161): [UEVENT] Sq: 1054 S: module A: 0 P: /module/rt3070sta
D/vold ( 2161): DEVPATH=/module/rt3070sta
D/vold ( 2161): No uevent handlers registered for 'module' subsystem
I/vold ( 2161): add@/class/net/wlan0
I/vold ( 2161): ACTION=add
I/vold ( 2161): DEVPATH=/class/net/wlan0
I/vold ( 2161): SUBSYSTEM=net
I/vold ( 2161): PHYSDEVPATH=/devices/platform/usbc.1/usb1/1-1/1-1.1
I/vold ( 2161): PHYSDEVBUS=usb
I/vold ( 2161): PHYSDEVDRIVER=usb
I/vold ( 2161): INTERFACE=wlan0
I/vold ( 2161): IFINDEX=3
I/vold ( 2161): SEQNUM=1055
D/vold ( 2161): [UEVENT] Sq: 1055 S: net A: 0 P: /class/net/wlan0
D/vold ( 2161): DEVPATH=/class/net/wlan0
D/vold ( 2161): PHYSDEVPATH=/devices/platform/usbc.1/usb1/1-1/1-1.1
D/vold ( 2161): PHYSDEVBUS=usb
D/vold ( 2161): PHYSDEVDRIVER=usb
D/vold ( 2161): INTERFACE=wlan0
D/vold ( 2161): IFINDEX=3
D/vold ( 2161): No uevent handlers registered for 'net' subsystem
I/vold ( 2161): add@/bus/usb/drivers/rt2870
I/vold ( 2161): ACTION=add
I/vold ( 2161): DEVPATH=/bus/usb/drivers/rt2870
I/vold ( 2161): SUBSYSTEM=drivers
I/vold ( 2161): SEQNUM=1056
D/vold ( 2161): [UEVENT] Sq: 1056 S: drivers A: 0 P: /bus/usb/drivers/rt2870
D/vold ( 2161): DEVPATH=/bus/usb/drivers/rt2870
D/vold ( 2161): No uevent handlers registered for 'drivers' subsystem
D/gsm_mux ( 2402): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2402): start_muxer_on_phy() failed
D/gsm_mux ( 2421): >> AT
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
I/ActivityManager( 2183): Start proc com.android.inputmethod.latin for service com.android.inputmethod.latin/.LatinIME: pid=2422 uid=10000 gids={3003}
D/gsm_mux ( 2421): >> AT
I/ARMAssembler( 2183): generated scanline__00000077:03545404_00000A04_00000000 [ 29 ipp] (51 ins) at [0x1ee338:0x1ee404] in 271000 ns
W/KeyCharacterMap( 2273): No keyboard for id 0
W/KeyCharacterMap( 2273): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
D/dalvikvm( 2422): Trying to load lib /system/lib/libjni_latinime.so 0x435fdf50
D/dalvikvm( 2422): Added shared lib /system/lib/libjni_latinime.so 0x435fdf50
I/ARMAssembler( 2183): generated scanline__00000177:03515104_00001A01_00000000 [ 64 ipp] (89 ins) at [0x242230:0x242394] in 308000 ns
I/ARMAssembler( 2183): generated scanline__00000177:03515104_00000A01_00000000 [ 46 ipp] (70 ins) at [0x242398:0x2424b0] in 298000 ns
D/gsm_mux ( 2421): >> AT
I/ActivityManager( 2183): Starting activity: Intent { action=android.settings.SETTINGS flags=0x10200000 comp={com.android.settings/com.android.settings.Settings} }
I/ActivityManager( 2183): Start proc com.android.settings for activity com.android.settings/.Settings: pid=2428 uid=1000 gids={3002, 3001, 3003}
W/InputManagerService( 2183): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@437ff130
D/gsm_mux ( 2421): >> ATZ
I/ActivityManager( 2183): Displayed activity com.android.settings/.Settings: 678 ms
D/gsm_mux ( 2421): >> ATE0
I/ActivityManager( 2183): Starting activity: Intent { action=android.intent.action.MAIN comp={com.android.settings/com.android.settings.WirelessSettings} }
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabling to Disabled
I/ActivityManager( 2183): Displayed activity com.android.settings/.WirelessSettings: 212 ms
D/gsm_mux ( 2421): >> AT+CSCLK=1
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabled to Enabling
E/WifiHW ( 2183): Unable to open connection to supplicant on "/data/system/wpa_supplicant/wlan0": No such file or directory
D/SettingsWifiEnabler( 2428): Received wifi state changed from Enabling to Enabled
D/gsm_mux ( 2421): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2421): start_muxer_on_phy() failed
D/gsm_mux ( 2442): >> AT
D/gsm_mux ( 2442): >> AT
D/gsm_mux ( 2442): >> AT
I/ActivityManager( 2183): Starting activity: Intent { action=android.intent.action.MAIN comp={com.android.settings/com.android.settings.wifi.WifiSettings} }
V/SettingsWifiLayer( 2428): What's up here? starScan failed?
D/SettingsWifiEnabler( 2428): Received wifi state changed from Enabling to Enabled
D/gsm_mux ( 2442): >> ATZ
I/ActivityManager( 2183): Displayed activity com.android.settings/.wifi.WifiSettings: 201 ms
V/WifiStateTracker( 2183): Connection to supplicant established, state=SCANNING
D/gsm_mux ( 2442): >> ATE0
D/gsm_mux ( 2442): >> AT+CSCLK=1
D/gsm_mux ( 2442): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2442): start_muxer_on_phy() failed
D/gsm_mux ( 2444): >> AT
V/WifiMonitor( 2183): Event [Trying to associate with 00:1c:b0:91:6e:8c (SSID='midfun' freq=2437 MHz)]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=3]
V/WifiStateTracker( 2183): Changing supplicant state: SCANNING ==> ASSOCIATING
D/dalvikvm( 2273): GC freed 2719 objects / 154712 bytes in 184ms
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=4]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATING ==> ASSOCIATED
V/WifiMonitor( 2183): Event [Associated with 00:1c:b0:91:6e:8c]
D/gsm_mux ( 2444): >> AT
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATED ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=6]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> GROUP_HANDSHAKE
V/WifiMonitor( 2183): Event [WPA: Key negotiation completed with 00:1c:b0:91:6e:8c [PTK=CCMP GTK=TKIP]]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=7]
V/WifiStateTracker( 2183): Changing supplicant state: GROUP_HANDSHAKE ==> COMPLETED
V/WifiMonitor( 2183): Event [CTRL-EVENT-CONNECTED - Connection to 00:1c:b0:91:6e:8c completed (auth) [id=0 id_str=]]
V/WifiStateTracker( 2183): New network state is CONNECTED
D/WifiStateTracker( 2183): DhcpHandler: DHCP request started
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: CONNECTING/OBTAINING_IPADDR, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/dalvikvm( 2428): GC freed 3294 objects / 208256 bytes in 89ms
D/gsm_mux ( 2444): >> AT
D/gsm_mux ( 2444): >> ATZ
D/gsm_mux ( 2444): >> ATE0
D/gsm_mux ( 2444): >> AT+CSCLK=1
D/gsm_mux ( 2444): >> AT+CMUX=0,0,5,127
D/dalvikvm( 2270): GC freed 2735 objects / 190008 bytes in 89ms
E/gsm_mux ( 2444): start_muxer_on_phy() failed
D/gsm_mux ( 2452): >> AT
D/gsm_mux ( 2452): >> AT
D/gsm_mux ( 2452): >> AT
D/gsm_mux ( 2452): >> ATZ
D/gsm_mux ( 2452): >> ATE0
D/gsm_mux ( 2452): >> AT+CSCLK=1
D/gsm_mux ( 2452): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2452): start_muxer_on_phy() failed
D/gsm_mux ( 2453): >> AT
D/gsm_mux ( 2453): >> AT
D/gsm_mux ( 2453): >> AT
D/gsm_mux ( 2453): >> ATZ
D/gsm_mux ( 2453): >> ATE0
D/gsm_mux ( 2453): >> AT+CSCLK=1
D/gsm_mux ( 2453): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2453): start_muxer_on_phy() failed
D/gsm_mux ( 2460): >> AT
D/gsm_mux ( 2460): >> AT
D/gsm_mux ( 2460): >> AT
D/gsm_mux ( 2460): >> ATZ
D/gsm_mux ( 2460): >> ATE0
D/gsm_mux ( 2460): >> AT+CSCLK=1
D/gsm_mux ( 2460): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2460): start_muxer_on_phy() failed
D/gsm_mux ( 2461): >> AT
D/gsm_mux ( 2461): >> AT
D/gsm_mux ( 2461): >> AT
D/gsm_mux ( 2461): >> ATZ
I/WifiStateTracker( 2183): DhcpHandler: DHCP request failed: Timed out waiting for DHCP to finish
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=8]
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiStateTracker( 2183): Changing supplicant state: COMPLETED ==> DORMANT
D/WifiStateTracker( 2183): Deconfiguring interface and stopping DHCP
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2461): >> ATE0
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2461): >> AT+CSCLK=1
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: DISCONNECTED/FAILED, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/gsm_mux ( 2461): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2461): start_muxer_on_phy() failed
D/gsm_mux ( 2468): >> AT
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> SCANNING
D/gsm_mux ( 2468): >> AT
D/gsm_mux ( 2468): >> AT
D/gsm_mux ( 2468): >> ATZ
D/gsm_mux ( 2468): >> ATE0
D/gsm_mux ( 2468): >> AT+CSCLK=1
D/gsm_mux ( 2468): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2468): start_muxer_on_phy() failed
D/gsm_mux ( 2470): >> AT
D/gsm_mux ( 2470): >> AT
D/dalvikvm( 2324): GC freed 3206 objects / 193440 bytes in 96ms
D/gsm_mux ( 2470): >> AT
D/gsm_mux ( 2470): >> ATZ
D/gsm_mux ( 2470): >> ATE0
D/gsm_mux ( 2470): >> AT+CSCLK=1
D/gsm_mux ( 2470): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2470): start_muxer_on_phy() failed
D/gsm_mux ( 2471): >> AT
D/dalvikvm( 2270): GC freed 371 objects / 68232 bytes in 79ms
D/gsm_mux ( 2471): >> AT
D/gsm_mux ( 2471): >> AT
D/gsm_mux ( 2471): >> ATZ
D/gsm_mux ( 2471): >> ATE0
D/dalvikvm( 2183): GC freed 8315 objects / 360968 bytes in 136ms
W/GoogleLoginService( 2314): Device has no accounts: sending Intent { action=android.accounts.LOGIN_ACCOUNTS_MISSING }
I/GoogleLoginService.PasswordEncrypter( 2314): no public key available, using default
I/ActivityManager( 2183): Stopping service: com.google.android.googleapps/.GoogleLoginService
D/WifiService( 2183): ACTION_SREEN_OFF
V/WifiMonitor( 2183): Event [CTRL-EVENT-TERMINATING - signal 15 received]
V/WifiStateTracker( 2183): Connection to supplicant lost
D/gsm_mux ( 2471): >> AT+CSCLK=1
D/gsm_mux ( 2471): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2471): start_muxer_on_phy() failed
D/gsm_mux ( 2472): >> AT
D/gsm_mux ( 2472): >> AT
D/KeyguardViewMediator( 2183): wakeWhenReadyLocked(4)
D/KeyguardViewMediator( 2183): wakeWhenReadyLocked(4)
D/KeyguardViewMediator( 2183): handleWakeWhenReady(4)
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabling to Disabled
D/WifiService( 2183): ACTION_SCREEN_ON
D/KeyguardViewMediator( 2183): handleWakeWhenReady(4)
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabled to Enabling
E/WifiHW ( 2183): Unable to open connection to supplicant on "wlan0": No such file or directory
V/SettingsWifiLayer( 2428): What's up here? starScan failed?
D/SettingsWifiEnabler( 2428): Received wifi state changed from Enabling to Enabled
[ 135.542753] <-- RTMPAllocTxRxRingMemory, Status=0
[ 135.547231] -->RTUSBVenderReset
[ 135.547864] <--RTUSBVenderReset
D/gsm_mux ( 2472): >> AT
[ 135.842041] Key1Str is Invalid key length(0) or Type(0)
[ 135.844555] Key2Str is Invalid key length(0) or Type(0)
[ 135.849824] Key3Str is Invalid key length(0) or Type(0)
[ 135.854959] Key4Str is Invalid key length(0) or Type(0)
[ 135.862427] 1. Phy Mode = 9
[ 135.862829] 2. Phy Mode = 9
[ 135.865618] NVM is Efuse and its size =2d[2d0-2fc]
[ 135.941036] 3. Phy Mode = 9
[ 135.950995] RTMPSetPhyMode: channel is out of range, use first channel=1
[ 135.958119] MCS Set = ff 00 00 00 01
W/KeyCharacterMap( 2183): No keyboard for id 0
W/KeyCharacterMap( 2183): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
W/InputManagerService( 2183): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@437b7ee8
W/KeyCharacterMap( 2428): No keyboard for id 0
W/KeyCharacterMap( 2428): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
[ 136.243561] <==== rt28xx_init, Status=0
[ 136.245776] 0x1300 = 00064300
[ 136.449581] #
D/gsm_mux ( 2472): >> ATZ
D/gsm_mux ( 2472): >> ATE0
D/gsm_mux ( 2472): >> AT+CSCLK=1
V/SettingsWifiLayer( 2428): What's up here? starScan failed?
W/InputManagerService( 2183): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@437b9250
D/gsm_mux ( 2472): >> AT+CMUX=0,0,5,127
V/WifiStateTracker( 2183): Connection to supplicant established, state=SCANNING
E/gsm_mux ( 2472): start_muxer_on_phy() failed
D/gsm_mux ( 2481): >> AT
D/gsm_mux ( 2481): >> AT
D/gsm_mux ( 2481): >> AT
D/gsm_mux ( 2481): >> ATZ
D/gsm_mux ( 2481): >> ATE0
[ 145.169955] ===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 307
[ 145.175831] ==>rt_ioctl_siwfreq::SIOCSIWFREQ[cmd=0x8b04] (Channel=1)
V/WifiMonitor( 2183): Event [Trying to associate with 00:1c:b0:91:6e:8c (SSID='midfun' freq=2437 MHz)]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=3]
V/WifiStateTracker( 2183): Changing supplicant state: SCANNING ==> ASSOCIATING
D/dalvikvm( 2314): GC freed 1512 objects / 107040 bytes in 203ms
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=4]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATING ==> ASSOCIATED
V/WifiMonitor( 2183): Event [Associated with 00:1c:b0:91:6e:8c]
D/gsm_mux ( 2481): >> AT+CSCLK=1
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATED ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=6]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> GROUP_HANDSHAKE
V/WifiMonitor( 2183): Event [WPA: Key negotiation completed with 00:1c:b0:91:6e:8c [PTK=CCMP GTK=TKIP]]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=7]
V/WifiStateTracker( 2183): Changing supplicant state: GROUP_HANDSHAKE ==> COMPLETED
V/WifiMonitor( 2183): Event [CTRL-EVENT-CONNECTED - Connection to 00:1c:b0:91:6e:8c completed (auth) [id=0 id_str=]]
V/WifiStateTracker( 2183): New network state is CONNECTED
D/WifiStateTracker( 2183): DhcpHandler: DHCP request started
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: CONNECTING/OBTAINING_IPADDR, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/gsm_mux ( 2481): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2481): start_muxer_on_phy() failed
D/gsm_mux ( 2489): >> AT
D/gsm_mux ( 2489): >> AT
D/gsm_mux ( 2489): >> AT
D/gsm_mux ( 2489): >> ATZ
D/gsm_mux ( 2489): >> ATE0
D/gsm_mux ( 2489): >> AT+CSCLK=1
D/gsm_mux ( 2489): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2489): start_muxer_on_phy() failed
D/gsm_mux ( 2496): >> AT
D/gsm_mux ( 2496): >> AT
D/gsm_mux ( 2496): >> AT
D/gsm_mux ( 2496): >> ATZ
D/gsm_mux ( 2496): >> ATE0
D/gsm_mux ( 2496): >> AT+CSCLK=1
D/gsm_mux ( 2496): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2496): start_muxer_on_phy() failed
D/gsm_mux ( 2497): >> AT
D/gsm_mux ( 2497): >> AT
D/gsm_mux ( 2497): >> AT
D/gsm_mux ( 2497): >> ATZ
D/gsm_mux ( 2497): >> ATE0
D/gsm_mux ( 2497): >> AT+CSCLK=1
D/gsm_mux ( 2497): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2497): start_muxer_on_phy() failed
D/gsm_mux ( 2498): >> AT
D/gsm_mux ( 2498): >> AT
D/gsm_mux ( 2498): >> AT
D/gsm_mux ( 2498): >> ATZ
D/gsm_mux ( 2498): >> ATE0
D/gsm_mux ( 2498): >> AT+CSCLK=1
D/gsm_mux ( 2498): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2498): start_muxer_on_phy() failed
D/gsm_mux ( 2499): >> AT
I/WifiStateTracker( 2183): DhcpHandler: DHCP request failed: Timed out waiting for DHCP to finish
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=8]
V/WifiStateTracker( 2183): Changing supplicant state: COMPLETED ==> DORMANT
D/WifiStateTracker( 2183): Deconfiguring interface and stopping DHCP
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2499): >> AT
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2499): >> AT
[ 178.915893] Terminate the task(RtmpMlmeTask) with pid(2476)!
[ 178.918865] Terminate the task(RtmpCmdQTask) with pid(2477)!
[ 178.924817] Terminate the task(RtmpTimerTask) with pid(2475)!
[ 178.930197] ---> RTMPFreeTxRxRingMemory
[ 178.933912] Dequeing URB which never Queued
[ 178.938129] Dequeing URB which never Queued
[ 178.942316] Dequeing URB which never Queued
[ 178.946422] Dequeing URB which never Queued
[ 178.950612] Dequeing URB which never Queued
[ 178.954747] Dequeing URB which never Queued
[ 178.958926] Dequeing URB which never Queued
[ 178.963116] Dequeing URB which never Queued
[ 178.967258] Dequeing URB which never Queued
[ 178.971454] Dequeing URB which never Queued
[ 178.975572] Dequeing URB which never Queued
[ 178.979763] Dequeing URB which never Queued
[ 178.983909] Dequeing URB which never Queued
[ 178.988071] Dequeing URB which never Queued
[ 178.992255] Dequeing URB which never Queued
[ 178.996404] Dequeing URB which never Queued
[ 179.000592] Dequeing URB which never Queued
[ 179.004736] Dequeing URB which never Queued
[ 179.008903] Dequeing URB which never Queued
[ 179.013086] Dequeing URB which never Queued
[ 179.017239] Dequeing URB which never Queued
[ 179.021425] Dequeing URB which never Queued
[ 179.025568] Dequeing URB which never Queued
[ 179.029751] Dequeing URB which never Queued
[ 179.033903] Dequeing URB which never Queued
[ 179.038071] Dequeing URB which never Queued
[ 179.042253] Dequeing URB which never Queued
[ 179.046400] Dequeing URB which never Queued
[ 179.050583] Dequeing URB which never Queued
[ 179.054733] Dequeing URB which never Queued
[ 179.058904] Dequeing URB which never Queued
[ 179.063085] Dequeing URB which never Queued
[ 179.067232] Dequeing URB which never Queued
[ 179.071414] Dequeing URB which never Queued
[ 179.075565] Dequeing URB which never Queued
[ 179.079751] Dequeing URB which never Queued
[ 179.083902] Dequeing URB which never Queued
[ 179.088065] Dequeing URB which never Queued
[ 179.092249] Dequeing URB which never Queued
[ 179.096397] Dequeing URB which never Queued
[ 179.100592] Dequeing URB which never Queued
[ 179.104732] Dequeing URB which never Queued
[ 179.109242] <--- RTMPFreeTxRxRingMemory
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: DISCONNECTED/FAILED, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/gsm_mux ( 2499): >> ATZ
D/gsm_mux ( 2499): >> ATE0
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> SCANNING
D/gsm_mux ( 2499): >> AT+CSCLK=1
D/gsm_mux ( 2499): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2499): start_muxer_on_phy() failed
D/gsm_mux ( 2506): >> AT
D/gsm_mux ( 2506): >> AT
D/gsm_mux ( 2506): >> AT
D/dalvikvm( 2324): GC freed 991 objects / 63344 bytes in 80ms
D/gsm_mux ( 2506): >> ATZ
D/gsm_mux ( 2506): >> ATE0
D/gsm_mux ( 2506): >> AT+CSCLK=1
D/gsm_mux ( 2506): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2506): start_muxer_on_phy() failed
D/gsm_mux ( 2507): >> AT
# ps
PID USER VSZ STAT COMMAND
1 root 2760 S init
2 root 0 SW< [kthreadd]
3 root 0 RW< [ksoftirqd/0]
4 root 0 SW< [events/0]
5 root 0 SW< [khelper]
10 root 0 SW< [suspend]
43 root 0 SW< [sirfsoc-adc]
102 root 0 SW< [kblockd/0]
111 root 0 SW< [kmmcd]
115 root 0 SW< [ksuspend_usbd]
121 root 0 SW< [khubd]
124 root 0 SW< [kseriod]
133 root 0 SW< [btaddconn]
134 root 0 SW< [btdelconn]
155 root 0 SW [pdflush]
156 root 0 SW [pdflush]
157 root 0 SW< [kswapd0]
159 root 0 SW< [aio/0]
160 root 0 SW< [nfsiod]
255 root 0 SW< [kapmd]
383 root 0 SW< [scsi_tgtd/0]
397 root 0 SW< [USB WorkQ]
402 root 0 RW< [mmcqd]
411 root 0 SW< [USB WorkQ]
467 root 0 SW< [krfcommd]
468 root 0 SW< [rpciod/0]
476 root 0 SW< [kjournald]
480 root 2760 S /bin/sh /etc/init.d/rcS
492 root 1744 S < /sbin/udevd --daemon
1355 root 0 SW< [sirfsoc_spi.0]
1358 root 0 SW< [sirfsoc_spi.1]
1389 root 79992 S /usr/bin/gpsexe -3irf1 -dspdevnode /dev/gps -spidevno
1396 root 10400 S /usr/bin/gpsmc
1414 root 288 S /etc/rcS.d/S99android start
2159 root 756 S /system/bin/sh
2160 1000 824 S /system/bin/servicemanager
2161 root 864 S /system/bin/vold
2162 root 684 S /system/bin/debuggerd
2164 root 72616 S zygote /bin/app_process -Xzygote /system/bin --zygote
2165 1013 45924 S /system/bin/mediaserver
2166 1002 1196 S /system/bin/dbus-daemon --system --nofork
2169 1002 1624 S /system/bin/hcid -s -n -f /etc/bluez/hcid.conf
2170 root 824 S /system/xbin/obexftpd -c /system/ftp -b
2171 root 816 S /system/bin/installd
2173 root 1268 S /sbin/adbd
2183 1000 253m S system_server
2267 1001 107m S com.android.phone
2270 10021 98976 S com.fring
2273 10000 100m S android.process.acore
2298 10006 99.5m S com.android.mms
2314 10017 97800 S com.google.process.gapps
2324 10007 97620 S android.process.media
2326 10001 96800 S android.process.im
2361 10020 93456 S com.android.alarmclock
2373 10024 98416 S com.google.android.apps.maps
2386 10025 99076 S com.android.calendar
2422 10000 95488 S com.android.inputmethod.latin
2428 1000 103m S com.android.settings
2469 root 696 T logcat
2534 root 1188 S /system/bin/vchanneld
2535 root 2764 R ps
my init.rc:
mkdir /data/misc/wifi 0770 wifi wifi
mkdir /data/misc/wifi/sockets 0770 wifi wifi
mkdir /data/system/wpa_supplicant 0770 wifi wifi
mkdir /data/misc/dhcp 0770 dhcp dhcp
chown dhcp dhcp /data/misc/dhcp
setprop wifi.interface wlan0
service wpa_supplicant /system/bin/wpa_supplicant -iwlan0 -c/data/misc/wifi/wpa_
group system wifi
disabled
oneshot
service dhcpcd /system/bin/dhcpcd -d -f /system/etc/dhcpcd/android.conf wlan0
group system dhcp
disabled
oneshot
property:init.svc.wpa_supplicant=stopped
stop dhcpcd
anyone can give some good advice?tks!
--
Achievement provides the only real pleasure in life!
I use rt3070 in android-cupcake ,ARM11,wifi obtain address failed(DHCP),but if use wpa_supplicant to connect server mannual,it is successfull connected,and dhcpcd wlan0 mannual ,also successful,but use wifi plugin to connnect automatical,it is failed.
W/System.err( 2270): at com.OF.Fring.comm.p.run(WriterBase.java:145)
D/gsm_mux ( 2305): >> AT+CSCLK=1
I/ActivityThread( 2386): Publishing provider calendar: com.android.providers.calendar.CalendarProvider
W/GoogleLoginService( 2314): Device has no accounts: sending Intent { action=android.accounts.LOGIN_ACCOUNTS_MISSING }
I/GoogleLoginService.PasswordEncrypter( 2314): no public key available, using default
I/ActivityManager( 2183): Stopping service: com.google.android.googleapps/.GoogleLoginService
I/ActivityManager( 2183): Stopping service: com.android.calendar/.AlertService
D/gsm_mux ( 2305): >> AT+CMUX=0,0,5,127
E/WifiHW ( 2183): Supplicant not running, cannot connect
E/gsm_mux ( 2305): start_muxer_on_phy() failed
D/gsm_mux ( 2402): >> AT
D/gsm_mux ( 2402): >> AT
D/gsm_mux ( 2402): >> AT
D/gsm_mux ( 2402): >> ATZ
D/gsm_mux ( 2402): >> ATE0
E/WifiHW ( 2183): Supplicant not running, cannot connect
V/WifiStateTracker( 2183): Supplicant died unexpectedly
D/gsm_mux ( 2402): >> AT+CSCLK=1
I/vold ( 2161): add@/module/rt3070sta
I/vold ( 2161): ACTION=add
I/vold ( 2161): DEVPATH=/module/rt3070sta
I/vold ( 2161): SUBSYSTEM=module
I/vold ( 2161): SEQNUM=1054
D/vold ( 2161): [UEVENT] Sq: 1054 S: module A: 0 P: /module/rt3070sta
D/vold ( 2161): DEVPATH=/module/rt3070sta
D/vold ( 2161): No uevent handlers registered for 'module' subsystem
I/vold ( 2161): add@/class/net/wlan0
I/vold ( 2161): ACTION=add
I/vold ( 2161): DEVPATH=/class/net/wlan0
I/vold ( 2161): SUBSYSTEM=net
I/vold ( 2161): PHYSDEVPATH=/devices/platform/usbc.1/usb1/1-1/1-1.1
I/vold ( 2161): PHYSDEVBUS=usb
I/vold ( 2161): PHYSDEVDRIVER=usb
I/vold ( 2161): INTERFACE=wlan0
I/vold ( 2161): IFINDEX=3
I/vold ( 2161): SEQNUM=1055
D/vold ( 2161): [UEVENT] Sq: 1055 S: net A: 0 P: /class/net/wlan0
D/vold ( 2161): DEVPATH=/class/net/wlan0
D/vold ( 2161): PHYSDEVPATH=/devices/platform/usbc.1/usb1/1-1/1-1.1
D/vold ( 2161): PHYSDEVBUS=usb
D/vold ( 2161): PHYSDEVDRIVER=usb
D/vold ( 2161): INTERFACE=wlan0
D/vold ( 2161): IFINDEX=3
D/vold ( 2161): No uevent handlers registered for 'net' subsystem
I/vold ( 2161): add@/bus/usb/drivers/rt2870
I/vold ( 2161): ACTION=add
I/vold ( 2161): DEVPATH=/bus/usb/drivers/rt2870
I/vold ( 2161): SUBSYSTEM=drivers
I/vold ( 2161): SEQNUM=1056
D/vold ( 2161): [UEVENT] Sq: 1056 S: drivers A: 0 P: /bus/usb/drivers/rt2870
D/vold ( 2161): DEVPATH=/bus/usb/drivers/rt2870
D/vold ( 2161): No uevent handlers registered for 'drivers' subsystem
D/gsm_mux ( 2402): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2402): start_muxer_on_phy() failed
D/gsm_mux ( 2421): >> AT
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
I/ActivityManager( 2183): Start proc com.android.inputmethod.latin for service com.android.inputmethod.latin/.LatinIME: pid=2422 uid=10000 gids={3003}
D/gsm_mux ( 2421): >> AT
I/ARMAssembler( 2183): generated scanline__00000077:03545404_00000A04_00000000 [ 29 ipp] (51 ins) at [0x1ee338:0x1ee404] in 271000 ns
W/KeyCharacterMap( 2273): No keyboard for id 0
W/KeyCharacterMap( 2273): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
D/dalvikvm( 2422): Trying to load lib /system/lib/libjni_latinime.so 0x435fdf50
D/dalvikvm( 2422): Added shared lib /system/lib/libjni_latinime.so 0x435fdf50
I/ARMAssembler( 2183): generated scanline__00000177:03515104_00001A01_00000000 [ 64 ipp] (89 ins) at [0x242230:0x242394] in 308000 ns
I/ARMAssembler( 2183): generated scanline__00000177:03515104_00000A01_00000000 [ 46 ipp] (70 ins) at [0x242398:0x2424b0] in 298000 ns
D/gsm_mux ( 2421): >> AT
I/ActivityManager( 2183): Starting activity: Intent { action=android.settings.SETTINGS flags=0x10200000 comp={com.android.settings/com.android.settings.Settings} }
I/ActivityManager( 2183): Start proc com.android.settings for activity com.android.settings/.Settings: pid=2428 uid=1000 gids={3002, 3001, 3003}
W/InputManagerService( 2183): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@437ff130
D/gsm_mux ( 2421): >> ATZ
I/ActivityManager( 2183): Displayed activity com.android.settings/.Settings: 678 ms
D/gsm_mux ( 2421): >> ATE0
I/ActivityManager( 2183): Starting activity: Intent { action=android.intent.action.MAIN comp={com.android.settings/com.android.settings.WirelessSettings} }
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabling to Disabled
I/ActivityManager( 2183): Displayed activity com.android.settings/.WirelessSettings: 212 ms
D/gsm_mux ( 2421): >> AT+CSCLK=1
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabled to Enabling
E/WifiHW ( 2183): Unable to open connection to supplicant on "/data/system/wpa_supplicant/wlan0": No such file or directory
D/SettingsWifiEnabler( 2428): Received wifi state changed from Enabling to Enabled
D/gsm_mux ( 2421): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2421): start_muxer_on_phy() failed
D/gsm_mux ( 2442): >> AT
D/gsm_mux ( 2442): >> AT
D/gsm_mux ( 2442): >> AT
I/ActivityManager( 2183): Starting activity: Intent { action=android.intent.action.MAIN comp={com.android.settings/com.android.settings.wifi.WifiSettings} }
V/SettingsWifiLayer( 2428): What's up here? starScan failed?
D/SettingsWifiEnabler( 2428): Received wifi state changed from Enabling to Enabled
D/gsm_mux ( 2442): >> ATZ
I/ActivityManager( 2183): Displayed activity com.android.settings/.wifi.WifiSettings: 201 ms
V/WifiStateTracker( 2183): Connection to supplicant established, state=SCANNING
D/gsm_mux ( 2442): >> ATE0
D/gsm_mux ( 2442): >> AT+CSCLK=1
D/gsm_mux ( 2442): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2442): start_muxer_on_phy() failed
D/gsm_mux ( 2444): >> AT
V/WifiMonitor( 2183): Event [Trying to associate with 00:1c:b0:91:6e:8c (SSID='midfun' freq=2437 MHz)]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=3]
V/WifiStateTracker( 2183): Changing supplicant state: SCANNING ==> ASSOCIATING
D/dalvikvm( 2273): GC freed 2719 objects / 154712 bytes in 184ms
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=4]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATING ==> ASSOCIATED
V/WifiMonitor( 2183): Event [Associated with 00:1c:b0:91:6e:8c]
D/gsm_mux ( 2444): >> AT
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATED ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=6]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> GROUP_HANDSHAKE
V/WifiMonitor( 2183): Event [WPA: Key negotiation completed with 00:1c:b0:91:6e:8c [PTK=CCMP GTK=TKIP]]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=7]
V/WifiStateTracker( 2183): Changing supplicant state: GROUP_HANDSHAKE ==> COMPLETED
V/WifiMonitor( 2183): Event [CTRL-EVENT-CONNECTED - Connection to 00:1c:b0:91:6e:8c completed (auth) [id=0 id_str=]]
V/WifiStateTracker( 2183): New network state is CONNECTED
D/WifiStateTracker( 2183): DhcpHandler: DHCP request started
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: CONNECTING/OBTAINING_IPADDR, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/dalvikvm( 2428): GC freed 3294 objects / 208256 bytes in 89ms
D/gsm_mux ( 2444): >> AT
D/gsm_mux ( 2444): >> ATZ
D/gsm_mux ( 2444): >> ATE0
D/gsm_mux ( 2444): >> AT+CSCLK=1
D/gsm_mux ( 2444): >> AT+CMUX=0,0,5,127
D/dalvikvm( 2270): GC freed 2735 objects / 190008 bytes in 89ms
E/gsm_mux ( 2444): start_muxer_on_phy() failed
D/gsm_mux ( 2452): >> AT
D/gsm_mux ( 2452): >> AT
D/gsm_mux ( 2452): >> AT
D/gsm_mux ( 2452): >> ATZ
D/gsm_mux ( 2452): >> ATE0
D/gsm_mux ( 2452): >> AT+CSCLK=1
D/gsm_mux ( 2452): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2452): start_muxer_on_phy() failed
D/gsm_mux ( 2453): >> AT
D/gsm_mux ( 2453): >> AT
D/gsm_mux ( 2453): >> AT
D/gsm_mux ( 2453): >> ATZ
D/gsm_mux ( 2453): >> ATE0
D/gsm_mux ( 2453): >> AT+CSCLK=1
D/gsm_mux ( 2453): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2453): start_muxer_on_phy() failed
D/gsm_mux ( 2460): >> AT
D/gsm_mux ( 2460): >> AT
D/gsm_mux ( 2460): >> AT
D/gsm_mux ( 2460): >> ATZ
D/gsm_mux ( 2460): >> ATE0
D/gsm_mux ( 2460): >> AT+CSCLK=1
D/gsm_mux ( 2460): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2460): start_muxer_on_phy() failed
D/gsm_mux ( 2461): >> AT
D/gsm_mux ( 2461): >> AT
D/gsm_mux ( 2461): >> AT
D/gsm_mux ( 2461): >> ATZ
I/WifiStateTracker( 2183): DhcpHandler: DHCP request failed: Timed out waiting for DHCP to finish
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=8]
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiStateTracker( 2183): Changing supplicant state: COMPLETED ==> DORMANT
D/WifiStateTracker( 2183): Deconfiguring interface and stopping DHCP
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2461): >> ATE0
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2461): >> AT+CSCLK=1
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: DISCONNECTED/FAILED, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/gsm_mux ( 2461): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2461): start_muxer_on_phy() failed
D/gsm_mux ( 2468): >> AT
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> SCANNING
D/gsm_mux ( 2468): >> AT
D/gsm_mux ( 2468): >> AT
D/gsm_mux ( 2468): >> ATZ
D/gsm_mux ( 2468): >> ATE0
D/gsm_mux ( 2468): >> AT+CSCLK=1
D/gsm_mux ( 2468): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2468): start_muxer_on_phy() failed
D/gsm_mux ( 2470): >> AT
D/gsm_mux ( 2470): >> AT
D/dalvikvm( 2324): GC freed 3206 objects / 193440 bytes in 96ms
D/gsm_mux ( 2470): >> AT
D/gsm_mux ( 2470): >> ATZ
D/gsm_mux ( 2470): >> ATE0
D/gsm_mux ( 2470): >> AT+CSCLK=1
D/gsm_mux ( 2470): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2470): start_muxer_on_phy() failed
D/gsm_mux ( 2471): >> AT
D/dalvikvm( 2270): GC freed 371 objects / 68232 bytes in 79ms
D/gsm_mux ( 2471): >> AT
D/gsm_mux ( 2471): >> AT
D/gsm_mux ( 2471): >> ATZ
D/gsm_mux ( 2471): >> ATE0
D/dalvikvm( 2183): GC freed 8315 objects / 360968 bytes in 136ms
W/GoogleLoginService( 2314): Device has no accounts: sending Intent { action=android.accounts.LOGIN_ACCOUNTS_MISSING }
I/GoogleLoginService.PasswordEncrypter( 2314): no public key available, using default
I/ActivityManager( 2183): Stopping service: com.google.android.googleapps/.GoogleLoginService
D/WifiService( 2183): ACTION_SREEN_OFF
V/WifiMonitor( 2183): Event [CTRL-EVENT-TERMINATING - signal 15 received]
V/WifiStateTracker( 2183): Connection to supplicant lost
D/gsm_mux ( 2471): >> AT+CSCLK=1
D/gsm_mux ( 2471): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2471): start_muxer_on_phy() failed
D/gsm_mux ( 2472): >> AT
D/gsm_mux ( 2472): >> AT
D/KeyguardViewMediator( 2183): wakeWhenReadyLocked(4)
D/KeyguardViewMediator( 2183): wakeWhenReadyLocked(4)
D/KeyguardViewMediator( 2183): handleWakeWhenReady(4)
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabling to Disabled
D/WifiService( 2183): ACTION_SCREEN_ON
D/KeyguardViewMediator( 2183): handleWakeWhenReady(4)
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
D/SettingsWifiEnabler( 2428): Received wifi state changed from Disabled to Enabling
E/WifiHW ( 2183): Unable to open connection to supplicant on "wlan0": No such file or directory
V/SettingsWifiLayer( 2428): What's up here? starScan failed?
D/SettingsWifiEnabler( 2428): Received wifi state changed from Enabling to Enabled
[ 135.542753] <-- RTMPAllocTxRxRingMemory, Status=0
[ 135.547231] -->RTUSBVenderReset
[ 135.547864] <--RTUSBVenderReset
D/gsm_mux ( 2472): >> AT
[ 135.842041] Key1Str is Invalid key length(0) or Type(0)
[ 135.844555] Key2Str is Invalid key length(0) or Type(0)
[ 135.849824] Key3Str is Invalid key length(0) or Type(0)
[ 135.854959] Key4Str is Invalid key length(0) or Type(0)
[ 135.862427] 1. Phy Mode = 9
[ 135.862829] 2. Phy Mode = 9
[ 135.865618] NVM is Efuse and its size =2d[2d0-2fc]
[ 135.941036] 3. Phy Mode = 9
[ 135.950995] RTMPSetPhyMode: channel is out of range, use first channel=1
[ 135.958119] MCS Set = ff 00 00 00 01
W/KeyCharacterMap( 2183): No keyboard for id 0
W/KeyCharacterMap( 2183): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
D/KeyguardViewMediator( 2183): pokeWakelock(5000)
W/InputManagerService( 2183): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@437b7ee8
W/KeyCharacterMap( 2428): No keyboard for id 0
W/KeyCharacterMap( 2428): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
[ 136.243561] <==== rt28xx_init, Status=0
[ 136.245776] 0x1300 = 00064300
[ 136.449581] #
D/gsm_mux ( 2472): >> ATZ
D/gsm_mux ( 2472): >> ATE0
D/gsm_mux ( 2472): >> AT+CSCLK=1
V/SettingsWifiLayer( 2428): What's up here? starScan failed?
W/InputManagerService( 2183): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@437b9250
D/gsm_mux ( 2472): >> AT+CMUX=0,0,5,127
V/WifiStateTracker( 2183): Connection to supplicant established, state=SCANNING
E/gsm_mux ( 2472): start_muxer_on_phy() failed
D/gsm_mux ( 2481): >> AT
D/gsm_mux ( 2481): >> AT
D/gsm_mux ( 2481): >> AT
D/gsm_mux ( 2481): >> ATZ
D/gsm_mux ( 2481): >> ATE0
[ 145.169955] ===>rt_ioctl_giwscan. 2(2) BSS returned, data->length = 307
[ 145.175831] ==>rt_ioctl_siwfreq::SIOCSIWFREQ[cmd=0x8b04] (Channel=1)
V/WifiMonitor( 2183): Event [Trying to associate with 00:1c:b0:91:6e:8c (SSID='midfun' freq=2437 MHz)]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=3]
V/WifiStateTracker( 2183): Changing supplicant state: SCANNING ==> ASSOCIATING
D/dalvikvm( 2314): GC freed 1512 objects / 107040 bytes in 203ms
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=4]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATING ==> ASSOCIATED
V/WifiMonitor( 2183): Event [Associated with 00:1c:b0:91:6e:8c]
D/gsm_mux ( 2481): >> AT+CSCLK=1
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: ASSOCIATED ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=5]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> FOUR_WAY_HANDSHAKE
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=6]
V/WifiStateTracker( 2183): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> GROUP_HANDSHAKE
V/WifiMonitor( 2183): Event [WPA: Key negotiation completed with 00:1c:b0:91:6e:8c [PTK=CCMP GTK=TKIP]]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=7]
V/WifiStateTracker( 2183): Changing supplicant state: GROUP_HANDSHAKE ==> COMPLETED
V/WifiMonitor( 2183): Event [CTRL-EVENT-CONNECTED - Connection to 00:1c:b0:91:6e:8c completed (auth) [id=0 id_str=]]
V/WifiStateTracker( 2183): New network state is CONNECTED
D/WifiStateTracker( 2183): DhcpHandler: DHCP request started
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: CONNECTING/OBTAINING_IPADDR, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/gsm_mux ( 2481): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2481): start_muxer_on_phy() failed
D/gsm_mux ( 2489): >> AT
D/gsm_mux ( 2489): >> AT
D/gsm_mux ( 2489): >> AT
D/gsm_mux ( 2489): >> ATZ
D/gsm_mux ( 2489): >> ATE0
D/gsm_mux ( 2489): >> AT+CSCLK=1
D/gsm_mux ( 2489): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2489): start_muxer_on_phy() failed
D/gsm_mux ( 2496): >> AT
D/gsm_mux ( 2496): >> AT
D/gsm_mux ( 2496): >> AT
D/gsm_mux ( 2496): >> ATZ
D/gsm_mux ( 2496): >> ATE0
D/gsm_mux ( 2496): >> AT+CSCLK=1
D/gsm_mux ( 2496): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2496): start_muxer_on_phy() failed
D/gsm_mux ( 2497): >> AT
D/gsm_mux ( 2497): >> AT
D/gsm_mux ( 2497): >> AT
D/gsm_mux ( 2497): >> ATZ
D/gsm_mux ( 2497): >> ATE0
D/gsm_mux ( 2497): >> AT+CSCLK=1
D/gsm_mux ( 2497): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2497): start_muxer_on_phy() failed
D/gsm_mux ( 2498): >> AT
D/gsm_mux ( 2498): >> AT
D/gsm_mux ( 2498): >> AT
D/gsm_mux ( 2498): >> ATZ
D/gsm_mux ( 2498): >> ATE0
D/gsm_mux ( 2498): >> AT+CSCLK=1
D/gsm_mux ( 2498): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2498): start_muxer_on_phy() failed
D/gsm_mux ( 2499): >> AT
I/WifiStateTracker( 2183): DhcpHandler: DHCP request failed: Timed out waiting for DHCP to finish
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=0 state=8]
V/WifiStateTracker( 2183): Changing supplicant state: COMPLETED ==> DORMANT
D/WifiStateTracker( 2183): Deconfiguring interface and stopping DHCP
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2499): >> AT
V/WifiMonitor( 2183): Event [CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys]
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=8]
D/gsm_mux ( 2499): >> AT
[ 178.915893] Terminate the task(RtmpMlmeTask) with pid(2476)!
[ 178.918865] Terminate the task(RtmpCmdQTask) with pid(2477)!
[ 178.924817] Terminate the task(RtmpTimerTask) with pid(2475)!
[ 178.930197] ---> RTMPFreeTxRxRingMemory
[ 178.933912] Dequeing URB which never Queued
[ 178.938129] Dequeing URB which never Queued
[ 178.942316] Dequeing URB which never Queued
[ 178.946422] Dequeing URB which never Queued
[ 178.950612] Dequeing URB which never Queued
[ 178.954747] Dequeing URB which never Queued
[ 178.958926] Dequeing URB which never Queued
[ 178.963116] Dequeing URB which never Queued
[ 178.967258] Dequeing URB which never Queued
[ 178.971454] Dequeing URB which never Queued
[ 178.975572] Dequeing URB which never Queued
[ 178.979763] Dequeing URB which never Queued
[ 178.983909] Dequeing URB which never Queued
[ 178.988071] Dequeing URB which never Queued
[ 178.992255] Dequeing URB which never Queued
[ 178.996404] Dequeing URB which never Queued
[ 179.000592] Dequeing URB which never Queued
[ 179.004736] Dequeing URB which never Queued
[ 179.008903] Dequeing URB which never Queued
[ 179.013086] Dequeing URB which never Queued
[ 179.017239] Dequeing URB which never Queued
[ 179.021425] Dequeing URB which never Queued
[ 179.025568] Dequeing URB which never Queued
[ 179.029751] Dequeing URB which never Queued
[ 179.033903] Dequeing URB which never Queued
[ 179.038071] Dequeing URB which never Queued
[ 179.042253] Dequeing URB which never Queued
[ 179.046400] Dequeing URB which never Queued
[ 179.050583] Dequeing URB which never Queued
[ 179.054733] Dequeing URB which never Queued
[ 179.058904] Dequeing URB which never Queued
[ 179.063085] Dequeing URB which never Queued
[ 179.067232] Dequeing URB which never Queued
[ 179.071414] Dequeing URB which never Queued
[ 179.075565] Dequeing URB which never Queued
[ 179.079751] Dequeing URB which never Queued
[ 179.083902] Dequeing URB which never Queued
[ 179.088065] Dequeing URB which never Queued
[ 179.092249] Dequeing URB which never Queued
[ 179.096397] Dequeing URB which never Queued
[ 179.100592] Dequeing URB which never Queued
[ 179.104732] Dequeing URB which never Queued
[ 179.109242] <--- RTMPFreeTxRxRingMemory
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
V/WifiStateTracker( 2183): New network state is DISCONNECTED
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> DORMANT
D/SettingsWifiEnabler( 2428): Received network state changed to NetworkInfo: type: WIFI[], state: DISCONNECTED/FAILED, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
D/gsm_mux ( 2499): >> ATZ
D/gsm_mux ( 2499): >> ATE0
V/WifiMonitor( 2183): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2]
V/WifiStateTracker( 2183): Changing supplicant state: DORMANT ==> SCANNING
D/gsm_mux ( 2499): >> AT+CSCLK=1
D/gsm_mux ( 2499): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2499): start_muxer_on_phy() failed
D/gsm_mux ( 2506): >> AT
D/gsm_mux ( 2506): >> AT
D/gsm_mux ( 2506): >> AT
D/dalvikvm( 2324): GC freed 991 objects / 63344 bytes in 80ms
D/gsm_mux ( 2506): >> ATZ
D/gsm_mux ( 2506): >> ATE0
D/gsm_mux ( 2506): >> AT+CSCLK=1
D/gsm_mux ( 2506): >> AT+CMUX=0,0,5,127
E/gsm_mux ( 2506): start_muxer_on_phy() failed
D/gsm_mux ( 2507): >> AT
# ps
PID USER VSZ STAT COMMAND
1 root 2760 S init
2 root 0 SW< [kthreadd]
3 root 0 RW< [ksoftirqd/0]
4 root 0 SW< [events/0]
5 root 0 SW< [khelper]
10 root 0 SW< [suspend]
43 root 0 SW< [sirfsoc-adc]
102 root 0 SW< [kblockd/0]
111 root 0 SW< [kmmcd]
115 root 0 SW< [ksuspend_usbd]
121 root 0 SW< [khubd]
124 root 0 SW< [kseriod]
133 root 0 SW< [btaddconn]
134 root 0 SW< [btdelconn]
155 root 0 SW [pdflush]
156 root 0 SW [pdflush]
157 root 0 SW< [kswapd0]
159 root 0 SW< [aio/0]
160 root 0 SW< [nfsiod]
255 root 0 SW< [kapmd]
383 root 0 SW< [scsi_tgtd/0]
397 root 0 SW< [USB WorkQ]
402 root 0 RW< [mmcqd]
411 root 0 SW< [USB WorkQ]
467 root 0 SW< [krfcommd]
468 root 0 SW< [rpciod/0]
476 root 0 SW< [kjournald]
480 root 2760 S /bin/sh /etc/init.d/rcS
492 root 1744 S < /sbin/udevd --daemon
1355 root 0 SW< [sirfsoc_spi.0]
1358 root 0 SW< [sirfsoc_spi.1]
1389 root 79992 S /usr/bin/gpsexe -3irf1 -dspdevnode /dev/gps -spidevno
1396 root 10400 S /usr/bin/gpsmc
1414 root 288 S /etc/rcS.d/S99android start
2159 root 756 S /system/bin/sh
2160 1000 824 S /system/bin/servicemanager
2161 root 864 S /system/bin/vold
2162 root 684 S /system/bin/debuggerd
2164 root 72616 S zygote /bin/app_process -Xzygote /system/bin --zygote
2165 1013 45924 S /system/bin/mediaserver
2166 1002 1196 S /system/bin/dbus-daemon --system --nofork
2169 1002 1624 S /system/bin/hcid -s -n -f /etc/bluez/hcid.conf
2170 root 824 S /system/xbin/obexftpd -c /system/ftp -b
2171 root 816 S /system/bin/installd
2173 root 1268 S /sbin/adbd
2183 1000 253m S system_server
2267 1001 107m S com.android.phone
2270 10021 98976 S com.fring
2273 10000 100m S android.process.acore
2298 10006 99.5m S com.android.mms
2314 10017 97800 S com.google.process.gapps
2324 10007 97620 S android.process.media
2326 10001 96800 S android.process.im
2361 10020 93456 S com.android.alarmclock
2373 10024 98416 S com.google.android.apps.maps
2386 10025 99076 S com.android.calendar
2422 10000 95488 S com.android.inputmethod.latin
2428 1000 103m S com.android.settings
2469 root 696 T logcat
2534 root 1188 S /system/bin/vchanneld
2535 root 2764 R ps
my init.rc:
mkdir /data/misc/wifi 0770 wifi wifi
mkdir /data/misc/wifi/sockets 0770 wifi wifi
mkdir /data/system/wpa_supplicant 0770 wifi wifi
mkdir /data/misc/dhcp 0770 dhcp dhcp
chown dhcp dhcp /data/misc/dhcp
setprop wifi.interface wlan0
service wpa_supplicant /system/bin/wpa_supplicant -iwlan0 -c/data/misc/wifi/wpa_
group system wifi
disabled
oneshot
service dhcpcd /system/bin/dhcpcd -d -f /system/etc/dhcpcd/android.conf wlan0
group system dhcp
disabled
oneshot
property:init.svc.wpa_supplicant=stopped
stop dhcpcd
anyone can give some good advice?tks!
--
Achievement provides the only real pleasure in life!
Jim Huang
Dec 22, 2009, 9:45:45 PM12/22/09
to 0xlab...@googlegroups.com, android...@googlegroups.com
2009/12/23 tommy tommy <hongj...@gmail.com>:
> hi,all!
>
> hi,all!
>
hi Tommy,
> I use rt3070 in android-cupcake ,ARM11,wifi obtain address failed(DHCP),but
> if use wpa_supplicant to connect server mannual,it is successfull
> connected,and dhcpcd wlan0 mannual ,also successful,but use wifi plugin to
> connnect automatical,it is failed.
[...]
Can you please cut off the messages via logcat <filter-flags>?
> V/WifiMonitor( 2183): Event [CTRL-EVENT-CONNECTED - Connection to
> 00:1c:b0:91:6e:8c completed (auth) [id=0 id_str=]]
> V/WifiStateTracker( 2183): New network state is CONNECTED
> D/WifiStateTracker( 2183): DhcpHandler: DHCP request started
[...]
> I/WifiStateTracker( 2183): DhcpHandler: DHCP request failed: Timed out
> waiting for DHCP to finish
It looks like the problem resulting from dhcpcd service. At least,
wpa_supplicant claims the
complete of the task.
Sincerely,
Jim Huang (jserv)
http://0xlab.org/
HsinYi Chen
Dec 23, 2009, 12:10:39 AM12/23/09
to 0xlab...@googlegroups.com
I think it is a CTRL-Interface problem
--
Best regards,
Tyson , Hsin Yi Chen
please check
1. hardware/hardware_legancy/wifi/wfif.c
2. /system/etc/wifi/wpa_supplicant
3. /data/misc/wifi/wpa_supplicant
4. the wpa_supplicant service in init.rc
the ctrl-interface should be the same in these 4 file.
and if you meet the permission problm of wpa_supplicant socket, please change the owner of wpa_supplicant sokect directory to system, for TI driver , this directory is /data/system/wpa_supplicant
2009/12/23 Jim Huang <js...@0xlab.org>
--
You received this message because you are subscribed to the Google Groups "0xlab-devel" group.
To post to this group, send email to 0xlab...@googlegroups.com.
To unsubscribe from this group, send email to 0xlab-devel...@googlegroups.com.
For more options, visit this group at http://groups.google.com/group/0xlab-devel?hl=en.
--
Best regards,
Tyson , Hsin Yi Chen
HsinYi Chen
Dec 23, 2009, 12:13:04 AM12/23/09
to 0xlab...@googlegroups.com
so far, I think, the real cause is you getting a wrong path define o CTRL-Interface in /data/misc/etc/wpa_supplicant/
2009/12/23 HsinYi Chen <ossug....@gmail.com>
tommy tommy
Dec 23, 2009, 12:57:32 AM12/23/09
to 0xlab...@googlegroups.com
hi,chen,first thanks for your reply.
1:android_cupcake/hardware/libhardware_legacy/wifi$ vim wifi.c
static const char IFACE_DIR[] = "/data/system/wpa_supplicant";
2:/system/etc/wifi/wpa_supplicant.conf
ctrl_interface=DIR=/data/system/wpa_supplicant GROUP=system
update_config=1
network={
ssid="xxxxxx"
psk="abcd123456"
proto=RSN
key_mgmt=WPA-PSK
group=CCMP TKIP
priority=1
}
3:/data/misc/wifi/wpa_supplicant.conf
ctrl_interface=DIR=/data/system/wpa_supplicant GROUP=system
update_config=1
network={
ssid="xxxxxx"
psk="abcd123456"
proto=RSN
key_mgmt=WPA-PSK
group=CCMP TKIP
priority=1
}
4:init.rc
setprop wifi.interface wlan0
service wpa_supplicant /system/bin/wpa_supplicant -iwlan0 -c/data/misc/wifi/wpa_supplicant.conf -iwlan0 -c/data/misc/wifi/wpa_supplicant.conf -dd
group system wifi
disabled
oneshot
service dhcpcd /system/bin/dhcpcd wlan0
group system dhcp
disabled
oneshot
--
1:android_cupcake/hardware/libhardware_legacy/wifi$ vim wifi.c
static const char IFACE_DIR[] = "/data/system/wpa_supplicant";
2:/system/etc/wifi/wpa_supplicant.conf
ctrl_interface=DIR=/data/system/wpa_supplicant GROUP=system
update_config=1
network={
ssid="xxxxxx"
psk="abcd123456"
proto=RSN
key_mgmt=WPA-PSK
group=CCMP TKIP
priority=1
}
3:/data/misc/wifi/wpa_supplicant.conf
ctrl_interface=DIR=/data/system/wpa_supplicant GROUP=system
update_config=1
network={
ssid="xxxxxx"
psk="abcd123456"
proto=RSN
key_mgmt=WPA-PSK
group=CCMP TKIP
priority=1
}
4:init.rc
setprop wifi.interface wlan0
service wpa_supplicant /system/bin/wpa_supplicant -iwlan0 -c/data/misc/wifi/wpa_supplicant.conf -iwlan0 -c/data/misc/wifi/wpa_supplicant.conf -dd
group system wifi
disabled
oneshot
group system dhcp
disabled
oneshot
2009/12/23 HsinYi Chen <ossug....@gmail.com>
--
HsinYi Chen
Dec 24, 2009, 12:34:35 PM12/24/09
to 0xlab...@googlegroups.com
please try to change the owner wifi to system
old
mkdir /data/misc/wifi 0770 wifi wifi
mkdir /data/misc/wifi/sockets 0770 wifi wifi
mkdir /data/system/wpa_supplicant 0770 wifi wifi
mkdir /data/misc/wifi/sockets 0770 wifi wifi
mkdir /data/system/wpa_supplicant 0770 wifi wifi
new
mkdir /data/misc/wifi 0770 system system
mkdir /data/misc/wifi/sockets 0770 system system
mkdir /data/system/wpa_supplicant 0770 system system
mkdir /data/misc/wifi/sockets 0770 system system
mkdir /data/system/wpa_supplicant 0770 system system
2009/12/23 tommy tommy <hongj...@gmail.com>
Reply all
Reply to author
Forward
0 new messages