1854558 - Intermittent [tier 2] raptor-browsertime Error: Browsertime failed to run | raptor-browsertime Critical: Failed to execute user script: UnexpectedAlertOpenError: Dismissed user prompt dialog: WebGL context lost, please reload the page

Status: RESOLVED INCOMPLETE

(Testing :: Raptor, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2023-09-22T06:28:49.242Z] 06:28:49     INFO -  raptor-browsertime Info: Benchmark custom metric collection
[task 2023-09-22T06:28:49.248Z] 06:28:49     INFO -  raptor-browsertime Info: Waiting 3000 ms for data from benchmark...
[task 2023-09-22T06:28:52.278Z] 06:28:52     INFO -  raptor-browsertime Info: Value of benchmark data:  ["raptor-benchmark","wasm-godot",[{"name":"wasm-instantiate","time":137.36},{"name":"engine-instantiate","time":457.24000000000007},{"name":"first-frame","time":600.3199999999999},{"name":"first-interactive","time":604.78},{"name":"cpuTime","time":602.9200000000001}]]
[task 2023-09-22T06:28:52.279Z] 06:28:52     INFO -  raptor-browsertime Info: Navigating to about:blank
[task 2023-09-22T06:28:52.279Z] 06:28:52     INFO -  raptor-browsertime Info: Navigating to url about:blank iteration 1
[task 2023-09-22T06:28:57.322Z] 06:28:57     INFO -  raptor-browsertime Info: Cycle 4, waiting for 1000 ms
[task 2023-09-22T06:28:58.324Z] 06:28:58     INFO -  raptor-browsertime Info: Cycle 4, starting the measure
[task 2023-09-22T06:28:58.325Z] 06:28:58     INFO -  raptor-browsertime Info: Testing url http://localhost:55079/wasm-godot/index.html iteration 1
[task 2023-09-22T06:29:04.408Z] 06:29:04     INFO -  raptor-browsertime Info: http://localhost:55079/wasm-godot/index.html has been tested before within the same run, it will get an extra query parameter named browsertime_run. Make sure to use alias to keep track of the URLs
[task 2023-09-22T06:29:04.435Z] 06:29:04     INFO -  raptor-browsertime Info: CPU / Power usage: 11945
[task 2023-09-22T06:29:04.615Z] 06:29:04    ERROR -  raptor-browsertime Error: Browsertime failed to run
[task 2023-09-22T06:29:04.636Z] 06:29:04    ERROR -  raptor-browsertime Error: Browsertime failed to run
[task 2023-09-22T06:29:04.636Z] 06:29:04 CRITICAL -  raptor-browsertime Critical: Failed to execute user script: UnexpectedAlertOpenError: Dismissed user prompt dialog: WebGL context lost, please reload the page
[task 2023-09-22T06:29:04.858Z] 06:29:04     INFO -  raptor-perftest Info: Removing temporary directory: /tmp/tmphb236y8u
[task 2023-09-22T06:29:04.873Z] 06:29:04    ERROR -  Traceback (most recent call last):
[task 2023-09-22T06:29:04.873Z] 06:29:04     INFO -    File "/home/cltbld/tasks/task_169535607641941/build/tests/raptor/raptor/raptor.py", line 190, in <module>
[task 2023-09-22T06:29:04.873Z] 06:29:04     INFO -      main()
[task 2023-09-22T06:29:04.874Z] 06:29:04     INFO -    File "/home/cltbld/tasks/task_169535607641941/build/tests/raptor/raptor/raptor.py", line 136, in main
[task 2023-09-22T06:29:04.874Z] 06:29:04     INFO -      success = raptor.run_tests(raptor_test_list, raptor_test_names)
[task 2023-09-22T06:29:04.875Z] 06:29:04     INFO -    File "/home/cltbld/tasks/task_169535607641941/build/tests/raptor/raptor/perftest.py", line 469, in run_tests
[task 2023-09-22T06:29:04.875Z] 06:29:04     INFO -      self.run_test(test, timeout=int(test.get("page_timeout")))
[task 2023-09-22T06:29:04.876Z] 06:29:04     INFO -    File "/home/cltbld/tasks/task_169535607641941/build/tests/raptor/raptor/browsertime/base.py", line 938, in run_test
[task 2023-09-22T06:29:04.876Z] 06:29:04     INFO -      raise Exception(self.browsertime_failure)
[task 2023-09-22T06:29:04.877Z] 06:29:04     INFO -  Exception: Failed to execute user script: UnexpectedAlertOpenError: Dismissed user prompt dialog: WebGL context lost, please reload the page
[task 2023-09-22T06:29:04.936Z] 06:29:04     INFO - Return code: 1
[task 2023-09-22T06:29:04.936Z] 06:29:04  WARNING - setting return code to 1
[task 2023-09-22T06:29:04.936Z] 06:29:04     INFO - Copying Raptor results to upload dir:
[task 2023-09-22T06:29:04.936Z] 06:29:04     INFO - /home/cltbld/tasks/task_169535607641941/build/blobber_upload_dir/perfherder-data.json
[task 2023-09-22T06:29:04.936Z] 06:29:04     INFO - Copying raptor results from /home/cltbld/tasks/task_169535607641941/build/raptor.json to /home/cltbld/tasks/task_169535607641941/build/blobber_upload_dir/perfherder-data.json
[task 2023-09-22T06:29:04.936Z] 06:29:04 CRITICAL - Error copying results /home/cltbld/tasks/task_169535607641941/build/raptor.json to upload dir /home/cltbld/tasks/task_169535607641941/build/blobber_upload_dir/perfherder-data.json
[task 2023-09-22T06:29:04.936Z] 06:29:04     INFO - [Errno 2] No such file or directory: '/home/cltbld/tasks/task_169535607641941/build/raptor.json'
[task 2023-09-22T06:29:04.937Z] 06:29:04     INFO - Running post-action listener: _package_coverage_data
[task 2023-09-22T06:29:04.937Z] 06:29:04     INFO - Running post-action listener: _resource_record_post_action
[task 2023-09-22T06:29:04.937Z] 06:29:04     INFO - Running post-action listener: process_java_coverage_data
[task 2023-09-22T06:29:04.937Z] 06:29:04     INFO - Running post-action listener: stop_device
[task 2023-09-22T06:29:04.937Z] 06:29:04     INFO - [mozharness: 2023-09-22 06:29:04.937920Z] Finished run-tests step (success)
[task 2023-09-22T06:29:04.938Z] 06:29:04     INFO - Running post-run listener: _resource_record_post_run
[task 2023-09-22T06:29:05.017Z] 06:29:05     INFO - Total resource usage - Wall time: 123s; CPU: 11%; Read bytes: 147726336; Write bytes: 1037352960; Read time: 1068; Write time: 7136
[task 2023-09-22T06:29:05.017Z] 06:29:05     INFO - TinderboxPrint: CPU usage<br/>10.5%
[task 2023-09-22T06:29:05.017Z] 06:29:05     INFO - TinderboxPrint: I/O read bytes / time<br/>147,726,336 / 1,068
[task 2023-09-22T06:29:05.017Z] 06:29:05     INFO - TinderboxPrint: I/O write bytes / time<br/>1,037,352,960 / 7,136
[task 2023-09-22T06:29:05.018Z] 06:29:05     INFO - TinderboxPrint: CPU idle<br/>878.5 (89.2%)
[task 2023-09-22T06:29:05.018Z] 06:29:05     INFO - TinderboxPrint: CPU system<br/>13.2 (1.3%)
[task 2023-09-22T06:29:05.018Z] 06:29:05     INFO - TinderboxPrint: CPU user<br/>88.3 (9.0%)
[task 2023-09-22T06:29:05.018Z] 06:29:05     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2023-09-22T06:29:05.018Z] 06:29:05     INFO - install-chromium-distribution - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-09-22T06:29:05.019Z] 06:29:05     INFO - install - Wall time: 10s; CPU: 13%; Read bytes: 0; Write bytes: 1007616; Read time: 0; Write time: 24
[task 2023-09-22T06:29:05.023Z] 06:29:05     INFO - run-tests - Wall time: 114s; CPU: 10%; Read bytes: 146767872; Write bytes: 1010040832; Read time: 1052; Write time: 6832
[task 2023-09-22T06:29:05.077Z] 06:29:05  WARNING - returning nonzero exit status 1
[taskcluster 2023-09-22T06:29:05.113Z]    Exit Code: 1
[taskcluster 2023-09-22T06:29:05.113Z]    User Time: 1m32.904256s
[taskcluster 2023-09-22T06:29:05.113Z]  Kernel Time: 8.198875s
[taskcluster 2023-09-22T06:29:05.113Z]    Wall Time: 3m29.973425518s
[taskcluster 2023-09-22T06:29:05.113Z]       Result: FAILED
[taskcluster 2023-09-22T06:29:05.113Z] === Task Finished ===
[taskcluster 2023-09-22T06:29:05.113Z] Task Duration: 3m29.976746906s
[taskcluster 2023-09-22T06:29:05.260Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2023-12-21T04:28:04.023Z
[taskcluster 2023-09-22T06:29:05.557Z] Uploading artifact public/test_info/resource-usage.json from file build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2023-12-21T04:28:04.023Z
[taskcluster 2023-09-22T06:29:05.817Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2023-12-21T04:28:04.023Z
[taskcluster:error] exit status 1

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

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

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1854558&startday=2023-10-09&endday=2023-10-15&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

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

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1854558&startday=2023-10-30&endday=2023-11-05&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

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

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

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-shippable-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1854558&startday=2023-11-20&endday=2023-11-26&tree=all

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-release: 1

Platform and build breakdown:

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

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

Comment 8

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

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