Develop Bugs

4.1.1 WiFi Turns Itself Off Sporadically

Since 4.1.1 WiFi turns itself off sporadically. My sleep policy is set to never.
I did a search and found the the "My Vodaphone" app was causing problems. I've never had that application, Vodaphone is not my service provider, and I live in the U.S.
Has anyone else had this problem and figured it out?

same problem
sarshadd said:
Since 4.1.1 WiFi turns itself off sporadically. My sleep policy is set to never.
I did a search and found the the "My Vodaphone" app was causing problems. I've never had that application, Vodaphone is not my service provider, and I live in the U.S.
Has anyone else had this problem and figured it out?
Click to expand...
Click to collapse
i have the same problem

Seems to happening extremely sporadically for me. Like maybe once every few weeks I'll catch it turning off WiFi when the screen's off.

i have the same problem, for ex. whilei'm watchimg a u2be vid the wifi turns off every 30sec-1min... i'm running stock jelly bean

Looked at some logs. It doesn't seem like there is anything external turning WiFi off. Seems like it just does it all by itself, even though I have WiFi sleep set to never... Maybe it's just a bug in 4.1.1 where you set it to sleep never and the setting doesn't stick? But then the issue should be more wide spread.
The few times I've caught it in the log, it happens generally right before the PicasaSyncManager process. I have Google photo sync disabled but instant upload for google+ enabled. I'm not sure if they use the same upload process though...
Anyone have any advice?
Code:
08-22 11:19:10.513 15518 15535 I Email : ReconcilePopImapAccountsSync: done
08-22 11:19:10.614 13541 13541 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.
08-22 11:19:10.614 316 692 W InputMethodManagerService: Window already focused, ignoring focus gain of: [email protected] attribute=null
08-22 11:19:10.708 316 604 I ActivityManager: No longer want com.google.android.googlequicksearchbox (pid 15170): hidden #16
08-22 11:19:10.934 15548 15550 D dalvikvm: GC_CONCURRENT freed 378K, 47% free 2652K/4995K, paused 12ms+3ms, total 33ms
08-22 11:19:10.934 15548 15575 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 6ms
08-22 11:19:15.263 11641 11643 D dalvikvm: GC_CONCURRENT freed 337K, 45% free 2959K/5379K, paused 12ms+14ms, total 45ms
08-22 11:19:16.661 540 542 D dalvikvm: GC_CONCURRENT freed 1150K, 38% free 5712K/9155K, paused 12ms+4ms, total 73ms
08-22 11:19:16.669 540 540 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 26ms
08-22 11:19:16.669 540 15580 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 40ms
[B][COLOR="Lime"]08-22 11:19:18.403 136 296 D CommandListener: Clearing all IP addresses on wlan0[/COLOR][/B]
[COLOR="Lime"][B]08-22 11:19:18.403 316 328 D WifiService: setWifiEnabled: false pid=849, uid=10070[/B][/COLOR]
08-22 11:19:18.427 15310 15310 I wpa_supplicant: CTRL_IFACE monitor[0]: 2 - No such file or directory
[COLOR="Lime"][B]08-22 11:19:18.442 316 390 D ConnectivityService: ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED[/B][/COLOR][/COLOR]
08-22 11:19:18.450 316 390 D NetUtils: android_net_utils_resetConnections in env=0x5b3bf520 clazz=0xf200001 iface=wlan0 mask=0x3
08-22 11:19:18.450 316 390 D ConnectivityService: Attempting to switch to mobile
08-22 11:19:18.450 316 390 D ConnectivityService: Attempting to switch to BLUETOOTH_TETHER
08-22 11:19:18.450 316 390 D ConnectivityService: Attempting to switch to ETHERNET
08-22 11:19:18.450 316 390 D ConnectivityService: resetConnections(wlan0, 3)
08-22 11:19:18.497 577 579 D dalvikvm: GC_CONCURRENT freed 723K, 40% free 4268K/7043K, paused 2ms+2ms, total 49ms
08-22 11:19:18.505 665 15471 W Smack/Packet: notify conn break (IOEx), close connection
08-22 11:19:18.513 316 390 D NetUtils: android_net_utils_resetConnections in env=0x5b3bf520 clazz=0x11400001 iface=wlan0 mask=0x3
08-22 11:19:18.513 316 390 D ConnectivityService: ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED
08-22 11:19:18.513 316 390 D ConnectivityService: Attempting to switch to mobile
08-22 11:19:18.513 316 390 D ConnectivityService: Attempting to switch to BLUETOOTH_TETHER
08-22 11:19:18.513 316 390 D ConnectivityService: Attempting to switch to ETHERNET
08-22 11:19:18.513 316 390 D ConnectivityService: resetConnections(wlan0, 3)
08-22 11:19:18.528 15310 15310 I wpa_supplicant: p2p0: CTRL-EVENT-TERMINATING
08-22 11:19:18.653 665 15471 I qtaguid : Failed write_ctrl(u 72) res=-1 errno=22
08-22 11:19:18.653 665 15471 I qtaguid : Untagging socket 72 failed errno=-22
08-22 11:19:18.653 665 15471 W NetworkManagementSocketTagger: untagSocket(72) failed with errno -22
08-22 11:19:18.661 316 390 D ConnectivityService: handleInetConditionChange: no active default network - ignore
08-22 11:19:18.708 665 667 D dalvikvm: GC_CONCURRENT freed 486K, 40% free 4037K/6723K, paused 12ms+4ms, total 48ms
08-22 11:19:18.919 316 320 D dalvikvm: GC_CONCURRENT freed 2009K, 24% free 25362K/33155K, paused 4ms+19ms, total 161ms
08-22 11:19:19.122 15310 15310 I wpa_supplicant: wlan0: CTRL-EVENT-TERMINATING
08-22 11:19:19.122 316 391 D Tethering: InitialState.processMessage what=4
08-22 11:19:19.122 316 391 D Tethering: sendTetherStateChangedBroadcast 0, 0, 0
08-22 11:19:21.520 316 391 D Tethering: MasterInitialState.processMessage what=3
08-22 11:19:21.559 316 391 D Tethering: MasterInitialState.processMessage what=3
08-22 11:19:21.591 15437 15455 D PicasaSyncManager: active network: null
08-22 11:19:21.591 15437 15455 D PicasaSyncManager: background data: true
08-22 11:19:21.692 15457 15490 D PicasaUploaderSyncManager: active network: null
08-22 11:19:21.692 15457 15490 D PicasaUploaderSyncManager: background data: true
08-22 11:19:21.794 15437 15455 D PicasaSyncManager: active network: null
08-22 11:19:21.794 15437 15455 D PicasaSyncManager: background data: true
08-22 11:19:21.841 15457 15490 D PicasaUploaderSyncManager: active network: null
08-22 11:19:21.841 15457 15490 D PicasaUploaderSyncManager: background data: true
08-22 11:19:21.934 136 291 D NetlinkEvent: Unexpected netlink message. type=0x0
08-22 11:19:21.942 316 390 D ConnectivityService: ConnectivityChange for mobile: CONNECTED/CONNECTED
08-22 11:19:21.942 316 390 E MobileDataStateTracker: default: unknown network type: 15
08-22 11:19:21.989 540 542 D dalvikvm: GC_CONCURRENT freed 1072K, 37% free 5785K/9155K, paused 12ms+14ms, total 86ms
08-22 11:19:22.942 316 390 D ConnectivityService: NetTransition Wakelock for WifiStateMachine released by timeout
08-22 11:19:24.489 140 140 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 0ms
08-22 11:19:24.497 316 332 I ActivityManager: Start proc com.google.android.googlequicksearchbox for broadcast com.google.android.googlequicksearchbox/com.google.android.apps.sidekick.calendar.CalendarIntentService$CalendarReceiver: pid=15610 uid=10055 gids={3003, 1028, 1007, 3002, 1015}
08-22 11:19:24.513 140 140 D dalvikvm: GC_EXPLICIT freed 39K, 51% free 2156K/4352K, paused 2ms+3ms, total 22ms

Whilst your sleep policy may be set to never, it could be that avoid poor connection is checked and causing the issue. Also, if Spare Parts is installed, sleep policy must be set to never in it as well.
Sent from my Galaxy Nexus using Tapatalk 2

Avoid poor connections is off.
wifi frequency bands is set to auto.
i do not have spare parts installed.

Wi-Fi DHCP problem between Nexus 7 LTE and Cisco Aironet 1100 in CM13

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
Code:
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: [email protected] attribute=null, token = [email protected]
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: [email protected] attribute=null, token = [email protected]
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: [email protected] attribute=null, token = [email protected]
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 [email protected]}
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 [email protected]}
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: [email protected] attribute=null, token = [email protected]
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

Corradossj said:
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
Code:
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: [email protected] attribute=null, token = [email protected]
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: [email protected] attribute=null, token = [email protected]
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.IInpu[email protected] attribute=null, token = [email protected]
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 [email protected]}
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 [email protected]}
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: [email protected] attribute=null, token = [email protected]
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
Click to expand...
Click to collapse
Solved with 31 of January build.

Nexus 7 (2013) won't connect to my home Wi-Fi (running Android 6.0.1)

I bought a second-hand Wi-Fi only Google/Asus Nexus 7 (2013), which came wiped, with Android 6.0.1 installed, but it won't connect to my home Wi-Fi router. It will save the details but when it tries to connect I get the message 'Wi-Fi Connection Failure'. I am certain the password is correct.
Other devices connect without problems, and I have successfully connected the Nexus to a work Wi-Fi network, but it's no good to me if it won't connect at home. I previously had another Nexus 7 that would connect fine, but was recently bricked by an Android update.
I have tried all suggested fixes I can find online, including:
- Restarting the router
- Wiping data on the Nexus 7
- Restarting the Nexus (in safe and normal mode)
- Switching Wi-Fi/Airplane Mode on and off on the Nexus 7
- Forgetting and re-entering the network details
- Changing the frequency on the Nexus 7
- Changing the channel and security settings on the router
None has any effect. As far as I know my router is on the latest firmware. It's a Sky Hub, which broadcasts at 2.4 GHz.
Can anyone think of a fix or any known issues? I can return the device free to the retailer but would like to see if I can avoid the hassle. I'm also going to avoid doing anything involving rooting the tablet for now in case that voids the warranty.

