[Nexus 7 (2013) Android Development] Corradossj:
Wi-Fi dhcp deb -> Cisco Aironet 1100 problem

Hi there! I've a problem with my Nexus 7 2013 (deb) and my AP Cisco Aironet 1100 series (AIR-AP1120B).

After I upgrade my nexus 7 2013 from CM12.1 snapshot to CM13 nightly (29 of January) don't work yet the dhcp with my AP.

If I set static IP address, I've any problem, when I set dhcp, the tablet loop in a state of "obtaining IP address".

I try to use the "use legacy DHCP client" in developer options and reload, without success.

I try to use the "Network settings reset" in back-up&reset options, without success.

I try to user two playstore app as "wifi fixer", without success.

I try to delete /data/misc/dhcp/ folder and reload, without success.

I try to delete /data/misc/dhcp/, /data/misc/wifi/ and /system/etc/wifi/ folders but wi-fi don't work.

I try to fix permission in recovery, but I have a bootloop and I restore my nandroid.

I have a log of my problem here: could you help me? It is a CM13 bug or a Nexus 7 problem?

PS: in CM12.1 all it's work fine. The problem is born with the CM12.1->CM13 upgrade.

Thank you man.

Corrado

01-29 22:24:42.122 D/su (25517): Finishing su operation for app [uid:10149, pkgName: com.nolanlawson.logcat]
01-29 22:24:42.124 I/SuControllerImpl( 912): Got change
01-29 22:24:42.129 D/su (25515): sending code
01-29 22:24:42.130 D/su (25515): child exited
01-29 22:24:42.130 D/su (25512): client exited 0
01-29 22:24:42.186 D/su (25525): su invoked.
01-29 22:24:42.186 D/su (25525): starting daemon client 10149 10149
01-29 22:24:42.190 D/su (25527): remote pid: 25525
01-29 22:24:42.191 D/su (25527): remote pts_slave:
01-29 22:24:42.191 D/su (25527): waiting for child exit
01-29 22:24:42.192 D/su (25529): su invoked.
01-29 22:24:42.193 E/su (25529): SU from: u0_a149
01-29 22:24:42.193 D/su (25529): Checking whether app [uid:10149, pkgName: com.nolanlawson.logcat] is allowed to be root
01-29 22:24:42.195 D/su (25529): Privilege elevation allowed by appops
01-29 22:24:42.195 D/su (25529): Allowing via appops.
01-29 22:24:42.195 D/su (25529): 10149 /system/bin/app_process32 executing 0 /system/bin/sh using binary /system/bin/sh : sh
01-29 22:24:42.196 D/su (25529): Waiting for pid 25530.
01-29 22:24:42.196 I/SuControllerImpl( 912): Got change
01-29 22:24:42.326 D/su (25529): Finishing su operation for app [uid:10149, pkgName: com.nolanlawson.logcat]
01-29 22:24:42.328 I/SuControllerImpl( 912): Got change
01-29 22:24:42.330 D/su (25527): sending code
01-29 22:24:42.330 D/su (25527): child exited
01-29 22:24:42.330 D/su (25525): client exited 0
01-29 22:24:42.454 D/su (25536): su invoked.
01-29 22:24:42.454 D/su (25536): starting daemon client 10149 10149
01-29 22:24:42.457 D/su (25538): remote pid: 25536
01-29 22:24:42.457 D/su (25538): remote pts_slave:
01-29 22:24:42.458 D/su (25538): waiting for child exit
01-29 22:24:42.462 D/su (25540): su invoked.
01-29 22:24:42.462 E/su (25540): SU from: u0_a149
01-29 22:24:42.463 D/su (25540): Checking whether app [uid:10149, pkgName: com.nolanlawson.logcat] is allowed to be root
01-29 22:24:42.467 I/SuControllerImpl( 912): Got change
01-29 22:24:42.469 D/su (25540): Privilege elevation allowed by appops
01-29 22:24:42.469 D/su (25540): Allowing via appops.
01-29 22:24:42.469 D/su (25540): 10149 /system/bin/app_process32 executing 0 /system/bin/sh using binary /system/bin/sh : sh
01-29 22:24:42.470 D/su (25540): Waiting for pid 25541.
01-29 22:24:42.491 D/su (25540): Finishing su operation for app [uid:10149, pkgName: com.nolanlawson.logcat]
01-29 22:24:42.493 I/SuControllerImpl( 912): Got change
01-29 22:24:42.495 D/su (25538): sending code
01-29 22:24:42.495 D/su (25538): child exited
01-29 22:24:42.495 D/su (25536): client exited 0
01-29 22:24:42.622 D/su (25546): su invoked.
01-29 22:24:42.622 D/su (25546): starting daemon client 10149 10149
01-29 22:24:42.630 D/su (25549): remote pid: 25546
01-29 22:24:42.630 D/su (25549): remote pts_slave:
01-29 22:24:42.631 D/su (25549): waiting for child exit
01-29 22:24:42.632 D/su (25551): su invoked.
01-29 22:24:42.632 E/su (25551): SU from: u0_a149
01-29 22:24:42.633 D/su (25551): Checking whether app [uid:10149, pkgName: com.nolanlawson.logcat] is allowed to be root
01-29 22:24:42.636 D/su (25551): Privilege elevation allowed by appops
01-29 22:24:42.636 D/su (25551): Allowing via appops.
01-29 22:24:42.636 D/su (25551): 10149 /system/bin/app_process32 executing 0 /system/bin/sh using binary /system/bin/sh : sh
01-29 22:24:42.636 D/su (25551): Waiting for pid 25552.
01-29 22:24:42.706 I/SuControllerImpl( 912): Got change
01-29 22:24:42.731 W/InputMethodManagerService( 685): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@b0081c1 attribute=null, token = android.os.BinderProxy@f7a7bbf
01-29 22:24:42.753 V/PhoneStatusBar( 912): setLightsOn(true)
01-29 22:24:43.490 D/PhoneStatusBar( 912): disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search quick_settings >
01-29 22:24:44.024 I/art ( 912): Background partial concurrent mark sweep GC freed 183873(10MB) AllocSpace objects, 25(2MB) LOS objects, 28% free, 39MB/55MB, paused 3.723ms total 178.802ms
01-29 22:24:44.358 D/NuPlayerDriver( 219): reset(0xb6098100)
01-29 22:24:44.358 D/NuPlayerDriver( 219): notifyListener_l(0xb6098100), (8, 0, 0)
01-29 22:24:44.389 D/NuPlayerDriver( 219): notifyResetComplete(0xb6098100)
01-29 22:24:44.393 D/NuPlayerDriver( 219): reset(0xb46d8600)
01-29 22:24:44.394 D/NuPlayerDriver( 219): notifyListener_l(0xb46d8600), (8, 0, 0)
01-29 22:24:44.407 D/NuPlayerDriver( 219): notifyResetComplete(0xb46d8600)
01-29 22:24:44.415 D/NuPlayerDriver( 219): reset(0xb6097f20)
01-29 22:24:44.416 D/NuPlayerDriver( 219): notifyListener_l(0xb6097f20), (8, 0, 0)
01-29 22:24:44.433 D/NuPlayerDriver( 219): notifyResetComplete(0xb6097f20)
01-29 22:24:45.514 D/WifiService( 685): setWifiEnabled: true pid=912, uid=10017
01-29 22:24:45.514 E/WifiService( 685): Invoking mWifiStateMachine.setWifiEnabled
01-29 22:24:45.552 D/WifiConfigStore( 685): Loading config and enabling all networks
01-29 22:24:45.619 D/WifiConfigStore( 685): loaded 0 passpoint configs
01-29 22:24:45.621 W/WifiConfigStore( 685): Upgrading network 1 to android.uid.system:1000
01-29 22:24:45.622 W/WifiConfigStore( 685): Upgrading network 0 to android.uid.system:1000
01-29 22:24:45.623 E/WifiConfigStore( 685): readAutoJoinStatus: Error parsing configurationjava.io.FileNotFoundException: /data/misc/wifi/autojoinconfig.txt: open failed: ENOENT (No such file or directory)
01-29 22:24:45.624 E/WifiConfigStore( 685): buildPnoList sortedWifiConfigurations size 2
01-29 22:24:45.624 E/WifiConfigStore( 685): found sortedWifiConfigurations : "Alice-33398456"-WPA_PSK
01-29 22:24:45.624 E/WifiConfigStore( 685): found sortedWifiConfigurations : "PC-Hotspot"-WPA_PSK
01-29 22:24:45.650 D/CommandListener( 215): Setting iface cfg
01-29 22:24:45.651 D/CommandListener( 215): Trying to bring up p2p0
01-29 22:24:45.651 D/WifiMonitor( 685): startMonitoring(p2p0) with mConnected = true
01-29 22:24:45.660 D/WifiNative-HAL( 685): p2pGetDeviceAddress
01-29 22:24:45.665 D/WifiNative-HAL( 685): p2pGetDeviceAddress returning ae:22:0b:a6:8a:31
01-29 22:24:45.682 I/wpa_supplicant( 3225): p2p0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=IT
01-29 22:24:45.683 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=WORLD
01-29 22:24:45.684 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=WORLD
01-29 22:24:46.222 D/WifiStateMachine( 685): shouldSwitchNetwork txSuccessRate=7,85 rxSuccessRate=23,15 delta 1000 -> 994
01-29 22:24:46.234 D/WifiStateMachine( 685): CMD_AUTO_CONNECT sup state ScanState my state DisconnectedState nid=1 roam=3
01-29 22:24:46.234 E/WifiConfigStore( 685): saveWifiConfigBSSID Setting BSSID for "Alice-33398456"-WPA_PSK to any
01-29 22:24:46.234 E/wifi_gbk2utf( 685): g_pItemList is NULL
01-29 22:24:46.254 D/WifiStateMachine( 685): CMD_AUTO_CONNECT will save config -> "Alice-33398456" nid=1
01-29 22:24:46.298 D/WifiStateMachine( 685): CMD_AUTO_CONNECT did save config -> nid=1
01-29 22:24:46.302 I/wpa_supplicant( 3225): wlan0: Trying to associate with SSID 'Alice-33398456'
01-29 22:24:46.368 I/wpa_supplicant( 3225): wlan0: Associated with 00:02:8a:9e:4b:7c
01-29 22:24:46.389 I/wpa_supplicant( 3225): wlan0: WPA: Key negotiation completed with 00:02:8a:9e:4b:7c [PTK=TKIP GTK=TKIP]
01-29 22:24:46.390 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-CONNECTED - Connection to 00:02:8a:9e:4b:7c completed [id=1 id_str=]
01-29 22:24:46.393 E/NetlinkEvent( 215): NetlinkEvent::FindParam(): Parameter 'UID' not found
01-29 22:24:46.394 D/Tethering( 685): sendTetherStateChangedBroadcast 1, 0, 0
01-29 22:24:46.413 D/ConnectivityService( 685): registerNetworkAgent NetworkAgentInfo{ ni{[type: WIFI[], state: CONNECTING/CONNECTING, reason: (unspecified), extra: "Alice-33398456", roaming: false, failover: false, isAvailable: true]} network{117} lp{{InterfaceName: wlan0 LinkAddresses: [] Routes: [] DnsAddresses: [] Domains: null MTU: 0 TcpBufferSizes: 524288,1048576,2560000,524288,1048576,2560000}} nc{[ Transports: WIFI Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN LinkUpBandwidth>=1048576Kbps LinkDnBandwidth>=1048576Kbps]} Score{20} everValidated{false} lastValidated{false} created{false} lingering{false} explicitlySelected{false} acceptUnvalidated{false} everCaptivePortalDetected{false} lastCaptivePortalDetected{false} }
01-29 22:24:46.413 E/WifiConfigStore( 685): saveWifiConfigBSSID Setting BSSID for "Alice-33398456"-WPA_PSK to any
01-29 22:24:46.413 D/ConnectivityService( 685): NetworkAgentInfo [WIFI () - 117] EVENT_NETWORK_INFO_CHANGED, going from null to CONNECTING
01-29 22:24:46.413 E/wifi_gbk2utf( 685): g_pItemList is NULL
01-29 22:24:46.427 E/WifiConfigStore( 685): saveWifiConfigBSSID Setting BSSID for "Alice-33398456"-WPA_PSK to any
01-29 22:24:46.427 E/wifi_gbk2utf( 685): g_pItemList is NULL
01-29 22:24:46.439 D/CommandListener( 215): Setting iface cfg
01-29 22:24:46.440 D/WifiStateMachine( 685): Start Dhcp Watchdog 16
01-29 22:24:46.449 D/ConnectivityService( 685): updateNetworkScore for NetworkAgentInfo [WIFI () - 117] to 60
01-29 22:24:46.451 D/IpReachabilityMonitor( 685): watch: iface{wlan0/28}, v{1}, ntable=[]
01-29 22:24:46.456 E/native ( 685): do suspend false
01-29 22:24:46.486 I/dhcpcd (25602): version 5.5.6 starting
01-29 22:24:46.488 E/dhcpcd (25602): get_duid: Read-only file system
01-29 22:24:46.650 I/dhcpcd (25602): wlan0: broadcasting for a lease
01-29 22:24:47.036 W/InputMethodManagerService( 685): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@f504687 attribute=null, token = android.os.BinderProxy@326d6b4
01-29 22:24:47.045 V/PhoneStatusBar( 912): setLightsOn(true)
01-29 22:24:47.078 D/PhoneStatusBar( 912): disable: < expand icons* alerts system_info* back home recent clock search quick_settings >
01-29 22:24:48.867 I/ClearcutLoggerApiImpl( 1941): disconnect managed GoogleApiClient
01-29 22:25:03.897 D/PhoneStatusBar( 912): disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search quick_settings >
01-29 22:25:09.611 E/NetlinkEvent( 215): NetlinkEvent::FindParam(): Parameter 'UID' not found
01-29 22:25:10.496 E/NetlinkEvent( 215): NetlinkEvent::FindParam(): Parameter 'UID' not found
01-29 22:25:10.844 W/InputMethodManagerService( 685): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@c79c795 attribute=null, token = android.os.BinderProxy@326d6b4
01-29 22:25:10.845 W/OpenGLRenderer( 912): Incorrectly called buildLayer on View: FrameLayout, destroying layer...
01-29 22:25:10.846 W/OpenGLRenderer( 912): Incorrectly called buildLayer on View: FrameLayout, destroying layer...
01-29 22:25:10.846 W/OpenGLRenderer( 912): Incorrectly called buildLayer on View: LinearLayout, destroying layer...
01-29 22:25:10.940 W/OpenGLRenderer( 912): Incorrectly called buildLayer on View: FrameLayout, destroying layer...
01-29 22:25:10.940 W/OpenGLRenderer( 912): Incorrectly called buildLayer on View: FrameLayout, destroying layer...
01-29 22:25:10.941 W/OpenGLRenderer( 912): Incorrectly called buildLayer on View: LinearLayout, destroying layer...
01-29 22:25:10.946 V/PhoneStatusBar( 912): setLightsOn(true)
01-29 22:25:10.975 D/PhoneStatusBar( 912): disable: < expand icons* alerts system_info* back home recent clock search quick_settings >
01-29 22:25:13.579 D/ConnectivityService( 685): notifyType CAP_CHANGED for NetworkAgentInfo [WIFI () - 117]
01-29 22:25:13.596 D/ConnectivityService( 685): updateNetworkScore for NetworkAgentInfo [WIFI () - 117] to 57
01-29 22:25:16.250 E/AppUsageEventWatcher( 1941): unexpected event type: 7
01-29 22:25:16.285 D/WifiService( 685): acquireWifiLockLocked: WifiLock{NlpWifiLock type=2 binder=android.os.BinderProxy@44c544d}
01-29 22:25:16.610 D/ConnectivityService( 685): notifyType CAP_CHANGED for NetworkAgentInfo [WIFI () - 117]
01-29 22:25:16.614 D/ConnectivityService( 685): updateNetworkScore for NetworkAgentInfo [WIFI () - 117] to 60
01-29 22:25:16.682 I/ActivityManager( 685): Start proc 25734:com.google.android.gm/u0a72 for content provider com.google.android.gm/.provider.PublicContentProvider
01-29 22:25:16.794 D/NetUtils( 685): dhcp_start failed : wlan0
01-29 22:25:16.795 E/DhcpStateMachine( 685): DHCP request failed on wlan0: Timed out waiting for DHCP to finish
01-29 22:25:16.799 E/WifiConfigStore( 685): SSID temp disabled for "Alice-33398456"-WPA_PSK had autoJoinStatus=0 self added false ephemeral false
01-29 22:25:16.799 E/WifiConfigStore( 685): message=DHCP FAILURE
01-29 22:25:16.800 E/WifiConfigStore( 685): blacklisted "Alice-33398456"-WPA_PSK to 0 due to IP config failures, count=1 disableReason=2 00:02:8a:9e:4b:7c ipfail=11
01-29 22:25:16.821 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-DISCONNECTED bssid=00:02:8a:9e:4b:7c reason=3 locally_generated=1
01-29 22:25:16.823 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
01-29 22:25:16.825 D/Tethering( 685): InitialState.processMessage what=4
01-29 22:25:16.826 W/System (25734): ClassLoader referenced unknown path: /data/app/com.google.android.gm-1/lib/arm
01-29 22:25:16.826 D/IpReachabilityMonitor( 685): clear: iface{wlan0/28}, v{2}, ntable=[]
01-29 22:25:16.827 D/WifiNative-HAL( 685): stopRssiMonitoring, cmdId 0
01-29 22:25:16.827 E/WifiConfigStore( 685): saveWifiConfigBSSID Setting BSSID for "Alice-33398456"-WPA_PSK to any
01-29 22:25:16.827 E/wifi_gbk2utf( 685): g_pItemList is NULL
01-29 22:25:16.832 D/Tethering( 685): sendTetherStateChangedBroadcast 0, 0, 0
01-29 22:25:16.837 D/CommandListener( 215): Clearing all IP addresses on wlan0
01-29 22:25:16.849 D/ConnectivityService( 685): NetworkAgentInfo [WIFI () - 117] EVENT_NETWORK_INFO_CHANGED, going from CONNECTING to DISCONNECTED
01-29 22:25:16.849 D/ConnectivityService( 685): NetworkAgentInfo [WIFI () - 117] got DISCONNECTED, was satisfying 0
01-29 22:25:16.850 D/WifiStateMachine( 685): Start Disconnecting Watchdog 16
01-29 22:25:16.855 D/WifiNative-HAL( 685): stopRssiMonitoring, cmdId 0
01-29 22:25:16.864 D/ConnectivityService( 685): notifyType LOST for NetworkAgentInfo [WIFI () - 117]
01-29 22:25:16.866 D/CommandListener( 215): Clearing all IP addresses on wlan0
01-29 22:25:16.867 E/ConnectivityService( 685): EVENT_NETWORK_INFO_CHANGED from unknown NetworkAgent
01-29 22:25:16.889 D/WifiNetworkAgent( 685): NetworkAgent: NetworkAgent channel lost
01-29 22:25:16.927 V/GLSActivity( 1941): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-29 22:25:17.018 W/GAV2 (25734): Thread[main,5,main]: Need to call initialize() and be in fallback mode to start dispatch.
01-29 22:25:17.082 I/EmailMigration(25734): No data to migrate
01-29 22:25:17.082 W/EmailMigration(25734): No Exchange migration, not the right Email provider version
01-29 22:25:17.093 V/GLSActivity( 1941): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-29 22:25:17.159 I/ActivityManager( 685): Start proc 25776:com.google.android.gm.exchange/u0a71 for service com.google.android.gm.exchange/com.android.exchange.service.EasService
01-29 22:25:17.209 V/GLSActivity( 1941): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-29 22:25:17.212 V/GLSActivity( 1941): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-29 22:25:17.220 W/ActivityManager( 685): Unable to start service Intent { cmp=com.google.android.gm/com.android.email.service.AttachmentService } U=0: not found
01-29 22:25:17.254 W/System (25776): ClassLoader referenced unknown path: /system/app/PrebuiltExchange3Google/lib/arm
01-29 22:25:17.305 W/GAV2 (25776): Thread[main,5,main]: Need to call initialize() and be in fallback mode to start dispatch.
01-29 22:25:17.327 I/Exchange(25776): EasService.onCreate
01-29 22:25:17.335 I/Exchange(25776): RestartPingTask
01-29 22:25:17.408 V/GLSActivity( 1941): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-29 22:25:17.409 I/Exchange(25776): RestartPingsTask did not start any pings.
01-29 22:25:17.410 I/Exchange(25776): PSS stopIfIdle
01-29 22:25:17.410 I/Exchange(25776): PSS has no active accounts; stopping service.
01-29 22:25:17.411 I/Exchange(25776): onDestroy
01-29 22:25:17.414 I/ActivityManager( 685): Killing 23505:com.cyanogenmod.lockclock/u0a53 (adj 15): empty #17
01-29 22:25:17.425 D/WifiStateMachine( 685): shouldSwitchNetwork txSuccessRate=504,50 rxSuccessRate=1482,25 delta 1000 -> 1
01-29 22:25:17.494 V/GLSActivity( 1941): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-29 22:25:17.496 D/WifiStateMachine( 685): CMD_AUTO_CONNECT sup state ScanState my state DisconnectedState nid=1 roam=3
01-29 22:25:17.496 D/WifiStateMachine( 685): CMD_AUTO_CONNECT will save config -> "Alice-33398456" nid=1
01-29 22:25:17.529 D/WifiStateMachine( 685): CMD_AUTO_CONNECT did save config -> nid=1
01-29 22:25:17.532 I/wpa_supplicant( 3225): wlan0: Trying to associate with SSID 'Alice-33398456'
01-29 22:25:17.564 D/WifiService( 685): releaseWifiLockLocked: WifiLock{NlpWifiLock type=2 binder=android.os.BinderProxy@44c544d}
01-29 22:25:17.569 V/GLSActivity( 1941): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-29 22:25:17.590 I/wpa_supplicant( 3225): wlan0: Associated with 00:02:8a:9e:4b:7c
01-29 22:25:17.603 D/LocationFilter( 1941): Location jumpped by 6.58082726388732m. Will ignore change=true
01-29 22:25:17.604 I/wpa_supplicant( 3225): wlan0: WPA: Key negotiation completed with 00:02:8a:9e:4b:7c [PTK=TKIP GTK=TKIP]
01-29 22:25:17.604 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-CONNECTED - Connection to 00:02:8a:9e:4b:7c completed [id=1 id_str=]
01-29 22:25:17.608 D/Tethering( 685): sendTetherStateChangedBroadcast 1, 0, 0
01-29 22:25:17.609 E/NetlinkEvent( 215): NetlinkEvent::FindParam(): Parameter 'UID' not found
01-29 22:25:17.617 D/ConnectivityService( 685): registerNetworkAgent NetworkAgentInfo{ ni{[type: WIFI[], state: CONNECTING/CONNECTING, reason: (unspecified), extra: "Alice-33398456", roaming: false, failover: false, isAvailable: true]} network{118} lp{{InterfaceName: wlan0 LinkAddresses: [] Routes: [] DnsAddresses: [] Domains: null MTU: 0 TcpBufferSizes: 524288,1048576,2560000,524288,1048576,2560000}} nc{[ Transports: WIFI Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN LinkUpBandwidth>=1048576Kbps LinkDnBandwidth>=1048576Kbps]} Score{20} everValidated{false} lastValidated{false} created{false} lingering{false} explicitlySelected{false} acceptUnvalidated{false} everCaptivePortalDetected{false} lastCaptivePortalDetected{false} }
01-29 22:25:17.617 E/WifiConfigStore( 685): saveWifiConfigBSSID Setting BSSID for "Alice-33398456"-WPA_PSK to any
01-29 22:25:17.617 D/ConnectivityService( 685): NetworkAgentInfo [WIFI () - 118] EVENT_NETWORK_INFO_CHANGED, going from null to CONNECTING
01-29 22:25:17.617 E/wifi_gbk2utf( 685): g_pItemList is NULL
01-29 22:25:17.628 E/WifiConfigStore( 685): saveWifiConfigBSSID Setting BSSID for "Alice-33398456"-WPA_PSK to any
01-29 22:25:17.628 E/wifi_gbk2utf( 685): g_pItemList is NULL
01-29 22:25:17.641 D/CommandListener( 215): Setting iface cfg
01-29 22:25:17.642 D/WifiStateMachine( 685): Start Dhcp Watchdog 17
01-29 22:25:17.653 D/IpReachabilityMonitor( 685): watch: iface{wlan0/28}, v{1}, ntable=[]
01-29 22:25:17.654 D/ConnectivityService( 685): updateNetworkScore for NetworkAgentInfo [WIFI () - 118] to 60
01-29 22:25:17.657 E/native ( 685): do suspend false
01-29 22:25:17.670 I/GCoreUlr( 1941): Successfully inserted 1 locations
01-29 22:25:17.673 I/GCoreUlr( 1941): Cancelling scheduled uploads
01-29 22:25:17.675 I/GCoreUlr( 1941): Not calling LocationReporter, hasMoved: false, elapsed millis: 2001343, request: Stationary(3600000)
01-29 22:25:17.676 I/GCoreUlr( 1941): Scheduling next upload for 1598657ms from now
01-29 22:25:17.684 I/dhcpcd (25800): version 5.5.6 starting
01-29 22:25:17.686 E/dhcpcd (25800): get_duid: Read-only file system
01-29 22:25:17.844 I/dhcpcd (25800): wlan0: broadcasting for a lease
01-29 22:25:21.223 I/ActivityManager( 685): Killing 23444:com.google.android.calendar/u0a70 (adj 15): empty #17
01-29 22:25:21.407 W/art ( 685): Long monitor contention event with owner method=void com.android.server.am.ActivityManagerService.serviceDoneExecuting(android.os.IBinder, int, int, int) from ActivityManagerService.java:16327 waiters=0 for 186ms
01-29 22:25:22.064 I/GAV2 (25734): Thread[GAThread,5,main]: No campaign data found.
01-29 22:25:22.334 I/art (25776): Waiting for a blocking GC DisableMovingGc
01-29 22:25:22.338 I/art (25776): Starting a blocking GC DisableMovingGc
01-29 22:25:22.357 I/GAV2 (25776): Thread[GAThread,5,main]: No campaign data found.
01-29 22:25:26.134 D/PhoneStatusBar( 912): disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search quick_settings >
01-29 22:25:28.178 E/NetlinkEvent( 215): NetlinkEvent::FindParam(): Parameter 'UID' not found
01-29 22:25:34.820 D/WifiService( 685): setWifiEnabled: false pid=912, uid=10017
01-29 22:25:34.820 E/WifiService( 685): Invoking mWifiStateMachine.setWifiEnabled
01-29 22:25:34.882 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-DISCONNECTED bssid=00:02:8a:9e:4b:7c reason=3 locally_generated=1
01-29 22:25:34.887 D/Tethering( 685): InitialState.processMessage what=4
01-29 22:25:34.915 D/Tethering( 685): sendTetherStateChangedBroadcast 0, 0, 0
01-29 22:25:34.923 I/wpa_supplicant( 3225): wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
01-29 22:25:34.925 D/IpReachabilityMonitor( 685): clear: iface{wlan0/28}, v{2}, ntable=[]
01-29 22:25:34.931 D/WifiNative-HAL( 685): stopRssiMonitoring, cmdId 0
01-29 22:25:34.932 E/WifiConfigStore( 685): saveWifiConfigBSSID Setting BSSID for "Alice-33398456"-WPA_PSK to any
01-29 22:25:34.932 E/wifi_gbk2utf( 685): g_pItemList is NULL
01-29 22:25:35.019 D/CommandListener( 215): Clearing all IP addresses on wlan0
01-29 22:25:35.022 D/ConnectivityService( 685): NetworkAgentInfo [WIFI () - 118] EVENT_NETWORK_INFO_CHANGED, going from CONNECTING to DISCONNECTED
01-29 22:25:35.022 D/ConnectivityService( 685): NetworkAgentInfo [WIFI () - 118] got DISCONNECTED, was satisfying 0
01-29 22:25:35.023 D/WifiStateMachine( 685): Start Disconnecting Watchdog 17
01-29 22:25:35.025 D/WifiNative-HAL( 685): stopRssiMonitoring, cmdId 0
01-29 22:25:35.028 D/CommandListener( 215): Clearing all IP addresses on wlan0
01-29 22:25:35.050 D/ConnectivityService( 685): notifyType LOST for NetworkAgentInfo [WIFI () - 118]
01-29 22:25:35.050 E/ConnectivityService( 685): EVENT_NETWORK_INFO_CHANGED from unknown NetworkAgent
01-29 22:25:35.066 D/WifiNetworkAgent( 685): NetworkAgent: NetworkAgent channel lost
01-29 22:25:35.086 W/Settings( 1941): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.
01-29 22:25:38.297 W/InputMethodManagerService( 685): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@caebc0f attribute=null, token = android.os.BinderProxy@326d6b4
01-29 22:25:38.306 V/PhoneStatusBar( 912): setLightsOn(true)
01-29 22:25:38.336 D/PhoneStatusBar( 912): disable: < expand icons* alerts system_info* back home recent clock search quick_settings >
01-29 22:25:41.394 D/PhoneStatusBar( 912): disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search quick_settings >
01-29 22:25:41.695 E/NetlinkEvent( 215): NetlinkEvent::FindParam(): Parameter 'UID' not found
01-29 22:25:43.746 D/StatusBar( 912): Clicked on content of 0|com.nolanlawson.logcat|2131296342|null|10149
01-29 22:25:43.789 V/PhoneStatusBar( 912): setLightsOn(true)
01-29 22:25:43.964 D/su (25934): su invoked.
01-29 22:25:43.964 D/su (25934): starting daemon client 10149 10149
01-29 22:25:43.967 D/su (25936): remote pid: 25934
01-29 22:25:43.967 D/su (25936): remote pts_slave:
01-29 22:25:43.968 D/su (25936): waiting for child exit
01-29 22:25:43.969 D/su (25938): su invoked.
01-29 22:25:43.970 E/su (25938): SU from: u0_a149
01-29 22:25:43.973 D/su (25938): Checking whether app [uid:10149, pkgName: com.nolanlawson.logcat] is allowed to be root
01-29 22:25:43.976 D/su (25938): Privilege elevation allowed by appops
01-29 22:25:43.977 D/su (25938): Allowing via appops.
01-29 22:25:43.977 D/su (25938): 10149 /system/bin/app_process32 executing 0 /system/bin/sh using binary /system/bin/sh : sh
01-29 22:25:43.977 D/su (25938): Waiting for pid 25939.
01-29 22:25:43.992 I/SuControllerImpl( 912): Got change
01-29 22:25:44.116 D/su (25938): Finishing su operation for app [uid:10149, pkgName: com.nolanlawson.logcat]
01-29 22:25:44.124 D/su (25936): sending code
01-29 22:25:44.124 D/su (25936): child exited
01-29 22:25:44.126 D/su (25934): client exited 0
01-29 22:25:44.143 I/SuControllerImpl( 912): Got change
01-29 22:25:44.238 D/su (25942): su invoked.
01-29 22:25:44.239 D/su (25942): starting daemon client 10149 10149
01-29 22:25:44.243 D/su (25944): remote pid: 25942
01-29 22:25:44.244 D/su (25944): remote pts_slave:
01-29 22:25:44.246 D/su (25944): waiting for child exit
01-29 22:25:44.247 D/su (25946): su invoked.
01-29 22:25:44.247 E/su (25946): SU from: u0_a149
01-29 22:25:44.248 D/su (25946): Checking whether app [uid:10149, pkgName: com.nolanlawson.logcat] is allowed to be root
01-29 22:25:44.251 D/su (25946): Privilege elevation allowed by appops
01-29 22:25:44.251 D/su (25946): Allowing via appops.
01-29 22:25:44.251 D/su (25946): 10149 /system/bin/app_process32 executing 0 /system/bin/sh using binary /system/bin/sh : sh
01-29 22:25:44.251 D/su (25946): Waiting for pid 25947.
01-29 22:25:44.262 I/SuControllerImpl( 912): Got change
01-29 22:25:44.273 D/su (25946): Finishing su operation for app [uid:10149, pkgName: com.nolanlawson.logcat]
01-29 22:25:44.278 D/su (25944): sending code
01-29 22:25:44.278 D/su (25944): child exited
01-29 22:25:44.278 D/su (25942): client exited 0
01-29 22:25:44.288 D/PhoneStatusBar( 912): disable: < expand icons* alerts system_info* back home recent clock search quick_settings >
01-29 22:25:44.288 I/SuControllerImpl( 912): Got change
01-29 22:25:44.331 D/su (25949): su invoked.
01-29 22:25:44.331 D/su (25949): starting daemon client 10149 10149
01-29 22:25:44.336 D/su (25951): remote pid: 25949
01-29 22:25:44.336 D/su (25951): remote pts_slave:
01-29 22:25:44.338 D/su (25951): waiting for child exit
01-29 22:25:44.339 D/su (25953): su invoked.
01-29 22:25:44.341 E/su (25953): SU from: u0_a149
01-29 22:25:44.343 D/su (25953): Checking whether app [uid:10149, pkgName: com.nolanlawson.logcat] is allowed to be root
01-29 22:25:44.351 D/su (25953): Privilege elevation allowed by appops
01-29 22:25:44.351 D/su (25953): Allowing via appops.
01-29 22:25:44.351 D/su (25953): 10149 /system/bin/app_process32 executing 0 /system/bin/sh using binary /system/bin/sh : sh
01-29 22:25:44.352 D/su (25953): Waiting for pid 25955.
01-29 22:25:44.367 I/SuControllerImpl( 912): Got change
01-29 22:25:44.389 D/su (25953): Finishing su operation for app [uid:10149, pkgName: com.nolanlawson.logcat]
01-29 22:25:44.398 I/SuControllerImpl( 912): Got change
01-29 22:25:44.399 D/su (25951): sending code
01-29 22:25:44.399 D/su (25951): child exited
01-29 22:25:44.401 D/su (25949): client exited 0