Open Bug 1354561 Opened 7 years ago Updated 3 years ago

Intermittent test_animSVGImage2.html | timing out after 120000ms. Animated image still doesn't look correct, after call #1 to myOnFrameUpdate

Categories

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

defect

Tracking

()

REOPENED

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, leave-open, Whiteboard: [stockwell disabled][stockwell needswork:owner])

Attachments

(3 files)

Summary: Intermittent image/test/mochitest/test_animSVGImage2.html | timing out after 120000ms. Animated image still doesn't look correct, after call #1 to myOnFrameUpdate → Intermittent test_animSVGImage2.html | timing out after 120000ms. Animated image still doesn't look correct, after call #1 to myOnFrameUpdate
https://wiki.mozilla.org/Bugmasters#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: REOPENED → RESOLVED
Closed: 6 years ago6 years ago
Resolution: --- → INCOMPLETE
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=169019795&repo=autoland&lineNumber=6924

20:43:43     INFO -  1175 INFO TEST-START | image/test/mochitest/test_ImageContentLoaded.html
20:43:44     INFO -  GECKO(3056) | MEMORY STAT | vsize 457MB | vsizeMaxContiguous 779MB | residentFast 67MB | heapAllocated 15MB
20:43:44     INFO -  1176 INFO TEST-OK | image/test/mochitest/test_ImageContentLoaded.html | took 1130ms
20:43:44     INFO -  1177 INFO TEST-START | image/test/mochitest/test_animSVGImage2.html
20:45:44     INFO -  TEST-INFO | started process screenshot
20:45:44     INFO -  TEST-INFO | screenshot: exit 0
20:45:44     INFO -  Buffered messages logged at 20:43:44
20:45:44     INFO -  1178 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | A valid string reason is expected
20:45:44     INFO -  1179 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | Reason cannot be empty
20:45:44     INFO -  1180 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | reference snapshot shouldn't match blank page snapshot
20:45:44     INFO -  1181 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | reference div should disappear when it becomes display:none
20:45:44     INFO -  1182 INFO TEST-FAIL | image/test/mochitest/test_animSVGImage2.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Early failure timeout
20:45:44     INFO -  1183 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | myOnFrameUpdate called
20:45:44     INFO -  Buffered messages finished
20:45:44    ERROR -  1184 INFO TEST-UNEXPECTED-FAIL | image/test/mochitest/test_animSVGImage2.html | timing out after 120000ms.  Animated image still doesn't look correct, after call #1 to myOnFrameUpdate
20:45:44     INFO -      failTest@image/test/mochitest/test_animSVGImage2.html:77:3
20:45:44     INFO -      setTimeout handler*SimpleTest_setTimeoutShim@SimpleTest/SimpleTest.js:676:12
20:45:44     INFO -      main@image/test/mochitest/test_animSVGImage2.html:116:3
20:45:44     INFO -      EventHandlerNonNull*@image/test/mochitest/test_animSVGImage2.html:119:1
20:45:44     INFO -  GECKO(3056) | MEMORY STAT | vsize 462MB | vsizeMaxContiguous 771MB | residentFast 70MB | heapAllocated 11MB
20:45:44     INFO -  1185 INFO TEST-OK | image/test/mochitest/test_animSVGImage2.html | took 120072ms
20:45:44     INFO -  1186 INFO TEST-START | image/test/mochitest/test_animation.html
20:45:44     INFO -  GECKO(3056) | MEMORY STAT | vsize 467MB | vsizeMaxContiguous 767MB | residentFast 76MB | heapAllocated 16MB
20:45:44     INFO -  1187 INFO TEST-OK | image/test/mochitest/test_animation.html | took 262ms
20:45:44     INFO -  1188 INFO TEST-START | image/test/mochitest/test_animation2.html
20:45:44     INFO -  GECKO(3056) | MEMORY STAT | vsize 474MB | vsizeMaxContiguous 760MB | residentFast 81MB | heapAllocated 20MB
20:45:44     INFO -  1189 INFO TEST-OK | image/test/mochitest/test_animation2.html | took 124ms
20:45:44     INFO -  1190 INFO TEST-START | image/test/mochitest/test_animation_operators.html
20:45:44     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | JavaScript error: , line 0: TypeError: can't access dead object
20:45:45     INFO -  GECKO(3056) | MEMORY STAT | vsize 478MB | vsizeMaxContiguous 760MB | residentFast 92MB | heapAllocated 28MB
20:45:45     INFO -  1191 INFO TEST-OK | image/test/mochitest/test_animation_operators.html | took 504ms
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: REOPENED → RESOLVED
Closed: 6 years ago6 years ago
Resolution: --- → INCOMPLETE
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=179842554&repo=try&lineNumber=6804

