Closed Bug 1344823 Opened 7 years ago Closed 5 years ago

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

Categories

(DevTools :: Debugger, defect, P2)

Product:
DevTools
Component:
Debugger
Type:
defect

Tracking

(firefox57 fix-optional)

Status:
RESOLVED WORKSFORME
Tracking Flags:
Tracking Status
firefox57 --- fix-optional

People

(Reporter: intermittent-bug-filer, Assigned: jlast)

References

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell unknown])

Assignee: nobody → jlaster
Priority: -- → P2
:jlast, this has gone up quite a bit in the last 3 days- pretty much on all configs
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1344823&startday=2017-08-14&endday=2017-08-23&tree=all

could you look into this as it is a fresh change?
Flags: needinfo?(jlaster)
status-firefox57: --- → fix-optional
Flags: needinfo?(jlaster)
34 failures in the last 7 days.
They occur on Linux (opt), Linux x64 (debug, asan, opt), OS X 10.10 (debug), Windows 7 (pgo, opt, debug).
Here is a recent log: https://treeherder.mozilla.org/logviewer.html#?repo=autoland&job_id=143588076&lineNumber=3318
:jlast, can you please take a look?
Flags: needinfo?(jlaster)
Whiteboard: [stockwell needswork]
Here is some context from the log in Comment 13:
[task 2017-11-11T05:05:04.233Z] 05:05:04     INFO - TEST-INFO | started process screentopng
9659
[task 2017-11-11T05:05:04.745Z] 05:05:04     INFO - TEST-INFO | screentopng: exit 0
9660
[task 2017-11-11T05:05:04.746Z] 05:05:04     INFO - Buffered messages logged at 05:03:33
9661
[task 2017-11-11T05:05:04.746Z] 05:05:04     INFO - Entering test bound 
9662
[task 2017-11-11T05:05:04.748Z] 05:05:04     INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/doc-scripts.html
9663
[task 2017-11-11T05:05:04.750Z] 05:05:04     INFO - Buffered messages logged at 05:03:35
9664
[task 2017-11-11T05:05:04.751Z] 05:05:04     INFO - Console message: [JavaScript Error: "TelemetryStopwatch: key "FX_SCHEDULE_PRESSURE_IDLE_SAMPLE_MS" was already initialized" {file: "resource://gre/modules/TelemetryStopwatch.jsm" line: 356}]
9665
[task 2017-11-11T05:05:04.752Z] 05:05:04     INFO - start@resource://gre/modules/TelemetryStopwatch.jsm:356:9
9666
[task 2017-11-11T05:05:04.753Z] 05:05:04     INFO - start@resource://gre/modules/TelemetryStopwatch.jsm:137:12
9667
[task 2017-11-11T05:05:04.755Z] 05:05:04     INFO - _createTimeoutFn/<@resource:///modules/SchedulePressure.jsm:42:11
9668
[task 2017-11-11T05:05:04.756Z] 05:05:04     INFO - setTimeout handler*SimpleTest_setTimeoutShim@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:676:12
9669
[task 2017-11-11T05:05:04.757Z] 05:05:04     INFO - startMonitoring@resource:///modules/SchedulePressure.jsm:105:7
9670
[task 2017-11-11T05:05:04.759Z] 05:05:04     INFO - onStateChange@chrome://browser/content/tabbrowser.xml:760:21
9671
[task 2017-11-11T05:05:04.761Z] 05:05:04     INFO - _callProgressListeners@resource://gre/modules/RemoteWebProgress.jsm:179:11
9672
[task 2017-11-11T05:05:04.763Z] 05:05:04     INFO - receiveMessage@resource://gre/modules/RemoteWebProgress.jsm:244:7
9673
[task 2017-11-11T05:05:04.764Z] 05:05:04     INFO - 
9674
[task 2017-11-11T05:05:04.765Z] 05:05:04     INFO - Buffered messages finished
9675
[task 2017-11-11T05:05:04.767Z] 05:05:04     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/new/test/mochitest/browser_dbg-search-file.js | Test timed out - 
9676
[task 2017-11-11T05:05:04.769Z] 05:05:04     INFO - Removing tab.
9677
[task 2017-11-11T05:05:04.770Z] 05:05:04     INFO - Waiting for event: 'TabClose' on [object XULElement].
9678
[task 2017-11-11T05:05:04.772Z] 05:05:04     INFO - Got event: 'TabClose' on [object XULElement].
9679
[task 2017-11-11T05:05:04.773Z] 05:05:04     INFO - Tab removed and finished closing
Update:
There have been 34 failures in the last week, according to Orange Factor.
Failures are only on OS X 10.10 / debug.

Here is a recent log file and a snippet with the failure:
https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-inbound&job_id=158406785&lineNumber=7359

01:40:50     INFO - Opening the toolbox
7357
01:40:50     INFO - Console message: [JavaScript Warning: "Loading failed for the <script> with source “http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/nested/deeper/deeper-source.js”." {file: "http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/doc-sources.html" line: 23}]
7358
01:40:50     INFO - Buffered messages finished
7359
01:40:50     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/new/test/mochitest/browser_dbg-sources.js | Test timed out - 
7360
01:40:50     INFO - GECKO(801) | --DOCSHELL 0x12dad6800 == 23 [pid = 801] [id = {79a4e48c-f608-b449-95e9-752de2330ae3}]
7361
01:40:50     INFO - GECKO(801) | --DOCSHELL 0x11a315800 == 22 [pid = 801] [id = {fa03f823-23d0-9e47-b311-31d5c5e6f672}]

The bug started to occur again on January 11th with a peak on the 21st.
Looking at the history of the bug this had some other relevant peaks in August and November 2017.
Whiteboard: [stockwell unknown] → [stockwell needswork]
I'm clearing the need info as this test has stabilized. We've done quite a bit of work on it in the past month to improve the stability.
Flags: needinfo?(jlaster)
Product: Firefox → DevTools

no longer intermittent

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