Closed Bug 1858292 Opened 2 years ago Closed 2 years ago

Intermittent raptor-browsertime Error: Browsertime failed to run | raptor-browsertime Critical: Couldn't execute script named interactionToNextPaintInfo error:UnexpectedAlertOpenError: Dismissed user prompt dialog: WebGL context lost, please reload the pa

Categories

(Testing :: Raptor, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


task 2023-10-11T00:21:19.123Z] 00:21:19     INFO -  raptor-browsertime Info: Navigating to url about:blank iteration 1
[task 2023-10-11T00:21:24.171Z] 00:21:24     INFO -  raptor-browsertime Info: Cycle 4, waiting for 1000 ms
[task 2023-10-11T00:21:25.171Z] 00:21:25     INFO -  raptor-browsertime Info: Cycle 4, starting the measure
[task 2023-10-11T00:21:25.172Z] 00:21:25     INFO -  raptor-browsertime Info: Testing url http://localhost:39515/wasm-godot/index.html iteration 1
[task 2023-10-11T00:21:31.249Z] 00:21:31     INFO -  raptor-browsertime Info: http://localhost:39515/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-10-11T00:21:31.288Z] 00:21:31     INFO -  raptor-browsertime Info: CPU / Power usage: 6650
[task 2023-10-11T00:21:31.485Z] 00:21:31    ERROR -  raptor-browsertime Error: Browsertime failed to run
[task 2023-10-11T00:21:31.489Z] 00:21:31 CRITICAL -  raptor-browsertime Critical: Couldn't execute script named interactionToNextPaintInfo error:UnexpectedAlertOpenError: Dismissed user prompt dialog: WebGL context lost, please reload the page
[task 2023-10-11T00:21:31.697Z] 00:21:31     INFO -  raptor-perftest Info: Removing temporary directory: /tmp/tmpje9umuwn
[task 2023-10-11T00:21:31.729Z] 00:21:31    ERROR -  Traceback (most recent call last):
[task 2023-10-11T00:21:31.730Z] 00:21:31     INFO -    File "/home/cltbld/tasks/task_169698348293350/build/tests/raptor/raptor/raptor.py", line 190, in <module>
[task 2023-10-11T00:21:31.730Z] 00:21:31     INFO -      main()
[task 2023-10-11T00:21:31.731Z] 00:21:31     INFO -    File "/home/cltbld/tasks/task_169698348293350/build/tests/raptor/raptor/raptor.py", line 136, in main
[task 2023-10-11T00:21:31.731Z] 00:21:31     INFO -      success = raptor.run_tests(raptor_test_list, raptor_test_names)
[task 2023-10-11T00:21:31.732Z] 00:21:31     INFO -    File "/home/cltbld/tasks/task_169698348293350/build/tests/raptor/raptor/perftest.py", line 467, in run_tests
[task 2023-10-11T00:21:31.732Z] 00:21:31     INFO -      self.run_test(test, timeout=int(test.get("page_timeout")))
[task 2023-10-11T00:21:31.733Z] 00:21:31     INFO -    File "/home/cltbld/tasks/task_169698348293350/build/tests/raptor/raptor/browsertime/base.py", line 993, in run_test
[task 2023-10-11T00:21:31.733Z] 00:21:31     INFO -      raise Exception(self.browsertime_failure)
[task 2023-10-11T00:21:31.734Z] 00:21:31     INFO -  Exception: Couldn't execute script named interactionToNextPaintInfo error:UnexpectedAlertOpenError: Dismissed user prompt dialog: WebGL context lost, please reload the page
[task 2023-10-11T00:21:31.791Z] 00:21:31     INFO - Return code: 1
[task 2023-10-11T00:21:31.791Z] 00:21:31  WARNING - setting return code to 1
[task 2023-10-11T00:21:31.791Z] 00:21:31     INFO - Copying Raptor results to upload dir:
[task 2023-10-11T00:21:31.792Z] 00:21:31     INFO - /home/cltbld/tasks/task_169698348293350/build/blobber_upload_dir/perfherder-data.json
[task 2023-10-11T00:21:31.792Z] 00:21:31     INFO - Copying raptor results from /home/cltbld/tasks/task_169698348293350/build/raptor.json to /home/cltbld/tasks/task_169698348293350/build/blobber_upload_dir/perfherder-data.json
[task 2023-10-11T00:21:31.792Z] 00:21:31 CRITICAL - Error copying results /home/cltbld/tasks/task_169698348293350/build/raptor.json to upload dir /home/cltbld/tasks/task_169698348293350/build/blobber_upload_dir/perfherder-data.json
[task 2023-10-11T00:21:31.792Z] 00:21:31     INFO - [Errno 2] No such file or directory: '/home/cltbld/tasks/task_169698348293350/build/raptor.json'
[task 2023-10-11T00:21:31.793Z] 00:21:31     INFO - Running post-action listener: _package_coverage_data
[task 2023-10-11T00:21:31.793Z] 00:21:31     INFO - Running post-action listener: _resource_record_post_action
[task 2023-10-11T00:21:31.793Z] 00:21:31     INFO - Running post-action listener: process_java_coverage_data
[task 2023-10-11T00:21:31.793Z] 00:21:31     INFO - Running post-action listener: stop_device
[task 2023-10-11T00:21:31.793Z] 00:21:31     INFO - [mozharness: 2023-10-11 00:21:31.793270Z] Finished run-tests step (success)
[task 2023-10-11T00:21:31.793Z] 00:21:31     INFO - Running post-run listener: _resource_record_post_run
[task 2023-10-11T00:21:31.871Z] 00:21:31     INFO - Total resource usage - Wall time: 121s; CPU: 8%; Read bytes: 147578880; Write bytes: 1035059200; Read time: 1488; Write time: 14092
[task 2023-10-11T00:21:31.871Z] 00:21:31     INFO - TinderboxPrint: CPU usage<br/>8.0%
[task 2023-10-11T00:21:31.871Z] 00:21:31     INFO - TinderboxPrint: I/O read bytes / time<br/>147,578,880 / 1,488
[task 2023-10-11T00:21:31.871Z] 00:21:31     INFO - TinderboxPrint: I/O write bytes / time<br/>1,035,059,200 / 14,092
[task 2023-10-11T00:21:31.871Z] 00:21:31     INFO - TinderboxPrint: CPU idle<br/>887.4 (91.6%)
[task 2023-10-11T00:21:31.871Z] 00:21:31     INFO - TinderboxPrint: CPU system<br/>12.5 (1.3%)
[task 2023-10-11T00:21:31.871Z] 00:21:31     INFO - TinderboxPrint: CPU user<br/>62.9 (6.5%)
[task 2023-10-11T00:21:31.872Z] 00:21:31     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2023-10-11T00:21:31.872Z] 00:21:31     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-10-11T00:21:31.872Z] 00:21:31     INFO - install - Wall time: 10s; CPU: 13%; Read bytes: 0; Write bytes: 20643840; Read time: 0; Write time: 288
[task 2023-10-11T00:21:31.876Z] 00:21:31     INFO - run-tests - Wall time: 112s; CPU: 8%; Read bytes: 146743296; Write bytes: 1012850688; Read time: 1476; Write time: 13772
[task 2023-10-11T00:21:31.931Z] 00:21:31  WARNING - returning nonzero exit status 1
[taskcluster 2023-10-11T00:21:31.967Z]    Exit Code: 1
[taskcluster 2023-10-11T00:21:31.967Z]    User Time: 1m32.486018s
[taskcluster 2023-10-11T00:21:31.967Z]  Kernel Time: 8.093613s
[taskcluster 2023-10-11T00:21:31.967Z]    Wall Time: 3m27.311736961s
[taskcluster 2023-10-11T00:21:31.967Z]       Result: FAILED
[taskcluster 2023-10-11T00:21:31.967Z] === Task Finished ===
[taskcluster 2023-10-11T00:21:31.967Z] Task Duration: 3m27.315192278s
[taskcluster 2023-10-11T00:21:32.076Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2024-01-08T21:38:02.510Z
[taskcluster 2023-10-11T00:21:32.402Z] 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 2024-01-08T21:38:02.510Z
[taskcluster 2023-10-11T00:21:32.730Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-01-08T21:38:02.510Z
[taskcluster:error] exit status 1

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.