Closed Bug 1677503 Opened 3 years ago Closed 3 years ago

Perma on Linux/Mac Exception: Browsertime failed to run

Categories

(Testing :: Raptor, defect, P5)

defect

Tracking

(firefox84 fixed, firefox85 fixed)

RESOLVED FIXED
85 Branch
Tracking Status
firefox84 --- fixed
firefox85 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: sparky)

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell disable-recommended])

Attachments

(1 file)

Filed by: rmaries [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=321901810&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/bhmsGIIDRvSbnuhpOLsReQ/runs/0/artifacts/public/logs/live_backing.log


[task 2020-11-16T12:45:52.848Z] 12:45:52     INFO -  Exception in thread ProcessReader:
[task 2020-11-16T12:45:52.848Z] 12:45:52    ERROR -  Traceback (most recent call last):
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -    File "/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/threading.py", line 801, in __bootstrap_inner
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -      self.run()
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -    File "/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/threading.py", line 754, in run
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -      self.__target(*self.__args, **self.__kwargs)
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -    File "/Users/cltbld/tasks/task_1605530455/build/venv/lib/python2.7/site-packages/mozprocess/processhandler.py", line 1265, in _read
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -      callback(line.rstrip())
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -    File "/Users/cltbld/tasks/task_1605530455/build/venv/lib/python2.7/site-packages/mozprocess/processhandler.py", line 1171, in __call__
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -      e(*args, **kwargs)
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -    File "/Users/cltbld/tasks/task_1605530455/build/tests/raptor/raptor/browsertime/base.py", line 412, in _line_handler
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -      raise Exception("Browsertime failed to run")
[task 2020-11-16T12:45:52.849Z] 12:45:52     INFO -  Exception: Browsertime failed to run
[task 2020-11-16T13:45:53.882Z] 13:45:53     INFO - Automation Error: mozprocess timed out after 3600 seconds running ['/Users/cltbld/tasks/task_1605530455/build/venv/bin/python', u'/Users/cltbld/tasks/task_1605530455/build/tests/raptor/raptor/raptor.py', u'--chimera', u'--enable-webrender', u'--browsertime-node', '/Users/cltbld/tasks/task_1605530455/fetches/node/bin/node', u'--browsertime-browsertimejs', '/Users/cltbld/tasks/task_1605530455/fetches/browsertime/node_modules/browsertime/bin/browsertime.js', u'--browsertime-chromedriver', '/Users/cltbld/tasks/task_1605530455/fetches/{}chromedriver', u'--browsertime-ffmpeg', '/Users/cltbld/tasks/task_1605530455/fetches/ffmpeg-4.1.1-macos64-static/bin/ffmpeg', u'--browsertime-geckodriver', '/Users/cltbld/tasks/task_1605530455/fetches/geckodriver', u'--browsertime-video', u'--browsertime', u'--binary', '/Users/cltbld/tasks/task_1605530455/build/application/Firefox Nightly.app/Contents/MacOS/firefox', u'--symbolsPath', u'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/eXEj7DyiSjqhAqtuuGGVuA/artifacts/public/build/target.crashreporter-symbols.zip', u'--app', 'firefox', u'--conditioned-profile-scenario', u'settled', u'--host', u'127.0.0.1', u'--test', 'pinterest', u'--log-tbpl-level=debug']
[task 2020-11-16T13:45:53.923Z] 13:45:53    ERROR - timed out after 3600 seconds of no output
[task 2020-11-16T13:45:53.923Z] 13:45:53    ERROR - Return code: -9
[task 2020-11-16T13:45:53.923Z] 13:45:53  WARNING - setting return code to -9
[task 2020-11-16T13:45:53.923Z] 13:45:53     INFO - Copying Raptor results to upload dir:
[task 2020-11-16T13:45:53.923Z] 13:45:53     INFO - /Users/cltbld/tasks/task_1605530455/build/blobber_upload_dir/perfherder-data.json
[task 2020-11-16T13:45:53.923Z] 13:45:53     INFO - Copying raptor results from /Users/cltbld/tasks/task_1605530455/build/raptor.json to /Users/cltbld/tasks/task_1605530455/build/blobber_upload_dir/perfherder-data.json
[task 2020-11-16T13:45:53.924Z] 13:45:53 CRITICAL - Error copying results /Users/cltbld/tasks/task_1605530455/build/raptor.json to upload dir /Users/cltbld/tasks/task_1605530455/build/blobber_upload_dir/perfherder-data.json
[task 2020-11-16T13:45:53.924Z] 13:45:53     INFO - [Errno 2] No such file or directory: u'/Users/cltbld/tasks/task_1605530455/build/raptor.json'
[task 2020-11-16T13:45:53.924Z] 13:45:53     INFO - Running post-action listener: _package_coverage_data
[task 2020-11-16T13:45:53.924Z] 13:45:53     INFO - Running post-action listener: _resource_record_post_action
[task 2020-11-16T13:45:53.924Z] 13:45:53     INFO - Running post-action listener: process_java_coverage_data
[task 2020-11-16T13:45:53.924Z] 13:45:53     INFO - Running post-action listener: stop_device
[task 2020-11-16T13:45:53.924Z] 13:45:53     INFO - [mozharness: 2020-11-16 13:45:53.924842Z] Finished run-tests step (success)
[task 2020-11-16T13:45:53.924Z] 13:45:53     INFO - Running post-run listener: _resource_record_post_run
[task 2020-11-16T13:45:54.137Z] 13:45:54     INFO - Total resource usage - Wall time: 3821s; CPU: 4.0%; Read bytes: 577458176; Write bytes: 8906216960; Read time: 8603; Write time: 50345
[task 2020-11-16T13:45:54.138Z] 13:45:54     INFO - TinderboxPrint: CPU usage<br/>3.8%
[task 2020-11-16T13:45:54.138Z] 13:45:54     INFO - TinderboxPrint: I/O read bytes / time<br/>577,458,176 / 8,603
[task 2020-11-16T13:45:54.138Z] 13:45:54     INFO - TinderboxPrint: I/O write bytes / time<br/>8,906,216,960 / 50,345
[task 2020-11-16T13:45:54.138Z] 13:45:54     INFO - TinderboxPrint: CPU idle<br/>14,462.8 (94.6%)
[task 2020-11-16T13:45:54.138Z] 13:45:54     INFO - TinderboxPrint: CPU system<br/>306.9 (2.0%)
[task 2020-11-16T13:45:54.138Z] 13:45:54     INFO - TinderboxPrint: CPU user<br/>514.2 (3.4%)
[task 2020-11-16T13:45:54.138Z] 13:45:54     INFO - TinderboxPrint: Swap in / out<br/>808,411,136 / 0
[task 2020-11-16T13:45:54.140Z] 13:45:54     INFO - install-chromium-distribution - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2020-11-16T13:45:54.143Z] 13:45:54     INFO - install - Wall time: 31s; CPU: 38.0%; Read bytes: 459191808; Write bytes: 448659456; Read time: 26702; Write time: 726
[task 2020-11-16T13:45:54.170Z] 13:45:54     INFO - run-tests - Wall time: 3791s; CPU: 4.0%; Read bytes: 561389568; Write bytes: 8455935488; Read time: 8434; Write time: 49601
[task 2020-11-16T13:45:54.840Z] 13:45:54  WARNING - returning nonzero exit status -9
[taskcluster 2020-11-16T13:45:54.875Z]    Exit Code: 247
[taskcluster 2020-11-16T13:45:54.875Z]    User Time: 2m1.938614s
[taskcluster 2020-11-16T13:45:54.875Z]  Kernel Time: 39.690582s
[taskcluster 2020-11-16T13:45:54.875Z]    Wall Time: 1h4m57.622243838s
[taskcluster 2020-11-16T13:45:54.875Z]       Result: FAILED
[taskcluster 2020-11-16T13:45:54.875Z] === Task Finished ===
[taskcluster 2020-11-16T13:45:54.875Z] Task Duration: 1h4m57.62590473s
[taskcluster 2020-11-16T13:45:55.000Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2021-11-16T10:21:06.162Z
[taskcluster 2020-11-16T13:45:55.477Z] Uploading artifact public/test_info/mitmproxy.log from file build/blobber_upload_dir/mitmproxy.log with content encoding "gzip", mime type "text/plain" and expiry 2021-11-16T10:21:06.162Z
[taskcluster 2020-11-16T13:45:55.663Z] Uploading artifact public/test_info/resource-usage.json from file build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2021-11-16T10:21:06.162Z
[taskcluster:error] exit status 247```

Greg, could you take a look?

Flags: needinfo?(gmierz2)
Summary: Perma Exception: Browsertime failed to run → Perma on Linux/Mac Exception: Browsertime failed to run
Assignee: nobody → gmierz2
Status: NEW → ASSIGNED
Pushed by archaeopteryx@coole-files.de:
https://hg.mozilla.org/integration/autoland/rev/ba7406e33c13
Disable conditioned profiles for desktop. r=aryx DONTBUILD
Flags: needinfo?(gmierz2)
Status: ASSIGNED → RESOLVED
Closed: 3 years ago
Resolution: --- → FIXED
Target Milestone: --- → 85 Branch

Comment on attachment 9188064 [details]
Bug 1677503 - Disable conditioned profiles for desktop. r?aryx

Beta/Release Uplift Approval Request

  • User impact if declined: No user impact.
  • Is this code covered by automated tests?: No
  • Has the fix been verified in Nightly?: Yes
  • Needs manual test from QE?: No
  • If yes, steps to reproduce:
  • List of other uplifts needed: None
  • Risk to taking this patch: Low
  • Why is the change risky/not risky? (and alternatives if risky): This patch only disables the conditioned profiles used in the browsertime performance tests so there is no risk to users.
  • String changes made/needed:
Attachment #9188064 - Flags: approval-mozilla-beta?

Comment on attachment 9188064 [details]
Bug 1677503 - Disable conditioned profiles for desktop. r?aryx

Approved for 84.0b3.

Attachment #9188064 - Flags: approval-mozilla-beta? → approval-mozilla-beta+
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: