Closed
Bug 1865520
Opened 1 year ago
Closed 3 months ago
Intermittent bugs/427017-1.xhtml != about:blank | single tracking bug
Categories
(Core :: Layout, defect, P5)
Core
Layout
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=436764500&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/H08m0lj1R1WzZnKECPmvFA/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/H08m0lj1R1WzZnKECPmvFA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2023-11-19T10:46:56.865Z] 10:46:56 INFO - #152458: XRE_GetBootstrap [Z:\task_170038867292476\build\application\firefox\xul.dll + 0x9056f42]
[task 2023-11-19T10:46:56.866Z] 10:46:56 INFO - #152459: ??? (???:???)
[task 2023-11-19T10:46:56.866Z] 10:46:56 INFO - #152460: ??? (???:???)
[task 2023-11-19T10:46:56.868Z] 10:46:56 INFO - #152461: ??? (???:???)
[task 2023-11-19T10:46:56.869Z] 10:46:56 INFO - #152462: neqo_http3::connection::Http3Connection::create_bidi_transport_stream(neqo_transport::connection::Connection*) [third_party/rust/neqo-http3/src/connection.rs:865]
[task 2023-11-19T10:46:56.869Z] 10:46:56 INFO - #152463: ??? (???:???)
[task 2023-11-19T10:46:56.870Z] 10:46:56 INFO - #152464: ??? (???:???)
[task 2023-11-19T10:46:56.871Z] 10:46:56 INFO - #152465: ??? (???:???)
[task 2023-11-19T10:46:56.872Z] 10:46:56 INFO - #152466: ??? (???:???)
[task 2023-11-19T10:46:56.873Z] 10:46:56 INFO - #152467: jog::jog_load_jogfile(nsstring::nsAString*) [toolkit/components/glean/bindings/jog/src/lib.rs:224]
[task 2023-11-19T10:46:56.873Z] 10:46:56 INFO - #152468: ??? (???:???)
[task 2023-11-19T10:46:56.874Z] 10:46:56 INFO - #152469: ??? (???:???)
[task 2023-11-19T10:46:56.874Z] 10:46:56 INFO - #152470: ??? (???:???)
[task 2023-11-19T10:46:56.875Z] 10:46:56 INFO - #152471: neqo_http3::connection::Http3Connection::create_bidi_transport_stream(neqo_transport::connection::Connection*) [third_party/rust/neqo-http3/src/connection.rs:865]
[task 2023-11-19T10:46:56.877Z] 10:46:56 INFO - #152472: ??? (???:???)
[task 2023-11-19T10:46:56.878Z] 10:46:56 INFO - #152473: ??? (???:???)
[task 2023-11-19T10:46:56.879Z] 10:46:56 INFO - #152474: ??? (???:???)
[task 2023-11-19T10:46:56.880Z] 10:46:56 INFO - #152475: WakeConditionVariable [C:\Windows\System32\KERNEL32.DLL + 0xa6d74]
[task 2023-11-19T10:46:56.880Z] 10:46:56 INFO - #152476: ??? (???:???)
[task 2023-11-19T10:46:56.881Z] 10:46:56 INFO - #152477: ??? (???:???)
[task 2023-11-19T10:46:56.882Z] 10:46:56 INFO - #152478: mozilla::dom::PContentChild::SendGetFontListShmBlock(unsigned int const&, unsigned int const&, mozilla::UniquePtr<void *,mozilla::detail::FileHandleDeleter>*) [s3:gecko-generated-sources-l1:a6f03e5c24f56cbf68d80af4188feb0ec4297055fd9afa399c85a63d4fef47834fa0937de845203d6156943374befb22b41905d16045015a5a95d7fbade4193f/ipc/ipdl/PContentChild.cpp::4730]
[task 2023-11-19T10:46:56.883Z] 10:46:56 INFO - #152479: ??? (???:???)
[task 2023-11-19T10:46:56.884Z] 10:46:56 INFO - #152480: ??? (???:???)
[task 2023-11-19T10:46:56.885Z] 10:46:56 INFO - #152481: data_storage::DataStorage::initialize() [security/manager/ssl/data_storage/src/lib.rs:801]
[task 2023-11-19T10:46:56.885Z] 10:46:56 INFO - #152482: ??? (???:???)
[task 2023-11-19T10:46:56.886Z] 10:46:56 INFO - #152483: XRE_GetBootstrap [Z:\task_170038867292476\build\application\firefox\xul.dll + 0x9ff4367]
[task 2023-11-19T10:46:56.887Z] 10:46:56 INFO - #152484: ??? (???:???)
[task 2023-11-19T10:46:56.887Z] 10:46:56 INFO - #152485: ??? (???:???)
[task 2023-11-19T10:46:56.888Z] 10:46:56 INFO - #152486: ??? (???:???)
[task 2023-11-19T10:46:56.889Z] 10:46:56 INFO - #152487: ??? (???:???)
[task 2023-11-19T10:46:56.890Z] 10:46:56 INFO - #152488: gWinEventLogSourceName [Z:\task_170038867292476\build\application\firefox\xul.dll + 0xafd7420]
[task 2023-11-19T10:46:56.891Z] 10:46:56 INFO - #152489: ??? (???:???)
[task 2023-11-19T10:46:56.891Z] 10:46:56 INFO - #152490: ??? (???:???)
[task 2023-11-19T10:46:56.893Z] 10:46:56 INFO - #152491: ??? (???:???)
[task 2023-11-19T10:46:56.893Z] 10:46:56 INFO - #152492: ??? (???:???)
[task 2023-11-19T10:46:56.894Z] 10:46:56 INFO - #152493: ??? (???:???)
[task 2023-11-19T10:46:56.895Z] 10:46:56 INFO - #152494: ??? (???:???)
[task 2023-11-19T10:46:56.896Z] 10:46:56 INFO - #152495: mozilla::ipc::CreateEndpoints<mozilla::PSandboxTestingParent,mozilla::PSandboxTestingChild>(mozilla::ipc::PrivateIPDLInterface const&, mozilla::ipc::Endpoint<mozilla::PSandboxTestingParent>*, mozilla::ipc::Endpoint<mozilla::PSandboxTestingChild>*) [ipc/glue/Endpoint.h:169]
[task 2023-11-19T10:46:56.897Z] 10:46:56 INFO - #152496: ??? (???:???)
[task 2023-11-19T10:46:56.897Z] 10:46:56 INFO - #152497: XRE_GetBootstrap [Z:\task_170038867292476\build\application\firefox\xul.dll + 0x8f16854]
[task 2023-11-19T10:46:56.898Z] 10:46:56 INFO - #152498: ??? (???:???)
[task 2023-11-19T10:46:56.899Z] 10:46:56 INFO - #152499: ??? (???:???)
[task 2023-11-19T10:46:56.900Z] 10:46:56 INFO - #152500: ??? (???:???)
[task 2023-11-19T10:46:56.900Z] 10:46:56 INFO - #152501: ??? (???:???)
[task 2023-11-19T10:46:56.902Z] 10:46:56 INFO - #152502: wgpu_bindings::server::Global::device_action<wgpu_hal::dx12::Api>(wgpu_core::id::Id<wgpu_core::device::resource::Device<wgpu_hal::empty::Api> >, enum2$<wgpu_bindings::DeviceAction>, wgpu_bindings::error::ErrorBuffer) [gfx/wgpu_bindings/src/server.rs:653]
[task 2023-11-19T10:46:56.902Z] 10:46:56 INFO - #152503: ??? (???:???)
[task 2023-11-19T10:46:56.903Z] 10:46:56 INFO - #152504: ??? (???:???)
[task 2023-11-19T10:46:56.904Z] 10:46:56 INFO - #152505: XRE_GetBootstrap [Z:\task_170038867292476\build\application\firefox\xul.dll + 0x9056f42]
[task 2023-11-19T10:46:56.904Z] 10:46:56 INFO - #152506: ??? (???:???)
[task 2023-11-19T10:46:56.905Z] 10:46:56 INFO - #152507: ??? (???:???)
[task 2023-11-19T10:46:56.906Z] 10:46:56 INFO - #152508: ??? (???:???)
[task 2023-11-19T10:46:56.907Z] 10:46:56 INFO - #152509: WakeConditionVariable [C:\Windows\System32\KERNEL32.DLL + 0xa6d74]
[task 2023-11-19T10:46:56.908Z] 10:46:56 INFO - #152510: mozilla::net::HttpChannelParent::WaitForBgParent(unsigned long long) [netwerk/protocol/http/HttpChannelParent.cpp:683]
[task 2023-11-19T10:46:56.909Z] 10:46:56 INFO - #152511: mozilla::dom::PerformanceEntryEvent_Binding::CreateInterfaceObjects(JSContext*, JS::Handle<JSObject *>, mozilla::dom::ProtoAndIfaceCache&, bool) [s3:gecko-generated-sources-l1:f7192f743e86f1860ca263377e712999977e10a2be4ffcd8cceda4046d7b1466e3909732f8a985cf228ed70fd5c0794929f1c0c9fb8006fef95793c16d90dfc3/dom/bindings/PerformanceEntryEventBinding.cpp::0]
[task 2023-11-19T10:46:56.909Z] 10:46:56 INFO - #152512: XRE_GetBootstrap [Z:\task_170038867292476\build\application\firefox\xul.dll + 0x9fc6f43]
[task 2023-11-19T10:46:56.910Z] 10:46:56 INFO - #152513: ??? (???:???)
[task 2023-11-19T10:46:56.910Z] 10:46:56 INFO - #152514: ??? (???:???)
[task 2023-11-19T10:46:56.911Z] 10:46:56 INFO - #152515: ??? (???:???)
[task 2023-11-19T10:46:56.912Z] 10:46:56 INFO - #152516: ??? (???:???)
[task 2023-11-19T10:46:56.913Z] 10:46:56 INFO - #152517: ??? (???:???)
[task 2023-11-19T10:46:56.913Z] 10:46:56 INFO - #152518: ??? (???:???)
[task 2023-11-19T10:46:56.914Z] 10:46:56 INFO - #152519: ??? (???:???)
[task 2023-11-19T10:46:56.915Z] 10:46:56 INFO - #152520: ??? (???:???)
[task 2023-11-19T10:46:56.916Z] 10:46:56 INFO - #152521: ??? (???:???)
[task 2023-11-19T10:46:56.916Z] 10:46:56 INFO - #152522: ??? (???:???)
[task 2023-11-19T10:46:56.917Z] 10:46:56 INFO - #152523: ??? (???:???)
[task 2023-11-19T10:46:56.918Z] 10:46:56 INFO - #152524: ??? (???:???)
[task 2023-11-19T10:46:56.919Z] 10:46:56 INFO - #152525: MapDebugInformation [C:\Windows\SYSTEM32\dbghelp.dll + 0x136363]
[task 2023-11-19T10:46:56.919Z] 10:46:56 INFO - #152526: ??? (???:???)
[task 2023-11-19T10:46:56.920Z] 10:46:56 INFO - [Child 4036, Main Thread] WARNING: Out-of-flow frame got reflowed before its placeholder: file /builds/worker/checkouts/gecko/layout/generic/nsPlaceholderFrame.cpp:118
[task 2023-11-19T10:46:56.925Z] 10:46:56 INFO - REFTEST TEST-UNEXPECTED-FAIL | layout/reftests/bugs/427017-1.xhtml != about:blank | load failed: timed out waiting for test to complete (waiting for onload scripts to complete)
[task 2023-11-19T10:46:56.926Z] 10:46:56 INFO - REFTEST INFO | Saved log: START file:///Z:/task_170038867292476/build/tests/reftest/tests/layout/reftests/bugs/427017-1.xhtml
[task 2023-11-19T10:46:56.927Z] 10:46:56 INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad setting up print mode
[task 2023-11-19T10:46:56.927Z] 10:46:56 INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering AfterOnLoadScripts
[task 2023-11-19T10:46:56.928Z] 10:46:56 INFO - REFTEST TEST-END | layout/reftests/bugs/427017-1.xhtml != about:blank
[task 2023-11-19T10:46:56.973Z] 10:46:56 INFO - REFTEST TEST-KNOWN-FAIL | layout/reftests/bugs/427017-1.xhtml != about:blank | assertion count 3 matches expected 3 assertions
[task 2023-11-19T10:46:56.974Z] 10:46:56 INFO - REFTEST TEST-START | layout/reftests/bugs/427129-scrollframe.html == layout/reftests/bugs/427129-ref.html
[task 2023-11-19T10:46:56.974Z] 10:46:56 INFO - REFTEST TEST-LOAD | file:///Z:/task_170038867292476/build/tests/reftest/tests/layout/reftests/bugs/427129-scrollframe.html | 997 / 2086 (47%)
[task 2023-11-19T10:46:56.980Z] 10:46:56 INFO - REFTEST TEST-LOAD | file:///Z:/task_170038867292476/build/tests/reftest/tests/layout/reftests/bugs/427129-ref.html | 997 / 2086 (47%)
[task 2023-11-19T10:46:56.984Z] 10:46:56 ERROR - REFTEST ERROR | file:///Z:/task_170038867292476/build/tests/reftest/tests/layout/reftests/bugs/427129-ref.html | program error managing timeouts
[task 2023-11-19T10:46:56.984Z] 10:46:56 ERROR -
[task 2023-11-19T10:46:57.601Z] 10:46:57 INFO - REFTEST TEST-UNEXPECTED-FAIL | layout/reftests/bugs/427129-scrollframe.html == layout/reftests/bugs/427129-ref.html | image comparison, max difference: 255, number of differing pixels: 583930
<...>
[task 2023-11-19T10:46:57.603Z] 10:46:57 INFO - REFTEST INFO | Saved log: START file:///Z:/task_170038867292476/build/tests/reftest/tests/layout/reftests/bugs/427129-scrollframe.html
[task 2023-11-19T10:46:57.603Z] 10:46:57 INFO - REFTEST INFO | Saved log: [CONTENT] RecordResult fired
[task 2023-11-19T10:46:57.604Z] 10:46:57 INFO - REFTEST INFO | Saved log: RecordResult fired
[task 2023-11-19T10:46:57.605Z] 10:46:57 INFO - REFTEST INFO | Saved log: START file:///Z:/task_170038867292476/build/tests/reftest/tests/layout/reftests/bugs/427129-ref.html
[task 2023-11-19T10:46:57.605Z] 10:46:57 INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad fired for previous document
[task 2023-11-19T10:46:57.606Z] 10:46:57 INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering AfterOnLoadScripts
[task 2023-11-19T10:46:57.606Z] 10:46:57 INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2023-11-19T10:46:57.607Z] 10:46:57 INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2023-11-19T10:46:57.607Z] 10:46:57 INFO - REFTEST INFO | Saved log: [CONTENT] RecordResult fired
[task 2023-11-19T10:46:57.608Z] 10:46:57 INFO - REFTEST INFO | Saved log: RecordResult fired
[task 2023-11-19T10:46:57.608Z] 10:46:57 INFO - REFTEST TEST-END | layout/reftests/bugs/427129-scrollframe.html == layout/reftests/bugs/427129-ref.html
[task 2023-11-19T10:46:57.609Z] 10:46:57 INFO - REFTEST TEST-START | layout/reftests/bugs/427129-table.html == layout/reftests/bugs/427129-ref.html
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•1 year ago
|
||
The test failure here was actually | load failed: timed out waiting for test to complete (waiting for onload scripts to complete).
This is after we failed an assertion (which is expected), ASSERTION: can't mark frame dirty during reflow, here in the log
https://treeherder.mozilla.org/logviewer?job_id=436764500&repo=try&lineNumber=8462
...and then we spend ~6 minutes printing out the backtrace, which is absolutely massive -- 152526 stack frames, somehow? I'm not sure if that's real, or if something related to the backtrace-generation-or-processing went haywire.
So anyway: probably we timed out due to time spent generating, processing, and/or just logging that massive backtrace.
For now I'm going to hope this was a one-off, with something having gone haywire here.
|
|
||
Comment 3•1 year ago
|
||
When I run the reftest locally in a linux debug build, I get 3 assertion failures (as-expected in the test annotation), each with fewer than 100 stack levels in the backtrace. Nowhere near 152526 stack frames.
|
||
Comment 4•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
|
Reporter | |
Comment 5•8 months ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=453629900&repo=mozilla-esr115
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 7•7 months ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: REOPENED → RESOLVED
Closed: 1 year ago → 7 months ago
Resolution: --- → INCOMPLETE
|
|
Reporter | |
Comment 8•4 months ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=468080887&repo=autoland
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 10•3 months ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: REOPENED → RESOLVED
Closed: 7 months ago → 3 months ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•