New issue
Advanced search Search tips

Issue 736817 link

Starred by 1 user

Issue metadata

Status: Assigned
Owner:
Cc:
Components:
EstimatedDays: ----
NextAction: ----
OS: Android
Pri: 1
Type: Bug

Blocked on:
issue 704660



Sign in to add a comment

blink_perf.svg fails on Nexus 5x perf bot

Project Member Reported by rnep...@chromium.org, Jun 26 2017

Issue description

https://uberchromegw.corp.google.com/i/chromium.perf/builders/Android%20Nexus5X%20Perf?numbuilds=200

Several pages fail pretty consistently and a few more are flaky. This goes all the way back as far as history goes. I am going to disable the consistent failures on this bot, but dont know what else I can do. This may be related to the problems with blink_perf.layout on the same bot. crbug.com/704660


Traceback (most recent call last):
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/story_runner.py", line 100, in _RunStoryAndProcessErrorIfNeeded
    state.WillRunStory(story)
  File "/b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/page/shared_page_state.py", line 221, in WillRunStory
    self._StartBrowser(page)
  File "/b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/page/shared_page_state.py", line 180, in _StartBrowser
    self._browser = self._possible_browser.Create(self._finder_options)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_finder.py", line 132, in Create
    browser_backend, self._platform_backend, self._credentials_path)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 58, in __init__
    self._browser_backend.Start()
  File "/b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_backend.py", line 151, in Start
    self._WaitForBrowserToComeUp()
  File "/b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/chrome_browser_backend.py", line 157, in _WaitForBrowserToComeUp
    raise exceptions.BrowserConnectionGoneException(self.browser, e)
BrowserConnectionGoneException: Timed out while waiting 60s for HasBrowserFinishedLaunching.
Found Minidump: True
Stack Trace:
********************************************************************************
	UI dump
	- (no package):
	  - (no id)
	- org.chromium.chrome:
	  - (no id)
	  - android:id/content
	  - android:id/navigationBarBackground
	  - android:id/statusBarBackground
	  - org.chromium.chrome:id/action_bar_root
	  - org.chromium.chrome:id/fre_content_wrapper
	  - org.chromium.chrome:id/fre_image_and_content
	  - org.chromium.chrome:id/fre_main_layout
	  - org.chromium.chrome:id/fre_pager
	  - org.chromium.chrome:id/image
	  - org.chromium.chrome:id/send_report_checkbox['Help make Chrome better by sending usage statistics and crash reports to Google.']
	  - org.chromium.chrome:id/terms_accept['Accept & continue']
	  - org.chromium.chrome:id/title['Welcome to Chrome']
	  - org.chromium.chrome:id/tos_and_privacy[u'By using this application, you agree to Chrome\u2019s Terms of Service and Privacy Notice.']
	********************************************************************************
	Logcat
	--------- beginning of main
	06-26 13:04:23.167 26860 26860 E cr_BkgrdTaskJS: Tried finishing non-current BackgroundTask.
	06-26 13:04:24.634 26903 26903 D AndroidRuntime: >>>>>> START com.android.internal.os.RuntimeInit uid 0 <<<<<<
	06-26 13:04:24.639 26903 26903 D AndroidRuntime: CheckJNI is OFF
	06-26 13:04:24.674 26903 26903 D ICU     : No timezone override file found: /data/misc/zoneinfo/current/icu/icu_tzdata.dat
	06-26 13:04:24.711 26903 26903 I Radio-JNI: register_android_hardware_Radio DONE
	06-26 13:04:24.729 26903 26903 D AndroidRuntime: Calling main entry com.android.commands.am.Am
	--------- beginning of system
	06-26 13:04:24.732   909  3712 I ActivityManager: START u0 {dat=about:blank flg=0x10000000 cmp=org.chromium.chrome/com.google.android.apps.chrome.Main} from uid 0 on display 0
	06-26 13:04:24.758 26860 26860 I cr_InstantAppsHandler: Not handling with Instant Apps because Chrome is not default or there's a specialized handler
	06-26 13:04:24.767   909  3537 I ActivityManager: START u0 {cmp=org.chromium.chrome/.browser.firstrun.FirstRunActivity (has extras)} from uid 10085 on display 0
	06-26 13:04:24.828 26860 26921 I cr_LibraryLoader: Using linker: org.chromium.base.library_loader.ModernLinker
	06-26 13:04:24.829 26860 26920 W cr_ChildProcLH: Create a new ChildConnectionAllocator with package name = org.chromium.chrome, sandboxed = true
	06-26 13:04:24.834 26860 26919 W cr_VariationsSeedFetch: UnknownHostException fetching first run seed: 
	06-26 13:04:24.835 26860 26922 I cr_base : Extracting resource /data/user/0/org.chromium.chrome/app_chrome/paks/en-GB.pak@15ce4782f0e
	06-26 13:04:24.838 26860 26924 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: true
	06-26 13:04:24.840 26860 26922 I cr_base : Extracting resource /data/user/0/org.chromium.chrome/app_chrome/paks/en-US.pak@15ce4782f0e
	06-26 13:04:24.856 26860 26921 I cr_LibraryLoader: Loading chrome
	06-26 13:04:24.871   909  3539 I ActivityManager: Start proc 26925:org.chromium.chrome:sandboxed_process0/u0i16 for service org.chromium.chrome/org.chromium.content.app.SandboxedProcessService0
	06-26 13:04:24.889 26925 26925 W dboxed_process0: type=1400 audit(0.0:160): avc: denied { search } for name="tmp" dev="dm-2" ino=752194 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:shell_data_file:s0 tclass=dir permissive=0
	06-26 13:04:24.902 26925 26925 I cr_ChildProcessService: Creating new ChildProcessService pid=26925
	06-26 13:04:24.919 26860 26924 I Adreno  : QUALCOMM build                   : 63c06b2, I8366cd0437
	06-26 13:04:24.919 26860 26924 I Adreno  : Build Date                       : 10/21/15
	06-26 13:04:24.919 26860 26924 I Adreno  : OpenGL ES Shader Compiler Version: XE031.05.13.02
	06-26 13:04:24.919 26860 26924 I Adreno  : Local Branch                     : 
	06-26 13:04:24.919 26860 26924 I Adreno  : Remote Branch                    : quic/LA.BF64.1.2.9_v2
	06-26 13:04:24.919 26860 26924 I Adreno  : Remote Branch                    : NONE
	06-26 13:04:24.919 26860 26924 I Adreno  : Reconstruct Branch               : NOTHING
	06-26 13:04:24.954 26860 26924 I OpenGLRenderer: Initialized EGL, version 1.4
	06-26 13:04:25.002 26860 26921 I cr_LibraryLoader: Time to load native libraries: 174 ms (timestamps 5280-5454)
	06-26 13:04:25.002 26860 26921 I chromium: [INFO:library_loader_hooks.cc(144)] Chromium logging enabled: level = 0, default verbosity = 0
	06-26 13:04:25.003 26860 26921 I cr_LibraryLoader: Expected native library version number "61.0.3142.0", actual native library version number "61.0.3142.0"
	06-26 13:04:25.089   909   928 I ActivityManager: Displayed org.chromium.chrome/.browser.firstrun.FirstRunActivity: +316ms (total +347ms)
	06-26 13:04:25.091 26903 26903 D AndroidRuntime: Shutting down VM
	06-26 13:04:25.096  3504  3504 I Keyboard.Facilitator: onFinishInput()
	06-26 13:04:25.107 26860 26860 I cr_BrowserStartup: Initializing chromium process, singleProcess=false
	06-26 13:04:25.140 26860 26942 W chromium: [WARNING:dns_config_service_posix.cc(326)] Failed to read DnsConfig.
	06-26 13:04:25.207 26860 26860 W GooglePlayServicesUtil: Google Play services out of date.  Requires 10298000 but found 8186448
	06-26 13:04:25.208   909  3539 I ActivityManager: Start proc 26960:org.chromium.chrome:privileged_process0/u0a85 for service org.chromium.chrome/org.chromium.content.app.PrivilegedProcessService0
	06-26 13:04:25.220 26860 26860 W GooglePlayServicesUtil: Google Play services out of date.  Requires 10298000 but found 8186448
	06-26 13:04:25.220 26860 26860 I cr_SnippetsLauncher: Disabling SnippetsLauncher because Play Services is not up to date.
	06-26 13:04:25.226   909  3735 W BackupManagerService: dataChanged but no participant pkg='org.chromium.chrome' uid=10085
	06-26 13:04:25.240 26960 26960 I cr_CommandLineInitUtil: Initializing command line from alternative file /data/local/tmp/chrome-command-line
	06-26 13:04:25.245 26960 26960 I cr_ChildProcessService: Creating new ChildProcessService pid=26960
	06-26 13:04:25.248   909  3712 D ConnectivityService: listenForNetwork for Listen from uid/pid:10085/26860 for NetworkRequest [ id=38, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ]
	06-26 13:04:25.251 26860 26860 W GooglePlayServicesUtil: Google Play services out of date.  Requires 10298000 but found 8186448
	06-26 13:04:25.251 26860 26860 I cr_BgSyncLauncher: Disabling Background Sync because Play Services is not up to date.
	06-26 13:04:25.252   909   920 W BackupManagerService: dataChanged but no participant pkg='org.chromium.chrome' uid=10085
	06-26 13:04:25.258   909  3735 D ConnectivityService: listenForNetwork for Listen from uid/pid:10085/26860 for NetworkRequest [ id=39, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ]
	06-26 13:04:25.262 26960 26973 I cr_LibraryLoader: Using linker: org.chromium.base.library_loader.ModernLinker
	06-26 13:04:25.282 26960 26977 I cr_LibraryLoader: Loading chrome
	06-26 13:04:25.314 26960 26977 I cr_LibraryLoader: Time to load native libraries: 51 ms (timestamps 5716-5767)
	06-26 13:04:25.315 26960 26977 I chromium: [INFO:library_loader_hooks.cc(144)] Chromium logging enabled: level = 0, default verbosity = 0
	06-26 13:04:25.315 26960 26977 I cr_LibraryLoader: Expected native library version number "61.0.3142.0", actual native library version number "61.0.3142.0"
	06-26 13:04:25.327 26960 26977 E libEGL  : validate_display:255 error 3008 (EGL_BAD_DISPLAY)
	06-26 13:04:25.327 26960 26977 I Adreno  : QUALCOMM build                   : 63c06b2, I8366cd0437
	06-26 13:04:25.327 26960 26977 I Adreno  : Build Date                       : 10/21/15
	06-26 13:04:25.327 26960 26977 I Adreno  : OpenGL ES Shader Compiler Version: XE031.05.13.02
	06-26 13:04:25.327 26960 26977 I Adreno  : Local Branch                     : 
	06-26 13:04:25.327 26960 26977 I Adreno  : Remote Branch                    : quic/LA.BF64.1.2.9_v2
	06-26 13:04:25.327 26960 26977 I Adreno  : Remote Branch                    : NONE
	06-26 13:04:25.327 26960 26977 I Adreno  : Reconstruct Branch               : NOTHING
	06-26 13:04:25.357 26860 26860 W GooglePlayServicesUtil: Google Play services out of date.  Requires 10298000 but found 8186448
	06-26 13:04:25.366 26960 26977 W VideoCapabilities: Unrecognized profile 2130706433 for video/avc
	06-26 13:04:25.381 26960 26977 I VideoCapabilities: Unsupported profile 4 for video/mp4v-es
	06-26 13:04:26.049   574   574 E QCALOG  : [MessageQ] ProcessNewMessage: [LOWI-SERVER] unknown deliver target [OS-Agent]
	06-26 13:05:25.137  3504 21150 I Keyboard.Facilitator.LanguageModelFlusher: run()
	06-26 13:05:25.138  3504 21150 I Keyboard.Facilitator: flushDynamicLanguageModels()
	06-26 13:05:25.154  3779  3779 I ConfigService: onCreate
	06-26 13:05:26.050   574   574 E QCALOG  : [MessageQ] ProcessNewMessage: [LOWI-SERVER] unknown deliver target [OS-Agent]
	06-26 13:05:30.218  3779  3779 I ConfigService: onDestroy
	06-26 13:05:31.953 26995 26995 D AndroidRuntime: >>>>>> START com.android.internal.os.RuntimeInit uid 0 <<<<<<
	06-26 13:05:31.959 26995 26995 D AndroidRuntime: CheckJNI is OFF
	06-26 13:05:31.996 26995 26995 D ICU     : No timezone override file found: /data/misc/zoneinfo/current/icu/icu_tzdata.dat
	06-26 13:05:32.038 26995 26995 I Radio-JNI: register_android_hardware_Radio DONE
	06-26 13:05:32.056 26995 26995 D AndroidRuntime: Calling main entry com.android.commands.uiautomator.Launcher
	06-26 13:05:33.097 26995 26995 W AccessibilityNodeInfoDumper: Fetch time: 3ms
	06-26 13:05:33.098   909   920 W WindowManager: Attempted to remove non-existing token: android.os.Binder@be72926
	06-26 13:05:33.120 26995 26995 D AndroidRuntime: Shutting down VM
	********************************************************************************
	Stack from Logcat
	Reading native crash info from stdin
	Unknown Android release, consider passing --packed-lib.
	Reading Android symbols from: /b/swarming/w/ir
	Searching for Chrome symbols from within: /b/swarming/w/ir/out/Release/lib.unstripped:/b/swarming/w/ir/out/Release/lib:/b/swarming/w/ir/out/Release
	
	********************************************************************************
