Intermittent assertion failed: `(left == right)`
Categories
(Core :: CSS Parsing and Computation, defect, P5)
Tracking
()
| Tracking | Status | |
|---|---|---|
| firefox-esr102 | --- | unaffected |
| firefox114 | --- | unaffected |
| firefox115 | --- | unaffected |
| firefox116 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: zrhoffman)
References
(Regression)
Details
(Keywords: assertion, intermittent-failure, regression)
Attachments
(2 files)
Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=418521334&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Ji9VEGRwSEW2-V8CnH8BWg/runs/0/artifacts/public/logs/live_backing.log
INFO - TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_hide.js
[task 2023-06-08T05:38:29.660Z] 05:38:29 INFO - GECKO(9224) | [Child 4388: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 19c6fc6ec00 == 6 [pid = 4388] [id = 885]
[task 2023-06-08T05:38:29.674Z] 05:38:29 INFO - GECKO(9224) | [Child 4388: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 31 (19c6878b010) [pid = 4388] [serial = 2527] [outer = 0]
[task 2023-06-08T05:38:29.675Z] 05:38:29 INFO - GECKO(9224) | [Child 4388: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 32 (19c6fc70800) [pid = 4388] [serial = 2528] [outer = 19c6878b010]
[task 2023-06-08T05:38:29.685Z] 05:38:29 INFO - GECKO(9224) | [Child 4388, Main Thread] WARNING: Fallback to FallbackRenderer: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2689
[task 2023-06-08T05:38:29.707Z] 05:38:29 INFO - GECKO(9224) | [Child 4388: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 33 (19c716b9400) [pid = 4388] [serial = 2529] [outer = 19c6878b010]
[task 2023-06-08T05:38:29.754Z] 05:38:29 INFO - GECKO(9224) | [Child 9016: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 1a764a3f400 == 1 [pid = 9016] [id = 0]
[task 2023-06-08T05:38:29.769Z] 05:38:29 INFO - GECKO(9224) | [Child 9016: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (1a75d48bf90) [pid = 9016] [serial = 1] [outer = 0]
[task 2023-06-08T05:38:29.770Z] 05:38:29 INFO - GECKO(9224) | [Child 9016: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (1a764a43000) [pid = 9016] [serial = 2] [outer = 1a75d48bf90]
[task 2023-06-08T05:38:29.786Z] 05:38:29 INFO - GECKO(9224) | Waiting for browser load
[task 2023-06-08T05:38:29.786Z] 05:38:29 INFO - GECKO(9224) | Waiting for browser state change
[task 2023-06-08T05:38:29.833Z] 05:38:29 INFO - GECKO(9224) | Saw state f0001 and status 0
[task 2023-06-08T05:38:29.864Z] 05:38:29 INFO - GECKO(9224) | [Child 9016: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (1a764a46000) [pid = 9016] [serial = 3] [outer = 1a75d48bf90]
[task 2023-06-08T05:38:29.959Z] 05:38:29 INFO - GECKO(9224) | Saw state c0010 and status 0
[task 2023-06-08T05:38:29.974Z] 05:38:29 INFO - GECKO(9224) | Browser got expected state change http://example.com/?one
[task 2023-06-08T05:38:29.990Z] 05:38:29 INFO - GECKO(9224) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-06-08T05:38:30.099Z] 05:38:30 INFO - GECKO(9224) | [Child 3408: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 2af4163f400 == 1 [pid = 3408] [id = 0]
[task 2023-06-08T05:38:30.101Z] 05:38:30 INFO - GECKO(9224) | [Child 3408: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (2af3a18bf90) [pid = 3408] [serial = 1] [outer = 0]
[task 2023-06-08T05:38:30.102Z] 05:38:30 INFO - GECKO(9224) | [Child 3408: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (2af41643000) [pid = 3408] [serial = 2] [outer = 2af3a18bf90]
[task 2023-06-08T05:38:30.115Z] 05:38:30 INFO - GECKO(9224) | Waiting for browser load
[task 2023-06-08T05:38:30.129Z] 05:38:30 INFO - GECKO(9224) | Waiting for browser state change
[task 2023-06-08T05:38:30.162Z] 05:38:30 INFO - GECKO(9224) | Saw state f0001 and status 0
[task 2023-06-08T05:38:30.225Z] 05:38:30 INFO - GECKO(9224) | [Child 3408: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (2af41646000) [pid = 3408] [serial = 3] [outer = 2af3a18bf90]
[task 2023-06-08T05:38:30.256Z] 05:38:30 INFO - GECKO(9224) | [Child 5680: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 190a9e3b000 == 1 [pid = 5680] [id = 159] [url = about:blank]
[task 2023-06-08T05:38:30.288Z] 05:38:30 INFO - GECKO(9224) | [Child 5680: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (190a298ac30) [pid = 5680] [serial = 350] [outer = 0] [url = about:blank]
[task 2023-06-08T05:38:30.335Z] 05:38:30 INFO - GECKO(9224) | Saw state c0010 and status 0
[task 2023-06-08T05:38:30.344Z] 05:38:30 INFO - GECKO(9224) | Browser got expected state change http://example.com/?two
[task 2023-06-08T05:38:30.356Z] 05:38:30 INFO - GECKO(9224) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-06-08T05:38:30.617Z] 05:38:30 INFO - GECKO(9224) | Hit MOZ_CRASH(assertion failed: `(left == right)`
[task 2023-06-08T05:38:30.625Z] 05:38:30 INFO - GECKO(9224) | left: `3`,
[task 2023-06-08T05:38:30.626Z] 05:38:30 INFO - GECKO(9224) | right: `2`: invalid cache) at /builds/worker/checkouts/gecko/servo/components/selectors/matching.rs:1044
[task 2023-06-08T05:38:30.774Z] 05:38:30 INFO - GECKO(9224) | #01: RustMozCrash(char const*, int, char const*) [mozglue/static/rust/wrappers.cpp:17]
[task 2023-06-08T05:38:30.788Z] 05:38:30 INFO - GECKO(9224) | #02: mozglue_static::panic_hook(core::panic::panic_info::PanicInfo*) [mozglue/static/rust/lib.rs:96]
<...>
INFO - zombiecheck | Checking for orphan process with PID: 1020
[task 2023-06-08T05:38:31.692Z] 05:38:31 INFO - mozcrash Copy/paste: Z:/task_168619934994203/fetches\minidump-stackwalk\minidump-stackwalk.exe --symbols-url=https://symbols.mozilla.org/ --cyborg=C:\Users\task_168619934994203\AppData\Local\Temp\tmpwigjhtdr\3d9d6378-1797-4988-af82-a55071495ffd.trace C:\Users\task_168619934994203\AppData\Local\Temp\tmp6tg7wool.mozrunner\minidumps\3d9d6378-1797-4988-af82-a55071495ffd.dmp Z:\task_168619934994203\build\symbols
[task 2023-06-08T05:38:41.697Z] 05:38:41 INFO - mozcrash Saved minidump as Z:\task_168619934994203\build\blobber_upload_dir\3d9d6378-1797-4988-af82-a55071495ffd.dmp
[task 2023-06-08T05:38:41.702Z] 05:38:41 INFO - mozcrash Saved app info as Z:\task_168619934994203\build\blobber_upload_dir\3d9d6378-1797-4988-af82-a55071495ffd.extra
[task 2023-06-08T05:38:42.433Z] 05:38:42 INFO - PROCESS-CRASH | assertion failed: `(left == right)`
[task 2023-06-08T05:38:42.433Z] 05:38:42 INFO - left: `3`,
[task 2023-06-08T05:38:42.433Z] 05:38:42 INFO - right: `2`: invalid cache [@ RustMozCrash] | browser/components/extensions/test/browser/browser_ext_tabs_hide.js
[task 2023-06-08T05:38:42.433Z] 05:38:42 INFO - Mozilla crash reason: assertion failed: `(left == right)`
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - left: `3`,
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - right: `2`: invalid cache
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Crash dump filename: C:\Users\task_168619934994203\AppData\Local\Temp\tmp6tg7wool.mozrunner\minidumps\3d9d6378-1797-4988-af82-a55071495ffd.dmp
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Operating system: Windows NT
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - 10.0.22621
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - CPU: amd64
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - family 6 model 106 stepping 6
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - 8 CPUs
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO -
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Crash reason: EXCEPTION_BREAKPOINT
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Crash address: 0x7ffc485fd2e3
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Crashing instruction: `int 0x3`
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - No memory accessed by instruction
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Process uptime: 802 seconds
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO -
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Thread 0 MainThread (crashed)
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - 0 xul.dll!MOZ_Crash(char const*, int, char const*) [Assertions.h:2b2fb0c1bd13f27bbd5094192791600a5e261c4b : 264]
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - Found by: inlining
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - 1 xul.dll!RustMozCrash(char const*, int, char const*) [wrappers.cpp:2b2fb0c1bd13f27bbd5094192791600a5e261c4b : 17 + 0x15]
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - rax = 0x00007ffc88907df8 rdx = 0x0000000000000000
INFO - rcx = 0x0000000000000000 rbx = 0x0000000000000045
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - rsi = 0x000000363cffb080 rdi = 0x0000000000000414
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - rbp = 0x000000363cffaed0 rsp = 0x000000363cffae10
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - r8 = 0x000000000000000e r9 = 0x00007ffc93e5cbf8
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - r10 = 0x00007ffc93cd0000 r11 = 0x000000363cffa7d0
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - r12 = 0x0000000000000414 r13 = 0x000000363cffb080
[task 2023-06-08T05:38:42.448Z] 05:38:42 INFO - r14 = 0x0000021e9d566c80 r15 = 0x000000000000004b
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rip = 0x00007ffc485fd2e3
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - Found by: given as instruction pointer in context
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - 2 xul.dll!mozglue_static::panic_hook(core::panic::panic_info::PanicInfo*) [lib.rs:2b2fb0c1bd13f27bbd5094192791600a5e261c4b : 96 + 0xd]
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rbx = 0x0000000000000045 rsi = 0x000000363cffae78
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rdi = 0x00007ffc49fc09b8 rbp = 0x000000363cffaed0
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rsp = 0x000000363cffae50 r12 = 0x0000000000000414
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - r13 = 0x000000363cffb080 r14 = 0x0000021e9d566c80
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - r15 = 0x000000000000004b rip = 0x00007ffc46dc86f2
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - Found by: call frame info
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - 3 xul.dll!core::ops::function::Fn::call<void (*)(ref$<core::panic::panic_info::PanicInfo>),tuple$<ref$<core::panic::panic_info::PanicInfo> > >(void (**)(core::panic::panic_info::PanicInfo*), core::panic::panic_info::PanicInfo*) [function.rs : 79 + 0x11]
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rbx = 0x0000000000000001 rsi = 0x00007ffc4a136870
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rdi = 0x000000363cffb420 rbp = 0x000000363cffb2f0
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rsp = 0x000000363cffb2d0 r12 = 0x0000021ea1818d30
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - r13 = 0x0000000000000003 r14 = 0x00007ffc4a133058
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - r15 = 0x0000000000000001 rip = 0x00007ffc46dc82e2
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - Found by: call frame info
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - 4 xul.dll!alloc::boxed::impl$47::call() [boxed.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 2001]
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - Found by: inlining
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - 5 xul.dll!std::panicking::rust_panic_with_hook() [panicking.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 696 + 0xd]
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rbx = 0x0000000000000001 rbp = 0x000000363cffb380
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - rsp = 0x000000363cffb300 r12 = 0x0000021ea1818d30
[task 2023-06-08T05:38:42.449Z] 05:38:42 INFO - r13 = 0x0000000000000003 r14 = 0x00007ffc4a133058
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - r15 = 0x0000000000000001 rip = 0x00007ffc47d4f142
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - Found by: call frame info
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - 6 xul.dll!std::panicking::begin_panic_handler::closure$0() [panicking.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 583 + 0x19]
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - rbx = 0x000000363cffb510 rsi = 0x00007ffc49fc97b8
INFO - rdi = 0x000000363cffb5d0 rbp = 0x000000363cffb440
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - rsp = 0x000000363cffb3f0 r12 = 0x0000021ea1818d30
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - r13 = 0x0000000000000003 r14 = 0x0000000000000000
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - r15 = 0x000000363cffc780 rip = 0x00007ffc47d4ee9e
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - Found by: call frame info
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - 7 xul.dll!std::sys_common::backtrace::__rust_end_short_backtrace<std::panicking::begin_panic_handler::closure_env$0,never$>() [backtrace.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 150 + 0x4]
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - rbx = 0x0000000000000000 rsi = 0x000000363cffb510
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - rdi = 0x00007ffc49fc97b8 rbp = 0x000000363cffb6c0
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - rsp = 0x000000363cffb470 r12 = 0x0000021ea1818d30
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - r13 = 0x0000000000000003 r14 = 0x0000000000000000
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - r15 = 0x000000363cffc780 rip = 0x00007ffc47d4bdf9
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - Found by: call frame info
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - 8 xul.dll!std::panicking::begin_panic_handler() [panicking.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 579 + 0x18]
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - rbx = 0x0000000000000000 rbp = 0x000000363cffb6c0
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - rsp = 0x000000363cffb4a0 r12 = 0x0000021ea1818d30
[task 2023-06-08T05:38:42.450Z] 05:38:42 INFO - r13 = 0x0000000000000003 r14 = 0x0000000000000000
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - r15 = 0x000000363cffc780 rip = 0x00007ffc47d4eb50
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - Found by: call frame info
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - 9 xul.dll!core::panicking::panic_fmt() [panicking.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 64 + 0x4]
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - rbx = 0x0000000000000000 rsi = 0x0000021ea1818c90
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - rdi = 0x000000363cffc3c8 rbp = 0x000000363cffb6c0
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - rsp = 0x000000363cffb4f0 r12 = 0x0000021ea1818d30
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - r13 = 0x0000000000000003 r14 = 0x0000000000000000
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - r15 = 0x000000363cffc780 rip = 0x00007ffc48a9dfd5
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - Found by: call frame info
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - 10 xul.dll!core::fmt::Arguments::new_v1() [mod.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 405]
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - Found by: inlining
[task 2023-06-08T05:38:42.451Z] 05:38:42 INFO - 11 xul.dll!core::panicking::assert_failed_inner() [panicking.rs:84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc : 251 + 0x4c]
<...>
Comment 1•3 years ago
|
||
The Bugbug bot thinks this bug should belong to the 'Core::CSS Parsing and Computation' component, and is moving the bug to that component. Please correct in case you think the bot is wrong.
Comment 3•3 years ago
|
||
Is bug 1837174 in the possible range? I suspect it might trigger this.
Comment 4•3 years ago
|
||
I believe :nth-child(... of) invalidation can break this assert because of this, which is used as the cache key. If we match both the element and the snapshot with the same selector, the element matches and the snapshot match, but a previous sibling matches (or the snapshot doesn't) it can change the effective index, I believe...
Zach, do you have cycles to look at this? I believe it should be possible to reproduce with a selector like the one introduced in bug 1837174 and various mutations in the sibling list.
| Assignee | ||
Comment 5•3 years ago
|
||
I'll look at this. At a glance, this looks similar to the issue I was originally running into when stylo itself performed :nth-child(... of) sibling invalidation (which caused caused that same assertion failure because the nth-index, while cached, was different in the snapshot).
If that's all it is, we could pull bug 1818151's original solution for this, using a separate nth-index cache key for element snapshots.
| Comment hidden (Intermittent Failures Robot) |
| Assignee | ||
Comment 7•3 years ago
|
||
Here is a reduced crashtest. Unlike running browser/components/extensions/test/browser/browser_ext_tabs_hide.js, opening the crashtest also produces the assertion failure on Linux, not only macOS and Windows.
Comment 8•3 years ago
|
||
(In reply to Emilio Cobos Álvarez (:emilio) from comment #3)
Is bug 1837174 in the possible range? I suspect it might trigger this.
Yes, that one landed late on 2023-06-07 UTC and the first failure is early on 2023-06-08 UTC.
| Assignee | ||
Comment 9•3 years ago
|
||
Also, restyle the child passed to RestyleSiblings, since stylo no longer
necessarily invalidates elements with HAS_SLOW_SELECTOR or
HAS_SLOW_SELECTOR_LATER_SIBLINGS.
Updated•3 years ago
|
Comment 10•3 years ago
|
||
Comment 12•3 years ago
|
||
| bugherder | ||
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Description
•