Let's see the log:
turn off wifi
run: adb logcat -v time > log.txt
turn on wifi
when you see the error, end adb log with ctrl-c immediately
zip up "log.txt" and attach it here
Be quick because the log gets big fast.
We'll be interested mostly in wpa_supplicant messages:
Code:
03-10 23:35:08.318 I/wpa_supplicant( 1879): wlan0: Trying to associate with SSID 'CC1'
03-10 23:35:08.432 D/Tethering( 561): sendTetherStateChangedBroadcast 1, 0, 0
03-10 23:35:08.436 D/NetworkManagementService( 561): getNetworkStatsSummaryXt:NetworkStats: elapsedRealtime=102015
03-10 23:35:08.436 D/NetworkManagementService( 561): [0] iface=lo uid=-1 set=ALL tag=0x0 rxBytes=0 rxPackets=0 txBytes=0 txPackets=0 operations=0
03-10 23:35:08.438 D/NetworkManagementService( 561): getNetworkStatsSummaryDev:NetworkStats: elapsedRealtime=102019
03-10 23:35:08.438 D/NetworkManagementService( 561): [0] iface=lo uid=-1 set=ALL tag=0x0 rxBytes=0 rxPackets=0 txBytes=0 txPackets=0 operations=0
03-10 23:35:08.441 I/wpa_supplicant( 1879): wlan0: Associated with 00:04:ad:d5:e2:0a
03-10 23:35:08.722 I/wpa_supplicant( 1879): wlan0: WPA: Key negotiation completed with 00:04:ad:d5:e2:0a [PTK=CCMP GTK=CCMP]
03-10 23:35:08.726 I/wpa_supplicant( 1879): wlan0: CTRL-EVENT-CONNECTED - Connection to 00:04:ad:d5:e2:0a completed [id=0 id_str=]

