1454475 - Intermittent devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

Status: RESOLVED INCOMPLETE

(DevTools :: Debugger, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: nerli [at] mozilla.com

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

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

[task 2018-04-16T16:47:37.218Z] 16:47:37     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - 
[task 2018-04-16T16:47:37.221Z] 16:47:37     INFO - GECKO(1049) | MEMORY STAT | vsize 3323MB | residentFast 791MB | heapAllocated 298MB
[task 2018-04-16T16:47:37.223Z] 16:47:37     INFO - TEST-OK | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | took 140347ms
[task 2018-04-16T16:47:37.224Z] 16:47:37     INFO - checking window state
[task 2018-04-16T16:47:37.225Z] 16:47:37     INFO - TEST-START | devtools/client/debugger/new/test/mochitest/browser_dbg-tabs-pretty-print.js
[task 2018-04-16T16:47:38.088Z] 16:47:38     INFO - GECKO(1049) | [ACTION] ADD_SOURCES  - {"type":"ADD_SOURCES","sources":[{"id":"server1.conn59.child1/source25","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js","isPrettyPrinted":false,"isWasm":false,"sourceMapURL":null,"isBlackBoxed":false,"loadedState":"unloaded"}]}
[task 2018-04-16T16:47:38.169Z] 16:47:38     INFO - GECKO(1049) | [ACTION] SET_WORKERS  - {"type":"SET_WORKERS","workers":[]}
[task 2018-04-16T16:47:38.170Z] 16:47:38     INFO - GECKO(1049) | [ACTION] CONNECT  - {"type":"CONNECT","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/doc-minified.html"}
[task 2018-04-16T16:47:38.353Z] 16:47:38     INFO - GECKO(1049) | [ACTION] SET_EXPANDED_STATE  - {"type":"SET_EXPANDED_STATE","expanded":{}}
[task 2018-04-16T16:47:38.612Z] 16:47:38     INFO - GECKO(1049) | [ACTION] SET_ORIENTATION  - {"type":"SET_ORIENTATION","orientation":"horizontal"}
[task 2018-04-16T16:47:38.851Z] 16:47:38     INFO - GECKO(1049) | [ACTION] TOGGLE_ACTIVE_SEARCH  - {"type":"TOGGLE_ACTIVE_SEARCH","value":null}
[task 2018-04-16T16:47:38.852Z] 16:47:38     INFO - GECKO(1049) | [ACTION] ADD_TAB  - {"type":"ADD_TAB","source":{"id":"server1.conn59.child1/source25","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js","sourceMapURL":null,"isBlackBoxed":false,"isPrettyPrinted":false,"isWasm":false,"contentType":"","loadedState":"unloaded"},"tabIndex":0}
[task 2018-04-16T16:47:38.888Z] 16:47:38     INFO - GECKO(1049) | [ACTION] SELECT_SOURCE  - {"type":"SELECT_SOURCE","source":{"id":"server1.conn59.child1/source25","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js","sourceMapURL":null,"isBlackBoxed":false,"isPrettyPrinted":false,"isWasm":false,"contentType":"","loadedState":"unloaded"},"location":{"sourceId":"server1.conn59.child1/source25"}}
[task 2018-04-16T16:47:39.091Z] 16:47:39     INFO - GECKO(1049) | [ACTION] LOAD_SOURCE_TEXT [start] - {"type":"LOAD_SOURCE_TEXT","sourceId":"server1.conn59.child1/source25","seqId":"1","status":"start"}
[task 2018-04-16T16:47:39.188Z] 16:47:39     INFO - GECKO(1049) | [ACTION] LOAD_SOURCE_TEXT [done] - {"type":"LOAD_SOURCE_TEXT","sourceId":"server1.conn59.child1/source25","seqId":"1","status":"done","value":{"id":"server1.conn59.child1/source25","text":"","contentType":"text/javascript"}}
[task 2018-04-16T16:47:39.411Z] 16:47:39     INFO - GECKO(1049) | [ACTION] SET_SYMBOLS [start] - {}
[task 2018-04-16T16:47:39.448Z] 16:47:39     INFO - GECKO(1049) | [ACTION] OUT_OF_SCOPE_LOCATIONS  - {}
[task 2018-04-16T16:47:39.449Z] 16:47:39     INFO - GECKO(1049) | [ACTION] IN_SCOPE_LINES  - {}
[task 2018-04-16T16:47:39.548Z] 16:47:39     INFO - GECKO(1049) | [ACTION] SET_SYMBOLS [done] - {}
[task 2018-04-16T16:47:39.589Z] 16:47:39     INFO - GECKO(1049) | [ACTION] SET_PAUSE_POINTS  - {}
[task 2018-04-16T16:47:39.667Z] 16:47:39     INFO - GECKO(1049) | [ACTION] SET_SOURCE_METADATA  - {"type":"SET_SOURCE_METADATA","sourceId":"server1.conn59.child1/source25","sourceMetaData":{}}
[task 2018-04-16T16:47:39.744Z] 16:47:39     INFO - GECKO(1049) | [ACTION] ADD_SOURCE  - {"type":"ADD_SOURCE","source":{"url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"contentType":"text/javascript","loadedState":"loading"}}
[task 2018-04-16T16:47:39.844Z] 16:47:39     INFO - GECKO(1049) | [ACTION] UPDATE_SOURCE  - {"type":"UPDATE_SOURCE","source":{"url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"contentType":"text/javascript","loadedState":"loaded","text":""}}
[task 2018-04-16T16:47:39.861Z] 16:47:39     INFO - GECKO(1049) | [ACTION] REMAP_BREAKPOINTS  - {"type":"REMAP_BREAKPOINTS","breakpoints":[]}
[task 2018-04-16T16:47:39.902Z] 16:47:39     INFO - GECKO(1049) | [ACTION] SET_PAUSE_POINTS  - {}
[task 2018-04-16T16:47:39.924Z] 16:47:39     INFO - GECKO(1049) | [ACTION] SET_SYMBOLS [start] - {}
[task 2018-04-16T16:47:39.986Z] 16:47:39     INFO - GECKO(1049) | [ACTION] SET_SYMBOLS [done] - {}
[task 2018-04-16T16:47:40.024Z] 16:47:40     INFO - GECKO(1049) | [ACTION] SET_PAUSE_POINTS  - {}
[task 2018-04-16T16:47:40.045Z] 16:47:40     INFO - GECKO(1049) | [ACTION] SET_SOURCE_METADATA  - {"type":"SET_SOURCE_METADATA","sourceId":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","sourceMetaData":{}}
[task 2018-04-16T16:47:40.061Z] 16:47:40     INFO - GECKO(1049) | [ACTION] TOGGLE_ACTIVE_SEARCH  - {"type":"TOGGLE_ACTIVE_SEARCH","value":null}
[task 2018-04-16T16:47:40.063Z] 16:47:40     INFO - GECKO(1049) | [ACTION] ADD_TAB  - {"type":"ADD_TAB","source":{"id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"text":"","contentType":"text/javascript","loadedState":"loaded"},"tabIndex":0}
[task 2018-04-16T16:47:40.103Z] 16:47:40     INFO - GECKO(1049) | [ACTION] SELECT_SOURCE  - {"type":"SELECT_SOURCE","source":{"id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"text":"","contentType":"text/javascript","loadedState":"loaded"},"location":{"sourceId":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143"}}
[task 2018-04-16T16:47:40.489Z] 16:47:40     INFO - GECKO(1049) | [ACTION] OUT_OF_SCOPE_LOCATIONS  - {}
[task 2018-04-16T16:47:40.491Z] 16:47:40     INFO - GECKO(1049) | [ACTION] IN_SCOPE_LINES  - {}
[task 2018-04-16T16:47:40.608Z] 16:47:40     INFO - GECKO(1049) | [ACTION] NAVIGATE  - {"type":"NAVIGATE","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/doc-minified.html"}
[task 2018-04-16T16:47:40.937Z] 16:47:40     INFO - GECKO(1049) | [ACTION] ADD_SOURCES  - {"type":"ADD_SOURCES","sources":[{"id":"server1.conn59.child1/source25","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js","isPrettyPrinted":false,"isWasm":false,"sourceMapURL":null,"isBlackBoxed":false,"loadedState":"unloaded"}]}
[task 2018-04-16T16:47:40.985Z] 16:47:40     INFO - GECKO(1049) | [ACTION] LOAD_SOURCE_TEXT [start] - {"type":"LOAD_SOURCE_TEXT","sourceId":"server1.conn59.child1/source25","seqId":"4","status":"start"}
[task 2018-04-16T16:47:41.088Z] 16:47:41     INFO - GECKO(1049) | [ACTION] LOAD_SOURCE_TEXT [done] - {"type":"LOAD_SOURCE_TEXT","sourceId":"server1.conn59.child1/source25","seqId":"4","status":"done","value":{"id":"server1.conn59.child1/source25","text":"","contentType":"text/javascript"}}
[task 2018-04-16T16:47:41.170Z] 16:47:41     INFO - GECKO(1049) | [ACTION] ADD_SOURCE  - {"type":"ADD_SOURCE","source":{"url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"contentType":"text/javascript","loadedState":"loading"}}
[task 2018-04-16T16:47:41.251Z] 16:47:41     INFO - GECKO(1049) | [ACTION] UPDATE_SOURCE  - {"type":"UPDATE_SOURCE","source":{"url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"contentType":"text/javascript","loadedState":"loaded","text":""}}
[task 2018-04-16T16:47:41.274Z] 16:47:41     INFO - GECKO(1049) | [ACTION] REMAP_BREAKPOINTS  - {"type":"REMAP_BREAKPOINTS","breakpoints":[]}
[task 2018-04-16T16:47:41.316Z] 16:47:41     INFO - GECKO(1049) | [ACTION] SET_PAUSE_POINTS  - {}
[task 2018-04-16T16:47:41.324Z] 16:47:41     INFO - GECKO(1049) | [ACTION] SET_SYMBOLS [start] - {}
[task 2018-04-16T16:47:41.360Z] 16:47:41     INFO - GECKO(1049) | [ACTION] SET_SYMBOLS [done] - {}
[task 2018-04-16T16:47:41.382Z] 16:47:41     INFO - GECKO(1049) | [ACTION] SET_PAUSE_POINTS  - {}
[task 2018-04-16T16:47:41.391Z] 16:47:41     INFO - GECKO(1049) | [ACTION] SET_SOURCE_METADATA  - {"type":"SET_SOURCE_METADATA","sourceId":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","sourceMetaData":{}}
[task 2018-04-16T16:47:41.399Z] 16:47:41     INFO - GECKO(1049) | [ACTION] TOGGLE_ACTIVE_SEARCH  - {"type":"TOGGLE_ACTIVE_SEARCH","value":null}
[task 2018-04-16T16:47:41.402Z] 16:47:41     INFO - GECKO(1049) | [ACTION] ADD_TAB  - {"type":"ADD_TAB","source":{"id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"text":"","contentType":"text/javascript","loadedState":"loaded"},"tabIndex":0}
[task 2018-04-16T16:47:41.403Z] 16:47:41     INFO - GECKO(1049) | [ACTION] SELECT_SOURCE  - {"type":"SELECT_SOURCE","source":{"id":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143","url":"http://example.com/browser/devtools/client/debugger/new/test/mochitest/examples/math.min.js:formatted","isBlackBoxed":false,"isPrettyPrinted":true,"isWasm":false,"text":"","contentType":"text/javascript","loadedState":"loaded"},"location":{"sourceId":"server1.conn59.child1/source25/originalSource-d096ee6b9228104ac049e96c5926c143"}}
[task 2018-04-16T16:47:41.745Z] 16:47:41     INFO - GECKO(1049) | [ACTION] OUT_OF_SCOPE_LOCATIONS  - {}
[task 2018-04-16T16:47:41.746Z] 16:47:41     INFO - GECKO(1049) | [ACTION] IN_SCOPE_LINES  - {}

Comment 1

[Cosmin Sabou [:CosminS]]

This has started to fail after this push. https://treeherder.mozilla.org/#/jobs?repo=mozilla-inbound&revision=63f8d54430b837552237d3fbaaaf87169db9738f&filter-searchStr=opt-mochitest-devtools-chrome-e10s

You can see the issue better in this range: https://treeherder.mozilla.org/#/jobs?repo=mozilla-inbound&filter-searchStr=opt-mochitest-devtools-chrome-e10s&fromchange=33c879d73a091e703187ea8ac0e7a0dcc1e0ea11&tochange=1a6e27a09653b27d965e45bd2838e829a4564ebc&selectedJob=174058266

From what I can see if fails more often on asan than on the pgo, it failed 11 times from 40 jobs while on pgo 2-3 fails from 40. And since that push this fail has picked up some steam, already having 16 fails under normal push conditions.
Jason, could you please take a look at this? Thank you.

Comment 2

[Intermittent Failures Robot]

28 failures in 148 pushes (0.189 failures/push) were associated with this bug yesterday.    

Repository breakdown:
* mozilla-inbound: 14
* autoland: 8
* mozilla-central: 6

Platform breakdown:
* linux64: 22
* linux32: 4
* linux32-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-17&endday=2018-04-17&tree=trunk

Comment 3

[Intermittent Failures Robot]

22 failures in 130 pushes (0.169 failures/push) were associated with this bug yesterday.    

Repository breakdown:
* mozilla-central: 10
* autoland: 8
* mozilla-inbound: 3
* try: 1

Platform breakdown:
* linux64: 15
* linux32: 5
* linux32-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-18&endday=2018-04-18&tree=trunk

Comment 4

[Cosmin Sabou [:CosminS]]

Joel, could you please take a look at this? What should we do in this case? 
Jason seems to be caught with something else and this has a pretty high failure rate. Should we back it out or disable it? Thanks.

Comment 5

[Joel Maher ( :jmaher ) (UTC -8)]

if :jlast does not have better advice, lets back out the offending patch tomorrow.

Comment 6

[Intermittent Failures Robot]

32 failures in 167 pushes (0.192 failures/push) were associated with this bug yesterday.    

Repository breakdown:
* mozilla-inbound: 13
* autoland: 13
* mozilla-central: 6

Platform breakdown:
* linux64: 25
* linux32: 5
* linux32-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-19&endday=2018-04-19&tree=trunk

Comment 7

[Jason Laster [:jlast]]

Hi, I'm taking a look. sorry for the delay

Comment 8

[Jason Laster [:jlast]]

Just investigated and all of the tests time time out during the test, which makes sense given how long the test is:

https://searchfox.org/mozilla-central/source/devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js#25

we should do one of two things, extend the timeout or have it take half as many steps. I would prefer extending the time out because it is nice to stress test the debugger a bit...

Comment 9

[Jason Laster [:jlast]]

Lastly, I'm not surprised this patch introduced the slow down, we are adding a new feature which *is* slow at the moment.

Comment 10

[Jason Laster [:jlast]]

This should be fixed here
https://bugzilla.mozilla.org/show_bug.cgi?id=1455345

Comment 11

[Intermittent Failures Robot]

47 failures in 130 pushes (0.362 failures/push) were associated with this bug yesterday.    

Repository breakdown:
* mozilla-inbound: 18
* autoland: 16
* mozilla-central: 7
* try: 6

Platform breakdown:
* linux64: 38
* linux32: 7
* linux32-nightly: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-20&endday=2018-04-20&tree=trunk

Comment 12

[Jason Laster [:jlast]]

I just pushed
https://bugzilla.mozilla.org/show_bug.cgi?id=1455345

lets see if this fixes it...

Comment 13

[Intermittent Failures Robot]

11 failures in 44 pushes (0.25 failures/push) were associated with this bug yesterday.    

** 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-inbound: 5
* autoland: 4
* mozilla-central: 2

Platform breakdown:
* linux64: 7
* linux32: 3
* linux32-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-21&endday=2018-04-21&tree=trunk

Comment 14

[Intermittent Failures Robot]

156 failures in 782 pushes (0.199 failures/push) were associated with this bug in the last 7 days. 

This is the #4 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-inbound: 58
* autoland: 50
* mozilla-central: 38
* try: 10

Platform breakdown:
* linux64: 118
* linux32: 25
* linux32-nightly: 12
* linux64-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-16&endday=2018-04-22&tree=trunk

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:
* try: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-23&endday=2018-04-29&tree=trunk

Comment 16

[Intermittent Failures Robot]

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

Repository breakdown:
* try: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-04-30&endday=2018-05-06&tree=trunk

Comment 17

[Intermittent Failures Robot]

3 failures in 639 pushes (0.005 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* autoland: 2
* mozilla-central: 1

Platform breakdown:
* linux64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-05-14&endday=2018-05-20&tree=trunk

Comment 18

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 1

Platform breakdown:
* windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-05-21&endday=2018-05-27&tree=trunk

Comment 19

[Firefox Bug Husbandry Bot]

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

Comment 20

[Raul Gurzau (:RaulG)]

https://treeherder.mozilla.org/logviewer.html#?job_id=184557283&repo=mozilla-inbound&lineNumber=7597

[task 2018-06-24T05:20:27.935Z] 05:20:27     INFO - Waiting for state change: selected source
[task 2018-06-24T05:20:27.937Z] 05:20:27     INFO - Finished waiting for state change: selected source
[task 2018-06-24T05:20:27.940Z] 05:20:27     INFO - Stepping in from 42260
[task 2018-06-24T05:20:27.943Z] 05:20:27     INFO - Buffered messages logged at 05:15:10
[task 2018-06-24T05:20:27.946Z] 05:20:27     INFO - Waiting for state change: paused
[task 2018-06-24T05:20:27.948Z] 05:20:27     INFO - Buffered messages logged at 05:15:37
[task 2018-06-24T05:20:27.951Z] 05:20:27     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 1
[task 2018-06-24T05:20:27.954Z] 05:20:27     INFO - Buffered messages logged at 05:15:48
[task 2018-06-24T05:20:27.956Z] 05:20:27     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:27.961Z] 05:20:27     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:27.963Z] 05:20:27     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:27.970Z] 05:20:27     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:27.971Z] 05:20:27     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:27.974Z] 05:20:27     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:27.977Z] 05:20:27     INFO - Buffered messages logged at 05:16:26
[task 2018-06-24T05:20:27.980Z] 05:20:27     INFO - Finished waiting for state change: paused
[task 2018-06-24T05:20:27.983Z] 05:20:27     INFO - Waiting for state change: selected source
[task 2018-06-24T05:20:27.985Z] 05:20:27     INFO - Finished waiting for state change: selected source
[task 2018-06-24T05:20:27.991Z] 05:20:27     INFO - Stepping in from 42307
[task 2018-06-24T05:20:27.993Z] 05:20:27     INFO - Buffered messages logged at 05:16:29
[task 2018-06-24T05:20:27.995Z] 05:20:27     INFO - Waiting for state change: paused
[task 2018-06-24T05:20:27.996Z] 05:20:27     INFO - Buffered messages logged at 05:16:45
[task 2018-06-24T05:20:27.998Z] 05:20:27     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.000Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.002Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.005Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.007Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.010Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.012Z] 05:20:28     INFO - Buffered messages logged at 05:17:21
[task 2018-06-24T05:20:28.014Z] 05:20:28     INFO - Finished waiting for state change: paused
[task 2018-06-24T05:20:28.015Z] 05:20:28     INFO - Waiting for state change: selected source
[task 2018-06-24T05:20:28.016Z] 05:20:28     INFO - Finished waiting for state change: selected source
[task 2018-06-24T05:20:28.021Z] 05:20:28     INFO - Stepping in from 42308
[task 2018-06-24T05:20:28.022Z] 05:20:28     INFO - Buffered messages logged at 05:17:23
[task 2018-06-24T05:20:28.024Z] 05:20:28     INFO - Waiting for state change: paused
[task 2018-06-24T05:20:28.028Z] 05:20:28     INFO - Buffered messages logged at 05:17:24
[task 2018-06-24T05:20:28.031Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.033Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.035Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.037Z] 05:20:28     INFO - Buffered messages logged at 05:17:26
[task 2018-06-24T05:20:28.038Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.040Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.042Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.044Z] 05:20:28     INFO - Buffered messages logged at 05:17:42
[task 2018-06-24T05:20:28.045Z] 05:20:28     INFO - Finished waiting for state change: paused
[task 2018-06-24T05:20:28.047Z] 05:20:28     INFO - Waiting for state change: selected source
[task 2018-06-24T05:20:28.049Z] 05:20:28     INFO - Finished waiting for state change: selected source
[task 2018-06-24T05:20:28.051Z] 05:20:28     INFO - Stepping in from 42263
[task 2018-06-24T05:20:28.052Z] 05:20:28     INFO - Buffered messages logged at 05:17:43
[task 2018-06-24T05:20:28.055Z] 05:20:28     INFO - Waiting for state change: paused
[task 2018-06-24T05:20:28.056Z] 05:20:28     INFO - Buffered messages logged at 05:18:18
[task 2018-06-24T05:20:28.058Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.061Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.062Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.064Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.065Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.066Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.069Z] 05:20:28     INFO - Buffered messages logged at 05:18:34
[task 2018-06-24T05:20:28.072Z] 05:20:28     INFO - Finished waiting for state change: paused
[task 2018-06-24T05:20:28.077Z] 05:20:28     INFO - Buffered messages logged at 05:18:35
[task 2018-06-24T05:20:28.079Z] 05:20:28     INFO - Waiting for state change: selected source
[task 2018-06-24T05:20:28.084Z] 05:20:28     INFO - Finished waiting for state change: selected source
[task 2018-06-24T05:20:28.097Z] 05:20:28     INFO - Stepping in from 42263
[task 2018-06-24T05:20:28.099Z] 05:20:28     INFO - Buffered messages logged at 05:18:39
[task 2018-06-24T05:20:28.099Z] 05:20:28     INFO - Waiting for state change: paused
[task 2018-06-24T05:20:28.101Z] 05:20:28     INFO - Buffered messages logged at 05:19:16
[task 2018-06-24T05:20:28.102Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.103Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.103Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.104Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.104Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.105Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.105Z] 05:20:28     INFO - Buffered messages logged at 05:19:53
[task 2018-06-24T05:20:28.107Z] 05:20:28     INFO - Finished waiting for state change: paused
[task 2018-06-24T05:20:28.107Z] 05:20:28     INFO - Waiting for state change: selected source
[task 2018-06-24T05:20:28.111Z] 05:20:28     INFO - Finished waiting for state change: selected source
[task 2018-06-24T05:20:28.112Z] 05:20:28     INFO - Stepping in from 42264
[task 2018-06-24T05:20:28.114Z] 05:20:28     INFO - Buffered messages logged at 05:19:55
[task 2018-06-24T05:20:28.115Z] 05:20:28     INFO - Waiting for state change: paused
[task 2018-06-24T05:20:28.121Z] 05:20:28     INFO - Buffered messages logged at 05:19:58
[task 2018-06-24T05:20:28.125Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.128Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.131Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.134Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.136Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xlink." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.139Z] 05:20:28     INFO - Console message: [JavaScript Warning: "Removed unsafe attribute. Element: svg. Attribute: xmlns." {file: "resource://devtools/shared/base-loader.js -> resource://devtools/client/shared/vendor/react-dom.js" line: 11623}]
[task 2018-06-24T05:20:28.141Z] 05:20:28     INFO - Buffered messages logged at 05:20:14
[task 2018-06-24T05:20:28.143Z] 05:20:28     INFO - Finished waiting for state change: paused
[task 2018-06-24T05:20:28.146Z] 05:20:28     INFO - Waiting for state change: selected source
[task 2018-06-24T05:20:28.149Z] 05:20:28     INFO - Finished waiting for state change: selected source
[task 2018-06-24T05:20:28.151Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | Line is highlighted as paused - 
[task 2018-06-24T05:20:28.153Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | There is only one line - 
[task 2018-06-24T05:20:28.156Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | debug line is visible - 
[task 2018-06-24T05:20:28.159Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | expression is highlighted as paused - 
[task 2018-06-24T05:20:28.161Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | top frame's source is selected - 
[task 2018-06-24T05:20:28.164Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | Line is highlighted as paused - 
[task 2018-06-24T05:20:28.166Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | There is only one line - 
[task 2018-06-24T05:20:28.169Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | debug line is visible - 
[task 2018-06-24T05:20:28.172Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | expression is highlighted as paused - 
[task 2018-06-24T05:20:28.174Z] 05:20:28     INFO - TEST-PASS | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | gutter is visible - 
[task 2018-06-24T05:20:28.177Z] 05:20:28     INFO - Leaving test bound test
[task 2018-06-24T05:20:28.180Z] 05:20:28     INFO - Buffered messages logged at 05:20:26
[task 2018-06-24T05:20:28.182Z] 05:20:28     INFO - Removing tab.
[task 2018-06-24T05:20:28.185Z] 05:20:28     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2018-06-24T05:20:28.187Z] 05:20:28     INFO - Got event: 'TabClose' on [object XULElement].
[task 2018-06-24T05:20:28.189Z] 05:20:28     INFO - Tab removed and finished closing
[task 2018-06-24T05:20:28.192Z] 05:20:28     INFO - Buffered messages finished
[task 2018-06-24T05:20:28.195Z] 05:20:28     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/new/test/mochitest/browser_dbg-stepping.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

Comment 21

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-06-18&endday=2018-06-24&tree=trunk

Comment 22

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-06-25&endday=2018-07-01&tree=trunk

Comment 23

[Intermittent Failures Robot]

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

Repository breakdown:
* try: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-07-02&endday=2018-07-08&tree=trunk

Comment 24

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-07-16&endday=2018-07-22&tree=trunk

Comment 25

[Intermittent Failures Robot]

3 failures in 760 pushes (0.004 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 2
* try: 1

Platform breakdown:
* linux64: 2
* linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-07-23&endday=2018-07-29&tree=trunk

Comment 26

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 2

Platform breakdown:
* linux64: 1
* linux32: 1

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

Comment 27

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 2

Platform breakdown:
* linux64: 1
* linux32: 1

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

Comment 28

[Firefox Bug Husbandry Bot]

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

Comment 29

[Andrei Ciure[:aciure]]

New occurrence:

https://treeherder.mozilla.org/#/jobs?repo=mozilla-inbound&resultStatus=testfailed%2Cbusted%2Cexception&classifiedState=unclassified&group_state=expanded&fromchange=d32110a492f5eece3697fd039d53dba247f9f202&selectedJob=212702062&searchStr=os%2Cx%2C10.10%2Copt%2Cmochitests%2Cwith%2Ce10s%2Ctest-macosx64%2Fopt-mochitest-devtools-chrome-e10s-6%2Cm-e10s%28dt6%29

Comment 30

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* osx-10-10: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2018-11-19&endday=2018-11-25&tree=all

Comment 31

[Intermittent Failures Robot]

3 failures in 1668 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 3

Platform breakdown:
* osx-10-10: 1
* linux64: 2

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

Comment 32

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2019-01-07&endday=2019-01-13&tree=all

Comment 33

[Firefox Bug Husbandry Bot]

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

Comment 34

[Andrei Ciure[:aciure]]

New occurrence:

https://treeherder.mozilla.org/#/jobs?repo=autoland&resultStatus=testfailed%2Cbusted%2Cexception&classifiedState=unclassified&fromchange=b2f1ef671ea2bfb598244b2fb7778cd36137eebf&selectedJob=237038483&searchStr=linux%2Cx64%2Casan%2Cmochitests%2Cwith%2Ce10s%2Ctest-linux64-asan%2Fopt-mochitest-devtools-chrome-e10s-3%2Cm-e10s%28dt3%29

Comment 35

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1454475&startday=2019-03-25&endday=2019-03-31&tree=all

Comment 36

[Firefox Bug Husbandry Bot]

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