1718424 - Intermittent tp5o_webext | Timeout in tp5n

Status: RESOLVED INCOMPLETE

(Testing :: Talos, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2021-06-26T23:12:17.831Z] 23:12:17     INFO -  TEST-INFO | started process 9616 (C:\Users\task_1624737010\build\application\firefox\firefox -wait-for-browser -no-deelevate -profile C:\Users\task_1624737010\AppData\Local\Temp\tmpvjdaawe0\profile)
[task 2021-06-26T23:12:17.987Z] 23:12:17     INFO -  PID 9616 | MOZ_EVENT_TRACE start 1624749137987
[task 2021-06-26T23:12:24.318Z] 23:12:24     INFO -  PID 9616 | __WARNTimeout (1/3) exceeded on http://163.com-talos/tests/tp5n/163.com/www.163.com/index.html__WARN
[task 2021-06-26T23:12:29.575Z] 23:12:29     INFO -  PID 9616 | __WARNTimeout (2/3) exceeded on http://163.com-talos/tests/tp5n/163.com/www.163.com/index.html__WARN
[task 2021-06-26T23:12:34.832Z] 23:12:34     INFO -  PID 9616 | __FAILTimeout in tp5n__FAIL
[task 2021-06-26T23:12:34.832Z] 23:12:34     INFO -  PID 9616 | __FAILTimeout (3/3) exceeded on http://163.com-talos/tests/tp5n/163.com/www.163.com/index.html__FAIL
[task 2021-06-26T23:12:48.519Z] 23:12:48     INFO -  PID 9616 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"SessionStore: flushing all windows","state":{"total":1,"current":0},"filename":"resource:///modules/sessionstore/SessionStore.jsm","lineNumber":2001,"stack":["resource:///modules/sessionstore/SessionStore.jsm:ssi_onQuitApplicationGranted:2001","resource:///modules/sessionstore/SessionStore.jsm:ssi_observe:954","chrome://pageloader/content/quit.js:goQuitApplication:66","chrome://pageloader/content/pageloader.js:plStopAll:936","chrome://pageloader/content/pageloader.js:plStop:881","chrome://pageloader/content/pageloader.js:loadFail/<:450"]}] Barrier: quit-application-granted
[task 2021-06-26T23:13:29.557Z] 23:13:29     INFO -  PID 9616 | MOZ_EVENT_TRACE stop 1624749209556
[task 2021-06-26T23:13:39.576Z] 23:13:39     INFO -  PID 9616 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ContentParent: id=238001ee800","state":{"remoteTypePrefix":"web"},"filename":"/builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp","lineNumber":3513,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162","chrome://global/content/elements/browser-custom-element.js:get loadContext:386","chrome://global/content/elements/browser-custom-element.js:construct:1005","chrome://global/content/elements/browser-custom-element.js:connectedCallback:324","chrome://browser/content/tabbrowser.js:_setupInitialBrowserAndTab:408","chrome://browser/content/tabbrowser.js:init:50","chrome://browser/content/browser.js:onDOMContentLoaded:1682"]}] Barrier: profile-before-change
[task 2021-06-26T23:13:44.526Z] 23:13:44     INFO -  PID 9616 | console.error: (new Error("SessionFile is closed", "resource:///modules/sessionstore/SessionFile.jsm", 433))
[task 2021-06-26T23:13:49.539Z] 23:13:49     INFO -  PID 9616 |
[task 2021-06-26T23:13:49.540Z] 23:13:49     INFO -  PID 9616 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x390076,name=PContent::Msg_DestroyBrowsingContextGroup) Channel error: cannot send/recv
[task 2021-06-26T23:13:49.540Z] 23:13:49     INFO -  PID 9616 |
[task 2021-06-26T23:13:49.629Z] 23:13:49     INFO -  TEST-INFO | 9616: exit 0
[task 2021-06-26T23:13:49.701Z] 23:13:49     INFO -  mozcrash checking C:\Users\task_1624737010\AppData\Local\Temp\tmpvjdaawe0\profile\minidumps for minidumps...
[task 2021-06-26T23:13:49.701Z] 23:13:49     INFO -  TEST-UNEXPECTED-ERROR | tp5o_webext | Timeout in tp5n
[task 2021-06-26T23:13:49.702Z] 23:13:49    ERROR -  Traceback (most recent call last):
[task 2021-06-26T23:13:49.702Z] 23:13:49     INFO -    File "C:\Users\task_1624737010\build\tests\talos\talos\run_tests.py", line 336, in run_tests
[task 2021-06-26T23:13:49.702Z] 23:13:49     INFO -      talos_results.add(mytest.runTest(browser_config, test))
[task 2021-06-26T23:13:49.703Z] 23:13:49     INFO -    File "C:\Users\task_1624737010\build\tests\talos\talos\ttest.py", line 65, in runTest
[task 2021-06-26T23:13:49.703Z] 23:13:49     INFO -      return self._runTest(browser_config, test_config, setup)
[task 2021-06-26T23:13:49.703Z] 23:13:49     INFO -    File "C:\Users\task_1624737010\build\tests\talos\talos\ttest.py", line 274, in _runTest
[task 2021-06-26T23:13:49.704Z] 23:13:49     INFO -      counter_management.results() if counter_management else None
[task 2021-06-26T23:13:49.704Z] 23:13:49     INFO -    File "C:\Users\task_1624737010\build\tests\talos\talos\results.py", line 95, in add
[task 2021-06-26T23:13:49.704Z] 23:13:49     INFO -      global_counters=self.global_counters,
[task 2021-06-26T23:13:49.705Z] 23:13:49     INFO -    File "C:\Users\task_1624737010\build\tests\talos\talos\results.py", line 343, in __init__
[task 2021-06-26T23:13:49.705Z] 23:13:49     INFO -      self.error(match.group(1))
[task 2021-06-26T23:13:49.705Z] 23:13:49     INFO -    File "C:\Users\task_1624737010\build\tests\talos\talos\results.py", line 357, in error
[task 2021-06-26T23:13:49.705Z] 23:13:49     INFO -      raise utils.TalosError(message)
[task 2021-06-26T23:13:49.706Z] 23:13:49     INFO -  talos.utils.TalosError: Timeout in tp5n
[task 2021-06-26T23:13:49.706Z] 23:13:49     INFO -  TEST-INFO took 95656ms
[task 2021-06-26T23:13:49.706Z] 23:13:49     INFO -  SUITE-END | took 217s
[task 2021-06-26T23:13:49.988Z] 23:13:49    ERROR - Return code: 2
[task 2021-06-26T23:13:49.988Z] 23:13:49  WARNING - setting return code to 2
[task 2021-06-26T23:13:49.988Z] 23:13:49    ERROR - # TBPL FAILURE #

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 2

Platform and build breakdown:

• windows10-64-shippable-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1718424&startday=2021-06-21&endday=2021-06-27&tree=all

Comment 2

[Intermittent Failures Robot]

3 failures in 723 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 3

Platform and build breakdown:

• windows10-64-shippable-qr: 3
  • opt: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1718424&startday=2021-06-28&endday=2021-07-04&tree=all

Comment 3

[Intermittent Failures Robot]

1 failures in 2387 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-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1718424&startday=2021-07-05&endday=2021-07-11&tree=all

Comment 4

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

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