Ok, no idea if I've done this right, but here goes (I'm trying to connect to SSID SKY8DBEF):
Code:
03-11 22:37:49.844 D/WifiService( 597): Connect with config* ID: -1 SSID: "SKY8DBEF" PROVIDER-NAME: null BSSID: null FQDN: null PRIO: 0
03-11 22:37:49.844 D/WifiService( 597): KeyMgmt: WPA_PSK Protocols:
03-11 22:37:49.844 D/WifiService( 597): AuthAlgorithms:
03-11 22:37:49.844 D/WifiService( 597): PairwiseCiphers:
03-11 22:37:49.844 D/WifiService( 597): GroupCiphers:
03-11 22:37:49.844 D/WifiService( 597): PSK: *
03-11 22:37:49.844 D/WifiService( 597): Enterprise config:
03-11 22:37:49.844 D/WifiService( 597): IP config:
03-11 22:37:49.844 D/WifiService( 597): IP assignment: DHCP
03-11 22:37:49.844 D/WifiService( 597): Proxy settings: NONE
03-11 22:37:49.844 D/WifiService( 597): cuid=-1 luid=-1 lcuid=0 userApproved=USER_UNSPECIFIED noInternetAccessExpected=false roamingFailureBlackListTimeMilli: 1000
03-11 22:37:49.844 D/WifiService( 597): triggeredLow: 0 triggeredBad: 0 triggeredNotHigh: 0
03-11 22:37:49.844 D/WifiService( 597): ticksLow: 0 ticksBad: 0 ticksNotHigh: 0
03-11 22:37:49.844 D/WifiService( 597): triggeredJoin: 0
03-11 22:37:49.844 D/WifiService( 597): autoJoinBailedDueToLowRssi: false
03-11 22:37:49.844 D/WifiService( 597): autoJoinUseAggressiveJoinAttemptThreshold: 0
03-11 22:37:49.845 I/chatty ( 597): uid=1000(system) WifiStateMachin expire 26 lines
03-11 22:37:49.850 E/WiFiServiceImpl ( 597): CONNECT nid=-1 uid=1000 name=android.uid.system:1000
03-11 22:37:49.850 D/WifiService( 597): Connect with config* ID: -1 SSID: "SKY8DBEF" PROVIDER-NAME: null BSSID: null FQDN: null PRIO: 0
03-11 22:37:49.850 D/WifiService( 597): KeyMgmt: WPA_PSK Protocols:
03-11 22:37:49.850 D/WifiService( 597): AuthAlgorithms:
03-11 22:37:49.850 D/WifiService( 597): PairwiseCiphers:
03-11 22:37:49.850 D/WifiService( 597): GroupCiphers:
03-11 22:37:49.850 D/WifiService( 597): PSK: *
03-11 22:37:49.850 D/WifiService( 597): Enterprise config:
03-11 22:37:49.850 D/WifiService( 597): IP config:
03-11 22:37:49.850 D/WifiService( 597): IP assignment: DHCP
03-11 22:37:49.850 D/WifiService( 597): Proxy settings: NONE
03-11 22:37:49.850 D/WifiService( 597): cuid=-1 luid=-1 lcuid=0 userApproved=USER_UNSPECIFIED noInternetAccessExpected=false roamingFailureBlackListTimeMilli: 1000
03-11 22:37:49.850 D/WifiService( 597): triggeredLow: 0 triggeredBad: 0 triggeredNotHigh: 0
03-11 22:37:49.850 D/WifiService( 597): ticksLow: 0 ticksBad: 0 ticksNotHigh: 0
03-11 22:37:49.850 D/WifiService( 597): triggeredJoin: 0
03-11 22:37:49.850 D/WifiService( 597): autoJoinBailedDueToLowRssi: false
03-11 22:37:49.850 D/WifiService( 597): autoJoinUseAggressiveJoinAttemptThreshold: 0
03-11 22:37:49.854 D/audio_hw_primary( 195): out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
03-11 22:37:49.887 I/Keyboard.Facilitator( 1008): onFinishInput()
03-11 22:37:49.891 D/AudioFlinger( 195): mixer(0xb4200000) throttle end: throttle time(4)
03-11 22:37:50.021 I/wpa_supplicant( 961): wlan0: Trying to associate with SSID 'SKY8DBEF'
03-11 22:37:51.062 I/wpa_supplicant( 961): wlan0: CTRL-EVENT-ASSOC-REJECT bssid=c0:3e:0f:8e:ea:15 status_code=1
03-11 22:37:51.062 I/wpa_supplicant( 961): wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=1 ssid="SKY8DBEF" auth_failures=1 duration=10 reason=CONN_FAILED
03-11 22:37:53.070 D/audio_hw_primary( 195): disable_audio_route: reset and update mixer path: low-latency-playback
03-11 22:37:53.071 D/audio_hw_primary( 195): disable_snd_device: snd_device(2: speaker)
03-11 22:38:01.658 I/wpa_supplicant( 961): wlan0: CTRL-EVENT-SSID-REENABLED id=1 ssid="SKY8DBEF"
03-11 22:38:01.665 I/chatty ( 597): uid=1000(system) WifiStateMachin expire 10 lines
03-11 22:38:16.975 E/ ( 193): invalid crash request of size 4 (from pid=5518 uid=0)
03-11 22:38:17.101 I/chatty ( 597): uid=1000 system_server expire 1 line
03-11 22:38:17.127 E/Diag_Lib( 5816): Diag_LSM_Init: Failed to open handle to diag driver, error = 2
03-11 22:38:17.127 E/Sensors ( 5816): sns_fsa_la.c(386):fsa: fflush failed, 9
03-11 22:38:17.128 E/Sensors ( 5816): sns_fsa_la.c(386):fsa: fflush failed, 9
03-11 22:38:17.154 W/Sensors ( 5816): sns_smr_la.c(446):smr_la: smr_apps_la_thread_main is starting, fd=11, sns_smr.en_rx_msg_ptr=b70009f8
03-11 22:38:17.175 W/Sensors ( 5816): sns_sam_app.c(6827):sns_sam_reg_algo: Registering algo service 16, err 0
03-11 22:38:17.195 E/Sensors ( 5816): sns_debug_main.c(565):Debug Config File missing in EFS!
03-11 22:38:28.381 I/chatty ( 597): uid=1000(system) HeapTaskDaemon expire 1 line
03-11 22:38:49.925 I/Keyboard.Facilitator.LanguageModelFlusher( 1008): run()
03-11 22:38:49.925 I/Keyboard.Facilitator( 1008): flushDynamicLanguageModels()
03-11 22:38:58.429 I/wpa_supplicant( 961): wlan0: Trying to associate with SSID 'SKY8DBEF'
03-11 22:38:59.567 I/wpa_supplicant( 961): wlan0: CTRL-EVENT-ASSOC-REJECT bssid=c0:3e:0f:8e:ea:15 status_code=1
03-11 22:38:59.567 I/wpa_supplicant( 961): wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=1 ssid="SKY8DBEF" auth_failures=1 duration=10 reason=CONN_FAILED
[/QUOTE]

