1730538 - Intermittent displaylist_mutate | Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]

Status: REOPENED

(Testing :: Talos, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2021-09-13T16:26:03.262Z] 16:26:03     INFO -  TEST-INFO | started process 1696 (C:\Users\task_1631548846\build\application\firefox\firefox -wait-for-browser -no-deelevate -profile C:\Users\task_1631548846\AppData\Local\Temp\tmpgw5iuvyd\profile)
[task 2021-09-13T16:26:08.901Z] 16:26:08     INFO -  PID 1696 | Cycle 1(1): loaded http://127.0.0.1:49868/tests/layout/benchmarks/displaylist_mutate.html (next: http://127.0.0.1:49868/tests/layout/benchmarks/displaylist_inactive_mutate.html)
[task 2021-09-13T16:26:09.473Z] 16:26:09     INFO -  PID 1696 |
[task 2021-09-13T16:26:09.473Z] 16:26:09     INFO -  PID 1696 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-09-13T16:26:09.474Z] 16:26:09     INFO -  PID 1696 |
[task 2021-09-13T16:26:09.474Z] 16:26:09     INFO -  PID 1696 |
[task 2021-09-13T16:26:09.474Z] 16:26:09     INFO -  PID 1696 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-09-13T16:26:09.474Z] 16:26:09     INFO -  PID 1696 |
[task 2021-09-13T16:26:09.474Z] 16:26:09     INFO -  PID 1696 |
[task 2021-09-13T16:26:09.475Z] 16:26:09     INFO -  PID 1696 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv
[task 2021-09-13T16:26:09.475Z] 16:26:09     INFO -  PID 1696 |
[task 2021-09-13T16:26:09.492Z] 16:26:09     INFO -  PID 1696 | Exiting due to channel error.
[task 2021-09-13T16:26:09.525Z] 16:26:09     INFO -  TEST-INFO | 1696: exit 1
[task 2021-09-13T16:26:09.570Z] 16:26:09     INFO -  mozcrash checking C:\Users\task_1631548846\AppData\Local\Temp\tmpgw5iuvyd\profile\minidumps for minidumps...
[task 2021-09-13T16:26:09.571Z] 16:26:09     INFO -  TEST-UNEXPECTED-ERROR | displaylist_mutate | Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
[task 2021-09-13T16:26:09.571Z] 16:26:09    ERROR -  Traceback (most recent call last):
[task 2021-09-13T16:26:09.571Z] 16:26:09     INFO -    File "C:\Users\task_1631548846\build\tests\talos\talos\run_tests.py", line 336, in run_tests
[task 2021-09-13T16:26:09.571Z] 16:26:09     INFO -      talos_results.add(mytest.runTest(browser_config, test))
[task 2021-09-13T16:26:09.572Z] 16:26:09     INFO -    File "C:\Users\task_1631548846\build\tests\talos\talos\ttest.py", line 65, in runTest
[task 2021-09-13T16:26:09.572Z] 16:26:09     INFO -      return self._runTest(browser_config, test_config, setup)
[task 2021-09-13T16:26:09.572Z] 16:26:09     INFO -    File "C:\Users\task_1631548846\build\tests\talos\talos\ttest.py", line 274, in _runTest
[task 2021-09-13T16:26:09.572Z] 16:26:09     INFO -      counter_management.results() if counter_management else None
[task 2021-09-13T16:26:09.573Z] 16:26:09     INFO -    File "C:\Users\task_1631548846\build\tests\talos\talos\results.py", line 95, in add
[task 2021-09-13T16:26:09.573Z] 16:26:09     INFO -      global_counters=self.global_counters,
[task 2021-09-13T16:26:09.573Z] 16:26:09     INFO -    File "C:\Users\task_1631548846\build\tests\talos\talos\results.py", line 346, in __init__
[task 2021-09-13T16:26:09.573Z] 16:26:09     INFO -      self.parse()
[task 2021-09-13T16:26:09.574Z] 16:26:09     INFO -    File "C:\Users\task_1631548846\build\tests\talos\talos\results.py", line 373, in parse
[task 2021-09-13T16:26:09.574Z] 16:26:09     INFO -      "Could not find report in browser output: %s" % self.report_tokens
[task 2021-09-13T16:26:09.575Z] 16:26:09     INFO -    File "C:\Users\task_1631548846\build\tests\talos\talos\results.py", line 357, in error
[task 2021-09-13T16:26:09.575Z] 16:26:09     INFO -      raise utils.TalosError(message)
[task 2021-09-13T16:26:09.575Z] 16:26:09     INFO -  talos.utils.TalosError: Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
[task 2021-09-13T16:26:09.576Z] 16:26:09     INFO -  TEST-INFO took 9649ms
[task 2021-09-13T16:26:09.576Z] 16:26:09     INFO -  SUITE-END | took 9s
[task 2021-09-13T16:26:10.006Z] 16:26:10    ERROR - Return code: 2
[task 2021-09-13T16:26:10.006Z] 16:26:10  WARNING - setting return code to 2
[task 2021-09-13T16:26:10.006Z] 16:26:10    ERROR - # TBPL FAILURE #
[task 2021-09-13T16:26:10.006Z] 16:26:10     INFO - Running post-action listener: _package_coverage_data
[task 2021-09-13T16:26:10.006Z] 16:26:10     INFO - Running post-action listener: _resource_record_post_action
[task 2021-09-13T16:26:10.007Z] 16:26:10     INFO - Running post-action listener: process_java_coverage_data
[task 2021-09-13T16:26:10.007Z] 16:26:10     INFO - [mozharness: 2021-09-13 16:26:10.007396Z] Finished run-tests step (success)
[task 2021-09-13T16:26:10.007Z] 16:26:10     INFO - Running post-run listener: _resource_record_post_run
[task 2021-09-13T16:26:10.092Z] 16:26:10     INFO - Total resource usage - Wall time: 12s; CPU: 47%; Read bytes: 444454912; Write bytes: 224899072; Read time: 9; Write time: 2
[task 2021-09-13T16:26:10.092Z] 16:26:10     INFO - TinderboxPrint: CPU usage<br/>46.6%
[task 2021-09-13T16:26:10.092Z] 16:26:10     INFO - TinderboxPrint: I/O read bytes / time<br/>444,454,912 / 9
[task 2021-09-13T16:26:10.092Z] 16:26:10     INFO - TinderboxPrint: I/O write bytes / time<br/>224,899,072 / 2
[task 2021-09-13T16:26:10.092Z] 16:26:10     INFO - TinderboxPrint: CPU idle<br/>51.3 (53.3%)
[task 2021-09-13T16:26:10.092Z] 16:26:10     INFO - TinderboxPrint: CPU system<br/>13.8 (14.4%)
[task 2021-09-13T16:26:10.093Z] 16:26:10     INFO - TinderboxPrint: CPU user<br/>30.8 (32.0%)
[task 2021-09-13T16:26:10.093Z] 16:26:10     INFO - install - Wall time: 2s; CPU: 14%; Read bytes: 2298880; Write bytes: 4026368; Read time: 0; Write time: 0
[task 2021-09-13T16:26:10.093Z] 16:26:10     INFO - run-tests - Wall time: 11s; CPU: 58%; Read bytes: 441660416; Write bytes: 102367232; Read time: 9; Write time: 2
[task 2021-09-13T16:26:10.098Z] 16:26:10  WARNING - returning nonzero exit status 2
[taskcluster 2021-09-13T16:26:10.138Z]    Exit Code: 2
[taskcluster 2021-09-13T16:26:10.138Z]    User Time: 0s
[taskcluster 2021-09-13T16:26:10.138Z]  Kernel Time: 15.625ms
[taskcluster 2021-09-13T16:26:10.138Z]    Wall Time: 1m9.5010675s
[taskcluster 2021-09-13T16:26:10.138Z]       Result: FAILED
[taskcluster 2021-09-13T16:26:10.138Z] === Task Finished ===
[taskcluster 2021-09-13T16:26:10.138Z] Task Duration: 1m9.5010675s
[taskcluster 2021-09-13T16:26:10.200Z] Uploading artifact public/logs/localconfig.json from file logs\localconfig.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2022-09-13T15:15:16.054Z
[taskcluster 2021-09-13T16:26:10.401Z] Uploading artifact public/test_info/g4_errorsummary.log from file build\blobber_upload_dir\g4_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2022-09-13T15:15:16.054Z
[taskcluster 2021-09-13T16:26:10.494Z] Uploading artifact public/test_info/g4_raw.log from file build\blobber_upload_dir\g4_raw.log with content encoding "gzip", mime type "text/plain" and expiry 2022-09-13T15:15:16.054Z
[taskcluster 2021-09-13T16:26:10.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/octet-stream" and expiry 2022-09-13T15:15:16.054Z
[taskcluster 2021-09-13T16:26:10.837Z] Uploading redirect artifact public/logs/live.log to URL https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/S8IK6hk3RGOO-yoOdBJcAg/runs/0/artifacts/public/logs/live_backing.log with mime type "text/plain; charset=utf-8" and expiry 2022-09-13T15:15:16.054Z
[taskcluster:error] exit status 2

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2021-09-13&endday=2021-09-19&tree=all

Comment 2

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

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

Comment 3

[Alexandru Michis [:malexandru]]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=360289373&repo=mozilla-central&lineNumber=1104

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2021-12-06&endday=2021-12-12&tree=all

Comment 5

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

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

Comment 6

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=363712773&repo=try

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2022-01-10&endday=2022-01-16&tree=all

Comment 8

[Intermittent Failures Robot]

3 failures in 3445 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1
• autoland: 2

Platform and build breakdown:

• windows10-64-shippable-qr: 2
  • opt: 2
• macosx1015-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2022-01-24&endday=2022-01-30&tree=all

Comment 9

[Intermittent Failures Robot]

6 failures in 3165 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2
• autoland: 4

Platform and build breakdown:

• macosx1015-64-shippable-qr: 3
  • opt: 3
• windows10-64-shippable-qr: 3
  • opt: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2022-01-31&endday=2022-02-06&tree=all

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2023-01-02&endday=2023-01-08&tree=all

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2023-01-16&endday=2023-01-22&tree=all

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2023-02-13&endday=2023-02-19&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2023-03-13&endday=2023-03-19&tree=all

Comment 14

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2023-07-17&endday=2023-07-23&tree=all

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1015-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2023-08-28&endday=2023-09-03&tree=all

Comment 16

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2023-12-25&endday=2023-12-31&tree=all

Comment 17

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2024-01-08&endday=2024-01-14&tree=all

Comment 18

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2024-02-26&endday=2024-03-03&tree=all

Comment 19

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2024-04-08&endday=2024-04-14&tree=all

Comment 20

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1730538&startday=2024-05-06&endday=2024-05-12&tree=all