1746866 - Permanent perftestt domcount mozperftest.test.browsertime.runner.NodeException: 1

Status: RESOLVED INCOMPLETE

(Testing :: mozperftest, defect, P5)

Description

[Treeherder Bug Filer]

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

---

Test runs as tier 3 which has to be manually activated to be displayed by Treeherder.

[task 2021-12-20T10:39:09.962Z] executing ['bash', '-cx', 'mkdir -p $MOZ_FETCHES_DIR/../artifacts && cd $MOZ_FETCHES_DIR && python3.8 python/mozperftest/mozperftest/runner.py browser/base/content/test/perftest_browser_xhtml_dom.js --browsertime-binary ${MOZ_FETCHES_DIR}/firefox/firefox-bin --flavor desktop-browser --perfherder --perfherder-metrics name:totalDOMCount,unit:count name:panelMenuCount,unit:count name:lightDOMCount,unit:count name:lightDOMDetails,unit:count --browsertime-geckodriver ${MOZ_FETCHES_DIR}/geckodriver --output $MOZ_FETCHES_DIR/../artifacts']
[task 2021-12-20T10:39:09.964Z] + mkdir -p /home/cltbld/tasks/task_163999664068175/fetches/../artifacts
[task 2021-12-20T10:39:09.965Z] + cd /home/cltbld/tasks/task_163999664068175/fetches
[task 2021-12-20T10:39:09.965Z] + python3.8 python/mozperftest/mozperftest/runner.py browser/base/content/test/perftest_browser_xhtml_dom.js --browsertime-binary /home/cltbld/tasks/task_163999664068175/fetches/firefox/firefox-bin --flavor desktop-browser --perfherder --perfherder-metrics name:totalDOMCount,unit:count name:panelMenuCount,unit:count name:lightDOMCount,unit:count name:lightDOMDetails,unit:count --browsertime-geckodriver /home/cltbld/tasks/task_163999664068175/fetches/geckodriver --output /home/cltbld/tasks/task_163999664068175/fetches/../artifacts
[task 2021-12-20T10:39:11.377Z] created virtual environment CPython3.8.8.final.0-64 in 30ms
[task 2021-12-20T10:39:11.377Z]   creator CPython3Posix(dest=/home/cltbld/tasks/task_163999664068175/fetches/obj-x86_64-pc-linux-gnu/_virtualenvs/common, clear=False, no_vcs_ignore=False, global=False)
[task 2021-12-20T10:39:11.377Z]   activators BashActivator,CShellActivator,FishActivator,PowerShellActivator,PythonActivator
[task 2021-12-20T10:39:11.552Z]  0:00.87 Created profile at /tmp/tmpy71hcex_.mozrunner
[task 2021-12-20T10:39:11.675Z]  0:01.00 Running browsertime with this command /home/cltbld/.mozbuild/browsertime/node_modules/browsertime/bin/browsertime.js -b firefox --skipHar --viewPort 1280x1024 --firefox.binaryPath /home/cltbld/tasks/task_163999664068175/fetches/firefox/firefox-bin --firefox.geckodriverPath /home/cltbld/tasks/task_163999664068175/fetches/geckodriver --resultDir /home/cltbld/tasks/task_163999664068175/artifacts/browsertime-results-1 --firefox.profileTemplate /tmp/tmpy71hcex_.mozrunner --iterations 1 /home/cltbld/tasks/task_163999664068175/fetches/browser/base/content/test/perftest_browser_xhtml_dom.js --firefox.preference mozperftest:true
[task 2021-12-20T10:39:11.675Z]  0:01.00 /home/cltbld/tasks/task_163999664068175/fetches/node/bin/node /home/cltbld/.mozbuild/browsertime/node_modules/browsertime/bin/browsertime.js -b firefox --skipHar --viewPort 1280x1024 --firefox.binaryPath /home/cltbld/tasks/task_163999664068175/fetches/firefox/firefox-bin --firefox.geckodriverPath /home/cltbld/tasks/task_163999664068175/fetches/geckodriver --resultDir /home/cltbld/tasks/task_163999664068175/artifacts/browsertime-results-1 --firefox.profileTemplate /tmp/tmpy71hcex_.mozrunner --iterations 1 /home/cltbld/tasks/task_163999664068175/fetches/browser/base/content/test/perftest_browser_xhtml_dom.js --firefox.preference mozperftest:true
[task 2021-12-20T10:39:12.164Z]  0:01.49 Running tests using Firefox - 1 iteration(s)
[task 2021-12-20T10:39:14.122Z]  0:03.44 Testing url data:text/html,BrowserDOM iteration 1
[task 2021-12-20T10:44:19.142Z]  5:08.46 Mozperftest failed to run: 
[task 2021-12-20T10:44:19.143Z]  5:08.46 URL failed to load, trying 5 more time(s): Failed waiting on page data:text/html,BrowserDOM  to finished loading, timed out after 300000 ms
[task 2021-12-20T10:49:20.145Z] 10:09.47 Mozperftest failed to run: 
[task 2021-12-20T10:49:20.146Z] 10:09.47 URL failed to load, trying 4 more time(s): Failed waiting on page data:text/html,BrowserDOM  to finished loading, timed out after 300000 ms
[task 2021-12-20T10:54:21.149Z] 15:10.47 Mozperftest failed to run: 
[task 2021-12-20T10:54:21.149Z] 15:10.47 URL failed to load, trying 3 more time(s): Failed waiting on page data:text/html,BrowserDOM  to finished loading, timed out after 300000 ms
[taskcluster 2021-12-20T10:55:57.204Z] [taskcluster-proxy] Successfully refreshed taskcluster-proxy credentials: task-client/P0vB77UfQE6foKuNuJS44A/0/on/mdc1/t-linux64-ms-060/until/1639998957.182
[task 2021-12-20T10:59:22.152Z] 20:11.47 Mozperftest failed to run: 
[task 2021-12-20T10:59:22.153Z] 20:11.47 URL failed to load, trying 2 more time(s): Failed waiting on page data:text/html,BrowserDOM  to finished loading, timed out after 300000 ms
[task 2021-12-20T11:04:23.156Z] 25:12.48 Mozperftest failed to run: 
[task 2021-12-20T11:04:23.157Z] 25:12.48 URL failed to load, trying 1 more time(s): Failed waiting on page data:text/html,BrowserDOM  to finished loading, timed out after 300000 ms
[task 2021-12-20T11:09:24.159Z] 30:13.48 Mozperftest failed to run: 
[task 2021-12-20T11:09:24.160Z] 30:13.48 URL failed to load, trying 0 more time(s): Failed waiting on page data:text/html,BrowserDOM  to finished loading, timed out after 300000 ms
[task 2021-12-20T11:09:24.160Z] 30:13.48 Mozperftest failed to run: 
[task 2021-12-20T11:09:24.161Z] 30:13.48 Mozperftest failed to run: 
[task 2021-12-20T11:09:24.541Z] 30:13.86 data:text/html,BrowserDOM
[task 2021-12-20T11:09:24.546Z] 30:13.87 Wrote data to ../artifacts/browsertime-results-1
[task 2021-12-20T11:09:24.570Z] Traceback (most recent call last):
[task 2021-12-20T11:09:24.570Z]   File "python/mozperftest/mozperftest/runner.py", line 209, in <module>
[task 2021-12-20T11:09:24.570Z]     sys.exit(main())
[task 2021-12-20T11:09:24.570Z]   File "python/mozperftest/mozperftest/runner.py", line 205, in main
[task 2021-12-20T11:09:24.570Z]     run_tests(mach_cmd, args, user_args)
[task 2021-12-20T11:09:24.570Z]   File "python/mozperftest/mozperftest/runner.py", line 152, in run_tests
[task 2021-12-20T11:09:24.570Z]     e.run(metadata)
[task 2021-12-20T11:09:24.570Z]   File "/home/cltbld/tasks/task_163999664068175/fetches/python/mozperftest/mozperftest/environment.py", line 93, in run
[task 2021-12-20T11:09:24.570Z]     metadata = testlayer(syslayer(metadata))
[task 2021-12-20T11:09:24.570Z]   File "/home/cltbld/tasks/task_163999664068175/fetches/python/mozperftest/mozperftest/layers.py", line 156, in __call__
[task 2021-12-20T11:09:24.570Z]     metadata = layer(metadata)
[task 2021-12-20T11:09:24.570Z]   File "/home/cltbld/tasks/task_163999664068175/fetches/python/mozperftest/mozperftest/layers.py", line 68, in __call__
[task 2021-12-20T11:09:24.570Z]     metadata = self.run(metadata)
[task 2021-12-20T11:09:24.570Z]   File "/home/cltbld/tasks/task_163999664068175/fetches/python/mozperftest/mozperftest/test/browsertime/runner.py", line 350, in run
[task 2021-12-20T11:09:24.570Z]     metadata = self._one_cycle(metadata, result_dir)
[task 2021-12-20T11:09:24.570Z]   File "/home/cltbld/tasks/task_163999664068175/fetches/python/mozperftest/mozperftest/test/browsertime/runner.py", line 421, in _one_cycle
[task 2021-12-20T11:09:24.570Z]     raise NodeException(exit_code)
[task 2021-12-20T11:09:24.570Z] mozperftest.test.browsertime.runner.NodeException: 1

Comment 1

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

Set release status flags based on info from the regressing bug 1732358

Comment 2

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

Please investigate how to fix these.

Comment 3

[Alexandru Ionescu (needinfo me) [:alexandrui]]

Answered in the sheriffs channel.

Comment 4

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

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