[G 2014 Q&A, Help & Troubleshooting] ggclanlord:
Edit - Phone is going into deep sleep now. Problem was because of an app (utter!). Uninstalled. Phone goes into deep sleep now.

Original post -

My phone isn't going into deep sleep. Was on nightly 18th May. Phone won't sleep hence updated to latest nightly, 30th May. Still won't.

Here's the logcat. Cleared log, power button, power button to wake display after a minute or so, save log.

If anyone can look into it and find the issue preventing phone from going to deep sleep, it'd be great!

05-31 18:04:33.592 I/PowerManagerService(883): Going to sleep due to power button (uid 1000)...

05-31 18:04:33.903 I/DisplayManagerService(883): Display device changed: DisplayDeviceInfo{"Built-in Screen": uniqueId="local:0", 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}

05-31 18:04:33.903 V/ActivityManager(883): Display changed displayId=0

05-31 18:04:33.907 D/SurfaceFlinger(230): Set power mode=0, type=0 flinger=0xb86815e0

05-31 18:04:33.907 D/qdhwcomposer(230): hwc_setPowerMode: Setting mode 0 on display: 0

05-31 18:04:34.047 I/art (883): Background sticky concurrent mark sweep GC freed 79848(5MB) AllocSpace objects, 21(336KB) LOS objects, 14% free, 37MB/43MB, paused 2.202ms total 147.632ms

05-31 18:04:34.226 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:34.227 D/qdhwcomposer(230): hwc_setPowerMode: Done setting mode 0 on display 0

05-31 18:04:34.227 D/SurfaceControl(883): Excessive delay in setPowerMode(): 324ms

05-31 18:04:34.227 I/QCOM PowerHAL(883): Got set_interactive hint

05-31 18:04:34.229 I/DreamManagerService(883): Entering dreamland.

05-31 18:04:34.229 I/PowerManagerService(883): Dozing...

05-31 18:04:34.229 I/DreamController(883): Starting dream: name=ComponentInfo{com.android.systemui/com.android.systemui.doze.DozeService}, isTest=false, canDoze=true, userId=0

05-31 18:04:34.258 D/PhoneStatusBar(1245): disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search >

05-31 18:04:34.280 D/BluetoothAdapter(1245): 679206172: getState() : mService = null. Returning STATE_OFF

05-31 18:04:34.280 D/BluetoothAdapter(1245): 679206172: getState() : mService = null. Returning STATE_OFF

05-31 18:04:34.294 W/Settings(1245): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.

05-31 18:04:34.299 W/Settings(1245): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.

05-31 18:04:34.324 D/BluetoothAdapter(1245): 679206172: getState() : mService = null. Returning STATE_OFF

05-31 18:04:34.324 D/BluetoothAdapter(1245): 679206172: getState() : mService = null. Returning STATE_OFF

05-31 18:04:34.342 D/BluetoothAdapter(1245): 679206172: getState() : mService = null. Returning STATE_OFF

05-31 18:04:34.342 D/BluetoothAdapter(1245): 679206172: getState() : mService = null. Returning STATE_OFF

05-31 18:04:34.342 W/Settings(1245): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.

05-31 18:04:34.343 W/Settings(1245): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.

05-31 18:04:34.354 W/Settings(1245): Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.

05-31 18:04:34.454 D/ScreenOnOffReceiver(3402): Received intent: Intent { act=android.intent.action.SCREEN_OFF flg=0x50000010 }.

05-31 18:04:34.459 D/PhoneStatusBar(1245): disable: < expand ICONS alerts SYSTEM_INFO back HOME* RECENT* clock SEARCH* >

05-31 18:04:34.461 V/PhoneStatusBar(1245): setLightsOn(true)

05-31 18:04:34.547 D/audio_hw_primary(248): adev_set_parameters: enter: screen_state=off

05-31 18:04:34.550 E/WifiStateMachine(883): cancelDelayedScan -> 30

05-31 18:04:34.626 D/Cleaner (27554): Cleaner check spent 58ms (24ms)

05-31 18:04:34.906 W/ActivityManager(883): SLOW OOM ADJ: 275ms for pid 743 = 5

05-31 18:04:34.910 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:35.079 E/libsuspend(883): Error writing to /sys/power/state: Try again

05-31 18:04:35.572 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:36.021 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:36.506 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:37.015 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:37.555 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:38.062 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:38.566 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:39.383 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:39.870 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:41.042 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:41.515 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:42.019 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:42.499 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:42.981 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:43.463 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:43.945 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:44.439 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:44.944 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:45.434 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:45.901 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:46.395 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:46.885 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:47.382 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:47.883 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:48.379 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:48.449 I/MDMCTBK (336): NetlinkHandler, power_supply subsys

05-31 18:04:48.449 I/MDMCTBK (336): NetlinkHandler, usbChargerStateChanged

05-31 18:04:48.449 I/MDMCTBK (336): checkDefaultInst, current pid is = 336

05-31 18:04:48.449 I/MDMCTBK (336): checkDefaultInst, no pid match

05-31 18:04:48.449 I/MDMCTBK (336): NetlinkHandler, power_supply subsys

05-31 18:04:48.449 I/MDMCTBK (336): NetlinkHandler, usbChargerStateChanged

05-31 18:04:48.449 I/MDMCTBK (336): checkDefaultInst, current pid is = 336

05-31 18:04:48.449 I/MDMCTBK (336): checkDefaultInst, no pid match

05-31 18:04:48.450 I/MDMCTBK (341): NetlinkHandler, power_supply subsys

05-31 18:04:48.450 I/MDMCTBK (341): NetlinkHandler, usbChargerStateChanged

05-31 18:04:48.450 I/MDMCTBK (341): checkDefaultInst, current pid is = 341

05-31 18:04:48.450 I/MDMCTBK (341): checkDefaultInst, pid match

05-31 18:04:48.450 I/MDMCTBK (341): MdmCutbackHndler,readFromFile = /sys/class/power_supply/usb/online

05-31 18:04:48.450 I/MDMCTBK (341): MdmCutbackHndler,readFromFile =

05-31 18:04:48.450 E/MDMCTBK (341): MdmCutbackHndler,Could not open ''

05-31 18:04:48.450 I/MDMCTBK (341): NetlinkHandler, power_supply subsys

05-31 18:04:48.450 I/MDMCTBK (341): NetlinkHandler, usbChargerStateChanged

05-31 18:04:48.450 I/MDMCTBK (341): checkDefaultInst, current pid is = 341

05-31 18:04:48.450 I/MDMCTBK (341): checkDefaultInst, pid match

05-31 18:04:48.450 I/MDMCTBK (341): MdmCutbackHndler,readFromFile = /sys/class/power_supply/usb/online

05-31 18:04:48.450 I/MDMCTBK (341): MdmCutbackHndler,readFromFile =

05-31 18:04:48.450 E/MDMCTBK (341): MdmCutbackHndler,Could not open ''

05-31 18:04:48.841 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:49.354 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:49.847 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:50.342 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:50.820 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:51.311 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:51.806 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:52.298 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:52.794 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:52.819 I/ScreenOn(4120): Call state value: 0

05-31 18:04:52.819 I/ScreenOnService(4120): Service Running! application found: false

05-31 18:04:53.255 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:53.752 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:54.251 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:54.752 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:55.245 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:55.744 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:56.238 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:56.737 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:57.216 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:57.722 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:57.747 I/ScreenOn(4120): Call state value: 0

05-31 18:04:57.747 I/ScreenOnService(4120): Service Running! application found: false

05-31 18:04:58.214 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:58.716 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:59.219 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:04:59.710 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:05:00.532 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:05:01.033 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:05:01.525 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:05:02.020 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:05:02.510 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:05:02.977 E/libsuspend(883): Error writing to /sys/power/state: Device or resource busy

05-31 18:05:04.299 I/ActivityManager(883): Start proc 6718:com.breakingnews/u0a211 for broadcast com.breakingnews/.widget.ListHomeWidget

05-31 18:05:04.341 I/art (261): Explicit concurrent mark sweep GC freed 703(30KB) AllocSpace objects, 0(0B) LOS objects, 39% free, 7MB/12MB, paused 403us total 41.107ms

05-31 18:05:04.413 I/art (261): Explicit concurrent mark sweep GC freed 8(256B) AllocSpace objects, 0(0B) LOS objects, 39% free, 7MB/12MB, paused 427us total 70.139ms

05-31 18:05:04.434 W/ResourcesManager(6718): Asset path '/system/framework/com.google.android.maps.jar' does not exist or contains no resources.

05-31 18:05:04.434 I/art (261): Explicit concurrent mark sweep GC freed 5(160B) AllocSpace objects, 0(0B) LOS objects, 39% free, 7MB/12MB, paused 417us total 20.451ms

05-31 18:05:04.575 D/ImageLoader(6718): Initialize ImageLoader with configuration

05-31 18:05:04.713 D/Breaking News APID(6718): 18ce12a7-871e-455c-bd01-c5b7bbb15846

05-31 18:05:04.738 I/Breaking News - UALib(6718): App APID: 18ce12a7-871e-455c-bd01-c5b7bbb15846

05-31 18:05:04.790 D/Breaking News(6718): StatsService: Requesting stats from server ...

05-31 18:05:04.803 D/Breaking News - UALib(6718): Push enabled: true

05-31 18:05:05.151 I/qdhwcomposer(230): handle_blank_event: dpy:0 panel power state: 0

05-31 18:05:05.154 W/ActivityManager(883): SLOW OOM ADJ: 352ms for pid 6718 = 5

05-31 18:05:05.181 D/Breaking News - UALib(6718): Starting GCM

05-31 18:05:05.202 I/Breaking News - UALib(6718): Using GCM Registration ID: APA91bF-4wmJOJmaacLO7Ot6nKuHy1hzXtL4YsE1LP0H29uNitxXOiU1KJDFcj_HF2F-K174E8GQbVSPeGQzKU2mEH5ztAX85veabaEVE9AvRsAMQC48szfHjG6ubE-Z_zGLQb3P07OP

05-31 18:0