Closed Bug 1739719 Opened 4 years ago Closed 4 years ago

Intermittent [tier 2] devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | Scrubber should be moved - Didn't expect 1200.050048828125, 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: mlaza [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=357165246&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/beMx1qo3QZmV9pmY23vO6Q/runs/0/artifacts/public/logs/live_backing.log

[task 2021-11-05T20:27:27.813Z] 20:27:27     INFO - TEST-START | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js
[task 2021-11-05T20:27:29.282Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2021-11-05T20:27:29.283Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_GRIDS"
[task 2021-11-05T20:27:29.304Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:29.386Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2021-11-05T20:27:29.393Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2021-11-05T20:27:29.552Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:29.632Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:29.714Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:29.799Z] 20:27:29     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:31.206Z] 20:27:31     INFO - TEST-INFO | started process screentopng
[task 2021-11-05T20:27:31.875Z] 20:27:31     INFO - TEST-INFO | screentopng: exit 0
[task 2021-11-05T20:27:31.877Z] 20:27:31     INFO - Buffered messages logged at 20:27:27
[task 2021-11-05T20:27:31.878Z] 20:27:31     INFO - Entering test bound 
[task 2021-11-05T20:27:31.879Z] 20:27:31     INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/inspector/animation/test/doc_simple_animation.html
[task 2021-11-05T20:27:31.880Z] 20:27:31     INFO - Buffered messages logged at 20:27:28
[task 2021-11-05T20:27:31.881Z] 20:27:31     INFO - Tab added and finished loading
[task 2021-11-05T20:27:31.882Z] 20:27:31     INFO - Opening the inspector
[task 2021-11-05T20:27:31.883Z] 20:27:31     INFO - Opening the toolbox
[task 2021-11-05T20:27:31.884Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.885Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.885Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 75}]
[task 2021-11-05T20:27:31.886Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.887Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.889Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 75}]
[task 2021-11-05T20:27:31.890Z] 20:27:31     INFO - Buffered messages logged at 20:27:29
[task 2021-11-05T20:27:31.892Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.893Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.895Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 75}]
[task 2021-11-05T20:27:31.897Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.899Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2021-11-05T20:27:31.906Z] 20:27:31     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 75}]
[task 2021-11-05T20:27:31.908Z] 20:27:31     INFO - Toolbox opened and focused
[task 2021-11-05T20:27:31.909Z] 20:27:31     INFO - Selecting the animationinspector sidebar
[task 2021-11-05T20:27:31.910Z] 20:27:31     INFO - Wait for loading first content
[task 2021-11-05T20:27:31.911Z] 20:27:31     INFO - Checking scrubber controller existence
[task 2021-11-05T20:27:31.912Z] 20:27:31     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | scrubber controller should exist - 
[task 2021-11-05T20:27:31.913Z] 20:27:31     INFO - Checking scrubber existence
[task 2021-11-05T20:27:31.914Z] 20:27:31     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | scrubber should exist - 
[task 2021-11-05T20:27:31.915Z] 20:27:31     INFO - Checking scrubber changes current time of animation and the position
[task 2021-11-05T20:27:31.916Z] 20:27:31     INFO - Click 0 on scrubber controller
[task 2021-11-05T20:27:31.917Z] 20:27:31     INFO - Wait until play state will be change to paused
[task 2021-11-05T20:27:31.918Z] 20:27:31     INFO - Wait until current time will be change to 0
[task 2021-11-05T20:27:31.919Z] 20:27:31     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | Position should be 0 at 0ms - 
[task 2021-11-05T20:27:31.920Z] 20:27:31     INFO - Click 140 on scrubber controller
[task 2021-11-05T20:27:31.921Z] 20:27:31     INFO - Wait until current time will be change to 120000
[task 2021-11-05T20:27:31.922Z] 20:27:31     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | Position should be 140 at 120000ms - 
[task 2021-11-05T20:27:31.923Z] 20:27:31     INFO - Click 70 on scrubber controller
[task 2021-11-05T20:27:31.924Z] 20:27:31     INFO - Wait until current time will be change to 60000
[task 2021-11-05T20:27:31.925Z] 20:27:31     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | Position should be 70 at 60000ms - 
[task 2021-11-05T20:27:31.926Z] 20:27:31     INFO - Checking current time scrubber position during running
[task 2021-11-05T20:27:31.927Z] 20:27:31     INFO - Click on pause/resume button
[task 2021-11-05T20:27:31.928Z] 20:27:31     INFO - Wait until play state will be change to running
[task 2021-11-05T20:27:31.928Z] 20:27:31     INFO - Waiting 1 seconds.
[task 2021-11-05T20:27:31.929Z] 20:27:31     INFO - Buffered messages finished
[task 2021-11-05T20:27:31.931Z] 20:27:31     INFO - TEST-UNEXPECTED-FAIL | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | Scrubber should be moved - Didn't expect 1200.050048828125, but got it
[task 2021-11-05T20:27:31.932Z] 20:27:31     INFO - Stack trace:
[task 2021-11-05T20:27:31.933Z] 20:27:31     INFO - chrome://mochikit/content/browser-test.js:test_isnot:1384
[task 2021-11-05T20:27:31.933Z] 20:27:31     INFO - chrome://mochitests/content/browser/devtools/client/inspector/animation/test/current-time-scrubber_head.js:testCurrentTimeScrubber:68
[task 2021-11-05T20:27:31.934Z] 20:27:31     INFO - chrome://mochitests/content/browser/devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js:null:13
[task 2021-11-05T20:27:31.935Z] 20:27:31     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-11-05T20:27:31.936Z] 20:27:31     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-11-05T20:27:31.937Z] 20:27:31     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-11-05T20:27:31.939Z] 20:27:31     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-11-05T20:27:31.940Z] 20:27:31     INFO - Checking draggable on scrubber over animation list
[task 2021-11-05T20:27:31.941Z] 20:27:31     INFO - Click on pause/resume button
[task 2021-11-05T20:27:31.942Z] 20:27:31     INFO - Wait until play state will be change to paused
[task 2021-11-05T20:27:31.943Z] 20:27:31     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:31.943Z] 20:27:31     INFO - Drag scrubber to X 5
[task 2021-11-05T20:27:31.944Z] 20:27:31     INFO - Wait until play state will be change to paused
[task 2021-11-05T20:27:31.945Z] 20:27:31     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:31.947Z] 20:27:31     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:31.948Z] 20:27:31     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | Scrubber should be draggable - 
[task 2021-11-05T20:27:31.949Z] 20:27:31     INFO - Checking a behavior which mouse out from animation inspector area during dragging from controller
[task 2021-11-05T20:27:31.949Z] 20:27:31     INFO - Drag on scrubber controller from 70 to 280
[task 2021-11-05T20:27:31.950Z] 20:27:31     INFO - Wait until play state will be change to paused
[task 2021-11-05T20:27:31.951Z] 20:27:31     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:31.952Z] 20:27:31     INFO - GECKO(3503) | console.log: "[DISPATCH] action type:" "UPDATE_ANIMATIONS"
[task 2021-11-05T20:27:31.953Z] 20:27:31     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | Click and DnD should be inactive - 
[task 2021-11-05T20:27:31.954Z] 20:27:31     INFO - Leaving test bound 
[task 2021-11-05T20:27:31.955Z] 20:27:31     INFO - GECKO(3503) | console.error: (new Error("Connection closed, pending request to server0.conn16.windowGlobal2147483659/animationplayer39, type getAnimationTypes failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:292:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:46:19\nupdateState@resource://devtools/client/inspector/animation/components/AnimatedPropertyList.js:78:31\ncomponentWillReceiveProps@resource://devtools/client/inspector/animation/components/AnimatedPropertyList.js:49:10\ncallComponentWillReceiveProps@resource://devtools/client/shared/vendor/react-dom.js:8303:14\nupdateClassInstance@resource://devtools/client/shared/vendor/react-dom.js:8482:36\nupdateClassComponent@resource://devtools/client/shared/vendor/react-dom.js:10599:20\nbeginWork@resource://devtools/client/shared/vendor/react-dom.js:11419:16\nperformUnitOfWork@resource://devtools/client/shared/vendor/react-dom.js:14702:12\nworkLoop@resource://devtools/client/shared/vendor/react-dom.js:14720:24\nrenderRoot@resource://devtools/client/shared/vendor/react-dom.js:14803:15\nperformWorkOnRoot@resource://devtools/client/shared/vendor/react-dom.js:15655:17\nperformWork@resource://devtools/client/shared/vendor/react-dom.js:15567:24\nperformSyncWork@resource://devtools/client/shared/vendor/react-dom.js:15541:14\nrequestWork@resource://devtools/client/shared/vendor/react-dom.js:15410:5\nscheduleWork@resource://devtools/client/shared/vendor/react-dom.js:15224:16\nenqueueSetState@resource://devtools/client/shared/vendor/react-dom.js:8192:17\nComponent.prototype.setState@resource://devtools/client/shared/vendor/react.js:328:16\nonStateChange@resource://devtools/client/shared/vendor/react-redux.js:1412:16\ndispatch@resource://devtools/client/shared/vendor/redux.js:265:7\nlog/</<@resource://devtools/client/shared/redux/middleware/log.js:27:9\nexports.history/</</<@resource://devtools/client/shared/redux/middleware/history.js:23:9\nwaitUntilService/</<@resource://devtools/client/shared/redux/middleware/wait-service.js:59:24\npromiseMiddleware/</<@resource://devtools/client/shared/redux/middleware/promise.js:24:14\nthunk/</</<@resource://devtools/client/shared/redux/middleware/thunk.js:18:11\nfireUpdateAction@resource://devtools/client/inspector/animation/animation.js:785:26\nsetAnimationsCurrentTime@resource://devtools/client/inspector/animation/animation.js:496:12\nAsync*updateAnimationsCurrentTime@resource://devtools/client/inspector/animation/components/CurrentTimeScrubber.js:117:29\nonMouseUp@resource://devtools/client/inspector/animation/components/CurrentTimeScrubber.js:84:12\nsynthesizeMouseAtPoint@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:628:32\nsynthesizeMouse@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:562:10\ndragOnCurrentTimeScrubberController@chrome://mochitests/content/browser/devtools/client/inspector/animation/test/head.js:448:14\nasync*testCurrentTimeScrubber@chrome://mochitests/content/browser/devtools/client/inspector/animation/test/current-time-scrubber_head.js:82:9\nasync*@chrome://mochitests/content/browser/devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js:13:9\nTester_execTest/<@chrome://mochikit/content/browser-test.js:1091:34\nTester_execTest@chrome://mochikit/content/browser-test.js:1131:11\nnextTest/<@chrome://mochikit/content/browser-test.js:939:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1041:13\n", "resource://devtools/shared/protocol/Front.js", 106))
[task 2021-11-05T20:27:32.081Z] 20:27:32     INFO - Removing tab.
[task 2021-11-05T20:27:32.084Z] 20:27:32     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2021-11-05T20:27:32.091Z] 20:27:32     INFO - Got event: 'TabClose' on [object XULElement].
[task 2021-11-05T20:27:32.105Z] 20:27:32     INFO - Tab removed and finished closing
[task 2021-11-05T20:27:32.115Z] 20:27:32     INFO - GECKO(3503) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'DevToolsFrame'
[task 2021-11-05T20:27:32.124Z] 20:27:32     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2021-11-05T20:27:32.128Z] 20:27:32     INFO - TEST-PASS | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2021-11-05T20:27:32.158Z] 20:27:32     INFO - GECKO(3503) | MEMORY STAT | vsize 3409MB | residentFast 585MB | heapAllocated 287MB
[task 2021-11-05T20:27:32.159Z] 20:27:32     INFO - TEST-OK | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber.js | took 4345ms
[task 2021-11-05T20:27:32.177Z] 20:27:32     INFO - checking window state
[task 2021-11-05T20:27:32.205Z] 20:27:32     INFO - TEST-START | devtools/client/inspector/animation/test/browser_animation_current-time-scrubber_each-different-creation-time-animations.js

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

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