Closed Bug 1522353 Opened 6 years ago Closed 6 years ago

Intermittent devtools/client/inspector/animation/test/browser_animation_current-time-label.js | Current time label should change - Didn't expect 03:36.279, but got it

Categories

(DevTools :: Inspector: Animations, defect, P5)

Product:
DevTools
Component:
Inspector: Animations
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: rmaries [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=223632975&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/H2i19iVmSGWg73cOLDta4w/runs/0/artifacts/public/logs/live_backing.log

00:33:36 INFO - TEST-START | devtools/client/inspector/animation/test/browser_animation_current-time-label.js
00:33:36 INFO - GECKO(7892) | ++DOCSHELL 0000014D72C44800 == 2 [pid = 4380] [id = {65769102-2e88-456f-a223-e8e8d3064076}]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 3 (0000014D72C96000) [pid = 4380] [serial = 27] [outer = 0000000000000000]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 4 (0000014D72CA2C00) [pid = 4380] [serial = 28] [outer = 0000014D72C96000]
00:33:36 INFO - GECKO(7892) | [Parent 7820, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/netwerk/url-classifier/UrlClassifierCommon.cpp, line 122
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 5 (0000014D72CAAC00) [pid = 4380] [serial = 29] [outer = 0000014D72C96000]
00:33:36 INFO - GECKO(7892) | ++DOCSHELL 000001FFC38B2800 == 10 [pid = 7820] [id = {16584874-ae94-4c7f-835f-eea6d0aecbed}]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 22 (000001FFC3867000) [pid = 7820] [serial = 183] [outer = 0000000000000000]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 23 (000001FFCE164C00) [pid = 7820] [serial = 184] [outer = 000001FFC3867000]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 24 (000001FFCF5AF800) [pid = 7820] [serial = 185] [outer = 000001FFC3867000]
00:33:36 INFO - GECKO(7892) | ++DOCSHELL 000001FFD342E000 == 11 [pid = 7820] [id = {173656da-7b83-490d-aa6a-1c18af60c5a7}]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 25 (000001FFCE161000) [pid = 7820] [serial = 186] [outer = 0000000000000000]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 26 (000001FFCF5B6C00) [pid = 7820] [serial = 187] [outer = 000001FFCE161000]
00:33:36 INFO - GECKO(7892) | ++DOCSHELL 000001FFD42C3800 == 12 [pid = 7820] [id = {1ec60489-7658-4703-bb72-db2b46b8cf9e}]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 27 (000001FFD02AD800) [pid = 7820] [serial = 188] [outer = 0000000000000000]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 28 (000001FFD02AFC00) [pid = 7820] [serial = 189] [outer = 000001FFD02AD800]
00:33:36 INFO - GECKO(7892) | ++DOCSHELL 000001FFD4F40000 == 13 [pid = 7820] [id = {f54f4b88-6579-4e2c-a660-1fe08705866e}]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 29 (000001FFD0914000) [pid = 7820] [serial = 190] [outer = 0000000000000000]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 30 (000001FFD0F7BC00) [pid = 7820] [serial = 191] [outer = 000001FFD0914000]
00:33:36 INFO - GECKO(7892) | ++DOCSHELL 000001FFD5560800 == 14 [pid = 7820] [id = {fb6ad3dd-3c02-4e4c-838d-ae03ce7f659f}]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 31 (000001FFD393D800) [pid = 7820] [serial = 192] [outer = 0000000000000000]
00:33:36 INFO - GECKO(7892) | ++DOMWINDOW == 32 (000001FFD3942800) [pid = 7820] [serial = 193] [outer = 000001FFD393D800]
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_GRIDS"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
00:33:36 INFO - GECKO(7892) | [Parent 7820, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file z:/build/build/src/dom/base/ThirdPartyUtil.cpp, line 226
00:33:36 INFO - GECKO(7892) | [Parent 7820, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file z:/build/build/src/dom/base/ThirdPartyUtil.cpp, line 226
00:33:36 INFO - GECKO(7892) | [Parent 7820, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file z:/build/build/src/dom/base/ThirdPartyUtil.cpp, line 226
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_SIDEBAR_SIZE"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 31 (000001FFD4FC5800) [pid = 7820] [serial = 177] [outer = 0000000000000000] [url = about:blank]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 30 (000001FFD0914000) [pid = 7820] [serial = 190] [outer = 0000000000000000] [url = about:blank]
00:33:36 INFO - GECKO(7892) | --DOCSHELL 000001FFD4F40000 == 13 [pid = 7820] [id = {f54f4b88-6579-4e2c-a660-1fe08705866e}]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 29 (000001FFD56BF800) [pid = 7820] [serial = 180] [outer = 0000000000000000] [url = chrome://devtools/content/inspector/markup/markup.xhtml]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 28 (000001FFC3865C00) [pid = 7820] [serial = 174] [outer = 0000000000000000] [url = chrome://devtools/content/inspector/index.xhtml]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 27 (000001FFC384C800) [pid = 7820] [serial = 171] [outer = 0000000000000000] [url = about:blank]
00:33:36 INFO - GECKO(7892) | --DOCSHELL 000001FFD555E000 == 12 [pid = 7820] [id = {07e94792-72f7-49e5-aca0-a73c40286e11}]
00:33:36 INFO - GECKO(7892) | --DOCSHELL 000001FFCFA0A800 == 11 [pid = 7820] [id = {ea3f3a9b-3480-4c5e-a838-5c286baac2e4}]
00:33:36 INFO - GECKO(7892) | --DOCSHELL 000001FFD0996800 == 10 [pid = 7820] [id = {85746b6e-298f-494f-b3df-3f066b13a8d2}]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 4 (0000014D7A677800) [pid = 4380] [serial = 25] [outer = 0000000000000000] [url = about:blank]
00:33:36 INFO - GECKO(7892) | --DOCSHELL 0000014D7A6A2000 == 1 [pid = 4380] [id = {a5c162ff-dc25-4829-9150-b64050aa4817}]
00:33:36 INFO - GECKO(7892) | --DOCSHELL 000001CA76A04800 == 1 [pid = 1224] [id = {d5c96f1a-78e4-43cd-ab66-cabb28026058}]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 3 (000001CA70E9A000) [pid = 1224] [serial = 30] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,<!DOCTYPE html><html><head> <style type="text/css"> div { opacity: 0; transition-duration: 5000ms; transition-property: opacity; } div.visible { opacity: 1; } </style></head><body> <div>test</div></body></html>]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 3 (0000014D72CA2C00) [pid = 4380] [serial = 28] [outer = 0000000000000000] [url = about:blank]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 2 (0000014D7A67BC00) [pid = 4380] [serial = 26] [outer = 0000000000000000] [url = about:blank]
00:33:36 INFO - GECKO(7892) | --DOMWINDOW == 2 (000001CA76ACA000) [pid = 1224] [serial = 32] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,<!DOCTYPE html><html><head> <style type="text/css"> div { opacity: 0; transition-duration: 5000ms; transition-property: opacity; } div.visible { opacity: 1; } </style></head><body> <div>test</div></body></html>]
00:33:36 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
00:33:37 INFO - GECKO(7892) | --DOMWINDOW == 26 (000001FFCF918C00) [pid = 7820] [serial = 173] [outer = 0000000000000000] [url = about:devtools-toolbox]
00:33:37 INFO - GECKO(7892) | --DOMWINDOW == 25 (000001FFCF925800) [pid = 7820] [serial = 182] [outer = 0000000000000000] [url = about:blank]
00:33:37 INFO - GECKO(7892) | --DOMWINDOW == 24 (000001FFCF91F400) [pid = 7820] [serial = 175] [outer = 0000000000000000] [url = about:blank]
00:33:37 INFO - GECKO(7892) | --DOMWINDOW == 23 (000001FFCF5B5C00) [pid = 7820] [serial = 172] [outer = 0000000000000000] [url = about:blank]
00:33:37 INFO - GECKO(7892) | --DOMWINDOW == 22 (000001FFD5A74800) [pid = 7820] [serial = 181] [outer = 0000000000000000] [url = chrome://devtools/content/inspector/markup/markup.xhtml]
00:33:37 INFO - GECKO(7892) | --DOMWINDOW == 21 (000001FFD0F7BC00) [pid = 7820] [serial = 191] [outer = 0000000000000000] [url = about:blank]
00:33:51 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
00:33:59 INFO - GECKO(7892) | [Parent 7820, Lazy Idle] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file z:/build/build/src/widget/windows/WinUtils.cpp, line 1340
00:34:07 INFO - GECKO(7892) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
00:34:09 INFO - TEST-INFO | started process screenshot
00:34:40 INFO - TEST-INFO | screenshot: exit 0
00:34:40 INFO - Buffered messages logged at 00:33:20
00:34:40 INFO - Entering test bound
00:34:40 INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/inspector/animation/test/doc_multi_timings.html
00:34:40 INFO - Tab added and finished loading
00:34:40 INFO - Loading the helper frame script chrome://mochitests/content/browser/devtools/client/inspector/animation/test/doc_frame_script.js
00:34:40 INFO - Loading the helper frame script chrome://mochitests/content/browser/devtools/client/shared/test/frame-script-utils.js
00:34:40 INFO - Sending message Test:RemoveAnimatedElementsExcept to content
00:34:40 INFO - Expecting message Test:RemoveAnimatedElementsExcept from content
00:34:40 INFO - Opening the inspector
00:34:40 INFO - Opening the toolbox
00:34:40 INFO - Buffered messages logged at 00:33:21
00:34:40 INFO - Toolbox opened and focused
00:34:40 INFO - Selecting the animationinspector sidebar
00:34:40 INFO - Buffered messages logged at 00:33:22
00:34:40 INFO - Checking current time label existence
00:34:40 INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-label.js | current time label should exist -
00:34:40 INFO - Checking current time label content
00:34:40 INFO - Click 70 on scrubber controller
00:34:40 INFO - Buffered messages logged at 00:33:35
00:34:40 INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-label.js | Content of label should be 08:20.000 -
00:34:40 INFO - Click 28 on scrubber controller
00:34:40 INFO - Buffered messages logged at 00:33:51
00:34:40 INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-label.js | Content of label should be 03:20.000 -
00:34:40 INFO - Checking current time label content during running
00:34:40 INFO - Click on pause/resume button
00:34:40 INFO - Buffered messages logged at 00:34:08
00:34:40 INFO - Waiting 1 seconds.
00:34:40 INFO - Buffered messages finished
00:34:40 INFO - TEST-UNEXPECTED-FAIL | devtools/client/inspector/animation/test/browser_animation_current-time-label.js | Current time label should change - Didn't expect 03:36.279, but got it
00:34:40 INFO - Stack trace:
00:34:40 INFO - chrome://mochikit/content/browser-test.js:test_isnot:1322
00:34:40 INFO - chrome://mochitests/content/browser/devtools/client/inspector/animation/test/browser_animation_current-time-label.js:null:31
00:34:40 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1108
00:34:40 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1099
00:34:40 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:997
00:34:40 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
00:34:40 INFO - Leaving test bound
00:34:40 INFO - GECKO(7892) | ++DOMWINDOW == 22 (000001FFCF91C800) [pid = 7820] [serial = 194] [outer = 000001FFC3867000]
00:34:40 INFO - Removing tab.
00:34:40 INFO - Waiting for event: 'TabClose' on [object XULElement].
00:34:40 INFO - Got event: 'TabClose' on [object XULElement].
00:34:40 INFO - Tab removed and finished closing
00:34:40 INFO - GECKO(7892) | --DOCSHELL 000001FFD42C3800 == 9 [pid = 7820] [id = {1ec60489-7658-4703-bb72-db2b46b8cf9e}]
00:34:40 INFO - GECKO(7892) | --DOMWINDOW == 21 (000001FFD02AD800) [pid = 7820] [serial = 188] [outer = 0000000000000000] [url = about:blank]
00:34:40 INFO - GECKO(7892) | MEMORY STAT | vsize 1978MB | vsizeMaxContiguous 68406306MB | residentFast 325MB | heapAllocated 92MB

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.