1513379 - Intermittent devtools/client/debugger/new/test/mochitest/browser_dbg-navigation.js | Test timed out -

Status: RESOLVED FIXED

(DevTools :: Debugger, defect, P1)

Description

[Treeherder Bug Filer]

Filed by: ccoroiu [at] mozilla.com

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

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

18:58:43     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-navigation.js | Is not paused - 
18:58:43     INFO - Navigating to doc-scripts.html
18:58:43     INFO - Waiting for NAVIGATE to dispatch 1 time(s)
18:58:43     INFO - Buffered messages logged at 18:54:59
18:58:43     INFO - NAVIGATE dispatched 1 time(s)
18:58:43     INFO - Waiting on sources: simple1.js, simple2.js, simple3.js, long.js, scripts.html
18:58:43     INFO - Waiting for state change: source simple1.js exists
18:58:43     INFO - Waiting for state change: source simple2.js exists
18:58:43     INFO - Waiting for state change: source simple3.js exists
18:58:43     INFO - Waiting for state change: source long.js exists
18:58:43     INFO - Waiting for state change: source scripts.html exists
18:58:43     INFO - Buffered messages logged at 18:56:48
18:58:43     INFO - Console message: [JavaScript Error: "Unknown collection "main/tippytop"" {file: "resource://services-settings/RemoteSettingsClient.jsm" line: 261}]
18:58:43     INFO - sync@resource://services-settings/RemoteSettingsClient.jsm:261:13
18:58:43     INFO - async*get@resource://services-settings/RemoteSettingsClient.jsm:230:17
18:58:43     INFO - async*getSite@resource://activity-stream/lib/FaviconFeed.jsm:156:25
18:58:43     INFO - async*fetchIcon@resource://activity-stream/lib/FaviconFeed.jsm:130:24
18:58:43     INFO - async*onAction@resource://activity-stream/lib/FaviconFeed.jsm:180:9
18:58:43     INFO - _middleware/</<@resource://activity-stream/lib/Store.jsm:51:11
18:58:43     INFO - Store/this[method]@resource://activity-stream/lib/Store.jsm:29:54
18:58:43     INFO - _requestRichIcon@resource://activity-stream/lib/TopSitesFeed.jsm:460:5
18:58:43     INFO - _fetchIcon@resource://activity-stream/lib/TopSitesFeed.jsm:424:5
18:58:43     INFO - async*getLinksWithDefaults@resource://activity-stream/lib/TopSitesFeed.jsm:329:11
18:58:43     INFO - async*refresh@resource://activity-stream/lib/TopSitesFeed.jsm:352:25
18:58:43     INFO - async*onAction@resource://activity-stream/lib/TopSitesFeed.jsm:652:9
18:58:43     INFO - _middleware/</<@resource://activity-stream/lib/Store.jsm:51:11
18:58:43     INFO - Store/this[method]@resource://activity-stream/lib/Store.jsm:29:54
18:58:43     INFO - init/this.intervalId<@resource://activity-stream/lib/SystemTickFeed.jsm:16:41
18:58:43     INFO - notify@resource://gre/modules/Timer.jsm:42:7
18:58:43     INFO - 
18:58:43     INFO - Buffered messages finished
18:58:43     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/new/test/mochitest/browser_dbg-navigation.js | Test timed out - 
18:58:43     INFO - GECKO(5672) | ++DOMWINDOW == 22 (000001754BC64C00) [pid = 3848] [serial = 241] [outer = 000001754BC5E800]
18:58:43     INFO - GECKO(5672) | [Parent 3848, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/dom/base/nsContentUtils.cpp, line 8166
18:58:46     INFO - Removing tab.
18:58:46     INFO - Waiting for event: 'TabClose' on [object XULElement].
18:58:46     INFO - Got event: 'TabClose' on [object XULElement].
18:58:46     INFO - Tab removed and finished closing
18:58:46     INFO - GECKO(5672) | --DOCSHELL 000001754D4DB800 == 8 [pid = 3848] [id = {088ca661-110e-41a4-ad19-0e03f29716c4}]
18:58:46     INFO - GECKO(5672) | --DOCSHELL 000001754D4DE800 == 7 [pid = 3848] [id = {ea72ceba-353c-4006-9269-57f6cea664e2}]

Comment 1

[Intermittent Failures Robot]

1 failures in 2485 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1

Platform breakdown:
* windows10-64-ccov: 1

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

Comment 2

[Intermittent Failures Robot]

2 failures in 2648 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 2

Platform breakdown:
* windows10-64-ccov: 2

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

Comment 3

[Firefox Bug Husbandry Bot]

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

Comment 4

[Daniel Varga [:dvarga]]

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=226737812&repo=mozilla-inbound&lineNumber=10291

[task 2019-02-07T07:41:48.558Z] 07:41:48 INFO - Finished waiting for state change: source simple2.js exists
[task 2019-02-07T07:41:48.560Z] 07:41:48 INFO - Finished waiting for state change: source simple3.js exists
[task 2019-02-07T07:41:48.561Z] 07:41:48 INFO - Finished waiting for state change: source long.js exists
[task 2019-02-07T07:41:48.562Z] 07:41:48 INFO - Finished waiting for state change: source scripts.html exists
[task 2019-02-07T07:41:48.564Z] 07:41:48 INFO - Buffered messages finished
[task 2019-02-07T07:41:48.565Z] 07:41:48 INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/new/test/mochitest/browser_dbg-navigation.js | Test timed out -
[task 2019-02-07T07:41:48.567Z] 07:41:48 INFO - GECKO(1964) | ++DOMWINDOW == 16 (0x7f89ee8f3c00) [pid = 1964] [serial = 300] [outer = 0x7f89ee8ea000]
[task 2019-02-07T07:41:49.750Z] 07:41:49 INFO - GECKO(1964) | --DOMWINDOW == 4 (0x7f8154db3c00) [pid = 2171] [serial = 101] [outer = (nil)] [url = http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/doc-scripts.html]
[task 2019-02-07T07:41:49.819Z] 07:41:49 INFO - Removing tab.
[task 2019-02-07T07:41:49.822Z] 07:41:49 INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-02-07T07:41:49.881Z] 07:41:49 INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-02-07T07:41:49.909Z] 07:41:49 INFO - Tab removed and finished closing
[task 2019-02-07T07:41:49.995Z] 07:41:49 INFO - TEST-FAIL | devtools/client/debugger/new/test/mochitest/browser_dbg-navigation.js | Assertion count 3 is greater than expected range 0-0 assertions. -
[task 2019-02-07T07:41:49.997Z] 07:41:49 INFO - GECKO(1964) | MEMORY STAT | vsize 2322MB | residentFast 453MB | heapAllocated 115MB
[task 2019-02-07T07:41:49.999Z] 07:41:49 INFO - TEST-OK | devtools/client/debugger/new/test/mochitest/browser_dbg-navigation.js | took 92245ms
[task 2019-02-07T07:41:50.012Z] 07:41:50 INFO - GECKO(1964) | ++DOCSHELL 0x7f066e832800 == 1 [pid = 2123] [id = {f7f539fb-9aad-445a-b866-292f311f4d47}]
[task 2019-02-07T07:41:50.016Z] 07:41:50 INFO - GECKO(1964) | ++DOMWINDOW == 1 (0x7f066c946000) [pid = 2123] [serial = 56] [outer = (nil)]
[task 2019-02-07T07:41:50.098Z] 07:41:50 INFO - GECKO(1964) | ++DOMWINDOW == 2 (0x7f066c947c00) [pid = 2123] [serial = 57] [outer = 0x7f066c946000]
[task 2019-02-07T07:41:50.116Z] 07:41:50 INFO - checking window state

Comment 5

[Andreea Pavel [:apavel]]

Can the initial failure here be from Bug 1434888?

Yura can you please take a look?

https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&selectedJob=216410547&searchStr=windows%2C10%2Cx64%2Cccov%2Cdebug%2Cmochitests%2Cwith%2Ce10s%2Ctest-windows10-64-ccov%2Fdebug-mochitest-devtools-chrome-e10s-5%2Cm-e10s%28dt5%29&tochange=7ea008f8701b6f95320a16d78ed6ed56e22235c6&fromchange=09493e80dbe7c1486eb3c93960cc81f73c8c5356&group_state=expanded

Comment 6

[Intermittent Failures Robot]

16 failures in 2658 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 10
• try: 1
• mozilla-inbound: 3
• mozilla-central: 2

Platform breakdown:

• osx-10-10: 3
• linux64: 13

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1513379&startday=2019-02-04&endday=2019-02-10&tree=all

Comment 7

[Intermittent Failures Robot]

21 failures in 564 pushes (0.037 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-central: 1
• autoland: 16
• mozilla-inbound: 4

Platform breakdown:

• osx-10-10: 8
• linux64: 13

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1513379&startday=2019-02-12&endday=2019-02-12&tree=all

Comment 8

[Yura Zenevich [:yzen] (please use "needinfo")]

(In reply to Andreea Pavel [:apavel] from comment #5)

Can the initial failure here be from Bug 1434888?

Yura can you please take a look?

https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&selectedJob=216410547&searchStr=windows%2C10%2Cx64%2Cccov%2Cdebug%2Cmochitests%2Cwith%2Ce10s%2Ctest-windows10-64-ccov%2Fdebug-mochitest-devtools-chrome-e10s-5%2Cm-e10s%28dt5%29&tochange=7ea008f8701b6f95320a16d78ed6ed56e22235c6&fromchange=09493e80dbe7c1486eb3c93960cc81f73c8c5356&group_state=expanded

Hmm, I'm not sure it would affect debugger, from the list of jobs it seems like similar tests started failing right before the bulk of commits with the patch from bug 1434888

Comment 9

[Intermittent Failures Robot]

66 failures in 2832 pushes (0.023 failures/push) were associated with this bug in the last 7 days.

This is the #19 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:

• autoland: 41
• mozilla-inbound: 10
• try: 2
• mozilla-central: 13

Platform breakdown:

• windows10-64: 1
• osx-10-10: 26
• windows10-64-ccov: 3
• linux64-ccov: 2
• linux64: 34

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1513379&startday=2019-02-11&endday=2019-02-17&tree=all

Comment 10

[Intermittent Failures Robot]

17 failures in 597 pushes (0.028 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 11
• mozilla-central: 3
• mozilla-inbound: 1
• try: 2

Platform breakdown:

• osx-10-10: 10
• linux64: 4
• windows10-64-ccov: 1
• linux64-ccov: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1513379&startday=2019-02-21&endday=2019-02-21&tree=all

Comment 11

[Dorel Luca [:dluca]]

This bug has failed 60 times in the last 7 days. Occurs on linux64,linux64-ccov, osx-10-10, windows10-64-ccov on debug and asan platforms

Recent log:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=228547607&repo=mozilla-central&lineNumber=10420

Comment 12

[Jason Laster [:jlast]]

Thanks for the update. I'll look into it.

Comment 13

[Jason Laster [:jlast]]

Attachment: Bug 1513379 - Only check pending source statuses once. r=bhackett

Comment 14

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/2b17b0593efb
Only check pending source statuses once. r=bhackett

Comment 15

[Razvan Maries]

https://hg.mozilla.org/mozilla-central/rev/2b17b0593efb

Comment 16

[Razvan Maries]

https://hg.mozilla.org/mozilla-central/rev/2b17b0593efb

Comment 17

[Intermittent Failures Robot]

53 failures in 2602 pushes (0.02 failures/push) were associated with this bug in the last 7 days.

This is the #22 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:

• autoland: 36
• mozilla-central: 8
• mozilla-inbound: 6
• try: 3

Platform breakdown:

• linux64: 13
• linux64-ccov: 3
• windows10-64-ccov: 4
• osx-10-10: 33

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1513379&startday=2019-02-18&endday=2019-02-24&tree=all

Comment 18

[Jason Laster [:jlast]]

just adding a timeline viewer

https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2019-01-28&endday=2019-02-25&tree=all&bug=1513379