mpb39 said:
Ok, no idea if I've done this right, but here goes (I'm trying to connect to SSID SKY8DBEF)
Click to expand...
Click to collapse
It logs:
Code:
wlan0: CTRL-EVENT-ASSOC-[B]REJECT [/B]bssid=c0:3e:0f:8e:ea:15
wlan0: ... id=1 ssid="SKY8DBEF" [B]auth_failures=1[/B]
The router rejects your N7. Can you check the router's own logs?
On your N7 go to WiFi Direct and rename the device. This will re-generate fresh /data/misc/wifi/wpa_supplicant.conf and may fix the problem which really looks like a bad passphrase.

Ok, I renamed it Nexus7, but it didn't have any effect. Exact same problem.
The router logs that I can access aren't detailed enough to show anything about device connections, as far as I can tell. Just router startups etc. And the N7 isn't showing up in the list of attached devices.
Any other ideas?
I'm thinking I should return the N7 to the retailer on Monday since I'm in a 14-day return period, so it doesn't matter if it's actually broken or not. Either way, if I can't connect to my home Wi-Fi the device is really no good to me.
k23m said:
It logs:
Code:
wlan0: CTRL-EVENT-ASSOC-[B]REJECT [/B]bssid=c0:3e:0f:8e:ea:15
wlan0: ... id=1 ssid="SKY8DBEF" [B]auth_failures=1[/B]
The router rejects your N7. Can you check the router's own logs?
On your N7 go to WiFi Direct and rename the device. This will re-generate fresh /data/misc/wifi/wpa_supplicant.conf and may fix the problem which really looks like a bad passphrase.
Click to expand...
Click to collapse

mpb39 said:
I bought a second-hand Wi-Fi only Google/Asus Nexus 7 (2013), which came wiped, with Android 6.0.1 installed...
Click to expand...
Click to collapse
It was wiped but the OS could have been modified. Does it accept OTA now? I'd reflash it with factory image anyway.

i was experienced the same problem with you, that was after i changed its mac address. what i did is i changed it back to the default one and its working fine again.

I suppose that could have been the problem, but would a factory reset not restore the original MAC code if it had been changed?
Anyway, I've returned the device to the retailer for a refund now.

