Closed Bug 1543892 Opened 6 years ago Closed 6 years ago

Intermittent The reftest suite: reftest-no-accel ran with return status: FAILURE

Categories

(Testing :: Reftest, defect, P5)

Version 3
defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

#[markdown(off)]
Filed by: csabou [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=239837505&repo=autoland

https://queue.taskcluster.net/v1/task/L10oktMISiadl16hQdfP0A/runs/0/artifacts/public/logs/live_backing.log

https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://queue.taskcluster.net/v1/task/L10oktMISiadl16hQdfP0A/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

03:38:54 INFO - 'WINDOWS_TRACING_FLAGS': '3',
03:38:54 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log'}
03:38:54 INFO - Calling ['Z:\\task_1555034416\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_1555034416\\build\\tests\\reftest\\runreftest.py', '--total-chunks', '4', '--this-chunk', '1', '--appname=Z:\\task_1555034416\\build\\application\\firefox\\firefox.exe', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=Z:\\task_1555034416\\build\\symbols', '--log-raw=Z:\\task_1555034416\\build\\blobber_upload_dir\\reftest-no-accel_raw.log', '--log-errorsummary=Z:\\task_1555034416\\build\\blobber_upload_dir\\reftest-no-accel_errorsummary.log', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=Z:\\task_1555034416\\build', '--log-raw=-', '--suite=reftest', '--setpref=layers.acceleration.disabled=true', '--', 'tests/reftest/tests/layout/reftests/reftest.list'] with output_timeout 1000
03:38:54 INFO - REFTEST INFO | Running with e10s: True
03:38:54 INFO - REFTEST INFO | Application command: Z:\task_1555034416\build\application\firefox\firefox.exe -marionette --wait-for-browser -profile c:\users\task_1555034416\appdata\local\temp\tmpdu_mqr.mozrunner
03:41:54 ERROR - TEST-UNEXPECTED-FAIL | None | application terminated with exit code 3221225477
03:41:54 INFO - Traceback (most recent call last):
03:41:54 INFO - File "Z:\task_1555034416\build\tests\reftest\runreftest.py", line 985, in <module>
03:41:54 INFO - sys.exit(run_test_harness(parser, options))
03:41:54 INFO - File "Z:\task_1555034416\build\tests\reftest\runreftest.py", line 977, in run_test_harness
03:41:54 INFO - result = reftest.runTests(options.tests, options)
03:41:54 INFO - File "Z:\task_1555034416\build\tests\reftest\runreftest.py", line 577, in runTests
03:41:54 INFO - return self.runSerialTests(manifests, options, cmdargs)
03:41:54 INFO - File "Z:\task_1555034416\build\tests\reftest\runreftest.py", line 913, in runSerialTests
03:41:54 INFO - tests = self.getActiveTests(manifests, options)
03:41:54 INFO - File "Z:\task_1555034416\build\tests\reftest\runreftest.py", line 851, in getActiveTests
03:41:54 INFO - self.runApp(options, cmdargs=cmdargs, prefs=prefs)
03:41:54 INFO - File "Z:\task_1555034416\build\tests\reftest\runreftest.py", line 801, in runApp
03:41:55 INFO - marionette.start_session()
03:41:55 INFO - File "Z:\task_1555034416\build\venv\lib\site-packages\marionette_driver\decorators.py", line 36, in _
03:41:55 INFO - m._handle_socket_failure()
03:41:55 INFO - File "Z:\task_1555034416\build\venv\lib\site-packages\marionette_driver\marionette.py", line 650, in _handle_socket_failure
03:41:55 INFO - reraise(exc, val, tb)
03:41:55 INFO - File "Z:\task_1555034416\build\venv\lib\site-packages\marionette_driver\decorators.py", line 26, in _
03:41:55 INFO - return func(*args, **kwargs)
03:41:55 INFO - File "Z:\task_1555034416\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1108, in start_session
03:41:55 INFO - self.raise_for_port(timeout=timeout)
03:41:55 INFO - File "Z:\task_1555034416\build\venv\lib\site-packages\marionette_driver\marionette.py", line 569, in raise_for_port
03:41:55 INFO - self.host, self.port))
03:41:55 INFO - socket.timeout: Timed out waiting for connection on 127.0.0.1:2828!
03:41:55 ERROR - Return code: 1
03:41:55 ERROR - No checks run.
03:41:55 ERROR - No suite end message was emitted by this harness.
03:41:55 INFO - TinderboxPrint: reftest-reftest-no-accel<br/><em class="testfail">T-FAIL</em>
03:41:55 ERROR - # TBPL FAILURE #
03:41:55 WARNING - setting return code to 2
03:41:55 ERROR - The reftest suite: reftest-no-accel ran with return status: FAILURE
03:41:55 INFO - Running post-action listener: _package_coverage_data
03:41:55 INFO - Running post-action listener: _resource_record_post_action
03:41:55 INFO - Running post-action listener: process_java_coverage_data
03:41:55 INFO - [mozharness: 2019-04-12 03:41:55.045000Z] Finished run-tests step (success)
03:41:55 INFO - Running post-run listener: _resource_record_post_run
03:41:55 INFO - Validating Perfherder data against Z:\task_1555034416\mozharness\external_tools\performance-artifact-schema.json
03:41:55 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 1.3166230366492166}, {"name": "io_write_bytes", "value": 265049088}, {"name": "io.read_bytes", "value": 60282880}, {"name": "io_write_time", "value": 2}, {"name": "io_read_time", "value": 2}], "extraOptions": ["e10s", "taskcluster-g2.2xlarge"], "name": "reftest.reftest-no-accel.reftest-no-accel.1.overall"}, {"subtests": [{"name": "time", "value": 4.628999948501587}, {"name": "cpu_percent", "value": 10.8875}], "name": "reftest.reftest-no-accel.reftest-no-accel.1.install"}, {"subtests": [{"name": "time", "value": 0.0}], "name": "reftest.reftest-no-accel.reftest-no-accel.1.stage-files"}, {"subtests": [{"name": "time", "value": 187.94599986076355}, {"name": "cpu_percent", "value": 1.0685483870967756}], "name": "reftest.reftest-no-accel.reftest-no-accel.1.run-tests"}]}
03:41:55 INFO - Total resource usage - Wall time: 192s; CPU: 1.0%; Read bytes: 60282880; Write bytes: 265049088; Read time: 2; Write time: 2
03:41:55 INFO - TinderboxPrint: CPU usage<br/>1.1%
03:41:55 INFO - TinderboxPrint: I/O read bytes / time<br/>60,282,880 / 2
03:41:55 INFO - TinderboxPrint: I/O write bytes / time<br/>265,049,088 / 2
03:41:55 INFO - TinderboxPrint: CPU idle<br/>1,517.2 (98.7%)
03:41:55 INFO - install - Wall time: 5s; CPU: 11.0%; Read bytes: 0; Write bytes: 159362560; Read time: 0; Write time: 0
03:41:55 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
03:41:55 INFO - run-tests - Wall time: 188s; CPU: 1.0%; Read bytes: 60118528; Write bytes: 29039616; Read time: 2; Write time: 1
03:41:55 WARNING - returning nonzero exit status 2
[taskcluster 2019-04-12T03:41:55.303Z] Exit Code: 2
[taskcluster 2019-04-12T03:41:55.303Z] User Time: 0s
[taskcluster 2019-04-12T03:41:55.303Z] Kernel Time: 15.6001ms
[taskcluster 2019-04-12T03:41:55.303Z] Wall Time: 15m3.6363546s
[taskcluster 2019-04-12T03:41:55.303Z] Result: FAILED
[taskcluster 2019-04-12T03:41:55.303Z] === Task Finished ===
[taskcluster 2019-04-12T03:41:55.303Z] Task Duration: 15m3.640355s
[taskcluster 2019-04-12T03:41:55.855Z] Uploading artifact public/logs/localconfig.json from file logs\localconfig.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2020-04-11T02:37:55.991Z
[taskcluster 2019-04-12T03:41:56.297Z] Uploading artifact public/test_info/reftest-no-accel_errorsummary.log from file build\blobber_upload_dir\reftest-no-accel_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2020-04-11T02:37:55.991Z
[taskcluster 2019-04-12T03:41:56.693Z] Uploading artifact public/test_info/reftest-no-accel_raw.log from file build\blobber_upload_dir\reftest-no-accel_raw.log with content encoding "gzip", mime type "text/plain" and expiry 2020-04-11T02:37:55.991Z
[taskcluster 2019-04-12T03:41:57.048Z] Uploading artifact public/test_info/resource-usage.json from file build\blobber_upload_dir\resource-usage.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2020-04-11T02:37:55.991Z
[taskcluster 2019-04-12T03:41:57.477Z] Uploading artifact public/test_info/system-info.log from file build\blobber_upload_dir\system-info.log with content encoding "gzip", mime type "text/plain" and expiry 2020-04-11T02:37:55.991Z
[taskcluster 2019-04-12T03:41:58.066Z] Uploading redirect artifact public/logs/live.log to URL https://queue.taskcluster.net/v1/task/L10oktMISiadl16hQdfP0A/runs/0/artifacts/public/logs/live_backing.log with mime type "text/plain; charset=utf-8" and expiry 2020-04-11T02:37:55.991Z
[taskcluster:error] exit status 2

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 6 years ago6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.