New issue
Advanced search Search tips
Note: Color blocks (like █ or █) mean that a user may not be available. Tooltip shows the reason.

Issue 645400 link

Starred by 1 user
Status: Archived
Owner:
dgozman@chromium.org
Closed: Dec 5
Cc:
eseckler@chromium.org
█ alexclarke@chromium.org
pfeldman@chromium.org
Components:
EstimatedDays: ----
NextAction: ----
OS: Android
Pri: 3
Type: Bug

Blocking:
issue 621867



Sign in to add a comment

DevToolsProtocolTest.BrowserGetTargets is flaky on Lollipop Low-end Tester

Project Member Reported by gsennton@chromium.org, Sep 9 2016 
DevToolsProtocolTest.BrowserGetTargets crashes flakily on Lollipop Low-end Tester

flakiness dashboard:

https://test-results.appspot.com/dashboards/flakiness_dashboard.html#tests=DevToolsProtocolTest.BrowserGetTargets&testType=content_browsertests


Logcat output from run #3978:

E68GC:  09-09 05:24:37.132 22291 22291 I cr_NativeTest: [INFO:test_support_android.cc(185)] MessagePumpForUIFactory already set, unable to override.
E68GC:  09-09 05:24:37.133 22291 22291 I cr_NativeTest: >>ScopedMainEntryLogger
E68GC:  09-09 05:24:37.134 22291 22291 I cr_NativeTest: Note: Google Test filter = DevToolsProtocolTest.BrowserGetTargets
E68GC:  09-09 05:24:37.136 22291 22291 I cr_NativeTest: [==========] Running 1 test from 1 test case.
E68GC:  09-09 05:24:37.138 22291 22291 I cr_NativeTest: [----------] Global test environment set-up.
E68GC:  09-09 05:24:37.139 22291 22291 I cr_NativeTest: [----------] 1 test from DevToolsProtocolTest, where TypeParam = 
E68GC:  09-09 05:24:37.150 22291 22291 I cr_NativeTest: [ RUN      ] DevToolsProtocolTest.BrowserGetTargets
E68GC:  09-09 05:24:37.151 22291 22291 I cr_NativeTest: [WARNING:dns_config_service_posix.cc(316)] Failed to read DnsConfig.
E68GC:  09-09 05:24:37.153 22291 22291 I cr_NativeTest: [ERROR:devtools_http_handler.cc(221)] Cannot start http server for devtools. Stop devtools.
E68GC:  09-09 05:24:37.173   551   567 I ActivityManager: START u0 {act=android.intent.action.MAIN flg=0x10000000 cmp=org.chromium.content_browsertests_apk/.ContentBrowserTestsActivity (has extras)} from uid 10090 on display 0
E68GC:  09-09 05:24:37.177   551   567 V WindowManager: addAppToken: AppWindowToken{2c167a28 token=Token{3a60904b ActivityRecord{29386d1a u0 org.chromium.content_browsertests_apk/.ContentBrowserTestsActivity t763}}} to stack=1 task=763 at 0
E68GC:  09-09 05:24:37.208  2020  2064 I OpenGLRenderer: Initialized EGL, version 1.4
E68GC:  09-09 05:24:37.211  2020  2064 I MaliEGL : [Mali]window_type=1, is_framebuffer=0, errnum = 0
E68GC:  09-09 05:24:37.211  2020  2064 I MaliEGL : [Mali]surface->num_buffers=4, surface->num_frames=3, win_min_undequeued=1
E68GC:  09-09 05:24:37.211  2020  2064 I MaliEGL : [Mali]max_allowed_dequeued_buffers=3
E68GC:  09-09 05:24:37.219   551   577 V WindowManager: Adding window Window{be040e6 u0 Starting org.chromium.content_browsertests_apk} at 10 of 17 (after Window{11e0f833 u0 Starting org.chromium.content_browsertests_apk EXITING})
E68GC:  09-09 05:24:37.262   551  1130 I ActivityManager: Start proc 22704:org.chromium.content_browsertests_apk:test_process/u0a90 for activity org.chromium.content_browsertests_apk/.ContentBrowserTestsActivity
E68GC:  09-09 05:24:37.275 22704 22704 I art     : Late-enabling -Xcheck:jni
E68GC:  09-09 05:24:37.313   551   577 V WindowManager: Layouts looping: On entry to LockedInner, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.314   551   577 V WindowManager: Layouts looping: loop number 4, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.314   551   577 V WindowManager: Layouts looping: after finishPostLayoutPolicyLw, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.315   551   577 V WindowManager: Layouts looping: wallpaper and commitFinishDrawingLocked true, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.317   551   577 V WindowManager: Layouts looping: WallpaperMayChange, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.319   551   577 V WindowManager: Layouts looping: On entry to LockedInner, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.320   551   577 V WindowManager: Layouts looping: loop number 5, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.320   551   577 V WindowManager: Layouts looping: after finishPostLayoutPolicyLw, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.320   551   577 V WindowManager: Layouts looping: wallpaper and commitFinishDrawingLocked true, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.322   551   577 V WindowManager: Layouts looping: WallpaperMayChange, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.323   551   577 E WindowManager: Performed 6 layouts in a row. Skipping
E68GC:  09-09 05:24:37.361   551   636 V WindowManager: Layouts looping: On entry to LockedInner, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.362   551   636 V WindowManager: Layouts looping: loop number 4, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.362   551   636 V WindowManager: Layouts looping: after finishPostLayoutPolicyLw, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.362   551   636 V WindowManager: Layouts looping: wallpaper and commitFinishDrawingLocked true, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.363   551   636 V WindowManager: Layouts looping: WallpaperMayChange, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.365   551   636 V WindowManager: Layouts looping: On entry to LockedInner, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.365   551   636 V WindowManager: Layouts looping: loop number 5, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.366   551   636 V WindowManager: Layouts looping: after finishPostLayoutPolicyLw, mPendingLayoutChanges = 0x0
E68GC:  09-09 05:24:37.366   551   636 V WindowManager: Layouts looping: wallpaper and commitFinishDrawingLocked true, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.367   551   636 V WindowManager: Layouts looping: WallpaperMayChange, mPendingLayoutChanges = 0x4
E68GC:  09-09 05:24:37.369   551   636 E WindowManager: Performed 6 layouts in a row. Skipping
E68GC:  09-09 05:24:37.414 22704 22704 I cr_NativeTest: Extras:
E68GC:  09-09 05:24:37.415 22704 22704 I cr_NativeTest:   org.chromium.native_test.NativeTest.StdoutFile
E68GC:  09-09 05:24:37.415 22704 22704 I cr_NativeTest:   org.chromium.native_test.NativeTest.Shard
E68GC:  09-09 05:24:37.498 22704 22704 W linker  : lib_content_browsertests__library.so: unused DT entry: type 0x6ffffffe arg 0x259bc
E68GC:  09-09 05:24:37.498 22704 22704 W linker  : lib_content_browsertests__library.so: unused DT entry: type 0x6fffffff arg 0x3
E68GC:  09-09 05:24:37.593 22704 22704 W linker  : libosmesa.so: unused DT entry: type 0x6ffffffe arg 0xa0c8
E68GC:  09-09 05:24:37.593 22704 22704 W linker  : libosmesa.so: unused DT entry: type 0x6fffffff arg 0x3
E68GC:  09-09 05:24:37.597 22704 22704 I cr_LibraryLoader: Time to load native libraries: 103 ms (timestamps 4167-4270)
E68GC:  09-09 05:24:37.597 22704 22704 I cr_LibraryLoader: Expected native library version number "", actual native library version number ""
E68GC:  09-09 05:24:37.598 22704 22704 W chromium: [0909/052437:WARNING:trace_config_file.cc(80)] The trace config file does not exist.
E68GC:  09-09 05:24:37.598 22704 22704 I chromium: [INFO:library_loader_hooks.cc(151)] Chromium logging enabled: level = 0, default verbosity = 0
E68GC:  09-09 05:24:37.653 22704 22723 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: false
E68GC:  09-09 05:24:37.660 22704 22704 D Atlas   : Validating map...
E68GC:  09-09 05:24:37.668   551   568 V WindowManager: Adding window Window{2e1c86be u0 org.chromium.content_browsertests_apk/org.chromium.content_browsertests_apk.ContentBrowserTestsActivity} at 11 of 18 (before Window{be040e6 u0 Starting org.chromium.content_browsertests_apk})
E68GC:  09-09 05:24:37.705 22704 22704 I chromium: [INFO:test_support_android.cc(185)] MessagePumpForUIFactory already set, unable to override.
E68GC:  09-09 05:24:37.739 22704 22724 W chromium: [WARNING:dns_config_service_posix.cc(316)] Failed to read DnsConfig.
E68GC:  09-09 05:24:37.912 22704 22741 E chromium: [ERROR:devtools_http_handler.cc(221)] Cannot start http server for devtools. Stop devtools.
E68GC:  09-09 05:24:37.993 22704 22704 I art     : Rejecting re-init on previously-failed class java.lang.Class<org.chromium.content.browser.FloatingWebActionModeCallback>
E68GC:  09-09 05:24:37.993 22704 22704 I art     : Rejecting re-init on previously-failed class java.lang.Class<org.chromium.content.browser.FloatingWebActionModeCallback>
E68GC:  09-09 05:24:38.073   551  1130 D ConnectivityService: listenForNetwork for NetworkRequest [ id=790, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ]
E68GC:  09-09 05:24:38.135 22704 22740 W cr_media: Requires BLUETOOTH permission
E68GC:  09-09 05:24:38.140 22704 22735 W cr_ChildProcLauncher: Create a new ChildConnectionAllocator with package name = org.chromium.content_browsertests_apk, inSandbox = true
E68GC:  09-09 05:24:38.148 22704 22735 D cr_ChildProcLauncher: [ChildProcessLauncher.java:100] Allocator allocated a connection, sandbox: true, slot: 0
E68GC:  09-09 05:24:38.191 22744 22744 I art     : Late-enabling -Xcheck:jni
E68GC:  09-09 05:24:38.194   551  1129 I ActivityManager: Start proc 22744:org.chromium.content_browsertests_apk:sandboxed_process0/u0i571 for service org.chromium.content_browsertests_apk/org.chromium.content.app.SandboxedProcessService0
E68GC:  09-09 05:24:38.197 22704 22735 D cr_ChildProcLauncher: [ChildProcessLauncher.java:810] Setting up connection to process: slot=0
E68GC:  09-09 05:24:38.198 22704 22735 I cr_LibraryLoader: Using linker: org.chromium.base.library_loader.LegacyLinker
E68GC:  09-09 05:24:38.223 22704 22723 I OpenGLRenderer: Initialized EGL, version 1.4
E68GC:  09-09 05:24:38.225 22704 22723 D OpenGLRenderer: Enabling debug mode 0
E68GC:  09-09 05:24:38.229 22704 22723 I MaliEGL : [Mali]window_type=1, is_framebuffer=0, errnum = 0
E68GC:  09-09 05:24:38.229 22704 22723 I MaliEGL : [Mali]surface->num_buffers=4, surface->num_frames=3, win_min_undequeued=1
E68GC:  09-09 05:24:38.229 22704 22723 I MaliEGL : [Mali]max_allowed_dequeued_buffers=3
E68GC:  09-09 05:24:38.252   551   567 V WindowManager: Adding window Window{33869621 u0 SurfaceView} at 11 of 19 (before Window{2e1c86be u0 org.chromium.content_browsertests_apk/org.chromium.content_browsertests_apk.ContentBrowserTestsActivity})
E68GC:  09-09 05:24:38.264 22704 22704 W art     : Attempt to remove local handle scope entry from IRT, ignoring
E68GC:  09-09 05:24:38.289 22744 22744 I cr_ChildProcessService: Creating new ChildProcessService pid=22744
E68GC:  09-09 05:24:38.301 22744 22764 W linker  : lib_content_browsertests__library.so: unused DT entry: type 0x6ffffffe arg 0x259bc
E68GC:  09-09 05:24:38.301 22744 22764 W linker  : lib_content_browsertests__library.so: unused DT entry: type 0x6fffffff arg 0x3
E68GC:  09-09 05:24:38.316   551   577 I ActivityManager: Displayed org.chromium.content_browsertests_apk/.ContentBrowserTestsActivity: +1s94ms
E68GC:  09-09 05:24:38.317   551  1130 W InputMethodManagerService: Got RemoteException sending setActive(false) notification to pid 22311 uid 10090
E68GC:  09-09 05:24:38.329 22704 22704 D cr_ChildProcLauncher: [ChildProcessLauncher.java:848] on connect callback, pid=22744 context=-1215036648 callbackType=2
E68GC:  09-09 05:24:38.386 22704 22765 E libEGL  : validate_display:255 error 3008 (EGL_BAD_DISPLAY)
E68GC:  09-09 05:24:38.430 22704 22765 W VideoCapabilities: Unrecognized profile/level 32768/2 for video/mp4v-es
E68GC:  09-09 05:24:38.430 22704 22765 I VideoCapabilities: Unsupported profile 8 for video/mp4v-es
E68GC:  09-09 05:24:38.430 22704 22765 I VideoCapabilities: Unsupported profile 8 for video/mp4v-es
E68GC:  09-09 05:24:38.430 22704 22765 I VideoCapabilities: Unsupported profile 8 for video/mp4v-es
E68GC:  09-09 05:24:38.430 22704 22765 I VideoCapabilities: Unsupported profile 8 for video/mp4v-es
E68GC:  09-09 05:24:38.430 22704 22765 I VideoCapabilities: Unsupported profile 8 for video/mp4v-es
E68GC:  09-09 05:24:38.430 22704 22765 I VideoCapabilities: Unsupported profile 8 for video/mp4v-es
E68GC:  09-09 05:24:38.463 22744 22764 W linker  : libosmesa.so: unused DT entry: type 0x6ffffffe arg 0xa0c8
E68GC:  09-09 05:24:38.463 22744 22764 W linker  : libosmesa.so: unused DT entry: type 0x6fffffff arg 0x3
E68GC:  09-09 05:24:38.466 22744 22764 I cr_LibraryLoader: Time to load native libraries: 166 ms (timestamps 4973-5139)
E68GC:  09-09 05:24:38.466 22744 22764 I cr_LibraryLoader: Expected native library version number "", actual native library version number ""
E68GC:  09-09 05:24:38.467 22744 22764 I cr_LibraryLoader: Using linker: org.chromium.base.library_loader.LegacyLinker
E68GC:  09-09 05:24:38.467 22704 22765 I VideoCapabilities: Unsupported profile 4 for video/mp4v-es
E68GC:  09-09 05:24:38.468 22744 22764 W chromium: [0909/052438:WARNING:trace_config_file.cc(80)] The trace config file does not exist.
E68GC:  09-09 05:24:38.469 22744 22764 I chromium: [INFO:library_loader_hooks.cc(151)] Chromium logging enabled: level = 0, default verbosity = 0
E68GC:  09-09 05:24:38.484 22704 22765 I MaliEGL : [Mali]window_type=1, is_framebuffer=0, errnum = 0
E68GC:  09-09 05:24:38.484 22704 22765 I MaliEGL : [Mali]surface->num_buffers=4, surface->num_frames=3, win_min_undequeued=1
E68GC:  09-09 05:24:38.484 22704 22765 I MaliEGL : [Mali]max_allowed_dequeued_buffers=3
E68GC:  09-09 05:24:38.673 22704 22704 I cr_Ime  : ImeThread is enabled.
E68GC:  09-09 05:24:39.135   551   916 W libprocessgroup: failed to open /acct/uid_10090/pid_22744/cgroup.procs: No such file or directory
E68GC:  09-09 05:24:39.135   551   916 I ActivityManager: Process org.chromium.content_browsertests_apk:sandboxed_process0 (pid 22744) has died
E68GC:  09-09 05:24:39.136   551   916 W ActivityManager: Scheduling restart of crashed service org.chromium.content_browsertests_apk/org.chromium.content.app.SandboxedProcessService0 in 1000ms
E68GC:  09-09 05:24:39.163 22704 22704 W cr_ScreenOrientation: Removing an inexistent observer!
E68GC:  09-09 05:24:40.178 22775 22775 I art     : Late-enabling -Xcheck:jni
E68GC:  09-09 05:24:40.179   551   572 I ActivityManager: Start proc 22775:org.chromium.content_browsertests_apk:sandboxed_process0/u0i572 for service org.chromium.content_browsertests_apk/org.chromium.content.app.SandboxedProcessService0
E68GC:  09-09 05:24:40.184 22704 22704 I Choreographer: Skipped 59 frames!  The application may be doing too much work on its main thread.
E68GC:  09-09 05:24:40.188 22704 22704 W cr_ChildProcessConnect: onServiceDisconnected (crash or killed by oom): pid=22744
E68GC:  09-09 05:24:40.190 22291 22291 I Process : Sending signal. PID: 22704 SIG: 9
E68GC:  09-09 05:24:40.206   551  9886 I WindowState: WIN DEATH: Window{2e1c86be u0 org.chromium.content_browsertests_apk/org.chromium.content_browsertests_apk.ContentBrowserTestsActivity}
E68GC:  09-09 05:24:40.206   551  1127 D ConnectivityService: ConnectivityService NetworkRequestInfo binderDied(NetworkRequest [ id=790, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ], android.os.BinderProxy@32d004a0)
E68GC:  09-09 05:24:40.208   551   630 D ConnectivityService: releasing NetworkRequest NetworkRequest [ id=790, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ]
E68GC:  09-09 05:24:40.209   551   630 E ConnectivityService: RemoteException caught trying to send a callback msg for NetworkRequest [ id=790, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ]
E68GC:  09-09 05:24:40.224   551   636 I ActivityManager: Process org.chromium.content_browsertests_apk:test_process (pid 22704) has died
E68GC:  09-09 05:24:40.239 22291 22291 I cr_NativeTest: [INFO:test_support_android.cc(185)] MessagePumpForUIFactory already set, unable to override.
E68GC:  09-09 05:24:40.240 22291 22291 I cr_NativeTest: >>ScopedMainEntryLogger
E68GC:  09-09 05:24:40.242 22291 22291 I cr_NativeTest: Note: Google Test filter = DownloadContentTest.RecoverFromInitFileError
E68GC:  09-09 05:24:40.243 22291 22291 I cr_NativeTest: [==========] Running 1 test from 1 test case.
E68GC:  09-09 05:24:40.244 22291 22291 I cr_NativeTest: [----------] Global test environment set-up.
E68GC:  09-09 05:24:40.245 22291 22291 I cr_NativeTest: [----------] 1 test from DownloadContentTest, where TypeParam = 
E68GC:  09-09 05:24:40.248 22291 22291 I cr_NativeTest: [ RUN      ] DownloadContentTest.RecoverFromInitFileError