Frequently wifi disconnects

I got 1-3 wifi disconnects every minute. After 1-2 sec the connections is established again. 2,4 or 5 ghz, WPA or WEP or none, doesn't matter. Also tried disabling play-services.
I'm on stock Android 8 with latest security patches. It's a brandnew phone.
Logcat is telling these errors. Anyone knows the reason for the disconnects?
this one is it in 4 out of 5 times
08-04 19:00:03.263 15061 15061 I wpa_supplicant: WEXT: Custom wireless event: 'TSMIE=0:0:0'
08-04 19:00:03.291 15061 15061 E wpa_supplicant: disconnect rssi= -78
08-04 19:00:03.292 15061 15061 I wpa_supplicant: wlan0: CTRL-EVENT-DISCONNECTED bssid=c4:04:15:3d:f1:7e reason=0 locally_generated=0 disconnect_rssi=78
08-04 19:00:03.302 15061 15061 E wpa_supplicant: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory
08-04 19:00:03.303 15061 15061 E wpa_supplicant: nl80211: Failed to set IPv4 unicast in multicast filter
08-04 19:00:03.309 15061 15061 E wpa_supplicant: eap_proxy: eap_proxy_notify_config
08-04 19:00:03.323 1636 2238 W WifiConfigManager: Looking up network with invalid networkId -1
Click to expand...
Click to collapse
this one is it in 1 out of 5 times
08-04 19:00:46.170 971 15060 E WifiHAL : Received fatal event, sending alert
08-04 19:00:47.128 1199 1199 E wificond: Received error message: Math result not representable
08-04 19:00:47.128 1199 1199 E wificond: NL80211_CMD_GET_STATION failed
08-04 19:00:47.129 1636 2238 E WificondControl: Invalid signal poll result from wificond
08-04 19:00:47.129 1636 2238 W WifiConfigManager: Looking up network with invalid networkId -1
Click to expand...
Click to collapse

I have problems connecting with 802.1x networks only if the AP is from Cisco on my Moto X Play. The log messages are similar. Given that another Moto X Play does not show this issue, I think it is a hardware issue (might be the same for you). But convincing Motorola to repair it even though it is not easily reproducable is difficult.

com.android.statementservice regularly crashing on LineageOS for microg

