1973110 - Perma raptor-browsertime Error: Browsertime failed to run | raptor-browsertime Critical: Failed to execute user script: JavascriptError: TypeError: can't access property Symbol.iterator, t.serverTiming is undefined [0m

Status: RESOLVED FIXED

(Testing :: Raptor, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2025-06-19T17:46:17.639+00:00] 17:46:17     INFO -  raptor-browsertime-desktop Info: binary_path: /home/cltbld/tasks/task_175035110152960/build/application/firefox/firefox
[task 2025-06-19T17:46:17.640+00:00] 17:46:17     INFO -  raptor-browsertime Info: timeout (ms): 2160000
[task 2025-06-19T17:46:17.640+00:00] 17:46:17     INFO -  raptor-browsertime Info: browsertime cwd: /home/cltbld/tasks/task_175035110152960/build
[task 2025-06-19T17:46:17.643+00:00] 17:46:17     INFO -  raptor-browsertime Info: browsertime cmd: /home/cltbld/tasks/task_175035110152960/fetches/node/bin/node /home/cltbld/tasks/task_175035110152960/fetches/browsertime/node_modules/browsertime/bin/browsertime.js --firefox.geckodriverPath /home/cltbld/tasks/task_175035110152960/fetches/geckodriver /home/cltbld/tasks/task_175035110152960/build/tests/raptor/raptor/browsertime/../../browsertime/constant_regression_test.js --firefox.noDefaultPrefs --browsertime.page_cycle_delay 1000 --skipHar --pageLoadStrategy none --webdriverPageload true --firefox.disableBrowsertimeExtension true --pageCompleteCheckStartWait 5000 --pageCompleteCheckPollTimeout 1000 --beforePageCompleteWaitTime 2000 --timeouts.pageLoad 2160000 --timeouts.script 2160000 --browsertime.page_cycles 1 --pageCompleteWaitTime 5000 --browsertime.url None --browsertime.post_startup_delay 30000 --iterations 1 --browsertime.chimera false --browsertime.test_bytecode_cache false --firefox.perfStats false --browsertime.moz_fetch_dir /home/cltbld/tasks/task_175035110152960/fetches --browsertime.expose_profiler false --browsertime.constant_value 1500 --browsertime.commands  --viewPort 1280x1024 --browser firefox --firefox.binaryPath /home/cltbld/tasks/task_175035110152960/build/application/firefox/firefox --resultDir /home/cltbld/tasks/task_175035110152960/build/blobber_upload_dir/browsertime-results/constant-regression --firefox.profileTemplate /tmp/tmpf8dogbeq.mozrunner --video false --visualMetrics false --browsertime.testName constant-regression --browsertime.liveSite False --browsertime.loginRequired False
[task 2025-06-19T17:46:17.643+00:00] 17:46:17     INFO -  raptor-browsertime Info: PATH: /home/cltbld/tasks/task_175035110152960/build/venv/bin:/bin:/sbin:/usr/bin:/usr/sbin:/usr/local/bin
[task 2025-06-19T17:46:17.643+00:00] 17:46:17     INFO -  raptor-browsertime Info: Calling browsertime with proc_timeout=2000000, and output_timeout=2000000
[task 2025-06-19T17:46:18.254+00:00] 17:46:18     INFO -  raptor-browsertime Info: Running tests using Firefox - 1 iteration(s)
[task 2025-06-19T17:46:18.280+00:00] 17:46:18     INFO -  raptor-browsertime Info: Using profile /tmp/tmpf8dogbeq.mozrunner
[task 2025-06-19T17:46:18.280+00:00] 17:46:18     INFO -  raptor-browsertime Info: Skip setting default preferences for Firefox
[task 2025-06-19T17:46:21.603+00:00] 17:46:21     INFO -  raptor-browsertime Info: Starting constant value regression test
[task 2025-06-19T17:46:21.603+00:00] 17:46:21     INFO -  raptor-browsertime Info: Start to measure regression-test
[task 2025-06-19T17:46:21.649+00:00] 17:46:21     INFO -  raptor-browsertime Info: CPU / Power usage: 88
[task 2025-06-19T17:46:21.809+00:00] 17:46:21    ERROR -  raptor-browsertime Error: Browsertime failed to run
[task 2025-06-19T17:46:21.810+00:00] 17:46:21    ERROR -  raptor-browsertime Error: Browsertime failed to run
[task 2025-06-19T17:46:21.951+00:00] 17:46:21     INFO -  TEST-INFO | screentopng: exit 0
[task 2025-06-19T17:46:21.951+00:00] 17:46:21    ERROR -  raptor-browsertime Critical: Failed to execute user script: JavascriptError: TypeError: can't access property Symbol.iterator, t.serverTiming is undefined
[task 2025-06-19T17:46:21.952+00:00] 17:46:21     INFO -  raptor-perftest Info: Removing temporary directory: /tmp/tmpg76igerr
[task 2025-06-19T17:46:21.953+00:00] 17:46:21    ERROR -  Traceback (most recent call last):
[task 2025-06-19T17:46:21.954+00:00] 17:46:21     INFO -    File "/home/cltbld/tasks/task_175035110152960/build/tests/raptor/raptor/raptor.py", line 189, in <module>
[task 2025-06-19T17:46:21.954+00:00] 17:46:21     INFO -      main()
[task 2025-06-19T17:46:21.954+00:00] 17:46:21     INFO -    File "/home/cltbld/tasks/task_175035110152960/build/tests/raptor/raptor/raptor.py", line 138, in main
[task 2025-06-19T17:46:21.954+00:00] 17:46:21     INFO -      success = raptor.run_tests(raptor_test_list, raptor_test_names)
[task 2025-06-19T17:46:21.955+00:00] 17:46:21     INFO -    File "/home/cltbld/tasks/task_175035110152960/build/tests/raptor/raptor/perftest.py", line 494, in run_tests
[task 2025-06-19T17:46:21.955+00:00] 17:46:21     INFO -      self.run_test(test, timeout=int(test.get("page_timeout")))
[task 2025-06-19T17:46:21.955+00:00] 17:46:21     INFO -    File "/home/cltbld/tasks/task_175035110152960/build/tests/raptor/raptor/browsertime/base.py", line 1111, in run_test
[task 2025-06-19T17:46:21.956+00:00] 17:46:21     INFO -      raise Exception(self.browsertime_failure)
[task 2025-06-19T17:46:21.956+00:00] 17:46:21    ERROR -  Exception: Failed to execute user script: JavascriptError: TypeError: can't access property Symbol.iterator, t.serverTiming is undefined
[task 2025-06-19T17:46:22.011+00:00] 17:46:22     INFO - Return code: 1
[task 2025-06-19T17:46:22.011+00:00] 17:46:22  WARNING - setting return code to 1
[task 2025-06-19T17:46:22.011+00:00] 17:46:22     INFO - Copying Raptor results to upload dir:
[task 2025-06-19T17:46:22.011+00:00] 17:46:22     INFO - /home/cltbld/tasks/task_175035110152960/build/blobber_upload_dir/perfherder-data.json
[task 2025-06-19T17:46:22.011+00:00] 17:46:22     INFO - Copying raptor results from /home/cltbld/tasks/task_175035110152960/build/raptor.json to /home/cltbld/tasks/task_175035110152960/build/blobber_upload_dir/perfherder-data.json
[task 2025-06-19T17:46:22.011+00:00] 17:46:22 CRITICAL - Error copying results /home/cltbld/tasks/task_175035110152960/build/raptor.json to upload dir /home/cltbld/tasks/task_175035110152960/build/blobber_upload_dir/perfherder-data.json
[task 2025-06-19T17:46:22.011+00:00] 17:46:22     INFO - [Errno 2] No such file or directory: '/home/cltbld/tasks/task_175035110152960/build/raptor.json'
[task 2025-06-19T17:46:22.012+00:00] 17:46:22     INFO - Running post-action listener: _package_coverage_data
[task 2025-06-19T17:46:22.012+00:00] 17:46:22     INFO - Running post-action listener: _resource_record_post_action
[task 2025-06-19T17:46:22.012+00:00] 17:46:22     INFO - Running post-action listener: process_java_coverage_data
[task 2025-06-19T17:46:22.012+00:00] 17:46:22     INFO - Running post-action listener: stop_device
[task 2025-06-19T17:46:22.012+00:00] 17:46:22     INFO - [mozharness: 2025-06-19 17:46:22.012825Z] Finished run-tests step (success)
[task 2025-06-19T17:46:22.012+00:00] 17:46:22     INFO - Running post-run listener: _resource_record_post_run
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - Total resource usage - Wall time: 11s; CPU: 16%; Read bytes: 35889152; Write bytes: 528551936; Read time: 2232; Write time: 14904
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: CPU usage<br/>16.1%
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: I/O read bytes / time<br/>35,889,152 / 2,232
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: I/O write bytes / time<br/>528,551,936 / 14,904
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: CPU idle<br/>72.7 (81.0%)
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: CPU iowait<br/>2.4 (2.7%)
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: CPU system<br/>1.4 (1.5%)
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: CPU user<br/>13.0 (14.5%)
[task 2025-06-19T17:46:22.108+00:00] 17:46:22     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2025-06-19T17:46:22.109+00:00] 17:46:22     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 2025-06-19T17:46:22.111+00:00] 17:46:22     INFO - install - Wall time: 6s; CPU: 13%; Read bytes: 122880; Write bytes: 432848896; Read time: 16; Write time: 10704
[task 2025-06-19T17:46:22.113+00:00] 17:46:22     INFO - run-tests - Wall time: 5s; CPU: 20%; Read bytes: 35766272; Write bytes: 95703040; Read time: 2216; Write time: 4200
[task 2025-06-19T17:46:22.191+00:00] 17:46:22  WARNING - returning nonzero exit status 1
[taskcluster 2025-06-19T17:46:22.230Z]    Exit Code: 1
[taskcluster 2025-06-19T17:46:22.230Z]    User Time: 1m19.068852s
[taskcluster 2025-06-19T17:46:22.230Z]  Kernel Time: 8.55877s
[taskcluster 2025-06-19T17:46:22.230Z]    Wall Time: 1m48.999561084s
[taskcluster 2025-06-19T17:46:22.230Z]       Result: FAILED
[taskcluster 2025-06-19T17:46:22.230Z] === Task Finished ===
[taskcluster 2025-06-19T17:46:22.230Z] Task Duration: 1m49.003152767s
[taskcluster 2025-06-19T17:46:22.381Z] Uploading artifact public/logs/localconfig.json from file /home/cltbld/tasks/task_175035110152960/logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2026-06-19T15:44:45.149Z
[taskcluster 2025-06-19T17:46:22.670Z] Uploading artifact public/test_info/mozilla-test-fail-screenshot_df63lwmx.png from file /home/cltbld/tasks/task_175035110152960/build/blobber_upload_dir/mozilla-test-fail-screenshot_df63lwmx.png with content encoding "identity", mime type "image/png" and expiry 2026-06-19T15:44:45.149Z
[taskcluster 2025-06-19T17:46:22.980Z] Uploading artifact public/test_info/profile_resource-usage.json from file /home/cltbld/tasks/task_175035110152960/build/blobber_upload_dir/profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2026-06-19T15:44:45.149Z
[taskcluster 2025-06-19T17:46:23.220Z] Uploading artifact public/test_info/resource-usage.json from file /home/cltbld/tasks/task_175035110152960/build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2026-06-19T15:44:45.149Z
[taskcluster 2025-06-19T17:46:23.430Z] [mounts] Preserving cache: Moving "/home/cltbld/tasks/task_175035110152960/.task-cache/pip" to "/home/cltbld/caches/Rscjuj0oSYienARHMvdD7Q"
[taskcluster 2025-06-19T17:46:23.430Z] [mounts] Preserving cache: Moving "/home/cltbld/tasks/task_175035110152960/.task-cache/uv" to "/home/cltbld/caches/WL8pQcMRRAai1G_gNLnIVg"
[taskcluster 2025-06-19T17:46:23.475Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2026-06-19T15:44:45.149Z
[taskcluster:error] exit status 1

Comment 1

[Cristina Horotan [:chorotan]]

Fixed by backout https://hg.mozilla.org/integration/autoland/rev/d248f3241bbe4d6eac4559f9d37493db1054990d