1869552 - Intermittent Assertion failure: [GFX1]: RGBX pixel at (0,0) in 784x252 surface is not opaque: 0,0,0,0, at /builds/worker/workspace/obj-build/dist/include/mozilla/gfx/Logging.h:756 | single tracking bug

Status: RESOLVED FIXED

(Core :: Graphics: Canvas2D, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2023-12-12T14:43:11.596Z] 14:43:11     INFO - TEST-START | toolkit/components/pdfjs/test/browser_pdfjs_js.js
[task 2023-12-12T14:43:11.640Z] 14:43:11     INFO - GECKO(24047) | [Child 24241: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f612d458400 == 1 [pid = 24241] [id = 3]
[task 2023-12-12T14:43:11.640Z] 14:43:11     INFO - GECKO(24047) | [Child 24241: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f612d499020) [pid = 24241] [serial = 10] [outer = 0]
<...>
[task 2023-12-12T14:43:13.961Z] 14:43:13     INFO - GECKO(24047) | [Parent 24047, CanvasRenderer] WARNING: Failed to make an ideal SurfaceFactory.: file /builds/worker/checkouts/gecko/dom/canvas/WebGLContext.cpp:1027
[task 2023-12-12T14:43:14.404Z] 14:43:14     INFO - GECKO(24047) | [Parent 24047, CanvasRenderer] WARNING: Failed to make an ideal SurfaceFactory.: file /builds/worker/checkouts/gecko/dom/canvas/WebGLContext.cpp:1027
[task 2023-12-12T14:43:14.507Z] 14:43:14     INFO - GECKO(24047) | [GFX1]: RGBX pixel at (0,0) in 784x252 surface is not opaque: 0,0,0,0
[task 2023-12-12T14:43:14.507Z] 14:43:14     INFO - GECKO(24047) | Assertion failure: [GFX1]: RGBX pixel at (0,0) in 784x252 surface is not opaque: 0,0,0,0, at /builds/worker/workspace/obj-build/dist/include/mozilla/gfx/Logging.h:756
[task 2023-12-12T14:43:14.514Z] 14:43:14     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2023-12-12T14:43:55.343Z] 14:43:55     INFO - GECKO(24047) | #01: mozilla::gfx::Log<1, mozilla::gfx::CriticalLogger>::WriteLog(std::string const&) [gfx/2d/Logging.h:757]
[task 2023-12-12T14:43:55.345Z] 14:43:55     INFO - GECKO(24047) | #02: mozilla::gfx::Log<1, mozilla::gfx::CriticalLogger>::Flush() [gfx/2d/Logging.h:278]
[task 2023-12-12T14:43:55.346Z] 14:43:55     INFO - GECKO(24047) | #03: mozilla::gfx::Log<1, mozilla::gfx::CriticalLogger>::~Log() [gfx/2d/Logging.h:269]
[task 2023-12-12T14:43:55.346Z] 14:43:55     INFO - GECKO(24047) | #04: mozilla::gfx::VerifyRGBXFormat(unsigned char*, mozilla::gfx::IntSizeTyped<mozilla::gfx::UnknownUnits> const&, int, mozilla::gfx::SurfaceFormat) [gfx/2d/DrawTargetSkia.cpp:172]
[task 2023-12-12T14:43:55.347Z] 14:43:55     INFO - GECKO(24047) | #05: mozilla::gfx::DrawTargetSkia::OptimizeSourceSurface(mozilla::gfx::SourceSurface*) const [gfx/2d/DrawTargetSkia.cpp:1653]
[task 2023-12-12T14:43:55.348Z] 14:43:55     INFO - GECKO(24047) | #06: nsLayoutUtils::SurfaceFromElement(mozilla::dom::HTMLCanvasElement*, unsigned int, RefPtr<mozilla::gfx::DrawTarget>&) [layout/base/nsLayoutUtils.cpp:7539]
[task 2023-12-12T14:43:55.350Z] 14:43:55     INFO - GECKO(24047) | #07: nsLayoutUtils::SurfaceFromElement(mozilla::dom::Element*, mozilla::Maybe<int> const&, mozilla::Maybe<int> const&, unsigned int, RefPtr<mozilla::gfx::DrawTarget>&) [layout/base/nsLayoutUtils.cpp:0]
[task 2023-12-12T14:43:55.350Z] 14:43:55     INFO - GECKO(24047) | #08: mozilla::dom::CanvasRenderingContext2D::DrawImage(mozilla::dom::HTMLImageElementOrSVGImageElementOrHTMLCanvasElementOrHTMLVideoElementOrOffscreenCanvasOrImageBitmapOrVideoFrame const&, double, double, double, double, double, double, double, double, unsigned char, mozilla::ErrorResult&) [dom/canvas/CanvasRenderingContext2D.cpp:5375]
[task 2023-12-12T14:43:55.351Z] 14:43:55     INFO - GECKO(24047) | #09: mozilla::dom::CanvasRenderingContext2D_Binding::drawImage(JSContext*, JS::Handle<JSObject*>, void*, JSJitMethodCallArgs const&) [s3:gecko-generated-sources:52e1f3d980b382123946ba29fc7255656ead0ea5f8de208aa5f96a01d897eab9aad5554154e3b54c5bf107341401fe7cd0b1c4784ac9cb7c056ba2adc4eea5db/dom/bindings/CanvasRenderingContext2DBinding.cpp::4028]
[task 2023-12-12T14:43:55.351Z] 14:43:55     INFO - GECKO(24047) | #10: mozilla::dom::binding_detail::GenericMethod<mozilla::dom::binding_detail::NormalThisPolicy, mozilla::dom::binding_detail::ThrowExceptions>(JSContext*, unsigned int, JS::Value*) [dom/bindings/BindingUtils.cpp:3322]
[task 2023-12-12T14:43:55.351Z] 14:43:55     INFO - GECKO(24047) | #11: CallJSNative(JSContext*, bool (*)(JSContext*, unsigned int, JS::Value*), js::CallReason, JS::CallArgs const&) [js/src/vm/Interpreter.cpp:479]
[task 2023-12-12T14:43:55.352Z] 14:43:55     INFO - GECKO(24047) | #12: js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [js/src/vm/Interpreter.cpp:573]
[task 2023-12-12T14:43:55.352Z] 14:43:55     INFO - GECKO(24047) | #13: js::Interpret(JSContext*, js::RunState&) [js/src/vm/Interpreter.cpp:3060]
[task 2023-12-12T14:43:55.353Z] 14:43:55     INFO - GECKO(24047) | #14: js::RunScript(JSContext*, js::RunState&) [js/src/vm/Interpreter.cpp:451]
[task 2023-12-12T14:43:55.354Z] 14:43:55     INFO - GECKO(24047) | #15: js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [js/src/vm/Interpreter.cpp:605]
[task 2023-12-12T14:43:55.354Z] 14:43:55     INFO - GECKO(24047) | #16: js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) [js/src/vm/Interpreter.cpp:672]
[task 2023-12-12T14:43:55.355Z] 14:43:55     INFO - GECKO(24047) | #17: js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::MutableHandle<JS::Value>) [js/src/vm/Interpreter.h:117]
[task 2023-12-12T14:43:55.356Z] 14:43:55     INFO - GECKO(24047) | #18: PromiseReactionJob(JSContext*, unsigned int, JS::Value*) [js/src/builtin/Promise.cpp:0]
[task 2023-12-12T14:43:55.356Z] 14:43:55     INFO - GECKO(24047) | #19: CallJSNative(JSContext*, bool (*)(JSContext*, unsigned int, JS::Value*), js::CallReason, JS::CallArgs const&) [js/src/vm/Interpreter.cpp:479]
[task 2023-12-12T14:43:55.357Z] 14:43:55     INFO - GECKO(24047) | #20: js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct, js::CallReason) [js/src/vm/Interpreter.cpp:573]
[task 2023-12-12T14:43:55.358Z] 14:43:55     INFO - GECKO(24047) | #21: js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>, js::CallReason) [js/src/vm/Interpreter.cpp:672]
[task 2023-12-12T14:43:55.359Z] 14:43:55     INFO - GECKO(24047) | #22: JS::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) [js/src/vm/CallAndConstruct.cpp:119]
[task 2023-12-12T14:43:55.362Z] 14:43:55     INFO - GECKO(24047) | #23: mozilla::dom::PromiseJobCallback::Call(mozilla::dom::BindingCallContext&, JS::Handle<JS::Value>, mozilla::ErrorResult&) [s3:gecko-generated-sources:5095268f7c5949f0c02c49221f34e314e5ee03c4a3d61ce784515eaf6c64062eb5bc701cb77a5178670ddafe096e283db067c70a27f138a46ba0f6b418691f4c/dom/bindings/PromiseBinding.cpp::83]
[task 2023-12-12T14:43:55.363Z] 14:43:55     INFO - GECKO(24047) | #24: mozilla::dom::PromiseJobCallback::Call(mozilla::ErrorResult&, char const*, mozilla::dom::CallbackObject::ExceptionHandling, JS::Realm*) [s3:gecko-generated-sources:0510db7d89ed2a7559a6cb8d9c78ca70cd2e06369e6f78f8d04e3545348cb44ddcaa7af945798b821a8d7729ea2f38ea75347b2414925c4e9d9cc974b821f591/dist/include/mozilla/dom/PromiseBinding.h::0]
[task 2023-12-12T14:43:55.364Z] 14:43:55     INFO - GECKO(24047) | #25: mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) [xpcom/base/CycleCollectedJSContext.cpp:210]
[task 2023-12-12T14:43:55.365Z] 14:43:55     INFO - GECKO(24047) | #26: mozilla::CycleCollectedJSContext::PerformMicroTaskCheckPoint(bool) [xpcom/base/CycleCollectedJSContext.cpp:713]
[task 2023-12-12T14:43:55.366Z] 14:43:55     INFO - GECKO(24047) | #27: mozilla::dom::CallbackObject::CallSetup::~CallSetup() [dom/bindings/CallbackObject.cpp:396]
[task 2023-12-12T14:43:55.366Z] 14:43:55     INFO - GECKO(24047) | #28: mozilla::dom::FrameRequestCallback::Call(double, mozilla::ErrorResult&, char const*, mozilla::dom::CallbackObject::ExceptionHandling, JS::Realm*) [s3:gecko-generated-sources:4192c8dccf481c3278a570b3cd66d3d18e5bb7b68ca2c796f56617e211f88d3249cf88d547d1f55eb1f4a9bd5683f2ae9937d841aa46a8207619c251c0a1373e/dist/include/mozilla/dom/AnimationFrameProviderBinding.h::86]
[task 2023-12-12T14:43:55.367Z] 14:43:55     INFO - GECKO(24047) | #29: nsRefreshDriver::RunFrameRequestCallbacks(mozilla::TimeStamp) [layout/base/nsRefreshDriver.cpp:2387]
[task 2023-12-12T14:43:55.368Z] 14:43:55     INFO - GECKO(24047) | #30: nsRefreshDriver::TickObserverArray(unsigned int, mozilla::TimeStamp) [layout/base/nsRefreshDriver.cpp:2479]
[task 2023-12-12T14:43:55.368Z] 14:43:55     INFO - GECKO(24047) | #31: nsRefreshDriver::Tick(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, nsRefreshDriver::IsExtraTick) [layout/base/nsRefreshDriver.cpp:2732]
[task 2023-12-12T14:43:55.379Z] 14:43:55     INFO - GECKO(24047) | #32: mozilla::detail::RunnableFunction<nsRefreshDriver::FinishedWaitingForTransaction()::$_0>::Run() [xpcom/threads/nsThreadUtils.h:549]
[task 2023-12-12T14:43:55.381Z] 14:43:55     INFO - GECKO(24047) | #33: mozilla::RunnableTask::Run() [xpcom/threads/TaskController.cpp:550]
[task 2023-12-12T14:43:55.382Z] 14:43:55     INFO - GECKO(24047) | #34: mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [xpcom/threads/TaskController.cpp:876]
[task 2023-12-12T14:43:55.383Z] 14:43:55     INFO - GECKO(24047) | #35: mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [xpcom/threads/TaskController.cpp:0]
[task 2023-12-12T14:43:55.384Z] 14:43:55     INFO - GECKO(24047) | #36: mozilla::TaskController::ProcessPendingMTTask(bool) [xpcom/threads/TaskController.cpp:485]
[task 2023-12-12T14:43:55.385Z] 14:43:55     INFO - GECKO(24047) | #37: mozilla::detail::RunnableFunction<mozilla::TaskController::TaskController()::$_0>::Run() [xpcom/threads/nsThreadUtils.h:549]
[task 2023-12-12T14:43:55.385Z] 14:43:55     INFO - GECKO(24047) | #38: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1203]
[task 2023-12-12T14:43:55.386Z] 14:43:55     INFO - GECKO(24047) | #39: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:480]
[task 2023-12-12T14:43:55.386Z] 14:43:55     INFO - GECKO(24047) | #40: mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:85]
[task 2023-12-12T14:43:55.387Z] 14:43:55     INFO - GECKO(24047) | #41: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:346]
[task 2023-12-12T14:43:55.387Z] 14:43:55     INFO - GECKO(24047) | #42: nsBaseAppShell::Run() [widget/nsBaseAppShell.cpp:150]
[task 2023-12-12T14:43:55.388Z] 14:43:55     INFO - GECKO(24047) | #43: nsAppShell::Run() [widget/gtk/nsAppShell.cpp:470]
[task 2023-12-12T14:43:55.388Z] 14:43:55     INFO - GECKO(24047) | #44: XRE_RunAppShell() [toolkit/xre/nsEmbedFunctions.cpp:721]
[task 2023-12-12T14:43:55.390Z] 14:43:55     INFO - GECKO(24047) | #45: mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:235]
[task 2023-12-12T14:43:55.390Z] 14:43:55     INFO - GECKO(24047) | #46: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:346]
[task 2023-12-12T14:43:55.391Z] 14:43:55     INFO - GECKO(24047) | #47: XRE_InitChildProcess(int, char**, XREChildData const*) [toolkit/xre/nsEmbedFunctions.cpp:660]
[task 2023-12-12T14:43:55.590Z] 14:43:55     INFO - GECKO(24047) | #48: main [browser/app/nsBrowserApp.cpp:375]
[task 2023-12-12T14:43:55.600Z] 14:43:55     INFO - GECKO(24047) | #49: __libc_start_main [/lib/x86_64-linux-gnu/libc.so.6 + 0x21b97]
[task 2023-12-12T14:43:55.606Z] 14:43:55     INFO - GECKO(24047) | #50: ??? [/builds/worker/workspace/build/application/firefox/firefox-bin + 0x3da29]
[task 2023-12-12T14:43:55.606Z] 14:43:55     INFO - GECKO(24047) | #51: ??? (???:???)
[task 2023-12-12T14:43:55.606Z] 14:43:55     INFO - GECKO(24047) | Hit MOZ_CRASH(GFX: An assert from the graphics logger) at /builds/worker/workspace/obj-build/dist/include/mozilla/gfx/Logging.h:757

