Permafailing imgur [tier 2] [mozilla-release] raptor-browsertime Critical: Browsertime process timed out after waiting 120 seconds for output
Categories
(Testing :: Raptor, defect, P5)
Tracking
(firefox124 fixed)
| Tracking | Status | |
|---|---|---|
| firefox124 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: ncsoregi [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=440809246&repo=mozilla-release
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MAatYzbVRJemdjkzk7k0hA/runs/0/artifacts/public/logs/live_backing.log
[task 2023-12-20T03:31:12.822Z] 03:31:12 INFO - raptor-browsertime Info: Testing url https://imgur.com/gallery/m5tYJL6 iteration 1
[task 2023-12-20T03:31:12.823Z] 03:31:12 INFO - raptor-browsertime Info: Start firefox window recorder.
[task 2023-12-20T03:32:20.068Z] 03:32:20 INFO - raptor-browsertime Info: Stop firefox window recorder.
[task 2023-12-20T03:34:20.202Z] 03:34:20 CRITICAL - raptor-browsertime Critical: Browsertime process timed out after waiting 120 seconds for output
[task 2023-12-20T03:34:20.202Z] 03:34:20 INFO - raptor-mitmproxy Info: MitmproxyDesktop stop!!
[task 2023-12-20T03:34:20.202Z] 03:34:20 INFO - raptor-mitmproxy Info: Mitmproxy stop!!
[task 2023-12-20T03:34:20.202Z] 03:34:20 INFO - raptor-mitmproxy Info: Stopping mitmproxy playback, killing process 1378
[task 2023-12-20T03:34:20.539Z] 03:34:20 INFO - raptor-mitmproxy Info: Successfully killed the mitmproxy playback process
[task 2023-12-20T03:34:20.540Z] 03:34:20 INFO - raptor-mitmproxy Info: Turning off the browser proxy
[task 2023-12-20T03:34:20.540Z] 03:34:20 INFO - raptor-mitmproxy Info: writing: /opt/worker/tasks/task_170304282856711/build/application/Firefox.app/Contents/Resources/distribution/policies.json
[task 2023-12-20T03:34:20.540Z] 03:34:20 INFO - raptor-perftest Info: Removing temporary directory: /var/folders/w1/j59dbgks1jsfshgv0w6ybx34000014/T/tmpbuyjxgma
[task 2023-12-20T03:34:20.565Z] 03:34:20 ERROR - Traceback (most recent call last):
[task 2023-12-20T03:34:20.565Z] 03:34:20 INFO - File "/opt/worker/tasks/task_170304282856711/build/tests/raptor/raptor/raptor.py", line 191, in <module>
[task 2023-12-20T03:34:20.565Z] 03:34:20 INFO - main()
[task 2023-12-20T03:34:20.565Z] 03:34:20 INFO - File "/opt/worker/tasks/task_170304282856711/build/tests/raptor/raptor/raptor.py", line 137, in main
[task 2023-12-20T03:34:20.566Z] 03:34:20 INFO - success = raptor.run_tests(raptor_test_list, raptor_test_names)
[task 2023-12-20T03:34:20.566Z] 03:34:20 INFO - File "/opt/worker/tasks/task_170304282856711/build/tests/raptor/raptor/perftest.py", line 467, in run_tests
[task 2023-12-20T03:34:20.566Z] 03:34:20 INFO - self.run_test(test, timeout=int(test.get("page_timeout")))
[task 2023-12-20T03:34:20.566Z] 03:34:20 INFO - File "/opt/worker/tasks/task_170304282856711/build/tests/raptor/raptor/browsertime/base.py", line 987, in run_test
[task 2023-12-20T03:34:20.566Z] 03:34:20 INFO - f"Browsertime process timed out after waiting {output_timeout} seconds "
[task 2023-12-20T03:34:20.566Z] 03:34:20 INFO - Exception: Browsertime process timed out after waiting 120 seconds for output
[task 2023-12-20T03:34:20.605Z] 03:34:20 INFO - Return code: 1
[task 2023-12-20T03:34:20.605Z] 03:34:20 WARNING - setting return code to 1
[task 2023-12-20T03:34:20.605Z] 03:34:20 INFO - Copying Raptor results to upload dir:
[task 2023-12-20T03:34:20.605Z] 03:34:20 INFO - /opt/worker/tasks/task_170304282856711/build/blobber_upload_dir/perfherder-data.json
[task 2023-12-20T03:34:20.605Z] 03:34:20 INFO - Copying raptor results from /opt/worker/tasks/task_170304282856711/build/raptor.json to /opt/worker/tasks/task_170304282856711/build/blobber_upload_dir/perfherder-data.json
[task 2023-12-20T03:34:20.605Z] 03:34:20 CRITICAL - Error copying results /opt/worker/tasks/task_170304282856711/build/raptor.json to upload dir /opt/worker/tasks/task_170304282856711/build/blobber_upload_dir/perfherder-data.json
[task 2023-12-20T03:34:20.605Z] 03:34:20 INFO - [Errno 2] No such file or directory: '/opt/worker/tasks/task_170304282856711/build/raptor.json'
Comment 1•2 years ago
|
||
Retriggering passed jobs on earlier pushes makes them fail: https://treeherder.mozilla.org/jobs?repo=mozilla-release&group_state=expanded&selectedTaskRun=MAatYzbVRJemdjkzk7k0hA.0&searchStr=os%2Cx%2C10.15%2Cwebrender%2Cshippable%2Copt%2Cbrowsertime%2Cperformance%2Ctests%2Con%2Cfirefox%2Ctest-macosx1015-64-shippable-qr%2Fopt-browsertime-tp6-firefox-imgur%2Cimgur&revision=a8daee71c97036d89232cdb16881b834448a2286
Greg, any chance you have a few spare minutes to check this?
Thank you!
| Comment hidden (Intermittent Failures Robot) |
Comment 3•2 years ago
|
||
This should get resolved by the re-recording from bug 1863130, but I'll have another look next week.
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 6•2 years ago
|
||
We're still waiting on a merge to see if it gets fixed. Currently, the test is still using the old recording.
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Updated•2 years ago
|
Updated•2 years ago
|
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 19•2 years ago
|
||
No longer happening since the 124 merge to mozilla-release: https://treeherder.mozilla.org/jobs?repo=mozilla-release&noTelemetry=1&resultStatus=success%2Ctestfailed%2Cbusted%2Cexception%2Cretry%2Cusercancel&searchStr=imgur&fromchange=163c38ee7a7a13a344e7fe15b75d86e6c5212ae0
Let's deem this as fixed so we avoid misclassifications here.
Description
•