[G 2014 Q&A, Help & Troubleshooting] ggclanlord:
Edit - Was some conflict because of a Xposed module. Uninstalling the module solved it.

Original post -

Phone isn't going into deep sleep.

Had this problem a couple of days back, downgraded Google play services and worked, phone used to go to sleep.

Now Google Play services auto updated, but still phone was going into deep sleep after that.

Although now I checked and it isn't.

Here's the logcat, if anyone can help and tell me what's the cause.

.m.run(HotwordRecognitionRunner.java:127)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:422)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.util.concurrent.FutureTask.run(FutureTask.java:237)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:152)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:265)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1112)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:587)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.lang.Thread.run(Thread.java:818)

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.apps.gsa.shared.util.bj.run(GsaThreadFactory.java:77)

03-22 19:14:02.531 W/ErrorProcessor(2810): Caused by: java.io.IOException: couldn't start recording, state is:1

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.speech.audio.x.bmh(MicrophoneInputStream.java:169)

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.speech.audio.x.read(MicrophoneInputStream.java:211)

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.apps.gsa.shared.util.bx.a(IoUtils.java:184)

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.speech.audio.ad.vo(Tee.java:406)

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.speech.audio.ad.o(Tee.java:294)

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.speech.audio.ae.read(Tee.java:491)

03-22 19:14:02.531 W/ErrorProcessor(2810): at java.io.InputStream.read(InputStream.java:162)

03-22 19:14:02.531 W/ErrorProcessor(2810): at com.google.android.speech.audio.m.run(AudioSource.java:189)

03-22 19:14:02.531 I/HotwordRecognitionRnr(2810): Stopping hotword detection.

03-22 19:14:02.532 I/HotwordWorker(2810): #onError(false)

03-22 19:14:02.548 I/Timeline(2437): Timeline: Activity_idle id: android.os.BinderProxy@2b90c064 time:6194421

03-22 19:14:02.653 I/Timeline(934): Timeline: Activity_windows_visible id: ActivityRecord{56d2b2f u0 com.teslacoilsw.launcher/com.android.launcher2.Launcher t447} time:6194526

03-22 19:14:02.781 I/Timeline(2437): Timeline: Activity_launch_request id:com.bvalosek.cpuspy time:6194654

03-22 19:14:02.782 I/ActivityManager(934): START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.bvalosek.cpuspy/.ui.HomeActivity bnds=[180,848][360,1022]} from uid 10086 on display 0

03-22 19:14:02.938 I/Timeline(28348): Timeline: Activity_idle id: android.os.BinderProxy@4f0aaaa time:6194811

03-22 19:14:02.963 I/art (934): Explicit concurrent mark sweep GC freed 66907(4MB) AllocSpace objects, 18(4MB) LOS objects, 33% free, 26MB/39MB, paused 22.069ms total 250.847ms

03-22 19:14:03.084 I/Timeline(934): Timeline: Activity_windows_visible id: ActivityRecord{6182b1a u0 com.bvalosek.cpuspy/.ui.HomeActivity t469} time:6194957

03-22 19:14:04.294 W/InputMethodManagerService(934): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@166eff85 attribute=null, token = android.os.BinderProxy@27c7883b

03-22 19:14:05.154 I/PowerManagerService(934): Going to sleep due to power button (uid 1000)...

03-22 19:14:05.155 I/PowerManagerService(934): Sleeping (uid 1000)...

03-22 19:14:05.212 D/PhoneStatusBar(1422): disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search >

03-22 19:14:05.225 D/BluetoothAdapter(1422): 635868128: getState() : mService = null. Returning STATE_OFF

03-22 19:14:05.225 D/BluetoothAdapter(1422): 635868128: getState() : mService = null. Returning STATE_OFF

03-22 19:14:05.242 D/BluetoothAdapter(1422): 635868128: getState() : mService = null. Returning STATE_OFF

03-22 19:14:05.242 D/BluetoothAdapter(1422): 635868128: getState() : mService = null. Returning STATE_OFF

03-22 19:14:05.264 D/BluetoothAdapter(1422): 635868128: getState() : mService = null. Returning STATE_OFF

03-22 19:14:05.264 D/BluetoothAdapter(1422): 635868128: getState() : mService = null. Returning STATE_OFF

03-22 19:14:05.273 W/Settings(1422): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.

03-22 19:14:05.427 D/PhoneStatusBar(1422): disable: < expand ICONS alerts SYSTEM_INFO back HOME* RECENT* clock SEARCH* >

03-22 19:14:05.469 D/audio_hw_primary(262): adev_set_parameters: enter: screen_state=off

03-22 19:14:05.469 E/audio_a2dp_hw(262): adev_set_parameters: ERROR: set param called even when stream out is null

03-22 19:14:05.481 I/DisplayManagerService(934): Display device changed: DisplayDeviceInfo{"Built-in Screen": 720 x 1280, 60.0 fps, supportedRefreshRates [60.0], density 320, 294.967 x 295.563 dpi, appVsyncOff 0, presDeadline 17666667, touch INTERNAL, rotation 0, type BUILT_IN, state OFF, FLAG_DEFAULT_DISPLAY, FLAG_ROTATES_WITH_CONTENT, FLAG_SECURE, FLAG_SUPPORTS_PROTECTED_BUFFERS}

03-22 19:14:05.485 D/SurfaceFlinger(230): Set power mode=0, type=0 flinger=0xb6a62000

03-22 19:14:05.485 D/qdhwcomposer(230): hwc_setPowerMode: Setting mode 0 on display: 0

03-22 19:14:05.485 D/PowerManagerService(934): acquireWakeLock: ignoring request from com.google.android.gms

03-22 19:14:05.486 V/ActivityManager(934): Display changed displayId=0

03-22 19:14:05.499 D/PowerManagerService(934): acquireWakeLock: ignoring request from com.google.android.gms

03-22 19:14:05.532 D/Cleaner (10664): Cleaner check spent 24ms (8ms)

03-22 19:14:05.817 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

03-22 19:14:05.818 D/qdhwcomposer(230): hwc_setPowerMode: Done setting mode 0 on display 0

03-22 19:14:05.819 D/SurfaceControl(934): Excessive delay in setPowerMode(): 337ms

03-22 19:14:05.819 I/QCOM PowerHAL(934): Got set_interactive hint

03-22 19:14:06.904 I/MDMCTBK (350): NetlinkHandler, power_supply subsys

03-22 19:14:06.904 I/MDMCTBK (350): NetlinkHandler, usbChargerStateChanged

03-22 19:14:06.904 I/MDMCTBK (350): checkDefaultInst, current pid is = 350

03-22 19:14:06.904 I/MDMCTBK (350): checkDefaultInst, no pid match

03-22 19:14:06.904 I/MDMCTBK (350): NetlinkHandler, power_supply subsys

03-22 19:14:06.904 I/MDMCTBK (350): NetlinkHandler, usbChargerStateChanged

03-22 19:14:06.904 I/MDMCTBK (350): checkDefaultInst, current pid is = 350

03-22 19:14:06.904 I/MDMCTBK (350): checkDefaultInst, no pid match

03-22 19:14:06.930 I/MDMCTBK (272): NetlinkHandler, power_supply subsys

03-22 19:14:06.930 I/MDMCTBK (272): NetlinkHandler, usbChargerStateChanged

03-22 19:14:06.930 I/MDMCTBK (272): checkDefaultInst, current pid is = 272

03-22 19:14:06.930 I/MDMCTBK (272): checkDefaultInst, pid match

03-22 19:14:06.930 I/MDMCTBK (272): MdmCutbackHndler,readFromFile = /sys/class/power_supply/usb/online

03-22 19:14:06.930 I/MDMCTBK (272): MdmCutbackHndler,readFromFile =

03-22 19:14:06.930 E/MDMCTBK (272): MdmCutbackHndler,Could not open ''

03-22 19:14:06.930 I/MDMCTBK (272): NetlinkHandler, power_supply subsys

03-22 19:14:06.930 I/MDMCTBK (272): NetlinkHandler, usbChargerStateChanged

03-22 19:14:06.930 I/MDMCTBK (272): checkDefaultInst, current pid is = 272

03-22 19:14:06.930 I/MDMCTBK (272): checkDefaultInst, pid match

03-22 19:14:06.930 I/MDMCTBK (272): MdmCutbackHndler,readFromFile = /sys/class/power_supply/usb/online

03-22 19:14:06.930 I/MDMCTBK (272): MdmCutbackHndler,readFromFile =

03-22 19:14:06.930 E/MDMCTBK (272): MdmCutbackHndler,Could not open ''

03-22 19:14:35.205 D/PowerManagerService(934): acquireWakeLock: ignoring request from com.google.android.gms

03-22 19:14:35.299 W/EventLoggerService(2810): Unable to send logs Error code: 262160 | The connection was not attempted due to lack of network connectivity.

03-22 19:14:37.532 I/PowerManagerService(934): Waking up from sleep (uid 1000)...

03-22 19:14:37.533 V/KeyguardServiceDelegate(934): onScreenTurnedOn(showListener = com.android.internal.policy.impl.PhoneWindowManager$2@118c0e20)

03-22 19:14:37.546 I/DisplayPowerController(934): Blocking screen on until initial contents have been drawn.

03-22 19:14:37.556 V/KeyguardServiceDelegate(934): **** SHOWN CALLED ****

03-22 19:14:37.559 I/QCOM PowerHAL(934): Got set_interactive hint

03-22 19:14:37.560 E/QCOM PowerHAL(934): Perflock release failed.

03-22 19:14:37.560 D/SurfaceFlinger(230): Set power mode=2, type=0 flinger=0xb6a62000

03-22 19:14:37.560 D/qdhwcomposer(230): hwc_setPowerMode: Setting mode 2 on display: 0

03-22 19:14:37.564 I/DisplayManagerService(934): Display device changed: DisplayDeviceInfo{"Built-in Screen": 720 x 1280, 60.0 fps, supportedRefreshRates [60.0], density 320, 294.967 x 295.563 dpi, appVsyncOff 0, presDeadline 17666667, touch INTERNAL, rotation 0, type BUILT_IN, state ON, FLAG_DEFAULT_DISPLAY, FLAG_ROTATES_WITH_CONTENT, FLAG_SECURE, FLAG_SUPPORTS_PROTECTED_BUFFERS}

03-22 19:14:37.566 V/ActivityManager(934): Display changed displayId=0

03-22 19:14:37.683 W/ActivityManager(934): getAssistContextExtras failed: no resumed activity

03-22 19:14:37.697 W/ActivityManager(934): getAssistContextExtras failed: no resumed activity

03-22 19:14:37.792 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 1

03-22 19:14:37.793 D/qdhwcomposer(230): hwc_setPowerMode: Done setting mode 2 on display 0

03-22 19:14:37.793 D/SurfaceControl(934): Excessive delay in setPowerMode(): 233ms

03-22 19:14:37.868 I/DisplayPowerController(934): Unblocked screen on after 322 ms

03-22 19:14:37.904 D/audio_hw_primary(262): adev_set_parameters: enter: screen_state=on

03-22 19:14:37.904 E/audio_a2dp_hw(262): adev_set_parameters: ERROR: set param called even when stream out is null

03-22 19:14:37.914 D/PowerManagerService(934): acquireWakeLock: ignoring request from com.google.android.gms

03-22 19:14:37.919 D/PowerManagerService(934): acquireWakeLock: ignoring request from com.google.android.gms

03-22 19:14:38.284 D/PhoneStatusBar(1422): disable: < expand ICONS alerts SYSTEM_INFO back HOME RECENT clock SEARCH >

03-22 19:14:38.314 D/PhoneStatusBar(1422): disable: < expand icons* alerts system_info* back HOME RECENT clock SEARCH >

03-22 19:14:38.368 W/InputMethodManagerService(934): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@c3b36bf attribute=android.view.inputmethod.EditorInfo@169eb18c, token = android.os.BinderProxy@27c7883b

03-22 19:14:38.376 I/Timeline(28348): Timeline: Activity_idle id: android.os.BinderProxy@4f0aaaa time:6230249

03-22 19:14:38.388 D/PhoneStatusBar(1422): disable: < expand icons alerts system_info back home* recent* clock search* >

03-22 19:14:38.397 W/ResourceType(28326): No package identifier when getting value for resource number 0x00000000

03-22 19:14:38.427 V/UserPresentBroadcastReceiver(2013): Received Intent { act=android.intent.action.USER_PRESENT flg=0x24000010 cmp=com.google.android.gms/.auth.trustagent.UserPresentBroadcastReceiver }.

03-22 19:14:39.670 W/InputMethodManagerService(934): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@3e3b0090 attribute=null, token = android.os.BinderProxy@27c7883b

03-22 19:14:40.389 W/ResourceType(1422): No package identifier when getting value for resource number 0x00000000

03-22 19:14:40.390 W/PackageManager(1422): Failure retrieving resources for com.bvalosek.cpuspy: Resource ID #0x0

03-22 19:14:40.399 I/ActivityManager(934): START u0 {act=com.android.systemui.recents.SHOW_RECENTS flg=0x10804000 cmp=com.android.systemui/.recents.RecentsActivity (has extras)} from uid 10016 on display 0

03-22 19:14:40.452 W/ResourceType(1422): No package identifier when getting value for resource number 0x00000000

03-22 19:14:40.452 W/PackageManager(1422): Failure retrieving resources for com.nolanlawson.logcat: Resource ID #0x0

03-22 19:14:40.465 W/ResourceType(1422): No package identifier when getting value for resource number 0x00000000

03-22 19:14:40.465 W/PackageManager(1422): Failure retrieving resources for com.bvalosek.cpuspy: Resource ID