Comment 1

[Iulian Moraru]

Hi Lee! Can you please take a look at this? Could this be something regressed by Bug 1829026?
Thank you!

• backfills and retriggers

Comment 2

[Intermittent Failures Robot]

11 failures in 4224 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 9
• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-qr: 10
  • debug: 10
• macosx1015-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2023-12-11&endday=2023-12-17&tree=all

Comment 3

[Lee Salzman [:lsalzman]]

Seems plausible this is a result of bug 1829026. The assertion shouldn't represent anything too bad or alarming, and it might take a while to track this down until we can find something more minimized a testcase.

Comment 4

[Intermittent Failures Robot]

13 failures in 3349 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 11
• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-qr: 13
  • debug: 13

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2023-12-18&endday=2023-12-24&tree=all

Comment 5

[Intermittent Failures Robot]

7 failures in 1162 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2
• autoland: 4
• try: 1

Platform and build breakdown:

• linux1804-64-qr: 7
  • debug: 7

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2023-12-25&endday=2023-12-31&tree=all

Comment 6

[Intermittent Failures Robot]

11 failures in 2274 pushes (0.005 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 4
• autoland: 7

Platform and build breakdown:

• linux1804-64-qr: 11
  • debug: 11

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2024-01-01&endday=2024-01-07&tree=all

Comment 7

[BugBot [:suhaib / :marco/ :calixte]]

Set release status flags based on info from the regressing bug 1829026

Comment 8

[Intermittent Failures Robot]

12 failures in 3217 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 9
• mozilla-central: 2
• try: 1

Platform and build breakdown:

• linux1804-64-qr: 11
  • debug: 11
• macosx1015-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2024-01-08&endday=2024-01-14&tree=all

Comment 9

[Intermittent Failures Robot]

11 failures in 3599 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 3
• autoland: 8

Platform and build breakdown:

• linux1804-64-qr: 11
  • debug: 11

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2024-01-15&endday=2024-01-21&tree=all

Comment 10

[Lee Salzman [:lsalzman]]

Attachment: Bug 1869552 - Check for WaitForCheckpoint failure. r?aosmond

Comment 11

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/ff89980efeaf
Check for WaitForCheckpoint failure. r=aosmond

Comment 12

[Atila Butkovits]

https://hg.mozilla.org/mozilla-central/rev/ff89980efeaf

Comment 13

[BugBot [:suhaib / :marco/ :calixte]]

The patch landed in nightly and beta is affected.
:lsalzman, is this bug important enough to require an uplift?

• If yes, please nominate the patch for beta approval.
• If no, please set status-firefox123 to wontfix.

For more information, please visit BugBot documentation.

Comment 14

[Intermittent Failures Robot]

2 failures in 4034 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1
• mozilla-beta: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1
• macosx1015-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2024-01-22&endday=2024-01-28&tree=all

Comment 15

[Intermittent Failures Robot]

1 failures in 3952 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• macosx1015-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869552&startday=2024-01-29&endday=2024-02-04&tree=all