Closed Bug 1780998 Opened 3 years ago Closed 2 months ago

Intermittent browser/components/extensions/test/browser/browser_ext_windows_update.js | single tracking bug

Categories

(WebExtensions :: Untriaged, defect, P5)

defect

Tracking

(firefox-esr91 unaffected, firefox-esr102 unaffected, firefox103 unaffected, firefox104 wontfix, firefox105 wontfix)

RESOLVED INCOMPLETE
Tracking Status
firefox-esr91 --- unaffected
firefox-esr102 --- unaffected
firefox103 --- unaffected
firefox104 --- wontfix
firefox105 --- wontfix

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, intermittent-testcase, regression, Whiteboard: [stockwell disabled])

Attachments

(1 file, 1 obsolete file)

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


[task 2022-07-25T00:47:01.600Z] 00:47:01     INFO - TEST-START | browser/components/extensions/test/browser/browser_ext_windows_update.js
[task 2022-07-25T00:47:01.608Z] 00:47:01     INFO - GECKO(1750) | [Parent 1750: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 16d33f800 == 35 [pid = 1750] [id = 559]
[task 2022-07-25T00:47:01.608Z] 00:47:01     INFO - GECKO(1750) | [Parent 1750: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 142 (1676b2c60) [pid = 1750] [serial = 1345] [outer = 0]
[task 2022-07-25T00:47:01.609Z] 00:47:01     INFO - GECKO(1750) | [Parent 1750: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 143 (1745c0c00) [pid = 1750] [serial = 1346] [outer = 1676b2c60]
[task 2022-07-25T00:47:01.614Z] 00:47:01     INFO - GECKO(1750) | [Parent 1750, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1357
[task 2022-07-25T00:47:01.854Z] 00:47:01     INFO - GECKO(1750) | [Parent 1750: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 185acc800 == 36 [pid = 1750] [id = 560]
[task 2022-07-25T00:47:01.855Z] 00:47:01     INFO - GECKO(1750) | [Parent 1750: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 144 (16e539600) [pid = 1750] [serial = 1347] [outer = 0]
[task 2022-07-25T00:47:01.855Z] 00:47:01     INFO - GECKO(1750) | [Parent 1750: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 145 (185acd800) [pid = 1750] [serial = 1348] [outer = 16e539600]
[task 2022-07-25T00:47:01.895Z] 00:47:01     INFO - GECKO(1750) | [Child 1758: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 11415f400 == 3 [pid = 1758] [id = 195]
[task 2022-07-25T00:47:01.895Z] 00:47:01     INFO - GECKO(1750) | [Child 1758: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (10b893650) [pid = 1758] [serial = 444] [outer = 0]
[task 2022-07-25T00:47:01.896Z] 00:47:01     INFO - GECKO(1750) | [Child 1758: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 7 (114161c00) [pid = 1758] [serial = 445] [outer = 10b893650]
[task 2022-07-25T00:47:01.911Z] 00:47:01     INFO - GECKO(1750) | [2022-07-25T00:47:01Z WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update

task 2022-07-25T00:47:07.715Z] 00:47:07     INFO - 
[task 2022-07-25T00:47:07.716Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected WINDOW_ID_CURRENT to refer to the same window - Expected: 3, Actual: 3 - 
[task 2022-07-25T00:47:07.716Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Got expected value for window.state - Expected: minimized, Actual: minimized - 
[task 2022-07-25T00:47:07.717Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected window state to be STATE_MINIMIZED - 
[task 2022-07-25T00:47:07.717Z] 00:47:07     INFO - Buffered messages logged at 00:47:05
[task 2022-07-25T00:47:07.718Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected WINDOW_ID_CURRENT to refer to the same window - Expected: 3, Actual: 3 - 
[task 2022-07-25T00:47:07.718Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected window.state (currently normal) to be "normal" but will accept "maximized" - 
[task 2022-07-25T00:47:07.719Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected windowState (currently 3) to be STATE_NORMAL but will accept STATE_MAXIMIZED - 
[task 2022-07-25T00:47:07.719Z] 00:47:07     INFO - Buffered messages logged at 00:47:07
[task 2022-07-25T00:47:07.720Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected WINDOW_ID_CURRENT to refer to the same window - Expected: 3, Actual: 3 - 
[task 2022-07-25T00:47:07.720Z] 00:47:07     INFO - Buffered messages finished
[task 2022-07-25T00:47:07.722Z] 00:47:07     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_windows_update.js | Got expected value for window.state - Expected: fullscreen, Actual: normal - 
[task 2022-07-25T00:47:07.722Z] 00:47:07     INFO - Stack trace:
[task 2022-07-25T00:47:07.722Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:test_ok:1400
[task 2022-07-25T00:47:07.722Z] 00:47:07     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:testHandler:83
[task 2022-07-25T00:47:07.722Z] 00:47:07     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:testResult:97
[task 2022-07-25T00:47:07.722Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersChild.jsm:listener:2020
[task 2022-07-25T00:47:07.722Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersChild.jsm:loadExtension/<:1950
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersChild.jsm:receiveMessage:253
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - JSActor query*resource://specialpowers/SpecialPowersParent.jsm:resultListener:1120
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - resource://gre/modules/ExtensionCommon.jsm:emit:320
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - resource://gre/modules/Extension.jsm:receiveMessage:2535
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - MessageListener.receiveMessage*resource://gre/modules/Extension.jsm:Extension:2339
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - resource://testing-common/ExtensionTestCommon.jsm:generate:673
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersParent.jsm:receiveMessage:1117
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - JSActor query*resource://specialpowers/SpecialPowersChild.jsm:loadExtension:2012
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension:128
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_windows_update.js:testWindowUpdate:52
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:handleTask:988
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1060
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1195
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:977
[task 2022-07-25T00:47:07.723Z] 00:47:07     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2022-07-25T00:47:07.724Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected window state to be STATE_FULLSCREEN - 
[task 2022-07-25T00:47:07.724Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected WINDOW_ID_CURRENT to refer to the same window - Expected: 3, Actual: 3 - 
[task 2022-07-25T00:47:07.725Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected window.state (currently normal) to be "normal" but will accept "maximized" - 
[task 2022-07-25T00:47:07.725Z] 00:47:07     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected windowState (currently 4) to be STATE_NORMAL but will accept STATE_MAXIMIZED - 
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - Stack trace:
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:test_ok:1400
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_windows_update.js:testWindowUpdate/<:153
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:testMessage:103
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersChild.jsm:listener:2020
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersChild.jsm:loadExtension/<:1950
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersChild.jsm:receiveMessage:253
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - JSActor query*resource://specialpowers/SpecialPowersParent.jsm:messageListener:1129
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - resource://gre/modules/ExtensionCommon.jsm:emit:320
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - resource://gre/modules/Extension.jsm:receiveMessage:2535
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - MessageListener.receiveMessage*resource://gre/modules/Extension.jsm:Extension:2339
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - resource://testing-common/ExtensionTestCommon.jsm:generate:673
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - resource://specialpowers/SpecialPowersParent.jsm:receiveMessage:1117
[task 2022-07-25T00:47:07.727Z] 00:47:07     INFO - JSActor query*resource://specialpowers/SpecialPowersChild.jsm:loadExtension:2012
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension:128
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_windows_update.js:testWindowUpdate:52
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:handleTask:988
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1060
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1195
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:977
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2022-07-25T00:47:07.728Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | window-update - 
[task 2022-07-25T00:47:07.729Z] 00:47:07     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | test result correct - 
[task 2022-07-25T00:47:07.729Z] 00:47:07     INFO - GECKO(1750) | [Child 1751, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-07-25T00:47:07.730Z] 00:47:07     INFO - GECKO(1750) | [Child 1751, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-07-25T00:47:07.730Z] 00:47:07     INFO - Leaving test bound testWindowUpdate

This macOS debug issue seems like fundamentally the same issue as bug 1780876, so I'll look into this there.

Depends on: 1780876
Flags: needinfo?(emilio)

Update:

There have been 33 failures within the last 7 days, all of them on OS X 10.15 WebRender debug.

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=399960977&repo=mozilla-central&lineNumber=47763

There have been 32 total failures in the last 7 days, recent failure log.
Affected platforms are:

  • macosx1015-64-qr
[task 2023-01-09T19:45:37.884Z] 19:45:37     INFO - Buffered messages logged at 19:45:37
[task 2023-01-09T19:45:37.885Z] 19:45:37     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected WINDOW_ID_CURRENT to refer to the same window - Expected: 3, Actual: 3 - 
[task 2023-01-09T19:45:37.885Z] 19:45:37     INFO - Buffered messages finished
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_windows_update.js | Got expected value for window.state - Expected: fullscreen, Actual: normal - 
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - Stack trace:
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - chrome://mochikit/content/browser-test.js:test_ok:1449
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:testHandler:83
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:testResult:97
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - resource://specialpowers/SpecialPowersChild.sys.mjs:listener:1989
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - resource://specialpowers/SpecialPowersChild.sys.mjs:loadExtension/<:1919
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - resource://specialpowers/SpecialPowersChild.sys.mjs:receiveMessage:222
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - JSActor query*resource://specialpowers/SpecialPowersParent.sys.mjs:resultListener:1113
[task 2023-01-09T19:45:37.887Z] 19:45:37     INFO - resource://gre/modules/ExtensionCommon.jsm:emit:323
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - resource://gre/modules/Extension.jsm:receiveMessage:2665
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - MessageListener.receiveMessage*resource://gre/modules/Extension.jsm:Extension:2469
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - resource://testing-common/ExtensionTestCommon.jsm:generate:691
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - resource://specialpowers/SpecialPowersParent.sys.mjs:receiveMessage:1110
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - JSActor query*resource://specialpowers/SpecialPowersChild.sys.mjs:loadExtension:1981
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension:128
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_windows_update.js:testWindowUpdate:52
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - chrome://mochikit/content/browser-test.js:handleTask:1037
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1109
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1244
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1026
[task 2023-01-09T19:45:37.888Z] 19:45:37     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1036
[task 2023-01-09T19:45:37.889Z] 19:45:37     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_windows_update.js | Expected window state to be STATE_FULLSCREEN - 
Flags: needinfo?(tomica)
Whiteboard: [stockwell needswork:owner]

There have been 39 total failures in the last 7 days, recent failure log.
Affected platforms are:

  • macosx1015-64-qr

There have been 37 total failures in the last 7 days, recent failure log.
Affected platforms are:

  • macosx1015-64-qr

There have been 38 total failures in the last 7 days, recent failure log.
Affected platforms are:

  • macosx1015-64-qr

Shane, any chance you could help us assign this to someone?
Thank you.

Flags: needinfo?(mixedpuppy)
Assignee: nobody → sstanca
Status: NEW → ASSIGNED

Hello Shane! Could you please take a look at this bug or redirect to someone else? It has 174 failures in the last 30 days and made a disable patch until there's a fix in place.

Thank you!

I am going to take a look.

Flags: needinfo?(tomica)
Flags: needinfo?(mixedpuppy)

William, any updates here? Should we disable this until there's a fix?

Flags: needinfo?(wdurand)
Pushed by sstanca@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/762bd70d6ab0 disable browser_ext_windows_update.js on mac 10.15 debug. r=intermittent-reviewers,jmaher
Assignee: sstanca → nobody
Status: ASSIGNED → NEW
Keywords: leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]

Sorry, I didn't have bandwidth for this intermittent. Thanks for disabling it, I'll still plan to take a look.

Flags: needinfo?(wdurand)
Attachment #9386224 - Attachment is obsolete: true
Status: NEW → RESOLVED
Closed: 7 months ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 7 months ago2 months ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: