Watchdog killing system process after log "E Watchdog_N: Unable to open stack of tid 7574: 2 (No such file or directory)

Lalit Kansara

unread,

Jan 7, 2013, 5:54:44 AM1/7/13

to android-...@googlegroups.com

Hi,

I'm getting wathdog killing system process: null on Monkey run, can someone help me to find out the cause? I've pasted last five seonds' UI logs and attached the trace file.

Android version: 4.1 Jelly bean

Last five seconds' UIlogs-

12-28 18:16:44.819 464 466 D dalvikvm: GC_CONCURRENT freed 6339K, 23% free 33395K/42887K, paused 15ms+158ms, total 428ms

12-28 18:16:44.819 464 476 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 391ms

12-28 18:16:44.819 464 627 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 352ms

12-28 18:16:44.819 464 540 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 337ms

12-28 18:16:45.129 464 513 E Sensors : poll() failed (Interrupted system call)

12-28 18:16:45.489 464 466 D dalvikvm: GC_CONCURRENT freed 14K, 23% free 33398K/42887K, paused 17ms+76ms, total 332ms

12-28 18:16:46.199 464 536 I ActivityManager: Displayed com.google.android.gsf.login/.AccountIntroUIActivity: +1m10s604ms (total +1m19s834ms)

12-28 18:16:46.219 464 536 I Choreographer: Skipped 4152 frames! The application may be doing too much work on its main thread.

12-28 18:16:46.259 7307 7307 I Choreographer: Skipped 3977 frames! The application may be doing too much work on its main thread.

12-28 18:16:46.279 146 1711 E MediaPlayerService: no current audio output

12-28 18:16:46.299 866 866 E MediaPlayer: Uri is content://media/external/audio/media/1844

12-28 18:16:46.599 464 513 E Sensors : poll() failed (Interrupted system call)

12-28 18:16:46.639 464 516 I ActivityManager: Start proc com.android.contacts for service com.android.contacts/.util.EmptyService: pid=7524 uid=10001 gids={3003, 1015, 1023, 1028}

12-28 18:16:46.749 7524 7524 E Trace : error opening trace file: Permission denied (13)

12-28 18:16:46.749 7524 7524 D ActivityThread: setTargetHeapUtilization:0.25

12-28 18:16:46.749 7524 7524 D ActivityThread: setTargetHeapIdealFree:8388608

12-28 18:16:46.749 7524 7524 D ActivityThread: setTargetHeapConcurrentStart:2097152

12-28 18:16:46.879 464 475 I ActivityManager: START {cmp=com.google.android.gsf.login/.LoginActivity (has extras) u=0} from pid 7307

12-28 18:16:46.909 580 580 D SizeAdaptiveLayout: com.android.internal.widget.SizeAdaptiveLayout@416d3270child view android.widget.LinearLayout@416d4a00 measured out of bounds at 90px clamped to 96px

12-28 18:16:46.909 580 580 D StatusBar.NetworkController: in updateWifiIcons, mWifiConnected: true, mDataAndWifiStacked: false

12-28 18:16:46.939 7234 7234 D Finsky : [1] AuthenticatedActivity.onCreate: Waiting for user to return from auth screen.

12-28 18:16:46.949 866 866 I MediaPlayer: Info (2,0)

12-28 18:16:47.169 6923 6923 W Service : setForeground: ignoring old API call on com.iflytek.player.PlayerService

12-28 18:16:47.299 464 466 D dalvikvm: GC_CONCURRENT freed 6055K, 22% free 33699K/42887K, paused 60ms+89ms, total 677ms

12-28 18:16:47.299 464 27513 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 130ms

12-28 18:16:47.299 464 475 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 132ms

12-28 18:16:47.299 464 541 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 131ms

12-28 18:16:47.299 464 540 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 31ms

12-28 18:16:47.299 464 24069 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 135ms

12-28 18:16:47.309 464 688 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 135ms

12-28 18:16:47.309 464 9371 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 138ms

12-28 18:16:47.309 464 7512 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 132ms

12-28 18:16:47.309 464 691 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 134ms

12-28 18:16:47.309 464 476 I ActivityManager: START {cmp=com.google.android.gsf.login/.UsernamePasswordActivity (has extras) u=0} from pid 7307

12-28 18:16:47.379 146 27392 E MediaPlayerService: no current audio output

12-28 18:16:47.379 866 866 E MediaPlayer: Uri is content://media/external/audio/media/1829

12-28 18:16:47.399 580 580 D SizeAdaptiveLayout: com.android.internal.widget.SizeAdaptiveLayout@416d9730child view android.widget.LinearLayout@417e6800 measured out of bounds at 90px clamped to 96px

12-28 18:16:47.429 6923 6923 I somusic : download manager service oncreate!

12-28 18:16:47.469 7524 7557 D AccountTypeManager: Registering 1 extension packages

12-28 18:16:47.489 464 541 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 0ms

12-28 18:16:47.569 7524 7557 I AccountTypeManager: Loaded meta-data for 4 account types, 2 accounts in 117ms(wall) 17ms(cpu)

12-28 18:16:47.859 464 541 D dalvikvm: GC_EXPLICIT freed 844K, 22% free 33800K/42887K, paused 9ms+96ms, total 377ms

12-28 18:16:47.909 464 536 I ActivityManager: Displayed com.google.android.gsf.login/.UsernamePasswordActivity: +519ms (total +1s242ms)

12-28 18:16:48.309 464 627 E Watchdog_N: Unable to open stack of tid 7574 : 2 (No such file or directory)

12-28 18:16:48.559 464 7576 D dalvikvm: GC_FOR_ALLOC freed 937K, 21% free 34075K/42887K, paused 227ms, total 227ms

12-28 18:16:48.559 464 541 W ProcessStats: Skipping unknown process pid 7577

12-28 18:16:48.779 464 7576 D dalvikvm: GC_FOR_ALLOC freed 392K, 21% free 34212K/43271K, paused 200ms, total 201ms

12-28 18:16:49.039 464 7576 D dalvikvm: GC_FOR_ALLOC freed 3K, 21% free 34466K/43271K, paused 263ms, total 263ms

12-28 18:16:49.149 628 632 D dalvikvm: GC_CONCURRENT freed 1731K, 35% free 9019K/13699K, paused 13ms+25ms, total 90ms

12-28 18:16:49.299 464 7576 D dalvikvm: GC_FOR_ALLOC freed 269K, 21% free 34597K/43719K, paused 233ms, total 234ms

12-28 18:16:49.529 464 7576 D dalvikvm: GC_FOR_ALLOC freed 870K, 23% free 33999K/43719K, paused 212ms, total 212ms

12-28 18:16:49.599 464 627 W Watchdog: *** WATCHDOG KILLING SYSTEM PROCESS: null

Thanks,

Lalit.

traces_4.txt

Dianne Hackborn

unread,

Jan 7, 2013, 2:15:18 PM1/7/13

to android-...@googlegroups.com

This thread seems to be stuck some way. You can see that it is sitting there holding the activity manager lock, with a bunch of other threads backed up waiting for it. The watch dog goes off if it detects that critical system components like the activity manager have become wedged in this way.

"Binder_2" prio=5 tid=10 SUSPENDED
  | group="main" sCount=1 dsCount=0 obj=0x41530d10 self=0x51dca008
  | sysTid=476 nice=0 sched=0/0 cgrp=apps handle=1354888880
  | schedstat=( 0 0 0 ) utm=12348 stm=1266 core=1
  at java.lang.StringBuilder.toString(StringBuilder.java:~663)
  at java.lang.StackTraceElement.toString(StackTraceElement.java:229)
  at java.lang.Throwable.printStackTrace(Throwable.java:329)
  at java.lang.Throwable.printStackTrace(Throwable.java:305)
  at android.app.ApplicationErrorReport$CrashInfo.<init>(ApplicationErrorReport.java:330)
  at android.os.StrictMode$ViolationInfo.<init>(StrictMode.java:2039)
  at android.os.StrictMode$AndroidBlockGuardPolicy.startHandlingViolationException(StrictMode.java:1137)
  at android.os.StrictMode$AndroidBlockGuardPolicy.onWriteToDisk(StrictMode.java:1082)
  at libcore.io.BlockGuardOs.write(BlockGuardOs.java:196)
  at libcore.io.IoBridge.write(IoBridge.java:457)
  at java.io.FileOutputStream.write(FileOutputStream.java:187)
  at java.io.OutputStreamWriter.flushBytes(OutputStreamWriter.java:167)
  at java.io.OutputStreamWriter.convert(OutputStreamWriter.java:181)
  at java.io.OutputStreamWriter.write(OutputStreamWriter.java:266)
  at java.io.PrintWriter.doWrite(PrintWriter.java:623)
  at java.io.PrintWriter.write(PrintWriter.java:601)
  at java.io.PrintWriter.write(PrintWriter.java:579)
  at java.io.PrintWriter.write(PrintWriter.java:641)
  at java.io.PrintWriter.print(PrintWriter.java:453)
  at java.io.PrintWriter.println(PrintWriter.java:549)
  at android.util.PrintWriterPrinter.println(PrintWriterPrinter.java:38)
  at android.content.pm.PackageItemInfo.dumpFront(PackageItemInfo.java:228)
  at android.content.pm.ApplicationInfo.dump(ApplicationInfo.java:442)
  at android.content.pm.ComponentInfo.dumpBack(ComponentInfo.java:132)
  at android.content.pm.ActivityInfo.dump(ActivityInfo.java:508)
  at android.content.pm.ResolveInfo.dump(ResolveInfo.java:223)
  at com.android.server.am.BroadcastRecord.dump(BroadcastRecord.java:161)
  at com.android.server.am.BroadcastQueue.dumpLocked(BroadcastQueue.java:1007)
  at com.android.server.am.ActivityManagerService.dumpBroadcastsLocked(ActivityManagerService.java:9635)
  at com.android.server.am.ActivityManagerService.dump(ActivityManagerService.java:8847)
  at android.os.Binder.dump(Binder.java:280)
  at android.os.Binder.onTransact(Binder.java:252)
  at android.app.ActivityManagerNative.onTransact(ActivityManagerNative.java:1699)
  at com.android.server.am.ActivityManagerService.onTransact(ActivityManagerService.java:1618)
  at android.os.Binder.execTransact(Binder.java:367)
  at dalvik.system.NativeStart.run(Native Method)

--
You received this message because you are subscribed to the Google Groups "android-platform" group.
To view this discussion on the web visit https://groups.google.com/d/msg/android-platform/-/5sbSZr95uhEJ.
To post to this group, send email to android-...@googlegroups.com.
To unsubscribe from this group, send email to android-platfo...@googlegroups.com.
For more options, visit this group at http://groups.google.com/group/android-platform?hl=en.

--
Dianne Hackborn
Android framework engineer
hac...@android.com

Note: please don't send private questions to me, as I don't have time to provide private support, and so won't reply to such e-mails. All such questions should be posted on public forums, where I and others can see and answer them.

Lalit Kansara

unread,

Jan 15, 2013, 6:35:25 AM1/15/13

to android-...@googlegroups.com

Thanks Dianne, that's true that the Binder_2 thread is stuck some way...

12-28 18:16:46.909 580 580 D SizeAdaptiveLayout: com.android.internal.widget.SizeAdaptiveLayout@416d3270child view android.widge...@416d4a00 measured out of bounds at 90px clamped to 96px

12-28 18:16:46.909   580   580 D StatusBar.NetworkController: in updateWifiIcons, mWifiConnected: true, mDataAndWifiStacked: false
12-28 18:16:46.939 7234 7234 D Finsky : [1] AuthenticatedActivity.onCreate: Waiting for user to return from auth screen.

12-28 18:16:46.949   866   866 I MediaPlayer: Info (2,0)
12-28 18:16:47.169 6923 6923 W Service : setForeground: ignoring old API call on com.iflytek.player.PlayerService
12-28 18:16:47.299   464   466 D dalvikvm: GC_CONCURRENT freed 6055K, 22% free 33699K/42887K, paused 60ms+89ms, total 677ms

12-28 18:16:47.299   464 27513 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 130ms
12-28 18:16:47.299   464   475 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 132ms
12-28 18:16:47.299   464   541 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 131ms

12-28 18:16:47.299   464   540 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 31ms
12-28 18:16:47.299   464 24069 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 135ms
12-28 18:16:47.309   464   688 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 135ms

12-28 18:16:47.309   464 9371 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 138ms
12-28 18:16:47.309   464 7512 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 132ms
12-28 18:16:47.309   464   691 D dalvikvm: WAIT_FOR_CONCURRENT_GC blocked 134ms

12-28 18:16:47.309   464   476 I ActivityManager: START {cmp=com.google.android.gsf.login/.UsernamePasswordActivity (has extras) u=0} from pid 7307
12-28 18:16:47.379   146 27392 E MediaPlayerService: no current audio output

12-28 18:16:47.379   866   866 E MediaPlayer: Uri is content://media/external/audio/media/1829

12-28 18:16:47.399 580 580 D SizeAdaptiveLayout: com.android.internal.widget.SizeAdaptiveLayout@416d9730child view android.widge...@417e6800 measured out of bounds at 90px clamped to 96px

Reply all

Reply to author

Forward