I think the only weird stuff I see in there is:
E68GC:  09-09 05:24:39.135   551   916 W libprocessgroup: failed to open /acct/uid_10090/pid_22744/cgroup.procs: No such file or directory
E68GC:  09-09 05:24:39.135   551   916 I ActivityManager: Process org.chromium.content_browsertests_apk:sandboxed_process0 (pid 22744) has died

any ideas on why this would happen?

Comment 1 by gsennton@chromium.org, Sep 9 2016

Labels: -Restrict-View-Google

Comment 2 by eseckler@chromium.org, Sep 12 2016 

Hmm, was trying to find those logs you pasted, instead I found the following from this build: https://build.chromium.org/p/chromium.android/builders/Lollipop%20Low-end%20Tester/builds/3927

C 6958.238s Main  [UNKNOWN] DevToolsProtocolTest.BrowserGetTargets:
C 6958.238s Main  [ RUN      ] DevToolsProtocolTest.BrowserGetTargets
C 6958.238s Main  [WARNING:dns_config_service_posix.cc(316)] Failed to read DnsConfig.
C 6958.238s Main  [ERROR:devtools_http_handler.cc(226)] Cannot start http server for devtools. Stop devtools.
C 6958.238s Main  
C 6958.238s Main  DevToolsProtocolTest.BrowserGetTargetsUNKNOWN

Seems like the devtools server can't be started b/c the DnsConfig service fails. Pavel, do you know if this could be the cause?

Comment 3 by gsennton@chromium.org, Sep 12 2016 

The logs I pasted are from the logcat dump of build #3978
(on the build page you can search for "logcat dump" and there should be a link with that name - for downloading the logcat output of the device).

Comment 4 by gsennton@chromium.org, Sep 12 2016 

If you look at the logs for build #3983 there is the following output:

C42GC:  09-10 05:36:32.868  1840  1840 I cr_NativeTest: Note: Google Test filter = DevToolsProtocolTest.BrowserGetTargets
C42GC:  09-10 05:36:32.870  1840  1840 I cr_NativeTest: [==========] Running 1 test from 1 test case.
C42GC:  09-10 05:36:32.871  1840  1840 I cr_NativeTest: [----------] Global test environment set-up.
C42GC:  09-10 05:36:32.872  1840  1840 I cr_NativeTest: [----------] 1 test from DevToolsProtocolTest, where TypeParam = 
C42GC:  09-10 05:36:32.873  1840  1840 I cr_NativeTest: [ RUN      ] DevToolsProtocolTest.BrowserGetTargets
C42GC:  09-10 05:36:32.874  1840  1840 I cr_NativeTest: [WARNING:dns_config_service_posix.cc(316)] Failed to read DnsConfig.
C42GC:  09-10 05:36:32.875  1840  1840 I cr_NativeTest: [ERROR:devtools_http_handler.cc(221)] Cannot start http server for devtools. Stop devtools.
C42GC:  09-10 05:36:32.876  1840  1840 I cr_NativeTest: referenceTable head length=54 1
C42GC:  09-10 05:36:32.877  1840  1840 I cr_NativeTest: [       OK ] DevToolsProtocolTest.BrowserGetTargets (972 ms)
C42GC:  09-10 05:36:32.878  1840  1840 I cr_NativeTest: [----------] 1 test from DevToolsProtocolTest (973 ms total)
C42GC:  09-10 05:36:32.881  1840  1840 I cr_NativeTest: [----------] Global test environment tear-down
C42GC:  09-10 05:36:32.882  1840  1840 I cr_NativeTest: [==========] 1 test from 1 test case ran. (973 ms total)
C42GC:  09-10 05:36:32.883  1840  1840 I cr_NativeTest: [  PASSED  ] 1 test.


so for that build the devtools don't matter :S

Comment 5 by cmasso@google.com, Feb 14 2018

Components: Platform>DevTools Tests>Flaky

Comment 6 by eostroukhov@chromium.org, Mar 19 2018

Owner: dgozman@chromium.org
Status: Assigned (was: Untriaged)

Comment 7 by pfeldman@chromium.org, Dec 5

Status: Archived (was: Assigned)
Test failures are processed as a part of a dedicated triage, bulk-closing the bugs.
►

Sign in to add a comment