Closed Bug 1540829 Opened 6 years ago Closed 1 year ago

Intermittent /css/css-flexbox/quirks-auto-block-size-with-percentage-item.html | #container 1 - assert_equals:

Categories

(Core :: CSS Parsing and Computation, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

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

Attachments

(1 file)

#[markdown(off)]
Filed by: csabou [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=237397879&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/FLd0QAzTSqu-gykZNO4M6w/runs/0/artifacts/public/logs/live_backing.log

[task 2019-04-01T19:15:46.728Z] 19:15:46 INFO - TEST-OK | /css/css-flexbox/position-absolute-004.html | took 1056ms
[task 2019-04-01T19:15:46.729Z] 19:15:46 INFO - TEST-START | /css/css-flexbox/quirks-auto-block-size-with-percentage-item.html
[task 2019-04-01T19:15:46.732Z] 19:15:46 INFO - Closing window 53687091201
[task 2019-04-01T19:15:47.084Z] 19:15:47 INFO - PID 2357 | --DOCSHELL 0xe6c09c00 == 0 [pid = 3141] [id = {a1a1fc39-1865-4d8d-b297-f7eda695b179}] [url = http://web-platform.test:8000/css/css-flexbox/position-absolute-004.html]
[task 2019-04-01T19:15:47.086Z] 19:15:47 INFO - PID 2357 | --DOMWINDOW == 3 (0xf7069460) [pid = 3141] [serial = 1] [outer = (nil)] [url = http://web-platform.test:8000/css/css-flexbox/position-absolute-004.html]
[task 2019-04-01T19:15:47.087Z] 19:15:47 INFO - PID 2357 | --DOMWINDOW == 2 (0xe790f000) [pid = 3141] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-04-01T19:15:47.087Z] 19:15:47 INFO - PID 2357 | --DOMWINDOW == 1 (0xe7184800) [pid = 3141] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-04-01T19:15:47.089Z] 19:15:47 INFO - PID 2357 | --DOMWINDOW == 0 (0xe718d000) [pid = 3141] [serial = 4] [outer = (nil)] [url = http://web-platform.test:8000/css/css-flexbox/position-absolute-004.html]
[task 2019-04-01T19:15:47.109Z] 19:15:47 INFO - PID 2357 | nsStringStats
[task 2019-04-01T19:15:47.109Z] 19:15:47 INFO - PID 2357 | => mAllocCount: 8610
[task 2019-04-01T19:15:47.110Z] 19:15:47 INFO - PID 2357 | => mReallocCount: 0
[task 2019-04-01T19:15:47.110Z] 19:15:47 INFO - PID 2357 | => mFreeCount: 8610
[task 2019-04-01T19:15:47.110Z] 19:15:47 INFO - PID 2357 | => mShareCount: 6230
[task 2019-04-01T19:15:47.110Z] 19:15:47 INFO - PID 2357 | => mAdoptCount: 494
[task 2019-04-01T19:15:47.111Z] 19:15:47 INFO - PID 2357 | => mAdoptFreeCount: 498
[task 2019-04-01T19:15:47.111Z] 19:15:47 INFO - PID 2357 | => Process ID: 3141, Thread ID: 4146566912
[task 2019-04-01T19:15:47.197Z] 19:15:47 INFO - PID 2357 | ++DOCSHELL 0xe6d09c00 == 1 [pid = 3172] [id = {e67dd38f-2c81-471c-9cb4-92c504196ae9}]
[task 2019-04-01T19:15:47.274Z] 19:15:47 INFO - PID 2357 | ++DOMWINDOW == 1 (0xf7169460) [pid = 3172] [serial = 1] [outer = (nil)]
[task 2019-04-01T19:15:47.310Z] 19:15:47 INFO - PID 2357 | ++DOMWINDOW == 2 (0xe7a0e000) [pid = 3172] [serial = 2] [outer = 0xf7169460]
[task 2019-04-01T19:15:47.548Z] 19:15:47 INFO - PID 2357 | ++DOMWINDOW == 3 (0xe7282800) [pid = 3172] [serial = 3] [outer = 0xf7169460]
[task 2019-04-01T19:15:47.645Z] 19:15:47 INFO - PID 2357 | [Child 3172, Main Thread] WARNING: site security information will not be persisted: file /builds/worker/workspace/build/src/security/manager/ssl/nsSiteSecurityService.cpp, line 506
[task 2019-04-01T19:15:47.661Z] 19:15:47 INFO - PID 2357 | ++DOMWINDOW == 4 (0xe728b400) [pid = 3172] [serial = 4] [outer = 0xf7169460]
[task 2019-04-01T19:15:47.750Z] 19:15:47 INFO - PID 2357 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpxPSuWt.mozrunner/runtests_leaks_838_tab_pid3211.log
[task 2019-04-01T19:15:47.873Z] 19:15:47 INFO - PID 2357 | [Parent 2357, Main Thread] WARNING: '!parent', file /builds/worker/workspace/build/src/netwerk/ipc/NeckoParent.cpp, line 955
[task 2019-04-01T19:15:47.930Z] 19:15:47 INFO - PID 2357 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-04-01T19:15:47.930Z] 19:15:47 INFO - PID 2357 | [Child 3211, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/netwerk/base/nsIOService.cpp, line 942
[task 2019-04-01T19:15:47.991Z] 19:15:47 INFO - PID 2357 | JavaScript warning: resource:///actors/PageStyleChild.jsm, line 30: Array.slice is deprecated; use Array.prototype.slice instead
[task 2019-04-01T19:15:47.992Z] 19:15:47 INFO - PID 2357 | JavaScript warning: resource:///actors/PageStyleChild.jsm, line 31: Array.map is deprecated; use Array.prototype.map instead
[task 2019-04-01T19:15:48.065Z] 19:15:48 INFO -
[task 2019-04-01T19:15:48.065Z] 19:15:48 INFO - TEST-UNEXPECTED-FAIL | /css/css-flexbox/quirks-auto-block-size-with-percentage-item.html | #container 1 - assert_equals:
[task 2019-04-01T19:15:48.065Z] 19:15:48 INFO - <div id="container" style="width:200px; height:456px;">
[task 2019-04-01T19:15:48.065Z] 19:15:48 INFO - <div style="display:flex; background:blue;" data-expected-height="100">
[task 2019-04-01T19:15:48.065Z] 19:15:48 INFO - <img style="width:100px; height: 50%;" src="support/1x1-green.png" data-expected-height="100">
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - <div style="width: 50px; height: 100%; background: red;" data-expected-height="0"></div>
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - </div>
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - </div>
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - height expected 100 but got 0
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - assert_tolerance@http://web-platform.test:8000/resources/check-layout-th.js:24:9
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - checkExpectedValues@http://web-platform.test:8000/resources/check-layout-th.js:39:9
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - checkSubtreeExpectedValues@http://web-platform.test:8000/resources/check-layout-th.js:7:25
[task 2019-04-01T19:15:48.066Z] 19:15:48 INFO - checkSubtreeExpectedValues/<@http://web-platform.test:8000/resources/check-layout-th.js:9:26
[task 2019-04-01T19:15:48.067Z] 19:15:48 INFO - checkSubtreeExpectedValues@http://web-platform.test:8000/resources/check-layout-th.js:8:29
[task 2019-04-01T19:15:48.067Z] 19:15:48 INFO - window.checkLayout/</<@http://web-platform.test:8000/resources/check-layout-th.js:182:34
[task 2019-04-01T19:15:48.067Z] 19:15:48 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
[task 2019-04-01T19:15:48.067Z] 19:15:48 INFO - test@http://web-platform.test:8000/resources/testharness.js:544:30
[task 2019-04-01T19:15:48.067Z] 19:15:48 INFO - window.checkLayout/<@http://web-platform.test:8000/resources/check-layout-th.js:176:9
[task 2019-04-01T19:15:48.067Z] 19:15:48 INFO - window.checkLayout@http://web-platform.test:8000/resources/check-layout-th.js:175:29
[task 2019-04-01T19:15:48.068Z] 19:15:48 INFO - @http://web-platform.test:8000/css/css-flexbox/quirks-auto-block-size-with-percentage-item.html:16:3
[task 2019-04-01T19:15:48.068Z] 19:15:48 INFO - TEST-OK | /css/css-flexbox/quirks-auto-block-size-with-percentage-item.html | took 1334ms

This started after the changes here landed: https://hg.mozilla.org/integration/mozilla-inbound/rev/b05ca53d777d

Depends on: 1527175

(In reply to Treeherder Bug Filer from comment #0)

This started after the changes here landed: https://hg.mozilla.org/integration/mozilla-inbound/rev/b05ca53d777d

Sure - that is the commit that added this test. :) (as part of bug 1527175)

So it seems that we simply fail this new test intermittently and/or under some conditions.

There are 163 total failures in the last 7 days on android-em-7-0-x86 opt, linux32 debug, linux32-shippable opt, linux64 asan and debug, linux64-shippable opt, osx-10-10-shippable opt, windows10-64 debug, windows7-32 debug, windows7-32-shippable opt

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=238013545&repo=autoland&lineNumber=6422

02:17:46 INFO - TEST-START | /css/css-flexbox/quirks-auto-block-size-with-percentage-item.html
02:17:46 INFO - Closing window 53687091201
02:17:46 INFO - PID 858 | [Child 884, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/workspace/build/src/widget/cocoa/nsAppShell.mm, line 722
02:17:46 INFO - PID 858 | ++DOCSHELL 0x114c82800 == 1 [pid = 885] [id = {eb6fcbc2-7adc-da40-9351-bb58d547b3cc}]
02:17:46 INFO - PID 858 | ++DOMWINDOW == 1 (0x11bb2f020) [pid = 885] [serial = 1] [outer = 0x0]
02:17:46 INFO - PID 858 | ++DOMWINDOW == 2 (0x114ca8000) [pid = 885] [serial = 2] [outer = 0x11bb2f020]
02:17:47 INFO - PID 858 | --DOCSHELL 0x120482800 == 0 [pid = 884] [id = {19b736e0-10c2-344b-9998-128f211d4ecf}] [url = http://web-platform.test:8000/css/css-flexbox/position-absolute-004.html]
02:17:47 INFO - PID 858 | --DOMWINDOW == 3 (0x12722f020) [pid = 884] [serial = 1] [outer = 0x0] [url = http://web-platform.test:8000/css/css-flexbox/position-absolute-004.html]
02:17:47 INFO - PID 858 | --DOMWINDOW == 2 (0x1204a8000) [pid = 884] [serial = 2] [outer = 0x0] [url = about:blank]
02:17:47 INFO - PID 858 | --DOMWINDOW == 1 (0x1272d1000) [pid = 884] [serial = 3] [outer = 0x0] [url = about:blank]
02:17:47 INFO - PID 858 | --DOMWINDOW == 0 (0x1272d7800) [pid = 884] [serial = 4] [outer = 0x0] [url = http://web-platform.test:8000/css/css-flexbox/position-absolute-004.html]
02:17:47 INFO - PID 858 | nsStringStats
02:17:47 INFO - PID 858 | => mAllocCount: 7804
02:17:47 INFO - PID 858 | => mReallocCount: 0
02:17:47 INFO - PID 858 | => mFreeCount: 7804
02:17:47 INFO - PID 858 | => mShareCount: 6505
02:17:47 INFO - PID 858 | => mAdoptCount: 492
02:17:47 INFO - PID 858 | => mAdoptFreeCount: 496
02:17:47 INFO - PID 858 | => Process ID: 884, Thread ID: 140735128331008
02:17:47 INFO - PID 858 | ++DOMWINDOW == 3 (0x11bbd1000) [pid = 885] [serial = 3] [outer = 0x11bb2f020]
02:17:47 INFO - PID 858 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/rs/dtm2_7_13kzb66gx_rkpmdrc00000x/T/tmpXUsvxo.mozrunner/runtests_leaks_650_tab_pid886.log
02:17:47 INFO - PID 858 | ++DOMWINDOW == 4 (0x11bbd7c00) [pid = 885] [serial = 4] [outer = 0x11bb2f020]
02:17:47 INFO - PID 858 | [Parent 858, Main Thread] WARNING: '!parent', file /builds/worker/workspace/build/src/netwerk/ipc/NeckoParent.cpp, line 955
02:17:47 INFO -
02:17:47 INFO - TEST-UNEXPECTED-FAIL | /css/css-flexbox/quirks-auto-block-size-with-percentage-item.html | #container 1 - assert_equals:
02:17:47 INFO - <div id="container" style="width:200px; height:456px;">
02:17:47 INFO - <div style="display:flex; background:blue;" data-expected-height="100">
02:17:47 INFO - <img style="width:100px; height: 50%;" src="support/1x1-green.png" data-expected-height="100">
02:17:47 INFO - <div style="width: 50px; height: 100%; background: red;" data-expected-height="0"></div>
02:17:47 INFO - </div>
02:17:47 INFO - </div>
02:17:47 INFO - height expected 100 but got 0
02:17:47 INFO - assert_tolerance@http://web-platform.test:8000/resources/check-layout-th.js:24:9
02:17:47 INFO - checkExpectedValues@http://web-platform.test:8000/resources/check-layout-th.js:39:9
02:17:47 INFO - checkSubtreeExpectedValues@http://web-platform.test:8000/resources/check-layout-th.js:7:25
02:17:47 INFO - checkSubtreeExpectedValues/<@http://web-platform.test:8000/resources/check-layout-th.js:9:26
02:17:47 INFO - checkSubtreeExpectedValues@http://web-platform.test:8000/resources/check-layout-th.js:8:29
02:17:47 INFO - window.checkLayout/</<@http://web-platform.test:8000/resources/check-layout-th.js:182:34
02:17:47 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1587:25
02:17:47 INFO - test@http://web-platform.test:8000/resources/testharness.js:544:30
02:17:47 INFO - window.checkLayout/<@http://web-platform.test:8000/resources/check-layout-th.js:176:9
02:17:47 INFO - window.checkLayout@http://web-platform.test:8000/resources/check-layout-th.js:175:29
02:17:47 INFO - @http://web-platform.test:8000/css/css-flexbox/quirks-auto-block-size-with-percentage-item.html:16:3
02:17:47 INFO - TEST-OK | /css/css-flexbox/quirks-auto-block-size-with-percentage-item.html | took 1059ms

Daniel, at this rate it's gonna reach the disable-recommended queue. Is there a plan to fix this?

Flags: needinfo?(dholbert)
Whiteboard: [stockwell needswork:owner]
Flags: needinfo?(james)

I would like a layout developer to make that call.

Flags: needinfo?(james)

Sure, let's go ahead and disable it.

Flags: needinfo?(dholbert)

Reasoning:

  1. It's not a regression [oops, that keyword was present for some reason -- removing]; just a new test from upstream that happens to occasionally fail.
  2. It's unknown at this point whether it's a test bug or a Firefox bug
  3. I tried to reproduce locally, on Monday, & was unable to do so (using a few runs of ./mach wpt --verify which uses chaos mode; not sure what I can do beyond that to try to make it happen in a locally debuggable way)
  4. Given the above, I don't think anyone will be able to jump on fixing this right away (nor does it rise to the priority of drop-other-things-to-investigate, beyond the time-boxed attempt that I tried to do in (3))
Keywords: regression
Keywords: leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Severity: normal → S3
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: