1489782 - Perma fail ccov TEST-UNEXPECTED-OK | /html/semantics/scripting-1/the-script-element/module/dynamic-import/dynamic-imports-fetch-error.sub.html | expected ERROR

Status: RESOLVED DUPLICATE of bug 1492074

(Core :: DOM: Core & HTML, defect, P2)

Description

[Treeherder Bug Filer]

Filed by: ccoroiu [at] mozilla.com

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

https://queue.taskcluster.net/v1/task/AD5OE_jKSVCcpsP47pB-fA/runs/1/artifacts/public/logs/live_backing.log

task 2018-09-08T01:48:05.328Z] 01:48:05     INFO - TEST-START | /html/semantics/scripting-1/the-script-element/module/dynamic-import/dynamic-imports-fetch-error.sub.html
[task 2018-09-08T01:48:05.558Z] 01:48:05     INFO - PID 6249 | ++DOCSHELL 0x7fb01d47b800 == 5 [pid = 6335] [id = {aed0fda7-bb16-4c44-8034-447baa9779a6}]
[task 2018-09-08T01:48:05.558Z] 01:48:05     INFO - PID 6249 | ++DOMWINDOW == 25 (0x7fb01c932000) [pid = 6335] [serial = 59] [outer = (nil)]
[task 2018-09-08T01:48:05.600Z] 01:48:05     INFO - PID 6249 | ++DOMWINDOW == 26 (0x7fb01d4c8400) [pid = 6335] [serial = 60] [outer = 0x7fb01c932000]
[task 2018-09-08T01:48:05.778Z] 01:48:05     INFO - PID 6249 | ++DOMWINDOW == 27 (0x7fb01e798400) [pid = 6335] [serial = 61] [outer = 0x7fb01c932000]
[task 2018-09-08T01:48:06.363Z] 01:48:06     INFO - PID 6249 | JavaScript error: http://web-platform.test:8000/html/semantics/scripting-1/the-script-element/module/dynamic-import/dynamic-imports-fetch-error.sub.html, line 20: SyntaxError: dynamic module import is not implemented
[task 2018-09-08T01:48:06.503Z] 01:48:06     INFO - TEST-UNEXPECTED-OK | /html/semantics/scripting-1/the-script-element/module/dynamic-import/dynamic-imports-fetch-error.sub.html | expected ERROR
[task 2018-09-08T01:48:06.503Z] 01:48:06     INFO - TEST-INFO expected ERROR | took 1170ms
[task 2018-09-08T01:48:06.560Z] 01:48:06     INFO - PID 6249 | 1536371286554	Marionette	INFO	Stopped listening on port 2828
[task 2018-09-08T01:48:06.581Z] 01:48:06     INFO - PID 6249 | JavaScript error: resource://activity-stream/lib/TopSitesFeed.jsm, line 86: TypeError: setting getter-only property "_currentSearchHostname"
[task 2018-09-08T01:48:06.920Z] 01:48:06     INFO - PID 6249 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2018-09-08T01:48:06.921Z] 01:48:06     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 866
[task 2018-09-08T01:48:07.152Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 3 (0x7f64c3a58800) [pid = 6310] [serial = 1] [outer = (nil)] [url = moz-extension://1f37f063-a431-427c-a0b4-d2bc34bbf671/_generated_background_page.html]
[task 2018-09-08T01:48:07.152Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.156Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.157Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.159Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.160Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.162Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.163Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.165Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.166Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.168Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 2 (0x7f649e1ef400) [pid = 6310] [serial = 4] [outer = (nil)] [url = moz-extension://8cdb8d9d-23e2-44c5-9c83-b65c0cb2c54a/_generated_background_page.html]
[task 2018-09-08T01:48:07.169Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.171Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.172Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.173Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.175Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.176Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.178Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.179Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.179Z] 01:48:07     INFO - PID 6249 | [Child 6310, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-08T01:48:07.179Z] 01:48:07     INFO - PID 6249 | --DOCSHELL 0x7f649e1d5000 == 1 [pid = 6310] [id = {21a0dbba-8216-4c39-8c5b-d23ed3ece3ac}]
[task 2018-09-08T01:48:07.179Z] 01:48:07     INFO - PID 6249 | --DOCSHELL 0x7f649d7ae800 == 0 [pid = 6310] [id = {7fdf3965-ec0a-424c-8202-07f47ac0c189}]
[task 2018-09-08T01:48:07.179Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 1 (0x7f649d720c00) [pid = 6310] [serial = 6] [outer = (nil)] [url = moz-extension://8cdb8d9d-23e2-44c5-9c83-b65c0cb2c54a/_generated_background_page.html]
[task 2018-09-08T01:48:07.179Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 0 (0x7f649e187800) [pid = 6310] [serial = 3] [outer = (nil)] [url = moz-extension://1f37f063-a431-427c-a0b4-d2bc34bbf671/_generated_background_page.html]
[task 2018-09-08T01:48:07.204Z] 01:48:07     INFO - PID 6249 | nsStringStats
[task 2018-09-08T01:48:07.204Z] 01:48:07     INFO - PID 6249 |  => mAllocCount:           9631
[task 2018-09-08T01:48:07.205Z] 01:48:07     INFO - PID 6249 |  => mReallocCount:            0
[task 2018-09-08T01:48:07.205Z] 01:48:07     INFO - PID 6249 |  => mFreeCount:            9631
[task 2018-09-08T01:48:07.205Z] 01:48:07     INFO - PID 6249 |  => mShareCount:           4891
[task 2018-09-08T01:48:07.206Z] 01:48:07     INFO - PID 6249 |  => mAdoptCount:            578
[task 2018-09-08T01:48:07.207Z] 01:48:07     INFO - PID 6249 |  => mAdoptFreeCount:        590
[task 2018-09-08T01:48:07.208Z] 01:48:07     INFO - PID 6249 |  => Process ID: 6310, Thread ID: 140070779762496
[task 2018-09-08T01:48:07.448Z] 01:48:07     INFO - PID 6249 | [Child 6382, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 866
[task 2018-09-08T01:48:07.453Z] 01:48:07     INFO - PID 6249 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2018-09-08T01:48:07.454Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 866
[task 2018-09-08T01:48:07.455Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 26 (0x7fb025b85c00) [pid = 6335] [serial = 54] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.458Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 25 (0x7fb01d894400) [pid = 6335] [serial = 37] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.460Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 24 (0x7fb01d4c1800) [pid = 6335] [serial = 40] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.464Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 23 (0x7fb01d4c0800) [pid = 6335] [serial = 39] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.464Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 22 (0x7fb01d4c8c00) [pid = 6335] [serial = 43] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.464Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 21 (0x7fb01d4bf400) [pid = 6335] [serial = 42] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.465Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 20 (0x7fb01d4c4400) [pid = 6335] [serial = 45] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.465Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 19 (0x7fb01d895c00) [pid = 6335] [serial = 48] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.465Z] 01:48:07     INFO - PID 6249 | --DOMWINDOW == 18 (0x7fb01e79b400) [pid = 6335] [serial = 51] [outer = (nil)] [url = about:blank]
[task 2018-09-08T01:48:07.466Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.467Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.468Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.470Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.471Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.472Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.473Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.474Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-08T01:48:07.475Z] 01:48:07     INFO - PID 6249 | [Child 6335, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399

Comment 1

[Intermittent Failures Robot]

17 failures in 136 pushes (0.125 failures/push) were associated with this bug yesterday.

Repository breakdown:
* mozilla-central: 17

Platform breakdown:
* windows10-64-ccov: 6
* linux64-ccov: 11

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1489782&startday=2018-09-08&endday=2018-09-08&tree=all

Comment 2

[Narcis Beleuzu [:NarcisB]]

Jon, seems that the fail is caused by https://hg.mozilla.org/mozilla-central/rev/d1b2141b1c454f28b8d35164c958e9ddcc7058fe .
Can you please take a look?

Comment 3

[Intermittent Failures Robot]

33 failures in 2667 pushes (0.012 failures/push) were associated with this bug in the last 7 days.

This is the #50 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. ** 

Repository breakdown:
* mozilla-central: 33

Platform breakdown:
* linux64-ccov: 19
* windows10-64-ccov: 14

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1489782&startday=2018-09-03&endday=2018-09-09&tree=all

Comment 4

[Jon Coppeard (:jonco)]

I'm confused by this.

The test is expected to fail, and an exception is being thrown:

[task 2018-09-08T01:48:06.363Z] 01:48:06     INFO - PID 6249 | JavaScript error: http://web-platform.test:8000/html/semantics/scripting-1/the-script-element/module/dynamic-import/dynamic-imports-fetch-error.sub.html, line 20: SyntaxError: dynamic module import is not implemented

But the test harness thinks it's an unexpected pass:

[task 2018-09-08T01:48:06.503Z] 01:48:06     INFO - TEST-UNEXPECTED-OK | /html/semantics/scripting-1/the-script-element/module/dynamic-import/dynamic-imports-fetch-error.sub.html | expected ERROR
[task 2018-09-08T01:48:06.503Z] 01:48:06     INFO - TEST-INFO expected ERROR | took 1170ms

When I run this locally, the exception is thrown followed by:

 5:02.96 TEST_END: Test ERROR. Subtests passed 0/1. Unexpected 0

Which and the test fails as expected.

Comment 5

[Intermittent Failures Robot]

15 failures in 507 pushes (0.03 failures/push) were associated with this bug yesterday.

Repository breakdown:
* mozilla-central: 15

Platform breakdown:
* windows10-64-ccov: 8
* linux64-ccov: 7

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1489782&startday=2018-09-13&endday=2018-09-13&tree=all

Comment 6

[Intermittent Failures Robot]

20 failures in 457 pushes (0.044 failures/push) were associated with this bug yesterday.

Repository breakdown:
* mozilla-central: 20

Platform breakdown:
* windows10-64-ccov: 10
* linux64-ccov: 10

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1489782&startday=2018-09-14&endday=2018-09-14&tree=all

Comment 7

[Andreea Pavel [:apavel]]

Jon, there are 102 total failures in the last 7 days. Are there any updates on this? 

Thanks you.

Comment 8

[Intermittent Failures Robot]

93 failures in 2684 pushes (0.035 failures/push) were associated with this bug in the last 7 days.

This is the #8 most frequent failure this week.

** This failure happened more than 75 times this week! Resolving this bug is a very high priority. ** 

** Try to resolve this bug as soon as possible. If unresolved for 1 week, the affected test(s) may be disabled. ** 

Repository breakdown:
* mozilla-central: 93

Platform breakdown:
* linux64-ccov: 45
* windows10-64-ccov: 48

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1489782&startday=2018-09-10&endday=2018-09-16&tree=all

Comment 9

[Jon Coppeard (:jonco)]

Hopefully this got fixed by bug 1492074.

Comment 10

[Intermittent Failures Robot]

28 failures in 2902 pushes (0.01 failures/push) were associated with this bug in the last 7 days.

** This test has failed more than 150 times in the last 21 days. It should be disabled until it can be fixed. ** 

Repository breakdown:
* mozilla-central: 28

Platform breakdown:
* linux64-ccov: 14
* windows10-64-ccov: 14

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1489782&startday=2018-09-17&endday=2018-09-23&tree=all

Comment 11

[Cristina Coroiu [:ccoroiu]]

No new failures since 19th of September.