[task 2018-05-23T16:19:14.330Z] 16:19:14     INFO - TEST-START | gfx/layers/apz/test/mochitest/test_bug1277814.html
[task 2018-05-23T16:19:14.440Z] 16:19:14     INFO - GECKO(5781) | Parent process: flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:19:14.557Z] 16:19:14     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:19:16.008Z] 16:19:16     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:41.647Z] 16:24:41     INFO - TEST-INFO | started process screentopng
[task 2018-05-23T16:24:41.933Z] 16:24:41     INFO - TEST-INFO | screentopng: exit 0
[task 2018-05-23T16:24:41.935Z] 16:24:41     INFO - TEST-UNEXPECTED-FAIL | gfx/layers/apz/test/mochitest/test_bug1277814.html | Test timed out. 
[task 2018-05-23T16:24:41.936Z] 16:24:41     INFO -     reportError@SimpleTest/TestRunner.js:121:7
[task 2018-05-23T16:24:41.936Z] 16:24:41     INFO -     TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7
[task 2018-05-23T16:24:42.644Z] 16:24:42     INFO - GECKO(5781) | MEMORY STAT | vsize 1574MB | residentFast 117MB | heapAllocated 21MB
[task 2018-05-23T16:24:42.656Z] 16:24:42     INFO - TEST-OK | gfx/layers/apz/test/mochitest/test_bug1277814.html | took 328323ms
[task 2018-05-23T16:24:42.700Z] 16:24:42     INFO - TEST-START | gfx/layers/apz/test/mochitest/test_bug1304689-2.html
[task 2018-05-23T16:24:42.881Z] 16:24:42     INFO - GECKO(5781) | Parent process: flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:43.901Z] 16:24:43     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:44.305Z] 16:24:44     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:45.049Z] 16:24:45     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:45.050Z] 16:24:45     INFO - GECKO(5781) | MEMORY STAT | vsize 1574MB | residentFast 118MB | heapAllocated 21MB
[task 2018-05-23T16:24:45.052Z] 16:24:45     INFO - TEST-OK | gfx/layers/apz/test/mochitest/test_bug1304689-2.html | took 2357ms
[task 2018-05-23T16:24:45.073Z] 16:24:45     INFO - TEST-START | gfx/layers/apz/test/mochitest/test_bug1304689.html
[task 2018-05-23T16:24:45.198Z] 16:24:45     INFO - GECKO(5781) | Parent process: flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:45.307Z] 16:24:45     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:45.404Z] 16:24:45     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:46.173Z] 16:24:46     INFO - GECKO(5781) | Flushed APZ repaints, waiting for callback...
[task 2018-05-23T16:24:46.181Z] 16:24:46     INFO - GECKO(5781) | MEMORY STAT | vsize 1574MB | residentFast 118MB | heapAllocated 21MB
[task 2018-05-23T16:24:46.199Z] 16:24:46     INFO - TEST-OK | gfx/layers/apz/test/mochitest/test_bug1304689.html | took 1118ms
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
In the last 7 days, there are 30 failures on this bug.
They occur on windows10-64-qr (opt).
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=182874492&repo=mozilla-central&lineNumber=7093
23:42:30     INFO -  1187 INFO TEST-START | image/test/mochitest/test_animSVGImage2.html
23:42:30     INFO -  GECKO(3628) | WARN: rx::HLSLCompiler::compileToBinary(228):
23:42:30     INFO -  GECKO(3628) | C:\fakepath(649,20-34): warning X3556: integer modulus may be much slower, try using uints if possible.
23:42:30     INFO -  GECKO(3628) | C:\fakepath(649,39-53): warning X3556: integer divides may be much slower, try using uints if possible.
23:44:30     INFO -  TEST-INFO | started process screenshot
23:44:30     INFO -  TEST-INFO | screenshot: exit 0
23:44:30     INFO -  Buffered messages logged at 23:42:30
23:44:30     INFO -  1188 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | A valid string reason is expected
23:44:30     INFO -  1189 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | Reason cannot be empty
23:44:30     INFO -  1190 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | reference snapshot shouldn't match blank page snapshot
23:44:30     INFO -  1191 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | reference div should disappear when it becomes display:none
23:44:30     INFO -  1192 INFO TEST-FAIL | image/test/mochitest/test_animSVGImage2.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Early failure timeout
23:44:30     INFO -  1193 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | myOnFrameUpdate called
23:44:30     INFO -  Buffered messages finished
23:44:30    ERROR -  1194 INFO TEST-UNEXPECTED-FAIL | image/test/mochitest/test_animSVGImage2.html | timing out after 120000ms.  Animated image still doesn't look correct, after call #1 to myOnFrameUpdate
23:44:30     INFO -      failTest@image/test/mochitest/test_animSVGImage2.html:77:3
23:44:30     INFO -      setTimeout handler*SimpleTest_setTimeoutShim@SimpleTest/SimpleTest.js:676:12
23:44:30     INFO -      main@image/test/mochitest/test_animSVGImage2.html:116:3
23:44:30     INFO -      EventHandlerNonNull*@image/test/mochitest/test_animSVGImage2.html:119:1
23:44:30     INFO -  GECKO(3628) | MEMORY STAT | vsize 2098640MB | vsizeMaxContiguous 129654780MB | residentFast 82MB | heapAllocated 10MB
23:44:30     INFO -  1195 INFO TEST-OK | image/test/mochitest/test_animSVGImage2.html | took 120155ms
:aosmond, can you have a look at this?
Flags: needinfo?(aosmond)
Update: there were 30 failures in the last 7 days: 29 failures on Windows 10x64 QR and 1 on Linux 32.
This bug failed 33 times in the last 7 days. Failures happen only on windows10-64-qr on opt build types.

