Closed Bug 1616905 Opened 5 years ago Closed 3 years ago

Intermittent browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The screen.height has a correct rounded value - 100 == 600 - got 100, expected 600 (operator ==)

Categories

(Core :: Security, defect, P5)

Product:
Core
Component:
Security
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1775701

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

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

[task 2020-02-20T16:49:53.096Z] 16:49:53 INFO - TEST-START | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js
[task 2020-02-20T16:49:55.478Z] 16:49:55 INFO - TEST-INFO | started process screentopng
[task 2020-02-20T16:49:55.763Z] 16:49:55 INFO - TEST-INFO | screentopng: exit 0
[task 2020-02-20T16:49:55.764Z] 16:49:55 INFO - Buffered messages logged at 16:49:53
[task 2020-02-20T16:49:55.765Z] 16:49:55 INFO - Entering test bound
[task 2020-02-20T16:49:55.766Z] 16:49:55 INFO - Buffered messages logged at 16:49:54
[task 2020-02-20T16:49:55.767Z] 16:49:55 INFO - Leaving test bound
[task 2020-02-20T16:49:55.768Z] 16:49:55 INFO - Entering test bound
[task 2020-02-20T16:49:55.769Z] 16:49:55 INFO - Buffered messages logged at 16:49:55
[task 2020-02-20T16:49:55.770Z] 16:49:55 INFO - TEST-PASS | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The screen.width has a correct rounded value - 600 == 600 -
[task 2020-02-20T16:49:55.771Z] 16:49:55 INFO - TEST-PASS | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The window.innerWidth has a correct rounded value - 600 == 600 -
[task 2020-02-20T16:49:55.772Z] 16:49:55 INFO - Buffered messages finished
[task 2020-02-20T16:49:55.773Z] 16:49:55 INFO - TEST-UNEXPECTED-FAIL | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The screen.height has a correct rounded value - 100 == 600 - got 100, expected 600 (operator ==)
[task 2020-02-20T16:49:55.774Z] 16:49:55 INFO - Stack trace:
[task 2020-02-20T16:49:55.775Z] 16:49:55 INFO - is@resource://specialpowers/SpecialPowersSandbox.jsm:89:21
[task 2020-02-20T16:49:55.775Z] 16:49:55 INFO - @chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:278:13
[task 2020-02-20T16:49:55.776Z] 16:49:55 INFO - EventListener.handleEvent*@chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:275:11
[task 2020-02-20T16:49:55.778Z] 16:49:55 INFO - @chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:274:11
[task 2020-02-20T16:49:55.779Z] 16:49:55 INFO - asyncexecute@resource://specialpowers/SpecialPowersSandbox.jsm:140:12
[task 2020-02-20T16:49:55.780Z] 16:49:55 INFO - _spawnTask@resource://specialpowers/SpecialPowersChild.jsm:1727:15
[task 2020-02-20T16:49:55.781Z] 16:49:55 INFO - receiveMessage@resource://specialpowers/SpecialPowersChild.jsm:285:21
[task 2020-02-20T16:49:55.782Z] 16:49:55 INFO - JSWindowActor queryreceiveMessage@resource://specialpowers/SpecialPowersParent.jsm:1055:12
[task 2020-02-20T16:49:55.783Z] 16:49:55 INFO - JSWindowActor queryspawn@resource://specialpowers/SpecialPowersChild.jsm:1682:17
[task 2020-02-20T16:49:55.784Z] 16:49:55 INFO - testWindowSizeSetting@chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:221:23
[task 2020-02-20T16:49:55.785Z] 16:49:55 INFO - doTest@chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:372:11
[task 2020-02-20T16:49:55.786Z] 16:49:55 INFO - doTests@chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:359:18
[task 2020-02-20T16:49:55.786Z] 16:49:55 INFO - asyncrun/<@chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:317:20
[task 2020-02-20T16:49:55.787Z] 16:49:55 INFO - Tester_execTest/<@chrome://mochikit/content/browser-test.js:1062:34
[task 2020-02-20T16:49:55.788Z] 16:49:55 INFO - async*Tester_execTest@chrome://mochikit/content/browser-test.js:1097:11
[task 2020-02-20T16:49:55.789Z] 16:49:55 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:925:14
[task 2020-02-20T16:49:55.790Z] 16:49:55 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:914:23
[task 2020-02-20T16:49:55.791Z] 16:49:55 INFO - Not taking screenshot here: see the one that was previously logged

See Also: → 1627059

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

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE

Recent log:
https://treeherder.mozilla.org/logviewer?job_id=327505435&repo=autoland&lineNumber=2956

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 4 years ago → 4 years ago
Resolution: --- → INCOMPLETE

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

[task 2021-07-31T22:13:12.426Z] 22:13:12     INFO - TEST-START | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js
[task 2021-07-31T22:13:12.447Z] 22:13:12     INFO - GECKO(5589) | [Parent 5589, Main Thread] WARNING: Ignoring duplicate observer.: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:2612
[task 2021-07-31T22:13:12.583Z] 22:13:12     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fd854704400 == 2 [pid = 5807] [id = 45]
[task 2021-07-31T22:13:12.584Z] 22:13:12     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7fd855142200) [pid = 5807] [serial = 127] [outer = 0]
[task 2021-07-31T22:13:12.586Z] 22:13:12     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (7fd854705400) [pid = 5807] [serial = 128] [outer = 7fd855142200]
[task 2021-07-31T22:13:12.824Z] 22:13:12     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (7fd85470b800) [pid = 5807] [serial = 129] [outer = 7fd855142200]
[task 2021-07-31T22:13:13.060Z] 22:13:13     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fd854707c00 == 3 [pid = 5807] [id = 46]
[task 2021-07-31T22:13:13.061Z] 22:13:13     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (7fd855c07580) [pid = 5807] [serial = 130] [outer = 0]
[task 2021-07-31T22:13:13.064Z] 22:13:13     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 7 (7fd854709000) [pid = 5807] [serial = 131] [outer = 7fd855c07580]
[task 2021-07-31T22:13:13.081Z] 22:13:13     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f161a20d000 == 37 [pid = 5589] [id = 165]
<...>
[task 2021-07-31T22:13:18.637Z] 22:13:18     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 20 (7fd856724400) [pid = 5807] [serial = 144] [outer = 7fd855832580]
[task 2021-07-31T22:13:19.575Z] 22:13:19     INFO - TEST-INFO | started process screentopng
[task 2021-07-31T22:13:19.903Z] 22:13:19     INFO - TEST-INFO | screentopng: exit 0
[task 2021-07-31T22:13:19.903Z] 22:13:19     INFO - Buffered messages logged at 22:13:12
[task 2021-07-31T22:13:19.911Z] 22:13:19     INFO - Entering test bound 
[task 2021-07-31T22:13:19.911Z] 22:13:19     INFO - Buffered messages logged at 22:13:15
[task 2021-07-31T22:13:19.911Z] 22:13:19     INFO - Leaving test bound 
[task 2021-07-31T22:13:19.912Z] 22:13:19     INFO - Entering test bound 
[task 2021-07-31T22:13:19.912Z] 22:13:19     INFO - Buffered messages logged at 22:13:18
[task 2021-07-31T22:13:19.913Z] 22:13:19     INFO - TEST-PASS | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The screen.width has a correct rounded value - 600 == 600 - 
[task 2021-07-31T22:13:19.913Z] 22:13:19     INFO - TEST-PASS | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The window.innerWidth has a correct rounded value - 600 == 600 - 
[task 2021-07-31T22:13:19.913Z] 22:13:19     INFO - Buffered messages finished
[task 2021-07-31T22:13:19.914Z] 22:13:19     INFO - TEST-UNEXPECTED-FAIL | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The screen.height has a correct rounded value - 100 == 600 - got 100, expected 600 (operator ==)
[task 2021-07-31T22:13:19.914Z] 22:13:19     INFO - Stack trace:
[task 2021-07-31T22:13:19.914Z] 22:13:19     INFO - is@resource://specialpowers/SpecialPowersSandbox.jsm:90:21
[task 2021-07-31T22:13:19.914Z] 22:13:19     INFO - @chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:461:13
[task 2021-07-31T22:13:19.914Z] 22:13:19     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-31T22:13:19.916Z] 22:13:19     INFO - TEST-UNEXPECTED-FAIL | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The window.innerHeight has a correct rounded value - 100 == 600 - got 100, expected 600 (operator ==)
[task 2021-07-31T22:13:19.916Z] 22:13:19     INFO - Stack trace:
[task 2021-07-31T22:13:19.916Z] 22:13:19     INFO - is@resource://specialpowers/SpecialPowersSandbox.jsm:90:21
[task 2021-07-31T22:13:19.916Z] 22:13:19     INFO - @chrome://mochitests/content/browser/browser/components/resistfingerprinting/test/browser/head.js:466:13
[task 2021-07-31T22:13:19.917Z] 22:13:19     INFO - GECKO(5589) | [Parent 5589, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:370
[task 2021-07-31T22:13:19.918Z] 22:13:19     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fd856727400 == 8 [pid = 5807] [id = 51]
[task 2021-07-31T22:13:19.919Z] 22:13:19     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 21 (7fd8558323c0) [pid = 5807] [serial = 145] [outer = 0]
[task 2021-07-31T22:13:19.920Z] 22:13:19     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 22 (7fd856729400) [pid = 5807] [serial = 146] [outer = 7fd8558323c0]
[task 2021-07-31T22:13:19.921Z] 22:13:19     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f16109aec00 == 45 [pid = 5589] [id = 173]
[task 2021-07-31T22:13:19.922Z] 22:13:19     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 343 (7f1610972200) [pid = 5589] [serial = 350] [outer = 0]
[task 2021-07-31T22:13:19.923Z] 22:13:19     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 344 (7f16109a9800) [pid = 5589] [serial = 351] [outer = 7f1610972200]
[task 2021-07-31T22:13:19.924Z] 22:13:19     INFO - GECKO(5589) | [Parent 5589, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4227
[task 2021-07-31T22:13:20.073Z] 22:13:20     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f1620b66000 == 46 [pid = 5589] [id = 174]
[task 2021-07-31T22:13:20.074Z] 22:13:20     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 345 (7f161c16b580) [pid = 5589] [serial = 352] [outer = 0]
[task 2021-07-31T22:13:20.120Z] 22:13:20     INFO - GECKO(5589) | Warning: asking to enable_gpu_markers but no supporting extension was found
[task 2021-07-31T22:13:20.283Z] 22:13:20     INFO - GECKO(5589) | [Parent 5589, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4225
[task 2021-07-31T22:13:20.291Z] 22:13:20     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 346 (7f1610c3d000) [pid = 5589] [serial = 353] [outer = 7f161c16b580]
[task 2021-07-31T22:13:20.377Z] 22:13:20     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 23 (7fd85512c400) [pid = 5807] [serial = 147] [outer = 7fd8558323c0]
[task 2021-07-31T22:13:20.779Z] 22:13:20     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7fd854703c00 == 7 [pid = 5807] [id = 44] [url = about:blank]
[task 2021-07-31T22:13:20.845Z] 22:13:20     INFO - GECKO(5589) | [Child 5663: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 6 (7f2ed3372c00) [pid = 5663] [serial = 185] [outer = 0] [url = about:blank]
[task 2021-07-31T22:13:20.847Z] 22:13:20     INFO - GECKO(5589) | [Child 5663: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (7f2ed3c8c800) [pid = 5663] [serial = 173] [outer = 0] [url = http://example.net/browser/browser/components/resistfingerprinting/test/browser/file_dummy.html]
[task 2021-07-31T22:13:20.847Z] 22:13:20     INFO - GECKO(5589) | [Child 5663: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (7f2ed4c4a400) [pid = 5663] [serial = 188] [outer = 0] [url = about:blank]
[task 2021-07-31T22:13:20.848Z] 22:13:20     INFO - GECKO(5589) | [Child 5663: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7f2ed336bc00) [pid = 5663] [serial = 182] [outer = 0] [url = about:blank]
[task 2021-07-31T22:13:20.848Z] 22:13:20     INFO - GECKO(5589) | [Child 5663: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f2ed4c4fc00) [pid = 5663] [serial = 191] [outer = 0] [url = about:blank]
[task 2021-07-31T22:13:21.135Z] 22:13:21     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fd85470c400 == 8 [pid = 5807] [id = 52]
[task 2021-07-31T22:13:21.136Z] 22:13:21     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 24 (7fd855832740) [pid = 5807] [serial = 148] [outer = 0]
[task 2021-07-31T22:13:21.137Z] 22:13:21     INFO - GECKO(5589) | [Child 5807: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 25 (7fd854710800) [pid = 5807] [serial = 149] [outer = 7fd855832740]
[task 2021-07-31T22:13:21.219Z] 22:13:21     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f161b36a800 == 47 [pid = 5589] [id = 175]
[task 2021-07-31T22:13:21.219Z] 22:13:21     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 347 (7f161be75900) [pid = 5589] [serial = 354] [outer = 0]
[task 2021-07-31T22:13:21.219Z] 22:13:21     INFO - GECKO(5589) | [Parent 5589: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 348 (7f161c10c800) [pid = 5589] [serial = 355] [outer = 7f161be75900]
[task 2021-07-31T22:13:21.230Z] 22:13:21     INFO - TEST-PASS | browser/components/resistfingerprinting/test/browser/browser_roundedWindow_windowSetting_mid_inner.js | The screen.width has a correct rounded value - 600 == 600 -
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

The tests are sometimes receiving an (async) "resize" event in response to application of the width and height windowFeatures passed to Window.open(). The GTK notifications do not allow us to distinguish between a response to a now-out-of-date internal resize request and an external resize from a window manager, so these "resize" events are always dispatched if notified by GTK. The tests can pass because this "resize" is often coalesced with the one from the (inner|outer)(Width|Height) assignment.

I expect that waiting for a "resize" with sizes different from initWidth/initHeight would be sufficient to make the test results consistent.

Blocks: 1641290, 1617046, 1631738, 1636672, 1627059, 1616981
See Also: 1627059 → 1766919
Status: REOPENED → RESOLVED
Closed: 4 years ago → 3 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.