********************************************************************************
Standard output:
********************************************************************************
	Cannot get standard output on Android
********************************************************************************
System log:
(Not implemented)
(INFO) 2017-06-26 13:05:41,105 cmd_helper._ValidateAndLogCommand:158  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01e2d69f26a8408e shell '( log -p i -t Telemetry '"'"'END SvgCubics.html'"'"' );echo %$?'
(INFO) 2017-06-26 13:05:41,205 cmd_helper._ValidateAndLogCommand:158  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/forwarder_host --adb=/b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb --serial-id=01e2d69f26a8408e --unmap 38962
[  FAILED  ] SvgCubics.html (79502 ms)
 
Blockedon: 704660
Labels: Performance-Sheriff-BotHealth
Cc: nedngu...@google.com
Failure rates for the last 10 runs. I am going to disable all but cowboy on this platform.

Debian: 4
FlowerFromMyGarden: 9
HarveyRayner: 10
SvgCubics: 9
SvgNestedUse: 9
WorldCup: 10
CrawFishGanson: 4
Cowboy_transform: 1

56

220:
* Debian.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html
 
219:
* CrawFishGanson.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html

218:
* Debian.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgNestedUse.html
* Worldcup.html

217:
* Cowboy_transform.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* Worldcup.html

216:
* Debian.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html

215:
* CrawFishGanson.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html

214:
* CrawFishGanson.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html

213:
* Debian.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html

212:
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html

211:
* CrawFishGanson.html
* FlowerFromMyGarden.html
* HarveyRayner.html
* SvgCubics.html
* SvgNestedUse.html
* Worldcup.html
Owner: kouhei@chromium.org
Add Kouhei@ as listed in benchmark owner.
Project Member

Comment 4 by bugdroid1@chromium.org, Jun 26 2017

The following revision refers to this bug:
  https://chromium.googlesource.com/chromium/src.git/+/6d56c2338b488e333e54aedc2f7fd6bee789ac78

commit 6d56c2338b488e333e54aedc2f7fd6bee789ac78
Author: rnephew <rnephew@chromium.org>
Date: Mon Jun 26 21:29:39 2017

[Telemetry] Disable blink_perf.svg failing stories on Nexus 5x.

Bug: 736817
Change-Id: I276cff41a61c1943b9777c96343a0538c6e4bd29
Reviewed-on: https://chromium-review.googlesource.com/549019
Reviewed-by: Ned Nguyen <nednguyen@google.com>
Commit-Queue: rnephew <rnephew@chromium.org>
Cr-Commit-Position: refs/heads/master@{#482409}
[modify] https://crrev.com/6d56c2338b488e333e54aedc2f7fd6bee789ac78/tools/perf/benchmarks/blink_perf.py

Components: Test>Android
Owner: ----
The error message here implies a problem with Browser start up. Correct me if I'm wrong.

_WaitForBrowserToComeUp
    raise exceptions.BrowserConnectionGoneException(self.browser, e)
BrowserConnectionGoneException: Timed out while waiting 60s for HasBrowserFinishedLaunching.

There is nothing in the test, as far as I know, that would prevent the browser from starting, although this log line is interesting:
06-26 13:04:25.327 26960 26977 E libEGL  : validate_display:255 error 3008 (EGL_BAD_DISPLAY)

Owner: kouhei@chromium.org
Status: Assigned (was: Untriaged)
Reassign to kouhei@ to try reenabling & probably investigating failure

Sign in to add a comment