Hi,
I have just installed LineageOS for microg 19 (19-20220522-microg-bramble) on my Pixel 4a 5g and I am receiving a regular popup every few minutes saying that "Intent Filter Verification Service has stopped".
From what I have read this is used to call another application on the phone (based on what type of thing needs to be handled)??
The logs I am getting with logcat do not seem to lead me towards anything (see below from two examples). I'm not sure if anyone has any suggestions on what could be causing this or where else I can look??
My suspicion is that this is something to do with not having the google apps (using microg instead) but not sure. I did find one other mention of it here, but no solution
Note: I did have LineageOS for microg 18 installed previously which did not exhibit this behaviour...
Example1:
Code:
05-31 23:53:49.627 966 966 D Zygote : Forked child process 10622
05-31 23:53:49.628 1718 2114 I ActivityManager: Start proc 10622:com.android.statementservice/u0a74 for service {com.android.statementservice/androidx.work.impl.background.systemjob.SystemJobService}
05-31 23:53:49.632 10622 10622 I libc : SetHeapTaggingLevel: tag level set to 0
05-31 23:53:49.644 1357 1429 I adbd : jdwp connection from 10622
05-31 23:53:49.646 10622 10622 D ProcessState: Binder ioctl to enable oneway spam detection failed: Invalid argument
05-31 23:53:49.638 0 0 I : c7 10622 binder: 10622:10622 ioctl 40046210 7fea0fb8d4 returned -22
05-31 23:53:49.651 1718 14826 D CompatibilityChangeReporter: Compat change id reported: 168419799; UID 10074; state: DISABLED
05-31 23:53:49.655 10622 10622 D CompatibilityChangeReporter: Compat change id reported: 171979766; UID 10074; state: DISABLED
05-31 23:53:49.658 10622 10622 D ApplicationLoaders: Returning zygote-cached class loader: /system/framework/android.test.base.jar
05-31 23:53:49.667 10622 10622 V GraphicsEnvironment: ANGLE Developer option for 'com.android.statementservice' set to: 'default'
05-31 23:53:49.667 10622 10622 V GraphicsEnvironment: ANGLE GameManagerService for com.android.statementservice: false
05-31 23:53:49.668 10622 10622 V GraphicsEnvironment: Neither updatable production driver nor prerelease driver is supported.
05-31 23:53:49.668 10622 10622 D NetworkSecurityConfig: No Network Security Config specified, using platform default
05-31 23:53:49.668 10622 10622 D NetworkSecurityConfig: No Network Security Config specified, using platform default
05-31 23:53:49.687 10622 10639 D CompatibilityChangeReporter: Compat change id reported: 160794467; UID 10074; state: DISABLED
05-31 23:53:49.689 1718 14826 D CompatibilityChangeReporter: Compat change id reported: 171306433; UID 10074; state: DISABLED
05-31 23:53:49.757 10622 10641 E AndroidRuntime: FATAL EXCEPTION: pool-3-thread-2
05-31 23:53:49.757 10622 10641 E AndroidRuntime: Process: com.android.statementservice, PID: 10622
05-31 23:53:49.757 10622 10641 E AndroidRuntime: java.lang.IllegalStateException: Data cannot occupy more than 10240 bytes when serialized
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at androidx.work.Data.toByteArrayInternal(Data.java:417)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at androidx.work.Data$Builder.build(Data.java:846)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at androidx.work.OverwritingInputMerger.merge(OverwritingInputMerger.java:44)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at androidx.work.impl.WorkerWrapper.runWorker(WorkerWrapper.java:227)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at androidx.work.impl.WorkerWrapper.run(WorkerWrapper.java:137)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at androidx.work.impl.utils.SerialExecutor$Task.run(SerialExecutor.java:91)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
05-31 23:53:49.757 10622 10641 E AndroidRuntime: at java.lang.Thread.run(Thread.java:920)
05-31 23:53:49.761 1718 10645 I DropBoxManagerService: add tag=system_app_crash isTagEnabled=true flags=0x2
05-31 23:53:49.762 10622 10641 I Process : Sending signal. PID: 10622 SIG: 9
05-31 23:53:49.782 1718 14826 I ActivityManager: Process com.android.statementservice (pid 10622) has died: cch+5 CEM
05-31 23:53:49.782 1718 2118 I libprocessgroup: Successfully killed process cgroup uid 10074 pid 10622 in 0ms
05-31 23:53:49.782 966 966 I Zygote : Process 10622 exited due to signal 9 (Killed)
Example2:
Code:
05-31 23:54:24.620 966 966 D Zygote : Forked child process 10707
05-31 23:54:24.620 1718 2114 I ActivityManager: Start proc 10707:com.android.statementservice/u0a74 for service {com.android.statementservice/androidx.work.impl.background.systemjob.SystemJobService}
05-31 23:54:24.625 10707 10707 I libc : SetHeapTaggingLevel: tag level set to 0
05-31 23:54:24.639 1357 1429 I adbd : jdwp connection from 10707
05-31 23:54:24.640 10707 10707 D ProcessState: Binder ioctl to enable oneway spam detection failed: Invalid argument
05-31 23:54:24.633 0 0 I : c3 10707 binder: 10707:10707 ioctl 40046210 7fea0fb8d4 returned -22
05-31 23:54:24.650 1718 14826 D CompatibilityChangeReporter: Compat change id reported: 168419799; UID 10074; state: DISABLED
05-31 23:54:24.654 10707 10707 D CompatibilityChangeReporter: Compat change id reported: 171979766; UID 10074; state: DISABLED
05-31 23:54:24.660 10707 10707 D ApplicationLoaders: Returning zygote-cached class loader: /system/framework/android.test.base.jar
05-31 23:54:24.678 10707 10707 V GraphicsEnvironment: ANGLE Developer option for 'com.android.statementservice' set to: 'default'
05-31 23:54:24.678 10707 10707 V GraphicsEnvironment: ANGLE GameManagerService for com.android.statementservice: false
05-31 23:54:24.679 10707 10707 V GraphicsEnvironment: Neither updatable production driver nor prerelease driver is supported.
05-31 23:54:24.680 10707 10707 D NetworkSecurityConfig: No Network Security Config specified, using platform default
05-31 23:54:24.680 10707 10707 D NetworkSecurityConfig: No Network Security Config specified, using platform default
05-31 23:54:24.699 10707 10724 D CompatibilityChangeReporter: Compat change id reported: 160794467; UID 10074; state: DISABLED
05-31 23:54:24.700 1718 4358 D CompatibilityChangeReporter: Compat change id reported: 171306433; UID 10074; state: DISABLED
05-31 23:54:24.726 1315 1315 I cnss-daemon: nl80211 response handler invoked
05-31 23:54:24.726 1315 1315 I cnss-daemon: nl80211_response_handler: cmd 103, vendorID 4980, subcmd 13 received
05-31 23:54:24.727 1017 2427 I WifiHAL : event received NL80211_CMD_VENDOR, vendor_id = 0x1374, subcmd = 0xd
05-31 23:54:24.765 10707 10726 E AndroidRuntime: FATAL EXCEPTION: pool-3-thread-2
05-31 23:54:24.765 10707 10726 E AndroidRuntime: Process: com.android.statementservice, PID: 10707
05-31 23:54:24.765 10707 10726 E AndroidRuntime: java.lang.IllegalStateException: Data cannot occupy more than 10240 bytes when serialized
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at androidx.work.Data.toByteArrayInternal(Data.java:417)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at androidx.work.Data$Builder.build(Data.java:846)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at androidx.work.OverwritingInputMerger.merge(OverwritingInputMerger.java:44)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at androidx.work.impl.WorkerWrapper.runWorker(WorkerWrapper.java:227)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at androidx.work.impl.WorkerWrapper.run(WorkerWrapper.java:137)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at androidx.work.impl.utils.SerialExecutor$Task.run(SerialExecutor.java:91)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
05-31 23:54:24.765 10707 10726 E AndroidRuntime: at java.lang.Thread.run(Thread.java:920)
05-31 23:54:24.768 1718 10731 I DropBoxManagerService: add tag=system_app_crash isTagEnabled=true flags=0x2