Log:
https://treeherder.mozilla.org/logviewer.html#?job_id=190473493&repo=mozilla-inbound&lineNumber=7334

1215 INFO TEST-PASS | image/test/mochitest/test_animSVGImage2.html | myOnFrameUpdate called
10:09:10     INFO -  Buffered messages finished
10:09:10    ERROR -  1216 INFO TEST-UNEXPECTED-FAIL | image/test/mochitest/test_animSVGImage2.html | timing out after 120000ms.  Animated image still doesn't look correct, after call #1 to myOnFrameUpdate
10:09:10     INFO -      failTest@image/test/mochitest/test_animSVGImage2.html:77:3
10:09:10     INFO -      setTimeout handler*SimpleTest_setTimeoutShim@SimpleTest/SimpleTest.js:676:12
10:09:10     INFO -      main@image/test/mochitest/test_animSVGImage2.html:116:3
10:09:10     INFO -      EventHandlerNonNull*@image/test/mochitest/test_animSVGImage2.html:119:1
10:09:10     INFO -  GECKO(8792) | MEMORY STAT | vsize 1482MB | vsizeMaxContiguous 131115135MB | residentFast 76MB | heapAllocated 12MB
10:09:10     INFO -  1217 INFO TEST-OK | image/test/mochitest/test_animSVGImage2.html | took 120197ms

:aosmond:

Can you please take a look at this?
Whiteboard: [stockwell unknown] → [stockwell needswork]
In the past 7 days we had 61 failures, all on windows10-64-qr opt build type.

:aosmond Can you please take a look at this issue?
aosmond:

Hi,

Have you had a chance to take a look at this bug yet?
Please take a look over this. Thanks.
Attachment #9000157 - Flags: review?(jmaher)
Comment on attachment 9000157 [details] [diff] [review]
Disable on windows webrender

Review of attachment 9000157 [details] [diff] [review]:
-----------------------------------------------------------------

looks good
Attachment #9000157 - Flags: review?(jmaher) → review+
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Pushed by cbrindusan@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/2852ef022080
Disable test_animSVGImage2.html on windows webrender for frequent failures. r=jmaher
Keywords: checkin-needed
I wonder if the problem is that FRAME_UPDATE doesn't guarantee it was repainted yet and we don't do anything when we take the screenshot to ensure it has happened.

In the last 7 days there have been 50 occurrences all on Linux64 QR build type Opt.

Whiteboard: [stockwell disabled] → [stockwell disabled][stockwell needswork]
Whiteboard: [stockwell disabled][stockwell needswork] → [stockwell needswork]

Created a patch in case we decide to disable this test. There are 99 failures in the last 21 days, on linux64-qr.

