Closed Bug 1665603 Opened 5 years ago Closed 5 years ago

Intermittent Assertion failure: mBuffer, at /builds/worker/checkouts/gecko/gfx/layers/client/ContentClient.cpp:873

Categories

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

Product:
Core
Component:
Graphics: Layers
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: assertion, intermittent-failure)

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

[task 2020-09-17T09:56:51.080Z] 09:56:51 INFO - TEST-START | browser/components/shell/test/browser_633221.js
[task 2020-09-17T09:56:51.081Z] 09:56:51 INFO - GECKO(5368) | Chrome file doesn't exist: /builds/worker/workspace/build/tests/mochitest/browser/browser/components/shell/test/head.js
[task 2020-09-17T09:56:51.223Z] 09:56:51 INFO - GECKO(5368) | Exiting due to channel error.
[task 2020-09-17T09:56:51.223Z] 09:56:51 INFO - GECKO(5368) | Exiting due to channel error.
[task 2020-09-17T09:56:51.223Z] 09:56:51 INFO - GECKO(5368) | Exiting due to channel error.
[task 2020-09-17T09:56:51.228Z] 09:56:51 INFO - GECKO(5368) | Sandbox: Unexpected EOF, op 0 flags 02400302 path /dev/shm/org.mozilla.ipc.5610.5
[task 2020-09-17T09:56:51.229Z] 09:56:51 INFO - GECKO(5368) | [Child 5610, Main Thread] WARNING: failed to open shm: Input/output error: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/shared_memory_posix.cc, line 163
[task 2020-09-17T09:56:51.229Z] 09:56:51 INFO - GECKO(5368) | [Child 5610, Main Thread] WARNING: Attempt to Lock a texture that is being read by the compositor!: file /builds/worker/checkouts/gecko/gfx/layers/client/TextureClient.cpp, line 696
[task 2020-09-17T09:56:51.230Z] 09:56:51 INFO - GECKO(5368) | [Child 5610, Main Thread] WARNING: failed to open shm: Connection reset by peer: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/shared_memory_posix.cc, line 163
[task 2020-09-17T09:56:51.231Z] 09:56:51 INFO - GECKO(5368) | [GFX1-]: Failed buffer for 0, 0, 1280, 966
[task 2020-09-17T09:56:51.232Z] 09:56:51 INFO - GECKO(5368) | [Child 5610, Main Thread] WARNING: failed to open shm: Broken pipe: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/shared_memory_posix.cc, line 163
[task 2020-09-17T09:56:51.234Z] 09:56:51 INFO - GECKO(5368) | Assertion failure: mBuffer, at /builds/worker/checkouts/gecko/gfx/layers/client/ContentClient.cpp:873
[task 2020-09-17T09:56:51.235Z] 09:56:51 INFO - GECKO(5368) | #01: mozilla::layers::ContentClientDoubleBuffered::BeginPaint(mozilla::layers::PaintedLayer*, unsigned int) [gfx/layers/client/ContentClient.cpp:787]
[task 2020-09-17T09:56:51.236Z] 09:56:51 INFO - GECKO(5368) | #02: mozilla::layers::ClientPaintedLayer::RenderLayerWithReadback(mozilla::layers::ReadbackProcessor*) [gfx/layers/client/ClientPaintedLayer.cpp:133]
[task 2020-09-17T09:56:51.237Z] 09:56:51 INFO - GECKO(5368) | Exiting due to channel error.
[task 2020-09-17T09:56:51.238Z] 09:56:51 INFO - GECKO(5368) | #03: mozilla::layers::ClientContainerLayer::RenderLayer() [gfx/layers/client/ClientContainerLayer.h:55]
[task 2020-09-17T09:56:51.238Z] 09:56:51 INFO - GECKO(5368) | #04: mozilla::layers::ClientContainerLayer::RenderLayer() [gfx/layers/client/ClientContainerLayer.h:55]
[task 2020-09-17T09:56:51.240Z] 09:56:51 INFO - GECKO(5368) | #05: mozilla::layers::ClientContainerLayer::RenderLayer() [gfx/layers/client/ClientContainerLayer.h:55]
[task 2020-09-17T09:56:51.242Z] 09:56:51 INFO - GECKO(5368) | #06: mozilla::layers::ClientLayerManager::EndTransactionInternal(void ()(mozilla::layers::PaintedLayer, gfxContext*, mozilla::gfx::IntRegionTyped<mozilla::gfx::UnknownUnits> const&, mozilla::gfx::IntRegionTyped<mozilla::gfx::UnknownUnits> const&, mozilla::layers::DrawRegionClip, mozilla::gfx::IntRegionTyped<mozilla::gfx::UnknownUnits> const&, void*), void*, mozilla::layers::LayerManager::EndTransactionFlags) [gfx/layers/client/ClientLayerManager.cpp:350]
[task 2020-09-17T09:56:51.244Z] 09:56:51 INFO - GECKO(5368) | #07: mozilla::layers::ClientLayerManager::EndTransaction(void ()(mozilla::layers::PaintedLayer, gfxContext*, mozilla::gfx::IntRegionTyped<mozilla::gfx::UnknownUnits> const&, mozilla::gfx::IntRegionTyped<mozilla::gfx::UnknownUnits> const&, mozilla::layers::DrawRegionClip, mozilla::gfx::IntRegionTyped<mozilla::gfx::UnknownUnits> const&, void*), void*, mozilla::layers::LayerManager::EndTransactionFlags) [gfx/layers/client/ClientLayerManager.cpp:406]
[task 2020-09-17T09:56:51.245Z] 09:56:51 INFO - GECKO(5368) | #08: nsDisplayList::PaintRoot(nsDisplayListBuilder*, gfxContext*, unsigned int) [layout/painting/nsDisplayList.cpp:2516]
[task 2020-09-17T09:56:51.246Z] 09:56:51 INFO - GECKO(5368) | #09: nsLayoutUtils::PaintFrame(gfxContext*, nsIFrame*, nsRegion const&, unsigned int, nsDisplayListBuilderMode, nsLayoutUtils::PaintFrameFlags) [layout/base/nsLayoutUtils.cpp:4352]
[task 2020-09-17T09:56:51.246Z] 09:56:51 INFO - GECKO(5368) | #10: mozilla::PresShell::Paint(nsView*, nsRegion const&, mozilla::PaintFlags) [layout/base/PresShell.cpp:6375]
[task 2020-09-17T09:56:51.246Z] 09:56:51 INFO - GECKO(5368) | #11: nsViewManager::ProcessPendingUpdatesPaint(nsIWidget*) [view/nsViewManager.cpp:460]
[task 2020-09-17T09:56:51.247Z] 09:56:51 INFO - GECKO(5368) | #12: nsViewManager::ProcessPendingUpdatesForView(nsView*, bool) [view/nsViewManager.cpp:396]
[task 2020-09-17T09:56:51.250Z] 09:56:51 INFO - GECKO(5368) | #13: nsViewManager::ProcessPendingUpdates() [view/nsViewManager.cpp:1019]
[task 2020-09-17T09:56:51.250Z] 09:56:51 INFO - GECKO(5368) | #14: nsRefreshDriver::Tick(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp) [layout/base/nsRefreshDriver.cpp:2289]
[task 2020-09-17T09:56:51.251Z] 09:56:51 INFO - GECKO(5368) | #15: mozilla::RefreshDriverTimer::TickRefreshDrivers(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, nsTArray<RefPtr<nsRefreshDriver> >&) [layout/base/nsRefreshDriver.cpp:346]
[task 2020-09-17T09:56:51.252Z] 09:56:51 INFO - GECKO(5368) | #16: mozilla::RefreshDriverTimer::Tick(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp) [layout/base/nsRefreshDriver.cpp:369]
[task 2020-09-17T09:56:51.252Z] 09:56:51 INFO - GECKO(5368) | #17: mozilla::VsyncRefreshDriverTimer::RefreshDriverVsyncObserver::TickRefreshDriver(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp) [layout/base/nsRefreshDriver.cpp:745]
[task 2020-09-17T09:56:51.253Z] 09:56:51 INFO - GECKO(5368) | #18: mozilla::VsyncRefreshDriverTimer::RefreshDriverVsyncObserver::NotifyParentProcessVsync() [layout/base/nsRefreshDriver.cpp:646]
[task 2020-09-17T09:56:51.253Z] 09:56:51 INFO - GECKO(5368) | #19: mozilla::VsyncRefreshDriverTimer::RefreshDriverVsyncObserver::ParentProcessVsyncNotifier::Run() [layout/base/nsRefreshDriver.cpp:539]
[task 2020-09-17T09:56:51.254Z] 09:56:51 INFO - GECKO(5368) | #20: mozilla::RunnableTask::Run() [xpcom/threads/TaskController.cpp:245]
[task 2020-09-17T09:56:51.255Z] 09:56:51 INFO - GECKO(5368) | #21: mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [xpcom/threads/TaskController.cpp:514]
[task 2020-09-17T09:56:51.257Z] 09:56:51 INFO - GECKO(5368) | #22: mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [xpcom/threads/TaskController.cpp:373]
[task 2020-09-17T09:56:51.258Z] 09:56:51 INFO - GECKO(5368) | #23: mozilla::TaskController::ProcessPendingMTTask(bool) [xpcom/threads/TaskController.cpp:170]
[task 2020-09-17T09:56:51.258Z] 09:56:51 INFO - GECKO(5368) | #24: mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_0>::Run() [xpcom/threads/nsThreadUtils.h:578]
[task 2020-09-17T09:56:51.259Z] 09:56:51 INFO - GECKO(5368) | Exiting due to channel error.
[task 2020-09-17T09:56:51.320Z] 09:56:51 INFO - TEST-INFO | Main app process: killed by SIGSEGV
[task 2020-09-17T09:56:51.321Z] 09:56:51 ERROR - TEST-UNEXPECTED-FAIL | ShutdownLeaks | process() called before end of test suite
[task 2020-09-17T09:56:51.321Z] 09:56:51 ERROR - TEST-UNEXPECTED-FAIL | did not see DOCSHELL log strings. this occurs if the DOCSHELL logging gets disabled by something. 16 created seen 0 destroyed seen
[task 2020-09-17T09:56:51.322Z] 09:56:51 ERROR - TEST-UNEXPECTED-FAIL | did not see DOMWINDOW log strings. this occurs if the DOMWINDOW logging gets disabled by something41 created seen 0 destroyed seen
[task 2020-09-17T09:56:51.323Z] 09:56:51 INFO - Buffered messages finished
[task 2020-09-17T09:56:51.324Z] 09:56:51 ERROR - TEST-UNEXPECTED-FAIL | browser/components/shell/test/browser_633221.js | application terminated with exit code -11
[task 2020-09-17T09:56:51.324Z] 09:56:51 INFO - runtests.py | Application ran for: 0:00:10.817797
[task 2020-09-17T09:56:51.325Z] 09:56:51 INFO - zombiecheck | Reading PID log: /tmp/tmpRnfBjCpidlog
[task 2020-09-17T09:56:51.326Z] 09:56:51 INFO - ==> process 5368 launched child process 5389
[task 2020-09-17T09:56:51.326Z] 09:56:51 INFO - ==> process 5368 launched child process 5530
[task 2020-09-17T09:56:51.327Z] 09:56:51 INFO - ==> process 5368 launched child process 5550
[task 2020-09-17T09:56:51.327Z] 09:56:51 INFO - ==> process 5368 launched child process 5610
[task 2020-09-17T09:56:51.328Z] 09:56:51 INFO - ==> process 5368 launched child process 5637
[task 2020-09-17T09:56:51.328Z] 09:56:51 INFO - ==> process 5368 launched child process 5703
[task 2020-09-17T09:56:51.329Z] 09:56:51 INFO - zombiecheck | Checking for orphan process with PID: 5637
[task 2020-09-17T09:56:51.329Z] 09:56:51 INFO - zombiecheck | Checking for orphan process with PID: 5703
[task 2020-09-17T09:56:51.330Z] 09:56:51 INFO - zombiecheck | Checking for orphan process with PID: 5610
[task 2020-09-17T09:56:51.330Z] 09:56:51 INFO - zombiecheck | Checking for orphan process with PID: 5389
[task 2020-09-17T09:56:51.331Z] 09:56:51 INFO - zombiecheck | Checking for orphan process with PID: 5550
[task 2020-09-17T09:56:51.331Z] 09:56:51 INFO - zombiecheck | Checking for orphan process with PID: 5530
[task 2020-09-17T09:56:51.332Z] 09:56:51 INFO - Stopping web server
[task 2020-09-17T09:56:51.336Z] 09:56:51 INFO - Stopping web socket server
[task 2020-09-17T09:56:51.356Z] 09:56:51 INFO - Stopping ssltunnel
[task 2020-09-17T09:56:51.376Z] 09:56:51 INFO - leakcheck | Processing log file /tmp/tmp9lcHWG.mozrunner/runtests_leaks.log
[task 2020-09-17T09:56:51.377Z] 09:56:51 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
[task 2020-09-17T09:56:51.378Z] 09:56:51 INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2020-09-17T09:56:51.378Z] 09:56:51 INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2020-09-17T09:56:51.379Z] 09:56:51 INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2020-09-17T09:56:51.379Z] 09:56:51 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes
[task 2020-09-17T09:56:51.380Z] 09:56:51 INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 400 bytes
[task 2020-09-17T09:56:51.380Z] 09:56:51 INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2020-09-17T09:56:51.380Z] 09:56:51 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 0 bytes
[task 2020-09-17T09:56:51.381Z] 09:56:51 INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2020-09-17T09:56:51.381Z] 09:56:51 INFO - leakcheck | Processing leak log file /tmp/tmp9lcHWG.mozrunner/runtests_leaks.log
[task 2020-09-17T09:56:51.381Z] 09:56:51 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default missing output line for total leaks!
[task 2020-09-17T09:56:51.382Z] 09:56:51 INFO - runtests.py | Running tests: end.
[task 2020-09-17T09:56:51.402Z] 09:56:51 INFO - Buffered messages finished
[task 2020-09-17T09:56:51.402Z] 09:56:51 INFO - Running manifest: browser/extensions/report-site-issue/test/browser/browser.ini
[task 2020-09-17T09:56:51.423Z] 09:56:51 INFO - Setting pipeline to PAUSED ...
[task 2020-09-17T09:56:51.423Z] 09:56:51 INFO - Pipeline is PREROLLING ...
[task 2020-09-17T09:56:51.424Z] 09:56:51 INFO - Pipeline is PREROLLED ...
[task 2020-09-17T09:56:51.424Z] 09:56:51 INFO - Setting pipeline to PLAYING ...
[task 2020-09-17T09:56:51.424Z] 09:56:51 INFO - New clock: GstSystemClock
[task 2020-09-17T09:56:51.460Z] 09:56:51 INFO - Got EOS from element "pipeline0".
[task 2020-09-17T09:56:51.460Z] 09:56:51 INFO - Execution ended after 0:00:00.033438231
[task 2020-09-17T09:56:51.460Z] 09:56:51 INFO - Setting pipeline to PAUSED ...
[task 2020-09-17T09:56:51.460Z] 09:56:51 INFO - Setting pipeline to READY ...
[task 2020-09-17T09:56:51.461Z] 09:56:51 INFO - (gst-launch-1.0:5731): GStreamer-CRITICAL **: 09:56:51.455: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2020-09-17T09:56:51.461Z] 09:56:51 INFO - Setting pipeline to NULL ...
[task 2020-09-17T09:56:51.461Z] 09:56:51 INFO - Freeing pipeline ...
[task 2020-09-17T09:56:51.757Z] 09:56:51 INFO - pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2020-09-17T09:56:51.946Z] 09:56:51 INFO - Increasing default timeout to 90 seconds
[task 2020-09-17T09:56:51.949Z] 09:56:51 INFO - MochitestServer : launching [u'/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-f', '/builds/worker/workspace/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpvqRZr8.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2020-09-17T09:56:51.950Z] 09:56:51 INFO - runtests.py | Server pid: 5750
[task 2020-09-17T09:56:51.966Z] 09:56:51 INFO - runtests.py | Websocket server pid: 5753
[task 2020-09-17T09:56:51.982Z] 09:56:51 INFO - [5750, Unnamed thread 7f318dd6e040] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-17T09:56:51.983Z] 09:56:51 INFO - [5750, Unnamed thread 7f318dd6e040] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-17T09:56:51.990Z] 09:56:51 INFO - runtests.py | SSL tunnel pid: 5756
[task 2020-09-17T09:56:52.072Z] 09:56:52 INFO - Couldn't convert chrome URL: chrome://branding/locale/brand.properties
...

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

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

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=334627070&repo=autoland&lineNumber=9077

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: 5 years ago → 5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.