Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=315586788&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Ko2c0x71RhqMzNprfbOOXg/runs/0/artifacts/public/logs/live_backing.log
[task 2020-09-14T00:49:21.144Z] 00:49:21 INFO - TEST-START | toolkit/content/tests/mochitest/test_mousecapture.xhtml
[task 2020-09-14T00:49:21.292Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp, line 3779
[task 2020-09-14T00:49:21.691Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] ###!!! ASSERTION: Unexpected document: 'aCapturingContent->OwnerDoc() == GetDocument()', file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp, line 7799
[task 2020-09-14T00:49:21.691Z] 00:49:21 INFO - GECKO(2465) | #01: mozilla::PresShell::EventHandler::HandleEventUsingCoordinates(nsIFrame*, mozilla::WidgetGUIEvent*, nsEventStatus*, bool) [layout/base/PresShell.cpp:6946]
[task 2020-09-14T00:49:21.693Z] 00:49:21 INFO - GECKO(2465) | #02: mozilla::PresShell::EventHandler::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6880]
[task 2020-09-14T00:49:21.693Z] 00:49:21 INFO - GECKO(2465) | #03: mozilla::PresShell::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6805]
[task 2020-09-14T00:49:21.694Z] 00:49:21 INFO - GECKO(2465) | #04: nsViewManager::DispatchEvent(mozilla::WidgetGUIEvent*, nsView*, nsEventStatus*) [view/nsViewManager.cpp:749]
[task 2020-09-14T00:49:21.694Z] 00:49:21 INFO - GECKO(2465) | #05: nsView::HandleEvent(mozilla::WidgetGUIEvent*, bool) [view/nsView.cpp:1134]
[task 2020-09-14T00:49:21.694Z] 00:49:21 INFO - GECKO(2465) | #06: mozilla::widget::PuppetWidget::DispatchEvent(mozilla::WidgetGUIEvent*, nsEventStatus&) [widget/PuppetWidget.cpp:381]
[task 2020-09-14T00:49:21.694Z] 00:49:21 INFO - GECKO(2465) | #07: nsContentUtils::SendMouseEvent(mozilla::PresShell*, nsTSubstring<char16_t> const&, float, float, int, int, int, int, bool, float, unsigned short, unsigned int, bool, bool*, bool, bool) [dom/base/nsContentUtils.cpp:7918]
[task 2020-09-14T00:49:21.700Z] 00:49:21 INFO - GECKO(2465) | #08: nsDOMWindowUtils::SendMouseEvent(nsTSubstring<char16_t> const&, float, float, int, int, int, bool, float, unsigned short, bool, bool, int, unsigned int, unsigned char, bool*) [dom/base/nsDOMWindowUtils.cpp:652]
[task 2020-09-14T00:49:21.701Z] 00:49:21 INFO - GECKO(2465) | #09: NS_InvokeByIndex [/Users/cltbld/tasks/task_1600039967/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1cc97e]
[task 2020-09-14T00:49:21.701Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] ###!!! ASSERTION: Unexpected document: 'capturingContent->OwnerDoc() == GetDocument()', file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp, line 7020
[task 2020-09-14T00:49:21.701Z] 00:49:21 INFO - GECKO(2465) | #01: mozilla::PresShell::EventHandler::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6880]
[task 2020-09-14T00:49:21.701Z] 00:49:21 INFO - GECKO(2465) | #02: mozilla::PresShell::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6805]
[task 2020-09-14T00:49:21.701Z] 00:49:21 INFO - GECKO(2465) | #03: nsViewManager::DispatchEvent(mozilla::WidgetGUIEvent*, nsView*, nsEventStatus*) [view/nsViewManager.cpp:749]
[task 2020-09-14T00:49:21.702Z] 00:49:21 INFO - GECKO(2465) | #04: nsView::HandleEvent(mozilla::WidgetGUIEvent*, bool) [view/nsView.cpp:1134]
[task 2020-09-14T00:49:21.702Z] 00:49:21 INFO - GECKO(2465) | #05: mozilla::widget::PuppetWidget::DispatchEvent(mozilla::WidgetGUIEvent*, nsEventStatus&) [widget/PuppetWidget.cpp:381]
[task 2020-09-14T00:49:21.702Z] 00:49:21 INFO - GECKO(2465) | #06: nsContentUtils::SendMouseEvent(mozilla::PresShell*, nsTSubstring<char16_t> const&, float, float, int, int, int, int, bool, float, unsigned short, unsigned int, bool, bool*, bool, bool) [dom/base/nsContentUtils.cpp:7918]
[task 2020-09-14T00:49:21.702Z] 00:49:21 INFO - GECKO(2465) | #07: nsDOMWindowUtils::SendMouseEvent(nsTSubstring<char16_t> const&, float, float, int, int, int, bool, float, unsigned short, bool, bool, int, unsigned int, unsigned char, bool*) [dom/base/nsDOMWindowUtils.cpp:652]
[task 2020-09-14T00:49:21.702Z] 00:49:21 INFO - GECKO(2465) | #08: NS_InvokeByIndex [/Users/cltbld/tasks/task_1600039967/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1cc97e]
[task 2020-09-14T00:49:21.703Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] ###!!! ASSERTION: Unexpected document: 'aCapturingContent->OwnerDoc() == GetDocument()', file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp, line 7799
[task 2020-09-14T00:49:21.703Z] 00:49:21 INFO - GECKO(2465) | #01: mozilla::PresShell::EventHandler::HandleEventUsingCoordinates(nsIFrame*, mozilla::WidgetGUIEvent*, nsEventStatus*, bool) [layout/base/PresShell.cpp:6946]
[task 2020-09-14T00:49:21.703Z] 00:49:21 INFO - GECKO(2465) | #02: mozilla::PresShell::EventHandler::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6880]
[task 2020-09-14T00:49:21.704Z] 00:49:21 INFO - GECKO(2465) | #03: mozilla::PresShell::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6805]
[task 2020-09-14T00:49:21.705Z] 00:49:21 INFO - GECKO(2465) | #04: nsViewManager::DispatchEvent(mozilla::WidgetGUIEvent*, nsView*, nsEventStatus*) [view/nsViewManager.cpp:749]
[task 2020-09-14T00:49:21.705Z] 00:49:21 INFO - GECKO(2465) | #05: nsView::HandleEvent(mozilla::WidgetGUIEvent*, bool) [view/nsView.cpp:1134]
[task 2020-09-14T00:49:21.705Z] 00:49:21 INFO - GECKO(2465) | #06: mozilla::widget::PuppetWidget::DispatchEvent(mozilla::WidgetGUIEvent*, nsEventStatus&) [widget/PuppetWidget.cpp:381]
[task 2020-09-14T00:49:21.705Z] 00:49:21 INFO - GECKO(2465) | #07: nsContentUtils::SendMouseEvent(mozilla::PresShell*, nsTSubstring<char16_t> const&, float, float, int, int, int, int, bool, float, unsigned short, unsigned int, bool, bool*, bool, bool) [dom/base/nsContentUtils.cpp:7918]
[task 2020-09-14T00:49:21.706Z] 00:49:21 INFO - GECKO(2465) | #08: nsDOMWindowUtils::SendMouseEvent(nsTSubstring<char16_t> const&, float, float, int, int, int, bool, float, unsigned short, bool, bool, int, unsigned int, unsigned char, bool*) [dom/base/nsDOMWindowUtils.cpp:652]
[task 2020-09-14T00:49:21.706Z] 00:49:21 INFO - GECKO(2465) | #09: NS_InvokeByIndex [/Users/cltbld/tasks/task_1600039967/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1cc97e]
[task 2020-09-14T00:49:21.706Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] ###!!! ASSERTION: Unexpected document: 'capturingContent->OwnerDoc() == GetDocument()', file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp, line 7020
[task 2020-09-14T00:49:21.706Z] 00:49:21 INFO - GECKO(2465) | #01: mozilla::PresShell::EventHandler::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6880]
[task 2020-09-14T00:49:21.707Z] 00:49:21 INFO - GECKO(2465) | #02: mozilla::PresShell::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6805]
[task 2020-09-14T00:49:21.708Z] 00:49:21 INFO - GECKO(2465) | #03: nsViewManager::DispatchEvent(mozilla::WidgetGUIEvent*, nsView*, nsEventStatus*) [view/nsViewManager.cpp:749]
[task 2020-09-14T00:49:21.708Z] 00:49:21 INFO - GECKO(2465) | #04: nsView::HandleEvent(mozilla::WidgetGUIEvent*, bool) [view/nsView.cpp:1134]
[task 2020-09-14T00:49:21.708Z] 00:49:21 INFO - GECKO(2465) | #05: mozilla::widget::PuppetWidget::DispatchEvent(mozilla::WidgetGUIEvent*, nsEventStatus&) [widget/PuppetWidget.cpp:381]
[task 2020-09-14T00:49:21.708Z] 00:49:21 INFO - GECKO(2465) | #06: nsContentUtils::SendMouseEvent(mozilla::PresShell*, nsTSubstring<char16_t> const&, float, float, int, int, int, int, bool, float, unsigned short, unsigned int, bool, bool*, bool, bool) [dom/base/nsContentUtils.cpp:7918]
[task 2020-09-14T00:49:21.711Z] 00:49:21 INFO - GECKO(2465) | #07: nsDOMWindowUtils::SendMouseEvent(nsTSubstring<char16_t> const&, float, float, int, int, int, bool, float, unsigned short, bool, bool, int, unsigned int, unsigned char, bool*) [dom/base/nsDOMWindowUtils.cpp:652]
[task 2020-09-14T00:49:21.711Z] 00:49:21 INFO - GECKO(2465) | #08: NS_InvokeByIndex [/Users/cltbld/tasks/task_1600039967/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1cc97e]
[task 2020-09-14T00:49:21.836Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp, line 1598
[task 2020-09-14T00:49:21.836Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: 'selection.mReply.mContentsRoot != mRootContent', file /builds/worker/checkouts/gecko/dom/events/IMEContentObserver.cpp, line 1314
[task 2020-09-14T00:49:21.836Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: 'aEvent->mReply.mContentsRoot != mRootContent', file /builds/worker/checkouts/gecko/dom/events/IMEContentObserver.cpp, line 707
[task 2020-09-14T00:49:21.836Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: '!queryText.mSucceeded', file /builds/worker/checkouts/gecko/widget/ContentCache.cpp, line 236
[task 2020-09-14T00:49:21.836Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: '!CacheText(aWidget, aNotification)', file /builds/worker/checkouts/gecko/widget/ContentCache.cpp, line 123
[task 2020-09-14T00:49:21.836Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: '!mContentCache.CacheAll(this, &aIMENotification)', file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 755
[task 2020-09-14T00:49:21.836Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] ###!!! ASSERTION: Unexpected document: 'aCapturingContent->OwnerDoc() == GetDocument()', file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp, line 7799
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #01: mozilla::PresShell::EventHandler::HandleEventUsingCoordinates(nsIFrame*, mozilla::WidgetGUIEvent*, nsEventStatus*, bool) [layout/base/PresShell.cpp:6946]
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #02: mozilla::PresShell::EventHandler::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6880]
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #03: mozilla::PresShell::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6805]
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #04: nsViewManager::DispatchEvent(mozilla::WidgetGUIEvent*, nsView*, nsEventStatus*) [view/nsViewManager.cpp:749]
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #05: nsView::HandleEvent(mozilla::WidgetGUIEvent*, bool) [view/nsView.cpp:1134]
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #06: mozilla::widget::PuppetWidget::DispatchEvent(mozilla::WidgetGUIEvent*, nsEventStatus&) [widget/PuppetWidget.cpp:381]
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #07: nsContentUtils::SendMouseEvent(mozilla::PresShell*, nsTSubstring<char16_t> const&, float, float, int, int, int, int, bool, float, unsigned short, unsigned int, bool, bool*, bool, bool) [dom/base/nsContentUtils.cpp:7918]
[task 2020-09-14T00:49:21.837Z] 00:49:21 INFO - GECKO(2465) | #08: nsDOMWindowUtils::SendMouseEvent(nsTSubstring<char16_t> const&, float, float, int, int, int, bool, float, unsigned short, bool, bool, int, unsigned int, unsigned char, bool*) [dom/base/nsDOMWindowUtils.cpp:652]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #09: NS_InvokeByIndex [/Users/cltbld/tasks/task_1600039967/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1cc97e]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | [Child 2467, Main Thread] ###!!! ASSERTION: Unexpected document: 'capturingContent->OwnerDoc() == GetDocument()', file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp, line 7020
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #01: mozilla::PresShell::EventHandler::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6880]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #02: mozilla::PresShell::HandleEvent(nsIFrame*, mozilla::WidgetGUIEvent*, bool, nsEventStatus*) [layout/base/PresShell.cpp:6805]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #03: nsViewManager::DispatchEvent(mozilla::WidgetGUIEvent*, nsView*, nsEventStatus*) [view/nsViewManager.cpp:749]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #04: nsView::HandleEvent(mozilla::WidgetGUIEvent*, bool) [view/nsView.cpp:1134]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #05: mozilla::widget::PuppetWidget::DispatchEvent(mozilla::WidgetGUIEvent*, nsEventStatus&) [widget/PuppetWidget.cpp:381]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #06: nsContentUtils::SendMouseEvent(mozilla::PresShell*, nsTSubstring<char16_t> const&, float, float, int, int, int, int, bool, float, unsigned short, unsigned int, bool, bool*, bool, bool) [dom/base/nsContentUtils.cpp:7918]
[task 2020-09-14T00:49:21.838Z] 00:49:21 INFO - GECKO(2465) | #07: nsDOMWindowUtils::SendMouseEvent(nsTSubstring<char16_t> const&, float, float, int, int, int, bool, float, unsigned short, bool, bool, int, unsigned int, unsigned char, bool*) [dom/base/nsDOMWindowUtils.cpp:652]
[task 2020-09-14T00:49:21.839Z] 00:49:21 INFO - GECKO(2465) | #08: NS_InvokeByIndex [/Users/cltbld/tasks/task_1600039967/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x1cc97e]
[task 2020-09-14T00:49:22.569Z] 00:49:22 INFO - GECKO(2465) | [Child 2468, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp, line 8515
[task 2020-09-14T00:49:22.569Z] 00:49:22 INFO - GECKO(2465) | [Child 2468, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp, line 8515
[task 2020-09-14T00:49:22.569Z] 00:49:22 INFO - GECKO(2465) | [Child 2468, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp, line 8515
[task 2020-09-14T00:49:22.569Z] 00:49:22 INFO - GECKO(2465) | [Child 2468, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp, line 8515
[task 2020-09-14T00:49:22.569Z] 00:49:22 INFO - GECKO(2465) | [Child 2468, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp, line 8515
[task 2020-09-14T00:49:22.569Z] 00:49:22 INFO - GECKO(2465) | [Child 2468, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp, line 8515
[task 2020-09-14T00:49:23.084Z] 00:49:23 INFO - TEST-INFO | started process screencapture
[task 2020-09-14T00:49:23.243Z] 00:49:23 INFO - TEST-INFO | screencapture: exit 0
[task 2020-09-14T00:49:23.243Z] 00:49:23 INFO - Buffered messages logged at 00:49:21
[task 2020-09-14T00:49:23.243Z] 00:49:23 INFO - must wait for load
[task 2020-09-14T00:49:23.244Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter target for point 112,20
[task 2020-09-14T00:49:23.244Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter left box size (2)
[task 2020-09-14T00:49:23.244Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter target for point 137,43
[task 2020-09-14T00:49:23.244Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter left box size (25)
[task 2020-09-14T00:49:23.244Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter target for point 4137,4018
[task 2020-09-14T00:49:23.245Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter left box size (4000)
[task 2020-09-14T00:49:23.245Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter target for point 198,6
[task 2020-09-14T00:49:23.245Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter left box size (-12)
[task 2020-09-14T00:49:23.245Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 2,2
[task 2020-09-14T00:49:23.245Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | splitter left box size (0)
[task 2020-09-14T00:49:23.245Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom target for point 12,29
[task 2020-09-14T00:49:23.246Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom target for point 35,52
[task 2020-09-14T00:49:23.246Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom target for point 4010,4027
[task 2020-09-14T00:49:23.246Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom target for point -2,15
[task 2020-09-14T00:49:23.246Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 2,2
[task 2020-09-14T00:49:23.246Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture and releaseCapture mousemove event target
[task 2020-09-14T00:49:23.246Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture and releaseCapture mousemove event fired
[task 2020-09-14T00:49:23.247Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture fails on non mousedown mousemove event target
[task 2020-09-14T00:49:23.247Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture fails on non mousedown mousemove event fired
[task 2020-09-14T00:49:23.247Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | document.releaseCapture releases capture mousemove event target
[task 2020-09-14T00:49:23.247Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | document.releaseCapture releases capture mousemove event fired
[task 2020-09-14T00:49:23.247Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | element.releaseCapture releases capture mousemove event target
[task 2020-09-14T00:49:23.248Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | element.releaseCapture releases capture mousemove event fired
[task 2020-09-14T00:49:23.248Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | element.releaseCapture during mousemove before releaseCapture mousemove event target
[task 2020-09-14T00:49:23.248Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | element.releaseCapture during mousemove before releaseCapture mousemove event fired
[task 2020-09-14T00:49:23.248Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | element.releaseCapture during mousemove after releaseCapture mousemove event target
[task 2020-09-14T00:49:23.248Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | element.releaseCapture during mousemove after releaseCapture mousemove event fired
[task 2020-09-14T00:49:23.248Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5spacer target for point 12,69
[task 2020-09-14T00:49:23.249Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5inner target for point 35,92
[task 2020-09-14T00:49:23.249Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5 target for point 4010,4067
[task 2020-09-14T00:49:23.249Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5 target for point -2,55
[task 2020-09-14T00:49:23.249Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 2,2
[task 2020-09-14T00:49:23.249Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5 target for point 12,69
[task 2020-09-14T00:49:23.249Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5 target for point 35,92
[task 2020-09-14T00:49:23.250Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5 target for point 4010,4067
[task 2020-09-14T00:49:23.250Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | custom5 target for point -2,55
[task 2020-09-14T00:49:23.250Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 2,2
[task 2020-09-14T00:49:23.250Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture only works on elements in documents mousemove event target
[task 2020-09-14T00:49:23.250Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture only works on elements in documents mousemove event fired
[task 2020-09-14T00:49:23.250Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture works on images mousemove event target
[task 2020-09-14T00:49:23.250Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture works on images mousemove event fired
[task 2020-09-14T00:49:23.251Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture on body retargets to root node mousemove event target
[task 2020-09-14T00:49:23.251Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | setCapture on body retargets to root node mousemove event fired
[task 2020-09-14T00:49:23.251Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 52,52
[task 2020-09-14T00:49:23.251Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | frameset after drag (2), new width 49, expected 49
[task 2020-09-14T00:49:23.251Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 75,75
[task 2020-09-14T00:49:23.252Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | frameset after drag (25), new width 72, expected 72
[task 2020-09-14T00:49:23.252Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 4050,4050
[task 2020-09-14T00:49:23.252Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | frameset after drag (4000), new width 92, expected 92
[task 2020-09-14T00:49:23.252Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | target for point 38,38
[task 2020-09-14T00:49:23.252Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | frameset after drag (-12), new width 35, expected 35
[task 2020-09-14T00:49:23.252Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | frameset after drag (0), new width 35, expected 35
[task 2020-09-14T00:49:23.253Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | scroll select
[task 2020-09-14T00:49:23.253Z] 00:49:23 INFO - must wait for load
[task 2020-09-14T00:49:23.253Z] 00:49:23 INFO - Buffered messages logged at 00:49:23
[task 2020-09-14T00:49:23.253Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | text is selected
[task 2020-09-14T00:49:23.253Z] 00:49:23 INFO - Scrolled 120 pixels
[task 2020-09-14T00:49:23.253Z] 00:49:23 INFO - Buffered messages finished
[task 2020-09-14T00:49:23.254Z] 00:49:23 INFO - TEST-UNEXPECTED-FAIL | toolkit/content/tests/mochitest/test_mousecapture.xhtml | selection scroll position after timer is at least 140
[task 2020-09-14T00:49:23.254Z] 00:49:23 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2020-09-14T00:49:23.254Z] 00:49:23 INFO - selectionScrollDone@toolkit/content/tests/mochitest/test_mousecapture.xhtml:87:7
[task 2020-09-14T00:49:23.254Z] 00:49:23 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | selection scroll position after timer is multiple of 20
[task 2020-09-14T00:49:23.254Z] 00:49:23 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp, line 348
[task 2020-09-14T00:49:23.254Z] 00:49:23 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp, line 348
[task 2020-09-14T00:49:23.256Z] 00:49:23 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp, line 348
[task 2020-09-14T00:49:23.306Z] 00:49:23 INFO - GECKO(2465) | [Parent 2465, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4272
[task 2020-09-14T00:49:23.650Z] 00:49:23 INFO - GECKO(2465) | [Parent 2465, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4270
[task 2020-09-14T00:49:23.752Z] 00:49:23 INFO - must wait for load
[task 2020-09-14T00:49:23.752Z] 00:49:23 INFO - must wait for focus
[task 2020-09-14T00:49:24.612Z] 00:49:24 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | text is selected
[task 2020-09-14T00:49:24.613Z] 00:49:24 INFO - Scrolled 140 pixels
[task 2020-09-14T00:49:24.613Z] 00:49:24 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | selection scroll position after timer is at least 140
[task 2020-09-14T00:49:24.613Z] 00:49:24 INFO - TEST-PASS | toolkit/content/tests/mochitest/test_mousecapture.xhtml | selection scroll position after timer is multiple of 20
[task 2020-09-14T00:49:24.620Z] 00:49:24 INFO - GECKO(2465) | MEMORY STAT | vsize 6679MB | residentFast 160MB | heapAllocated 19MB
[task 2020-09-14T00:49:24.621Z] 00:49:24 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp, line 348
[task 2020-09-14T00:49:24.622Z] 00:49:24 INFO - GECKO(2465) | [Child 2467, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp, line 348
[task 2020-09-14T00:49:24.723Z] 00:49:24 INFO - TEST-OK | toolkit/content/tests/mochitest/test_mousecapture.xhtml | took 3577ms
[task 2020-09-14T00:49:24.785Z] 00:49:24 INFO - TEST-KNOWN-FAIL | toolkit/content/tests/mochitest/test_mousecapture.xhtml | assertion count 6 matches expected 6 to 12 assertions
[task 2020-09-14T00:49:24.786Z] 00:49:24 INFO - TEST-START | Shutdown
[task 2020-09-14T00:49:24.786Z] 00:49:24 INFO - Passed: 60
[task 2020-09-14T00:49:24.786Z] 00:49:24 INFO - Failed: 1
[task 2020-09-14T00:49:24.786Z] 00:49:24 INFO - Todo: 0
[task 2020-09-14T00:49:24.786Z] 00:49:24 INFO - Mode: e10s
[task 2020-09-14T00:49:24.786Z] 00:49:24 INFO - Slowest: 3577ms - /tests/toolkit/content/tests/mochitest/test_mousecapture.xhtml
Description
•