Closed
Bug 1902573
Opened 1 year ago
Closed 1 year ago
Intermittent details-summary/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: tszentpeteri [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=462306275&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/QR7m7HnNTNemzKd5VR6piA/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/QR7m7HnNTNemzKd5VR6piA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2024-06-14T02:26:56.472Z] 02:26:56 INFO - REFTEST TEST-END | layout/reftests/details-summary/move-position-absolute-summary-to-different-details.html == layout/reftests/details-summary/move-position-absolute-summary-to-different-details-ref.html
[task 2024-06-14T02:26:56.497Z] 02:26:56 INFO - REFTEST INFO | Slowest test took 354ms (file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/details-summary/overflow-auto-open-details.html)
[task 2024-06-14T02:26:56.497Z] 02:26:56 INFO - REFTEST INFO | Total canvas count = 7
[task 2024-06-14T02:26:56.946Z] 02:26:56 INFO - 1718332016945 Marionette TRACE Received observer notification quit-application
[task 2024-06-14T02:26:56.946Z] 02:26:56 INFO - 1718332016945 Marionette INFO Stopped listening on port 2828
[task 2024-06-14T02:26:56.947Z] 02:26:56 INFO - 1718332016945 Marionette DEBUG Marionette stopped listening
[task 2024-06-14T02:26:57.524Z] 02:26:57 INFO - REFTEST INFO | Process mode: e10s
[task 2024-06-14T02:26:57.525Z] 02:26:57 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2024-06-14T02:26:57.539Z] 02:26:57 INFO - REFTEST INFO | Running tests in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/filters/css-filters/reftest.list
[task 2024-06-14T02:26:57.547Z] 02:26:57 INFO - REFTEST INFO | Running with e10s: True
[task 2024-06-14T02:26:57.547Z] 02:26:57 INFO - REFTEST INFO | Running with fission: True
[task 2024-06-14T02:26:57.548Z] 02:26:57 INFO - REFTEST INFO | Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -profile /tmp/tmptr59puzc.mozrunner
[task 2024-06-14T02:26:58.032Z] 02:26:58 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-06-14T02:29:57.608Z] 02:29:57 INFO - REFTEST TEST-UNEXPECTED-FAIL | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/details-summary/reftest.list | application terminated with exit code 127
[task 2024-06-14T02:29:57.686Z] 02:29:57 INFO - Traceback (most recent call last):
[task 2024-06-14T02:29:57.686Z] 02:29:57 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1193, in <module>
[task 2024-06-14T02:29:57.687Z] 02:29:57 INFO - sys.exit(run_test_harness(parser, options))
[task 2024-06-14T02:29:57.687Z] 02:29:57 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1185, in run_test_harness
[task 2024-06-14T02:29:57.688Z] 02:29:57 INFO - result = reftest.runTests(options.tests, options)
[task 2024-06-14T02:29:57.688Z] 02:29:57 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 704, in runTests
[task 2024-06-14T02:29:57.689Z] 02:29:57 INFO - return self.runSerialTests(manifests, options, cmdargs)
[task 2024-06-14T02:29:57.689Z] 02:29:57 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1127, in runSerialTests
[task 2024-06-14T02:29:57.690Z] 02:29:57 INFO - status = run(tests=tests)
[task 2024-06-14T02:29:57.690Z] 02:29:57 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1069, in run
[task 2024-06-14T02:29:57.691Z] 02:29:57 INFO - status = self.runApp(
[task 2024-06-14T02:29:57.691Z] 02:29:57 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 1015, in runApp
[task 2024-06-14T02:29:57.692Z] 02:29:57 INFO - raise reraise(exc, value, tb)
[task 2024-06-14T02:29:57.692Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/six.py", line 696, in reraise
[task 2024-06-14T02:29:57.692Z] 02:29:57 INFO - raise value
[task 2024-06-14T02:29:57.693Z] 02:29:57 INFO - File "/builds/worker/workspace/build/tests/reftest/runreftest.py", line 954, in runApp
[task 2024-06-14T02:29:57.693Z] 02:29:57 INFO - marionette.start_session()
[task 2024-06-14T02:29:57.694Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/decorators.py", line 34, in _
[task 2024-06-14T02:29:57.694Z] 02:29:57 INFO - m._handle_socket_failure()
[task 2024-06-14T02:29:57.695Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 820, in _handle_socket_failure
[task 2024-06-14T02:29:57.695Z] 02:29:57 INFO - reraise(exc_cls, exc, tb)
[task 2024-06-14T02:29:57.695Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/six.py", line 696, in reraise
[task 2024-06-14T02:29:57.696Z] 02:29:57 INFO - raise value
[task 2024-06-14T02:29:57.696Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/decorators.py", line 24, in _
[task 2024-06-14T02:29:57.696Z] 02:29:57 INFO - return func(*args, **kwargs)
[task 2024-06-14T02:29:57.697Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 1368, in start_session
[task 2024-06-14T02:29:57.697Z] 02:29:57 INFO - self.raise_for_port(timeout=timeout)
[task 2024-06-14T02:29:57.697Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 744, in raise_for_port
[task 2024-06-14T02:29:57.698Z] 02:29:57 INFO - raise socket.timeout(
[task 2024-06-14T02:29:57.698Z] 02:29:57 INFO - socket.timeout: Timed out waiting for connection on 127.0.0.1:2828!
[task 2024-06-14T02:29:57.711Z] 02:29:57 INFO - Exception ignored in: <function BaseProfile.__del__ at 0x7ff5ecdc9b80>
[task 2024-06-14T02:29:57.712Z] 02:29:57 INFO - Traceback (most recent call last):
[task 2024-06-14T02:29:57.713Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozprofile/profile.py", line 84, in __del__
[task 2024-06-14T02:29:57.713Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozprofile/profile.py", line 294, in cleanup
[task 2024-06-14T02:29:57.714Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozprofile/profile.py", line 92, in cleanup
[task 2024-06-14T02:29:57.714Z] 02:29:57 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/mozfile/mozfile.py", line 248, in remove
[task 2024-06-14T02:29:57.715Z] 02:29:57 INFO - ImportError: sys.meta_path is None, Python is likely shutting down
[task 2024-06-14T02:29:57.731Z] 02:29:57 INFO - Return code: 1
[task 2024-06-14T02:29:57.731Z] 02:29:57 ERROR - No suite end message was emitted by this harness.
[task 2024-06-14T02:29:57.732Z] 02:29:57 INFO - TinderboxPrint: reftest-reftest<br/>3625/0/0
[task 2024-06-14T02:29:57.732Z] 02:29:57 WARNING - setting return code to 2
[task 2024-06-14T02:29:57.732Z] 02:29:57 INFO - The reftest suite: reftest ran with return status: FAILURE
[task 2024-06-14T02:29:57.733Z] 02:29:57 INFO - Running post-action listener: _package_coverage_data
[task 2024-06-14T02:29:57.733Z] 02:29:57 INFO - Running post-action listener: _resource_record_post_action
[task 2024-06-14T02:29:57.733Z] 02:29:57 INFO - Running post-action listener: process_java_coverage_data
[task 2024-06-14T02:29:57.734Z] 02:29:57 INFO - [mozharness: 2024-06-14 02:29:57.733248Z] Finished run-tests step (success)
[task 2024-06-14T02:29:57.734Z] 02:29:57 INFO - [mozharness: 2024-06-14 02:29:57.733298Z] Running uninstall step.
[task 2024-06-14T02:29:57.734Z] 02:29:57 INFO - Running pre-action listener: _resource_record_pre_action
[task 2024-06-14T02:29:57.735Z] 02:29:57 INFO - Running main action method: uninstall
[task 2024-06-14T02:29:57.736Z] 02:29:57 INFO - Skipping uninstall for non-MSIX test
[task 2024-06-14T02:29:57.736Z] 02:29:57 INFO - Running post-action listener: _resource_record_post_action
[task 2024-06-14T02:29:57.736Z] 02:29:57 INFO - [mozharness: 2024-06-14 02:29:57.733635Z] Finished uninstall step (success)
[task 2024-06-14T02:29:57.736Z] 02:29:57 INFO - Running post-run listener: _resource_record_post_run
[task 2024-06-14T02:29:57.955Z] 02:29:57 INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2024-06-14T02:29:57.958Z] 02:29:57 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "reftest.reftest.1.overall", "extraOptions": ["e10s", "taskcluster-projects/887720501152/machineTypes/n2-standard-2"], "subtests": [{"name": "cpu_percent", "value": 61.27058823529439}, {"name": "io_write_bytes", "value": 780140544}, {"name": "io.read_bytes", "value": 5509120}, {"name": "io_write_time", "value": 323088}, {"name": "io_read_time", "value": 2496}]}, {"name": "reftest.reftest.1.start-pulseaudio", "subtests": [{"name": "time", "value": 0.02242336400001932}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.reftest.1.install", "subtests": [{"name": "time", "value": 10.95958405600004}, {"name": "cpu_percent", "value": 50.368981481481484}]}, {"name": "reftest.reftest.1.stage-files", "subtests": [{"name": "time", "value": 0.0006597839999926691}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.reftest.1.run-tests", "subtests": [{"name": "time", "value": 691.044027871}, {"name": "cpu_percent", "value": 61.44188250614985}]}, {"name": "reftest.reftest.1.uninstall", "subtests": [{"name": "time", "value": 0.00026501600018491445}, {"name": "cpu_percent", "value": 0}]}]}
[task 2024-06-14T02:29:57.958Z] 02:29:57 INFO - Total resource usage - Wall time: 702s; CPU: Can't collect data; Read bytes: 5509120; Write bytes: 780140544; Read time: 2496; Write time: 323088
[task 2024-06-14T02:29:57.959Z] 02:29:57 INFO - TinderboxPrint: I/O read bytes / time<br/>5,509,120 / 2,496
[task 2024-06-14T02:29:57.959Z] 02:29:57 INFO - TinderboxPrint: I/O write bytes / time<br/>780,140,544 / 323,088
[task 2024-06-14T02:29:57.959Z] 02:29:57 INFO - TinderboxPrint: CPU idle<br/>525.4 (37.7%)
[task 2024-06-14T02:29:57.959Z] 02:29:57 INFO - TinderboxPrint: CPU iowait<br/>17.1 (1.2%)
[task 2024-06-14T02:29:57.960Z] 02:29:57 INFO - TinderboxPrint: CPU system<br/>83.6 (6.0%)
[task 2024-06-14T02:29:57.960Z] 02:29:57 INFO - TinderboxPrint: CPU user<br/>764.3 (54.9%)
[task 2024-06-14T02:29:57.960Z] 02:29:57 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2024-06-14T02:29:57.961Z] 02:29:57 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-06-14T02:29:57.961Z] 02:29:57 INFO - install - Wall time: 11s; CPU: 50%; Read bytes: 0; Write bytes: 17453056; Read time: 0; Write time: 5840
[task 2024-06-14T02:29:57.962Z] 02:29:57 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-06-14T02:29:57.983Z] 02:29:57 INFO - run-tests - Wall time: 691s; CPU: 61%; Read bytes: 5509120; Write bytes: 762687488; Read time: 2496; Write time: 317248
[task 2024-06-14T02:29:57.986Z] 02:29:57 INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-06-14T02:29:58.882Z] 02:29:58 WARNING - returning nonzero exit status 2
[task 2024-06-14T02:29:58.933Z] cleanup
[task 2024-06-14T02:29:58.933Z] + cleanup
[task 2024-06-14T02:29:58.933Z] + local rv=2
[task 2024-06-14T02:29:58.933Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2024-06-14T02:29:58.934Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2024-06-14T02:29:59.030Z] + '[' ']'
[task 2024-06-14T02:29:59.030Z] + true
[task 2024-06-14T02:29:59.031Z] + cleanup_xvfb
[task 2024-06-14T02:29:59.031Z] ++ pidof Xvfb
[task 2024-06-14T02:29:59.038Z] + local xvfb_pid=48
[task 2024-06-14T02:29:59.038Z] + local vnc=false
[task 2024-06-14T02:29:59.038Z] + local interactive=false
[task 2024-06-14T02:29:59.038Z] + '[' -n 48 ']'
[task 2024-06-14T02:29:59.038Z] + [[ false == false ]]
[task 2024-06-14T02:29:59.038Z] + [[ false == false ]]
[task 2024-06-14T02:29:59.038Z] + kill 48
[task 2024-06-14T02:29:59.038Z] + screen -XS xvfb quit
[task 2024-06-14T02:29:59.079Z] No screen session found.
[task 2024-06-14T02:29:59.079Z] + true
[task 2024-06-14T02:29:59.080Z] + exit 2
[taskcluster 2024-06-14 02:30:00.089Z] === Task Finished ===
[taskcluster 2024-06-14 02:30:01.549Z] Unsuccessful task run with exit code: 2 completed in 1092.474 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
•