1764446 - Intermittent TEST-UNEXPECTED-TIMEOUT | toolkit/xre/test/test_install_hash.js | Test timed out

Status: RESOLVED DUPLICATE of bug 1781459

(Toolkit :: Startup and Profile System, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2022-04-12T21:20:57.019Z] 21:20:57     INFO -  TEST-START | toolkit/xre/test/test_install_hash.js
[task 2022-04-12T21:25:57.072Z] 21:25:57  WARNING -  TEST-UNEXPECTED-TIMEOUT | toolkit/xre/test/test_install_hash.js | Test timed out
[task 2022-04-12T21:25:57.072Z] 21:25:57     INFO -  TEST-INFO took 300052ms
[task 2022-04-12T21:25:57.072Z] 21:25:57     INFO -  >>>>>>>
[task 2022-04-12T21:25:57.072Z] 21:25:57     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2022-04-12T21:25:57.073Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2022-04-12T21:25:57.073Z] 21:25:57     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2022-04-12T21:25:57.074Z] 21:25:57     INFO -  running event loop
[task 2022-04-12T21:25:57.074Z] 21:25:57     INFO -  toolkit/xre/test/test_install_hash.js | Starting testSameBinary
[task 2022-04-12T21:25:57.074Z] 21:25:57     INFO -  (xpcshell/head.js) | test testSameBinary pending (2)
[task 2022-04-12T21:25:57.074Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2022-04-12T21:25:57.074Z] 21:25:57     INFO -  TEST-PASS | toolkit/xre/test/test_install_hash.js | testSameBinary - [testSameBinary : 73] Should have the same hash when running the same binary. - "94581CCFA43E1AE9" == "94581CCFA43E1AE9"
[task 2022-04-12T21:25:57.075Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 1 pending (2)
[task 2022-04-12T21:25:57.075Z] 21:25:57     INFO -  (xpcshell/head.js) | test testSameBinary finished (2)
[task 2022-04-12T21:25:57.075Z] 21:25:57     INFO -  toolkit/xre/test/test_install_hash.js | Starting testUpperCase
[task 2022-04-12T21:25:57.076Z] 21:25:57     INFO -  (xpcshell/head.js) | test testUpperCase pending (2)
[task 2022-04-12T21:25:57.076Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 1 finished (2)
[task 2022-04-12T21:25:57.077Z] 21:25:57     INFO -  TEST-PASS | toolkit/xre/test/test_install_hash.js | testUpperCase - [testUpperCase : 86] Should have seen the same hash from Z:\\TASK_1649795805\\BUILD\\APPLICATION\\FIREFOX\\XPCSHELL.EXE. - "94581CCFA43E1AE9" == "94581CCFA43E1AE9"
[task 2022-04-12T21:25:57.077Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 2 pending (2)
[task 2022-04-12T21:25:57.077Z] 21:25:57     INFO -  (xpcshell/head.js) | test testUpperCase finished (2)
[task 2022-04-12T21:25:57.078Z] 21:25:57     INFO -  toolkit/xre/test/test_install_hash.js | Starting testLowerCase
[task 2022-04-12T21:25:57.078Z] 21:25:57     INFO -  (xpcshell/head.js) | test testLowerCase pending (2)
[task 2022-04-12T21:25:57.079Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 2 finished (2)
[task 2022-04-12T21:25:57.079Z] 21:25:57     INFO -  TEST-PASS | toolkit/xre/test/test_install_hash.js | testLowerCase - [testLowerCase : 100] Should have seen the same hash from Z:\\task_1649795805\\build\\application\\firefox\\xpcshell.exe. - "94581CCFA43E1AE9" == "94581CCFA43E1AE9"
[task 2022-04-12T21:25:57.079Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 3 pending (2)
[task 2022-04-12T21:25:57.080Z] 21:25:57     INFO -  (xpcshell/head.js) | test testLowerCase finished (2)
[task 2022-04-12T21:25:57.080Z] 21:25:57     INFO -  toolkit/xre/test/test_install_hash.js | Starting testEachPart
[task 2022-04-12T21:25:57.080Z] 21:25:57     INFO -  (xpcshell/head.js) | test testEachPart pending (2)
[task 2022-04-12T21:25:57.081Z] 21:25:57     INFO -  (xpcshell/head.js) | test run_next_test 3 finished (2)
[task 2022-04-12T21:25:57.081Z] 21:25:57     INFO -  TEST-PASS | toolkit/xre/test/test_install_hash.js | testEachPart - [testEachPart : 123] Should have seen the same hash from Z:\\task_1649795805\\build\\application\\firefox\\XPCSHELL.EXE. - "94581CCFA43E1AE9" == "94581CCFA43E1AE9"
[task 2022-04-12T21:25:57.082Z] 21:25:57     INFO -  <<<<<<<
[task 2022-04-12T21:25:57.171Z] 21:25:57     INFO -  xpcshell return code: None
[task 2022-04-12T21:42:37.200Z] 21:42:37     INFO - Automation Error: mozprocess timed out after 1000 seconds running ['Z:\\task_1649795805\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_1649795805\\build\\tests\\xpcshell\\runxpcshelltests.py', 'browser/components/about/test/unit/xpcshell.ini', 'browser/components/enterprisepolicies/tests/xpcshell/xpcshell.ini', 'browser/components/pagedata/tests/unit/xpcshell.ini', 'browser/components/places/tests/unit/xpcshell.ini', 'browser/components/search/test/unit/xpcshell.ini', 'browser/components/shell/test/unit/xpcshell.ini', 'browser/components/syncedtabs/test/xpcshell/xpcshell.ini', 'browser/components/tests/unit/xpcshell.ini', 'browser/extensions/formautofill/test/unit/heuristics/xpcshell.ini', 'browser/modules/test/unit/xpcshell.ini', 'caps/tests/unit/xpcshell.ini', 'chrome/test/unit_ipc/xpcshell.ini', 'devtools/client/inspector/changes/test/xpcshell/xpcshell.ini', 'devtools/client/inspector/compatibility/test/xpcshell/xpcshell.ini', 'devtools/client/shared/remote-debugging/adb/xpcshell/xpcshell.ini', 'devtools/client/shared/test/xpcshell/xpcshell.ini', 'devtools/shared/transport/tests/xpcshell/xpcshell.ini', 'docshell/test/unit_ipc/xpcshell.ini', 'dom/quota/test/xpcshell/caching/xpcshell.ini', 'extensions/pref/autoconfig/test/unit/xpcshell.ini', 'image/test/unit/xpcshell.ini', 'intl/benchmarks/xpcshell.ini', 'mobile/android/components/extensions/test/xpcshell/xpcshell.ini', 'netwerk/cookie/test/unit/xpcshell.ini', 'netwerk/dns/tests/unit/xpcshell.ini', 'remote/shared/messagehandler/test/xpcshell/xpcshell.ini', 'services/fxaccounts/tests/xpcshell/xpcshell.ini', 'services/sync/tests/unit/xpcshell.ini', 'testing/xpcshell/example/unit/xpcshell-with-prefs.ini', 'testing/xpcshell/example/unit/xpcshell.ini', 'toolkit/components/aboutmemory/tests/xpcshell/xpcshell.ini', 'toolkit/components/backgroundhangmonitor/tests/xpcshell.ini', 'toolkit/components/extensions/test/xpcshell/native_messaging.ini', 'toolkit/components/extensions/test/xpcshell/webidl-api/xpcshell.ini', 'toolkit/components/extensions/test/xpcshell/xpcshell-e10s.ini', 'toolkit/components/extensions/test/xpcshell/xpcshell-remote.ini', 'toolkit/components/extensions/test/xpcshell/xpcshell.ini', 'toolkit/components/forgetaboutsite/test/unit/xpcshell.ini', 'toolkit/components/lz4/tests/xpcshell/xpcshell.ini', 'toolkit/components/mozintl/test/xpcshell.ini', 'toolkit/components/nimbus/test/unit/xpcshell.ini', 'toolkit/components/passwordmgr/test/unit/xpcshell.ini', 'toolkit/components/places/tests/favicons/xpcshell.ini', 'toolkit/components/places/tests/history/xpcshell.ini', 'toolkit/components/places/tests/migration/xpcshell.ini', 'toolkit/components/places/tests/unit/xpcshell.ini', 'toolkit/components/telemetry/tests/unit/xpcshell.ini', 'toolkit/components/terminator/tests/xpcshell/xpcshell.ini', 'toolkit/components/timermanager/tests/unit/xpcshell.ini', 'toolkit/components/url-classifier/tests/unit/xpcshell.ini', 'toolkit/components/urlformatter/tests/unit/xpcshell.ini', 'toolkit/components/utils/test/unit/xpcshell.ini', 'toolkit/components/windowcreator/tests/unit/xpcshell.ini', 'toolkit/components/xulstore/tests/xpcshell/xpcshell.ini', 'toolkit/content/tests/unit/xpcshell.ini', 'toolkit/mozapps/update/tests/unit_background_update/xpcshell.ini', 'toolkit/xre/test/xpcshell.ini', 'tools/profiler/tests/xpcshell/xpcshell.ini', 'widget/tests/unit/xpcshell.ini', '--setpref=network.process.enabled=true', '--setpref=network.http.network_access_on_socket_process.enabled=true', '--setpref=network.ssl_tokens_cache_enabled=true', '--setpref=fission.autostart=true', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--self-test', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EnwuZn7pQGGjKO2pCaqCwA/artifacts/public/build/target.crashreporter-symbols.zip', '--test-plugin-path=Z:\\task_1649795805\\build\\application\\firefox\\plugins', '--log-raw=Z:\\task_1649795805\\build\\blobber_upload_dir\\xpcshell_raw.log', '--log-errorsummary=Z:\\task_1649795805\\build\\blobber_upload_dir\\xpcshell_errorsummary.log', '--utility-path=tests/bin', '--xpcshell=Z:\\task_1649795805\\build\\application\\firefox/xpcshell.exe', '--manifest=tests/xpcshell/tests/xpcshell.ini']
[task 2022-04-12T21:42:37.206Z] 21:42:37    ERROR - timed out after 1000 seconds of no output
[task 2022-04-12T21:42:37.207Z] 21:42:37    ERROR - Return code: 572
[task 2022-04-12T21:42:37.207Z] 21:42:37    ERROR - No tests run or test summary not found

Comment 1

[Natalia Csoregi [:nataliaCs]]

First occurrence: https://treeherder.mozilla.org/jobs?repo=autoland&searchStr=Windows%2C7%2CWebRender%2CShippable%2Copt%2CXpcshell%2Ctests%2Cwith%2Cnetworking%2Con%2Csocket%2Cprocess%2Ctest-windows7-32-shippable-qr%2Fopt-xpcshell-spi-nw-fis-e10s%2CX1&tochange=859502846859e9b8633d24ea692d54dd03cb5877&fromchange=4e8d20735e547a8fc1fa8a9e94e671ef8b5e934e&group_state=expanded&selectedTaskRun=acs523VkQeifJZps-AtxBQ.0

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• windows7-32-shippable-qr: 1
  • opt: 1
• windows7-32-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1764446&startday=2022-04-11&endday=2022-04-17&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• comm-central: 2

Platform and build breakdown:

• windows10-64-2004-qr: 2
  • debug: 1
  • opt: 1

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64-2004-ccov-qr: 1
  • opt: 1

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