Sorry I don't have a solution for you but since you are using LineageOS+microG on a Pixel phone, you might be interested in switching to CalyxOS as they seem to already have a workaround in place even though the bug isn't fixed yet.
See here under "Issues":
CalyxOS News
📰 Read about what we're working on, important announcements, and upcoming events.
calyxos.org
Relevant commit:
https://review.calyxos.org/c/CalyxOS/vendor_calyx/+/7976
As a bonus, with CalyxOS you also get better security than just LineageOS+microG thanks to bootloader relocking.

I am suffered by that bug too. I can't see any harm by this, but it is annoying. The patch in CalyxOS is just to hide that problem as a workaround.

I filed a bug report here:
Intent filter verification service / com.android.statementservice regularly crashing on LineageOS for microg · Issue #1740 · microg/GmsCore
I am aware this is a very unclear specification of a bug. It is not clear who and what is responsible for this - can be also Android12 (LOS). But it seems to be that the combination of LOS and micr...
github.com
Please report there all your findings @maloo1 and @johnfocker

So I ended up following @johnfocker's suggestion and installed CalyxOS (android 12) and it does "fix" the issue.
I guess Calyx is a perfect fit for my needs anyway (microg, locked boot loader, great polished daily driver) so Ill probably stick with it unless I end up with a phone that is not supported.
It would make sense to have it fixed in microg thou if thats the root cause... I'll see what I can add to the bug...
Thanks again!

Very strange. The messages disappear to pop up after some time.
Lately I installe the new Magisk 25 and BetterBatteryStats (XDA) and it appears again - althoug I am not sure that was really reason. There is continiously changes in phone, so difficult to nail it down.

Quote from flipreverse:
This seems to be a bug in AOSP: https://android.googlesource.com/platform/frameworks/base/+/4978d1ad10293900e9b5feea349abd09ceb6e710
The LOS repo android_frameworks_base does not have this commit at the moment. I'll cherry-pick that one, and give it a try.
Click to expand...
Click to collapse

ale5000 said:
Quote from flipreverse:
Click to expand...
Click to collapse
ist this the bug fix?
https://review.lineageos.org/c/LineageOS/android_frameworks_base/+/334683

kurtn said:
ist this the bug fix?
https://review.lineageos.org/c/LineageOS/android_frameworks_base/+/334683
Click to expand...
Click to collapse
Yes.

ale5000 said:
Yes.
Click to expand...
Click to collapse
Just too late for the lineage.microg.org August round of builds.