1787312 - Intermittent layout/base/crashtests/1746989.html | application timed out after 370 seconds with no output

Status: RESOLVED INCOMPLETE

(Core :: Layout, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ccozmuta [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=388494093&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/C0-6ZL0TR9SU_IelXSNs0Q/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/C0-6ZL0TR9SU_IelXSNs0Q/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2022-08-25T19:30:47.619Z] 19:30:47     INFO - REFTEST TEST-START | layout/base/crashtests/1746989.html
[task 2022-08-25T19:30:47.628Z] 19:30:47     INFO - REFTEST INFO | SET PREFERENCE pref(layout.accessiblecaret.enabled,true)
[task 2022-08-25T19:30:47.629Z] 19:30:47     INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/base/crashtests/1746989.html | 54 / 123 (43%)
[task 2022-08-25T19:36:57.844Z] 19:36:57    ERROR - REFTEST ERROR | layout/base/crashtests/1746989.html | application timed out after 370 seconds with no output
[task 2022-08-25T19:36:57.845Z] 19:36:57    ERROR - REFTEST ERROR | Force-terminating active process(es).
[task 2022-08-25T19:36:57.847Z] 19:36:57     INFO - REFTEST TEST-INFO | started process screentopng
[task 2022-08-25T19:36:58.235Z] 19:36:58     INFO - REFTEST TEST-INFO | screentopng: exit 0
[task 2022-08-25T19:36:58.235Z] 19:36:58     INFO - REFTEST INFO | Can't trigger Breakpad, just killing process
[task 2022-08-25T19:36:58.394Z] 19:36:58    ERROR - TEST-UNEXPECTED-FAIL | layout/base/crashtests/1746989.html | application terminated with exit code -15
[task 2022-08-25T19:36:58.418Z] 19:36:58     INFO - REFTEST INFO | Process mode: e10s
[task 2022-08-25T19:36:58.419Z] 19:36:58  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-08-25T19:36:58.460Z] 19:36:58    ERROR - Return code: 241
[task 2022-08-25T19:36:58.462Z] 19:36:58    ERROR - No suite end message was emitted by this harness.
[task 2022-08-25T19:36:58.463Z] 19:36:58     INFO - TinderboxPrint: reftest-crashtest<br/>108/0/0
[task 2022-08-25T19:36:58.463Z] 19:36:58    ERROR - # TBPL FAILURE #
[task 2022-08-25T19:36:58.463Z] 19:36:58  WARNING - setting return code to 2
[task 2022-08-25T19:36:58.464Z] 19:36:58    ERROR - The reftest suite: crashtest ran with return status: FAILURE
[task 2022-08-25T19:36:58.464Z] 19:36:58     INFO - Running post-action listener: _package_coverage_data
[task 2022-08-25T19:36:58.465Z] 19:36:58     INFO - Running post-action listener: _resource_record_post_action
[task 2022-08-25T19:36:58.466Z] 19:36:58     INFO - Running post-action listener: process_java_coverage_data
[task 2022-08-25T19:36:58.467Z] 19:36:58     INFO - [mozharness: 2022-08-25 19:36:58.462979Z] Finished run-tests step (success)
[task 2022-08-25T19:36:58.467Z] 19:36:58     INFO - Running post-run listener: _resource_record_post_run
[task 2022-08-25T19:36:58.531Z] 19:36:58     INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2022-08-25T19:36:58.536Z] 19:36:58     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "reftest.crashtest.17.overall", "extraOptions": ["e10s", "taskcluster-projects/887720501152/machineTypes/n2-standard-2"], "subtests": [{"name": "cpu_percent", "value": 58.01201716738194}, {"name": "io_write_bytes", "value": 2219577344}, {"name": "io.read_bytes", "value": 36696064}, {"name": "io_write_time", "value": 1036836}, {"name": "io_read_time", "value": 592}]}, {"name": "reftest.crashtest.17.start-pulseaudio", "subtests": [{"name": "time", "value": 0.03775215148925781}]}, {"name": "reftest.crashtest.17.install", "subtests": [{"name": "time", "value": 36.36626720428467}, {"name": "cpu_percent", "value": 50.73}]}, {"name": "reftest.crashtest.17.stage-files", "subtests": [{"name": "time", "value": 0.0005347728729248047}]}, {"name": "reftest.crashtest.17.run-tests", "subtests": [{"name": "time", "value": 431.1713140010834}, {"name": "cpu_percent", "value": 58.61013986013986}]}]}
[task 2022-08-25T19:36:58.537Z] 19:36:58     INFO - Total resource usage - Wall time: 467s; CPU: 59%; Read bytes: 36696064; Write bytes: 2219577344; Read time: 592; Write time: 1036836
[task 2022-08-25T19:36:58.537Z] 19:36:58     INFO - TinderboxPrint: CPU usage<br/>58.6%
[task 2022-08-25T19:36:58.538Z] 19:36:58     INFO - TinderboxPrint: I/O read bytes / time<br/>36,696,064 / 592
[task 2022-08-25T19:36:58.539Z] 19:36:58     INFO - TinderboxPrint: I/O write bytes / time<br/>2,219,577,344 / 1,036,836
[task 2022-08-25T19:36:58.539Z] 19:36:58     INFO - TinderboxPrint: CPU idle<br/>389.5 (41.8%)
[task 2022-08-25T19:36:58.539Z] 19:36:58     INFO - TinderboxPrint: CPU system<br/>16.5 (1.8%)
[task 2022-08-25T19:36:58.540Z] 19:36:58     INFO - TinderboxPrint: CPU user<br/>524.4 (56.3%)
[task 2022-08-25T19:36:58.540Z] 19:36:58     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2022-08-25T19:36:58.540Z] 19:36:58     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2022-08-25T19:36:58.541Z] 19:36:58     INFO - install - Wall time: 36s; CPU: 51%; Read bytes: 237568; Write bytes: 1825026048; Read time: 200; Write time: 806836
[task 2022-08-25T19:36:58.541Z] 19:36:58     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2022-08-25T19:36:58.542Z] 19:36:58     INFO - run-tests - Wall time: 431s; CPU: 59%; Read bytes: 8138752; Write bytes: 304820224; Read time: 112; Write time: 21120
[task 2022-08-25T19:36:58.594Z] 19:36:58  WARNING - returning nonzero exit status 2

Comment 1

[Intermittent Failures Robot]

1 failures in 3293 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1787312&startday=2022-08-22&endday=2022-08-28&tree=all

Comment 2

[Intermittent Failures Robot]

1 failures in 3537 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1787312&startday=2022-08-29&endday=2022-09-04&tree=all

Comment 3

[Intermittent Failures Robot]

1 failures in 3023 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1787312&startday=2022-09-12&endday=2022-09-18&tree=all

Comment 4

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.