Attachment #9036860 - Flags: review?(jmaher)
Comment on attachment 9036860 [details] [diff] [review]
Skipped test on linux qr

Review of attachment 9036860 [details] [diff] [review]:
-----------------------------------------------------------------

70 failures on linux-qr in the last week == ready to disable.
Attachment #9036860 - Flags: review?(jmaher) → review+
Keywords: checkin-needed
Whiteboard: [stockwell needswork:owner] → [stockwell disabled]

Pushed by rmaries@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/ed01030dd8ad
Disable test_animSVGImage2.html on linux qr for frequent failures. r=jmaher

Keywords: checkin-needed
Flags: needinfo?(aosmond)

In the last 7 days there have been 22 occurrences on android-em-7-0-x86_64-qr debug and opt.

Recent failure: https://treeherder.mozilla.org/logviewer?job_id=322535376&repo=autoland&lineNumber=2231

Andrew, could you, please, take a look?

Flags: needinfo?(aosmond)

For at least the last 30 days, all failures have been on android-webrender. This test is disabled on windows-webrender and linux-webrender:

https://searchfox.org/mozilla-central/rev/49345a8de9adf7c3ded3b173108d7182d2cea929/image/test/mochitest/mochitest.ini#109

Should it be disabled on all webrender?

(In reply to Bogdan Tara[:bogdan_tara | bogdant] from comment #112)

In the last 7 days there have been 22 occurrences on android-em-7-0-x86_64-qr debug and opt.

Recent failure: https://treeherder.mozilla.org/logviewer?job_id=322535376&repo=autoland&lineNumber=2231

Logcat for that, in case it is useful:
https://firefoxci.taskcluster-artifacts.net/GdVJJg1LSQyu_a-q1p9gGA/0/public/test_info//logcat-emulator-5554.log

11-21 16:02:26.321  4764  4764 D GeckoSession: handleMessage GeckoView:LocationChange uri=http://mochi.test:8888/tests/image/test/mochitest/test_animSVGImage2.html
11-21 16:02:26.333  4764  4844 E eglCodecCommon: glUtilsParamSize: unknow param 0x00008741
11-21 16:02:26.407  4793  4810 I GeckoDump: ⰲ겿{"action":"test_status","time":1605974546406,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","subtest":"A valid string reason is expected","status":"PASS","js_source":"TestRunner.js"}ⰲ겿
11-21 16:02:26.409  4793  4810 I GeckoDump: ⰲ겿{"action":"test_status","time":1605974546409,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","subtest":"Reason cannot be empty","status":"PASS","js_source":"TestRunner.js"}ⰲ겿
11-21 16:02:26.413  4793  4810 W Web Content: [JavaScript Warning: "The character encoding of a framed document was not declared. The document may appear different if viewed without the document framing it." {file: "http://mochi.test:8888/tests/image/test/mochitest/test_animSVGImage2.html" line: 0}]
11-21 16:02:26.416  4793  4810 D GeckoViewContentDelegateChild[C]: handleEvent: DOMContentLoaded
11-21 16:02:26.457  4793  4810 I GeckoDump: ⰲ겿{"action":"test_status","time":1605974546456,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","subtest":"reference snapshot shouldn't match blank page snapshot","status":"PASS","js_source":"TestRunner.js"}ⰲ겿
11-21 16:02:26.466  4793  4810 I GeckoDump: ⰲ겿{"action":"test_status","time":1605974546466,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","subtest":"reference div should disappear when it becomes display:none","status":"PASS","js_source":"TestRunner.js"}ⰲ겿
11-21 16:02:26.479  4793  4810 I GeckoDump: ⰲ겿{"action":"test_status","time":1605974546478,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","subtest":"The author of the test has indicated that flaky timeouts are expected.  Reason: Early failure timeout","status":"FAIL","js_source":"TestRunner.js"}ⰲ겿
11-21 16:02:26.480  4793  4810 D GeckoViewContent[C]: handleEvent: pageshow
11-21 16:02:26.480  4793  4810 D GeckoViewAutofill[C]: handleEvent: pageshow
11-21 16:02:26.498  4764  4844 W webrender::device::gl: Attribute VertexAttribute { name: "aUvRect1", count: 4, kind: F32 } is not found in the shader composite. Expected at 6, found at -1
11-21 16:02:26.500  4764  4844 W webrender::device::gl: Attribute VertexAttribute { name: "aUvRect2", count: 4, kind: F32 } is not found in the shader composite. Expected at 7, found at -1
11-21 16:02:26.501  4764  4844 E eglCodecCommon: glUtilsParamSize: unknow param 0x00008741
11-21 16:02:26.512  4793  4810 I GeckoDump: ⰲ겿{"action":"test_status","time":1605974546510,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","subtest":"myOnFrameUpdate called","status":"PASS","js_source":"TestRunner.js"}ⰲ겿
11-21 16:02:26.650  4764  4844 E eglCodecCommon: glUtilsParamSize: unknow param 0x00008caa
11-21 16:02:26.656  4764  4844 W webrender::device::gl: Cropping texture upload Rect(0x1 at (0, 0)) to None
11-21 16:02:26.657  4764  4844 W webrender::device::gl: Cropping texture upload Rect(0x1 at (0, 0)) to None
11-21 16:02:26.659  4764  4844 W webrender::device::gl: Cropping texture upload Rect(0x1 at (0, 0)) to None
11-21 16:02:26.668  4793  4810 D GeckoViewContentDelegateChild[C]: handleEvent: MozFirstContentfulPaint
11-21 16:02:26.697  4764  4844 E eglCodecCommon: glUtilsParamSize: unknow param 0x00008caa
11-21 16:02:27.322  4764  4779 W GeckoEventDispatcher: No listener for GeckoView:StateUpdated
11-21 16:04:26.484  4793  4810 I GeckoDump: ⰲ겿{"action":"test_status","time":1605974666482,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","subtest":"timing out after 120000ms.  Animated image still doesn't look correct, after call #1 to myOnFrameUpdate","status":"FAIL","expected":"PASS","stack":"    SimpleTest.ok@SimpleTest/SimpleTest.js:417:16\n    failTest@image/test/mochitest/test_animSVGImage2.html:77:5\n","js_source":"TestRunner.js"}ⰲ겿
11-21 16:04:26.503  4793  4810 I GeckoDump: MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
11-21 16:04:26.504  4793  4810 I GeckoDump: MEMORY STAT | vsize 4142MB | residentFast 118MB | heapAllocated 12MB
11-21 16:04:26.522  4793  4810 I GeckoDump: ⰲ겿{"action":"test_end","time":1605974666521,"thread":null,"pid":null,"source":"mochitest","test":"/tests/image/test/mochitest/test_animSVGImage2.html","status":"OK","message":"Finished in 121233ms","stack":{"runtime":121233},"js_source":"TestRunner.js"}ⰲ겿

Update:

There have been 40 failures within the last 7 days:

  • 2 failures on Android 7.0 x86-64 Shippable WebRender opt
  • 38 failures on Android 7.0 x86-64 WebRender opt/debug

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

[task 2021-02-06T23:52:49.192Z] 23:52:49 INFO - TEST-PASS | image/test/mochitest/test_animSVGImage2.html | myOnFrameUpdate called
[task 2021-02-06T23:52:49.192Z] 23:52:49 INFO - Buffered messages finished
[task 2021-02-06T23:52:49.192Z] 23:52:49 WARNING - TEST-UNEXPECTED-FAIL | image/test/mochitest/test_animSVGImage2.html | timing out after 120000ms. Animated image still doesn't look correct, after call #1 to myOnFrameUpdate
[task 2021-02-06T23:52:49.192Z] 23:52:49 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2021-02-06T23:52:49.192Z] 23:52:49 INFO - failTest@image/test/mochitest/test_animSVGImage2.html:77:5
[task 2021-02-06T23:52:49.193Z] 23:52:49 INFO - TEST-OK | image/test/mochitest/test_animSVGImage2.html | took 121118ms

Whiteboard: [stockwell disabled] → [stockwell disabled][stockwell needswork:owner]

Andrew are there any updates here?

Flags: needinfo?(aosmond)
Flags: needinfo?(aosmond)

If my hunch in comment 51 is correct, then the test failure is mostly a faulty test rather than a bug in gecko. In this particular case, disabling/removing the test entirely is probably a better use of our time than delving further.

Flags: needinfo?(aosmond)
Severity: normal → S4
Priority: -- → P5
Pushed by archaeopteryx@coole-files.de:
https://hg.mozilla.org/integration/autoland/rev/88d5ac8f36da
disable test_animSVGImage2.html for frequent failures. r=intermittent-reviewers,tnikkel,jmaher DONTBUILD
You need to log in before you can comment on or make changes to this bug.