Closed
Bug 1897236
Opened 1 year ago
Closed 1 year ago
Intermittent dom/reftest.list | application terminated with exit code 127
Categories
(Core :: Graphics: WebRender, defect, P5)
Core
Graphics: WebRender
Tracking
()
RESOLVED
DUPLICATE
of bug 1819763
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=458480918&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/a2VrnP8cS2WcRoCPVF0WUg/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/a2VrnP8cS2WcRoCPVF0WUg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2024-05-16T16:12:05.532Z] 16:12:05 INFO - REFTEST TEST-PASS | layout/reftests/dom/multipleappendwitheditable.xhtml == layout/reftests/dom/multipleappendwitheditable-ref.xhtml | image comparison, max difference: 0, number of differing pixels: 0
[task 2024-05-16T16:12:05.534Z] 16:12:05 INFO - REFTEST TEST-END | layout/reftests/dom/multipleappendwitheditable.xhtml == layout/reftests/dom/multipleappendwitheditable-ref.xhtml
[task 2024-05-16T16:12:05.622Z] 16:12:05 INFO - REFTEST INFO | Slowest test took 725ms (file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/dom/appendsingle.html)
[task 2024-05-16T16:12:05.623Z] 16:12:05 INFO - REFTEST INFO | Total canvas count = 2
[task 2024-05-16T16:12:09.711Z] 16:12:09 INFO - 1715875929710 Marionette TRACE Received observer notification quit-application
[task 2024-05-16T16:12:09.713Z] 16:12:09 INFO - 1715875929711 Marionette INFO Stopped listening on port 2828
[task 2024-05-16T16:12:09.718Z] 16:12:09 INFO - 1715875929717 Marionette DEBUG Marionette stopped listening
[task 2024-05-16T16:12:13.838Z] 16:12:13 INFO - REFTEST INFO | Process mode: e10s
[task 2024-05-16T16:12:13.838Z] 16:12:13 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2024-05-16T16:12:13.852Z] 16:12:13 INFO - REFTEST INFO | Running tests in file:///builds/worker/workspace/build/tests/reftest/tests/image/test/reftest/bmp/bmp-24bpp/reftest.list
[task 2024-05-16T16:12:13.862Z] 16:12:13 INFO - REFTEST INFO | Running with e10s: True
[task 2024-05-16T16:12:13.862Z] 16:12:13 INFO - REFTEST INFO | Running with fission: True
[task 2024-05-16T16:12:13.862Z] 16:12:13 INFO - REFTEST INFO | INFO | runtests.py | TSan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2024-05-16T16:12:13.862Z] 16:12:13 INFO - REFTEST INFO | Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -profile /tmp/tmpxujl0xa4.mozrunner
[task 2024-05-16T16:12:16.665Z] 16:12:16 INFO - Inconsistency detected by ld.so: ../elf/dl-tls.c: 481: _dl_allocate_tls_init: Assertion `listp->slotinfo[cnt].gen <= GL(dl_tls_generation)' failed!
[task 2024-05-16T16:15:13.921Z] 16:15:13 INFO - REFTEST TEST-UNEXPECTED-FAIL | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/dom/reftest.list | application terminated with exit code 127
[task 2024-05-16T16:15:14.073Z] 16:15:14 INFO - Traceback (most recent call last):
[task 2024-05-16T16:15:14.075Z] 16:15:14 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1193, in <module>
[task 2024-05-16T16:15:14.076Z] 16:15:14 INFO - sys.exit(run_test_harness(parser, options))
[task 2024-05-16T16:15:14.078Z] 16:15:14 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1185, in run_test_harness
[task 2024-05-16T16:15:14.080Z] 16:15:14 INFO - result = reftest.runTests(options.tests, options)
[task 2024-05-16T16:15:14.081Z] 16:15:14 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 704, in runTests
[task 2024-05-16T16:15:14.082Z] 16:15:14 INFO - return self.runSerialTests(manifests, options, cmdargs)
[task 2024-05-16T16:15:14.086Z] 16:15:14 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1127, in runSerialTests
[task 2024-05-16T16:15:14.087Z] 16:15:14 INFO - status = run(tests=tests)
[task 2024-05-16T16:15:14.088Z] 16:15:14 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1069, in run
[task 2024-05-16T16:15:14.089Z] 16:15:14 INFO - status = self.runApp(
[task 2024-05-16T16:15:14.090Z] 16:15:14 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1015, in runApp
[task 2024-05-16T16:15:14.091Z] 16:15:14 INFO - raise reraise(exc, value, tb)
[task 2024-05-16T16:15:14.092Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/six.py", line 696, in reraise
[task 2024-05-16T16:15:14.092Z] 16:15:14 INFO - raise value
[task 2024-05-16T16:15:14.093Z] 16:15:14 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 954, in runApp
[task 2024-05-16T16:15:14.094Z] 16:15:14 INFO - marionette.start_session()
[task 2024-05-16T16:15:14.095Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/decorators.py", line 34, in _
[task 2024-05-16T16:15:14.096Z] 16:15:14 INFO - m._handle_socket_failure()
[task 2024-05-16T16:15:14.096Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 820, in _handle_socket_failure
[task 2024-05-16T16:15:14.097Z] 16:15:14 INFO - reraise(exc_cls, exc, tb)
[task 2024-05-16T16:15:14.098Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/six.py", line 696, in reraise
[task 2024-05-16T16:15:14.098Z] 16:15:14 INFO - raise value
[task 2024-05-16T16:15:14.099Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/decorators.py", line 24, in _
[task 2024-05-16T16:15:14.100Z] 16:15:14 INFO - return func(*args, **kwargs)
[task 2024-05-16T16:15:14.101Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 1368, in start_session
[task 2024-05-16T16:15:14.101Z] 16:15:14 INFO - self.raise_for_port(timeout=timeout)
[task 2024-05-16T16:15:14.102Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 744, in raise_for_port
[task 2024-05-16T16:15:14.103Z] 16:15:14 INFO - raise socket.timeout(
[task 2024-05-16T16:15:14.103Z] 16:15:14 INFO - socket.timeout: Timed out waiting for connection on 127.0.0.1:2828!
[task 2024-05-16T16:15:14.108Z] 16:15:14 INFO - Exception ignored in: <function BaseProfile.__del__ at 0x7fcf6d16d040>
[task 2024-05-16T16:15:14.110Z] 16:15:14 INFO - Traceback (most recent call last):
[task 2024-05-16T16:15:14.110Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozprofile/profile.py", line 84, in __del__
[task 2024-05-16T16:15:14.111Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozprofile/profile.py", line 294, in cleanup
[task 2024-05-16T16:15:14.112Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozprofile/profile.py", line 92, in cleanup
[task 2024-05-16T16:15:14.113Z] 16:15:14 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozfile/mozfile.py", line 248, in remove
[task 2024-05-16T16:15:14.114Z] 16:15:14 INFO - ImportError: sys.meta_path is None, Python is likely shutting down
[task 2024-05-16T16:15:14.129Z] 16:15:14 INFO - Return code: 1
[task 2024-05-16T16:15:14.131Z] 16:15:14 ERROR - No suite end message was emitted by this harness.
[task 2024-05-16T16:15:14.132Z] 16:15:14 INFO - TinderboxPrint: reftest-reftest<br/>1373/0/0
[task 2024-05-16T16:15:14.132Z] 16:15:14 WARNING - setting return code to 2
[task 2024-05-16T16:15:14.133Z] 16:15:14 INFO - The reftest suite: reftest ran with return status: FAILURE
[task 2024-05-16T16:15:14.134Z] 16:15:14 INFO - Running post-action listener: _package_coverage_data
[task 2024-05-16T16:15:14.135Z] 16:15:14 INFO - Running post-action listener: _resource_record_post_action
[task 2024-05-16T16:15:14.136Z] 16:15:14 INFO - Running post-action listener: process_java_coverage_data
[task 2024-05-16T16:15:14.136Z] 16:15:14 INFO - [mozharness: 2024-05-16 16:15:14.130588Z] Finished run-tests step (success)
[task 2024-05-16T16:15:14.137Z] 16:15:14 INFO - [mozharness: 2024-05-16 16:15:14.130638Z] Running uninstall step.
[task 2024-05-16T16:15:14.138Z] 16:15:14 INFO - Running pre-action listener: _resource_record_pre_action
[task 2024-05-16T16:15:14.139Z] 16:15:14 INFO - Running main action method: uninstall
[task 2024-05-16T16:15:14.139Z] 16:15:14 INFO - Skipping uninstall for non-MSIX test
[task 2024-05-16T16:15:14.140Z] 16:15:14 INFO - Running post-action listener: _resource_record_post_action
[task 2024-05-16T16:15:14.141Z] 16:15:14 INFO - [mozharness: 2024-05-16 16:15:14.130877Z] Finished uninstall step (success)
[task 2024-05-16T16:15:14.142Z] 16:15:14 INFO - Running post-run listener: _resource_record_post_run
[task 2024-05-16T16:15:14.553Z] 16:15:14 INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2024-05-16T16:15:14.557Z] 16:15:14 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "reftest.reftest.5.overall", "extraOptions": ["e10s", "taskcluster-projects/887720501152/machineTypes/n2-standard-2"], "subtests": [{"name": "cpu_percent", "value": 68.31136502832692}, {"name": "io_write_bytes", "value": 1578250240}, {"name": "io.read_bytes", "value": 35176448}, {"name": "io_write_time", "value": 1248924}, {"name": "io_read_time", "value": 7852}]}, {"name": "reftest.reftest.5.start-pulseaudio", "subtests": [{"name": "time", "value": 0.04043013999944378}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.reftest.5.install", "subtests": [{"name": "time", "value": 76.33053558900065}, {"name": "cpu_percent", "value": 50.561876640419946}]}, {"name": "reftest.reftest.5.stage-files", "subtests": [{"name": "time", "value": 0.0013516589988284977}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.reftest.5.run-tests", "subtests": [{"name": "time", "value": 1229.5814476679989}, {"name": "cpu_percent", "value": 69.41271751504354}]}, {"name": "reftest.reftest.5.uninstall", "subtests": [{"name": "time", "value": 0.00012972600052307826}, {"name": "cpu_percent", "value": 0}]}]}
[task 2024-05-16T16:15:14.558Z] 16:15:14 INFO - Total resource usage - Wall time: 1306s; CPU: Can't collect data; Read bytes: 35176448; Write bytes: 1578250240; Read time: 7852; Write time: 1248924
[task 2024-05-16T16:15:14.559Z] 16:15:14 INFO - TinderboxPrint: I/O read bytes / time<br/>35,176,448 / 7,852
[task 2024-05-16T16:15:14.560Z] 16:15:14 INFO - TinderboxPrint: I/O write bytes / time<br/>1,578,250,240 / 1,248,924
[task 2024-05-16T16:15:14.561Z] 16:15:14 INFO - TinderboxPrint: CPU idle<br/>789.9 (30.4%)
[task 2024-05-16T16:15:14.562Z] 16:15:14 INFO - TinderboxPrint: CPU iowait<br/>33.6 (1.3%)
[task 2024-05-16T16:15:14.562Z] 16:15:14 INFO - TinderboxPrint: CPU system<br/>141.4 (5.4%)
[task 2024-05-16T16:15:14.563Z] 16:15:14 INFO - TinderboxPrint: CPU user<br/>1,633.4 (62.8%)
[task 2024-05-16T16:15:14.564Z] 16:15:14 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2024-05-16T16:15:14.564Z] 16:15:14 INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-05-16T16:15:14.567Z] 16:15:14 INFO - install - Wall time: 76s; CPU: 51%; Read bytes: 24576; Write bytes: 1042571264; Read time: 832; Write time: 1019464
[task 2024-05-16T16:15:14.569Z] 16:15:14 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-05-16T16:15:14.611Z] 16:15:14 INFO - run-tests - Wall time: 1230s; CPU: 69%; Read bytes: 35151872; Write bytes: 524652544; Read time: 7020; Write time: 216108
[task 2024-05-16T16:15:14.619Z] 16:15:14 INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-05-16T16:15:16.406Z] 16:15:16 WARNING - returning nonzero exit status 2
[task 2024-05-16T16:15:16.557Z] cleanup
[task 2024-05-16T16:15:16.558Z] + cleanup
[task 2024-05-16T16:15:16.558Z] + local rv=2
[task 2024-05-16T16:15:16.558Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2024-05-16T16:15:16.558Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2024-05-16T16:15:16.561Z] + '[' ']'
[task 2024-05-16T16:15:16.561Z] + true
[task 2024-05-16T16:15:16.561Z] + cleanup_xvfb
[task 2024-05-16T16:15:16.562Z] ++ pidof Xvfb
[task 2024-05-16T16:15:16.568Z] + local xvfb_pid=48
[task 2024-05-16T16:15:16.568Z] + local vnc=false
[task 2024-05-16T16:15:16.568Z] + local interactive=false
[task 2024-05-16T16:15:16.568Z] + '[' -n 48 ']'
[task 2024-05-16T16:15:16.568Z] + [[ false == false ]]
[task 2024-05-16T16:15:16.568Z] + [[ false == false ]]
[task 2024-05-16T16:15:16.568Z] + kill 48
[task 2024-05-16T16:15:16.593Z] + screen -XS xvfb quit
[task 2024-05-16T16:15:16.593Z] No screen session found.
[task 2024-05-16T16:15:16.595Z] + true
[task 2024-05-16T16:15:16.596Z] + exit 2
[taskcluster 2024-05-16 16:15:17.163Z] === Task Finished ===
[taskcluster 2024-05-16 16:15:18.577Z] Unsuccessful task run with exit code: 2 completed in 1399.837 seconds
| Comment hidden (Intermittent Failures Robot) |
Comment 2•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•