1763209 - Intermittent browser/components/places/tests/browser/browser_copy_query_without_tree.js | Test timed out -

Status: RESOLVED DUPLICATE of bug 1775663

(Firefox :: Bookmarks & History, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=373489594&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/VRYkWc2XS0mwPjP3CDKb1g/runs/0/artifacts/public/logs/live_backing.log

---

[task 2022-04-05T17:52:35.263Z] 17:52:35     INFO - TEST-PASS | browser/components/places/tests/browser/browser_copy_query_without_tree.js | Clipboard has the given value: '{"title":"Bookmarks Toolbar","id":-1,"itemGuid":"toolbar____v","instanceId":"aAuUAQV_AfEp","type":"text/x-moz-place","uri":"place:parent=toolbar_____","concreteId":3,"concreteGuid":"toolbar_____"}' - 
[task 2022-04-05T17:52:35.263Z] 17:52:35     INFO - Buffered messages finished
[task 2022-04-05T17:52:35.263Z] 17:52:35     INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_copy_query_without_tree.js | Test timed out - 
[task 2022-04-05T17:52:35.263Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-04-05T17:52:35.263Z] 17:52:35     INFO - GECKO(4898) | MEMORY STAT | vsize 4087MB | residentFast 781MB | heapAllocated 399MB
[task 2022-04-05T17:52:35.263Z] 17:52:35     INFO - TEST-OK | browser/components/places/tests/browser/browser_copy_query_without_tree.js | took 90200ms
[task 2022-04-05T17:52:35.266Z] 17:52:35     INFO - GECKO(4898) | [Child 4999: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f2283b26c00 == 1 [pid = 4999] [id = 28]
[task 2022-04-05T17:52:35.266Z] 17:52:35     INFO - GECKO(4898) | [Child 4999: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f229fe95bc0) [pid = 4999] [serial = 66] [outer = 0]
[task 2022-04-05T17:52:35.266Z] 17:52:35     INFO - GECKO(4898) | [Child 4999: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f2283b27000) [pid = 4999] [serial = 67] [outer = 7f229fe95bc0]
[task 2022-04-05T17:52:35.266Z] 17:52:35     INFO - checking window state
[task 2022-04-05T17:52:35.393Z] 17:52:35     INFO - TEST-START | browser/components/places/tests/browser/browser_cutting_bookmarks.js
[task 2022-04-05T17:52:35.420Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7ff449c04c00 == 7 [pid = 4898] [id = 67]
[task 2022-04-05T17:52:35.421Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 13 (7ff47750d480) [pid = 4898] [serial = 223] [outer = 0]
[task 2022-04-05T17:52:35.422Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 14 (7ff449c0ac00) [pid = 4898] [serial = 224] [outer = 7ff47750d480]
[task 2022-04-05T17:52:35.429Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1358
[task 2022-04-05T17:52:35.431Z] 17:52:35     INFO - GECKO(4898) | must wait for load
[task 2022-04-05T17:52:35.433Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4147
[task 2022-04-05T17:52:35.513Z] 17:52:35     INFO - GECKO(4898) | [GLX] window 22003c2 has VisualID 0x41
[task 2022-04-05T17:52:35.520Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898, Renderer] WARNING: robust_buffer_access_behavior marked as unsupported: file /builds/worker/checkouts/gecko/gfx/gl/GLContextFeatures.cpp:632
[task 2022-04-05T17:52:35.520Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898, Renderer] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file /builds/worker/checkouts/gecko/gfx/gl/GLContext.cpp:999
[task 2022-04-05T17:52:35.521Z] 17:52:35     INFO - GECKO(4898) | [Parent 4898, Renderer] WARNING: robustness marked as unsupported: file /builds/worker/checkouts/gecko/gfx/gl/GLContextFeatures.cpp:632
[task 2022-04-05T17:52:35.522Z] 17:52:35     INFO - GECKO(4898) | [2022-04-05T17:52:35Z WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2022-04-05T17:52:35.560Z] 17:52:35     INFO - GECKO(4898) | [2022-04-05T17:52:35Z WARN  webrender::renderer] asking to enable_gpu_markers but no supporting extension was found
[task 2022-04-05T17:52:35.573Z] 17:52:35     INFO - GECKO(4898) | must wait for focus
[task 2022-04-05T17:52:36.399Z] 17:52:36     INFO - GECKO(4898) | [2022-04-05T17:52:36Z WARN  webrender::device::gl] Attribute VertexAttribute { name: "aUvRect1", count: 4, kind: F32 } is not found in the shader composite. Expected at 6, found at -1
[task 2022-04-05T17:52:36.399Z] 17:52:36     INFO - GECKO(4898) | [2022-04-05T17:52:36Z WARN  webrender::device::gl] Attribute VertexAttribute { name: "aUvRect2", count: 4, kind: F32 } is not found in the shader composite. Expected at 7, found at -1
[task 2022-04-05T17:52:36.402Z] 17:52:36     INFO - GECKO(4898) | [2022-04-05T17:52:36Z WARN  webrender::device::gl] Attribute VertexAttribute { name: "aColor", count: 4, kind: F32 } is not found in the shader composite. Expected at 3, found at -1
[task 2022-04-05T17:52:36.404Z] 17:52:36     INFO - GECKO(4898) | [2022-04-05T17:52:36Z WARN  webrender::device::gl] Attribute VertexAttribute { name: "aUvRect1", count: 4, kind: F32 } is not found in the shader composite. Expected at 6, found at -1
[task 2022-04-05T17:52:36.405Z] 17:52:36     INFO - GECKO(4898) | [2022-04-05T17:52:36Z WARN  webrender::device::gl] Attribute VertexAttribute { name: "aUvRect2", count: 4, kind: F32 } is not found in the shader composite. Expected at 7, found at -1
[task 2022-04-05T17:52:36.743Z] 17:52:36     INFO - GECKO(4898) | [2022-04-05T17:52:36Z WARN  webrender::renderer] asking to enable_gpu_markers but no supporting extension was found
[task 2022-04-05T17:52:43.524Z] 17:52:43     INFO - GECKO(4898) | [Parent 4898: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7ff466d92800 == 6 [pid = 4898] [id = 66] [url = chrome://browser/content/places/places.xhtml]
[task 2022-04-05T17:52:43.572Z] 17:52:43     INFO - GECKO(4898) | [Child 5105: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f1204c77800 == 0 [pid = 5105] [id = 23] [url = about:blank]
[task 2022-04-05T17:52:44.349Z] 17:52:44     INFO - GECKO(4898) | [Parent 4898: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (7ff47750f350) [pid = 4898] [serial = 221] [outer = 0] [url = chrome://browser/content/places/places.xhtml]
[task 2022-04-05T17:52:47.820Z] 17:52:47     INFO - GECKO(4898) | [Parent 4898: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (7ff466d9c800) [pid = 4898] [serial = 222] [outer = 0] [url = about:blank]
[task 2022-04-05T17:52:47.885Z] 17:52:47     INFO - GECKO(4898) | [Child 5105: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f1220c95bc0) [pid = 5105] [serial = 53] [outer = 0] [url = about:blank]
[task 2022-04-05T17:52:51.938Z] 17:52:51     INFO - GECKO(4898) | [Child 5105: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f1204c77c00) [pid = 5105] [serial = 54] [outer = 0] [url = about:blank]
[task 2022-04-05T17:54:05.407Z] 17:54:05     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-04-05T17:54:05.407Z] 17:54:05     INFO - Buffered messages logged at 17:52:35
[task 2022-04-05T17:54:05.408Z] 17:54:05     INFO - Entering test bound 
[task 2022-04-05T17:54:05.408Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Bookmark/History tree is shown - true == true - 
[task 2022-04-05T17:54:05.409Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Downloads are hidden - true == true - 
[task 2022-04-05T17:54:05.410Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Current view is shown - true == true - 
[task 2022-04-05T17:54:05.410Z] 17:54:05     INFO - Buffered messages logged at 17:52:36
[task 2022-04-05T17:54:05.410Z] 17:54:05     INFO - Selecting BookmarksToolbar in the left pane
[task 2022-04-05T17:54:05.411Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Bookmark has the right parent - 
[task 2022-04-05T17:54:05.412Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Bookmark has the right parent - 
[task 2022-04-05T17:54:05.413Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Bookmark has the right parent - 
[task 2022-04-05T17:54:05.416Z] 17:54:05     INFO - Selecting the bookmarks in the right pane
[task 2022-04-05T17:54:05.416Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Found the expected bookmark in the expected position - 
[task 2022-04-05T17:54:05.416Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Found the expected bookmark in the expected position - 
[task 2022-04-05T17:54:05.416Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Found the expected bookmark in the expected position - 
[task 2022-04-05T17:54:05.417Z] 17:54:05     INFO - Initializing clipboard with "waitForClipboard-known-value-0.487974611421372"...
[task 2022-04-05T17:54:05.418Z] 17:54:05     INFO - Succeeded initializing clipboard, start requested things...
[task 2022-04-05T17:54:05.419Z] 17:54:05     INFO - Cutting selection
[task 2022-04-05T17:54:05.420Z] 17:54:05     INFO - TEST-PASS | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Clipboard has the given value: '{"title":"0","id":7,"itemGuid":"rl1-v-pdfJll","instanceId":"aAuUAQV_AfEp","parent":3,"parentGuid":"toolbar_____","dateAdded":1649181155692000,"lastModified":1649181155692000,"type":"text/x-moz-place","uri":"http://example.com/"},{"title":"1","id":8,"itemGuid":"-_yyvkqVVY1b","instanceId":"aAuUAQV_AfEp","parent":3,"parentGuid":"toolbar_____","dateAdded":1649181156242000,"lastModified":1649181156242000,"type":"text/x-moz-place","uri":"http://example.com/"},{"title":"2","id":9,"itemGuid":"1BSZYB17csAV","instanceId":"aAuUAQV_AfEp","parent":3,"parentGuid":"toolbar_____","dateAdded":1649181156658000,"lastModified":1649181156658000,"type":"text/x-moz-place","uri":"http://example.com/"}' - 
[task 2022-04-05T17:54:05.421Z] 17:54:05     INFO - Selecting UnfiledBookmarks in the left pane
[task 2022-04-05T17:54:05.422Z] 17:54:05     INFO - Pasting clipboard
[task 2022-04-05T17:54:05.423Z] 17:54:05     INFO - Buffered messages finished
[task 2022-04-05T17:54:05.424Z] 17:54:05     INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_cutting_bookmarks.js | Test timed out - 
[task 2022-04-05T17:54:05.431Z] 17:54:05     INFO - GECKO(4898) | [Parent 4898, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-04-05T17:54:05.584Z] 17:54:05     INFO - GECKO(4898) | MEMORY STAT | vsize 4089MB | residentFast 780MB | heapAllocated 400MB
[task 2022-04-05T17:54:05.587Z] 17:54:05     INFO - TEST-OK | browser/components/places/tests/browser/browser_cutting_bookmarks.js | took 90193ms
[task 2022-04-05T17:54:05.606Z] 17:54:05     INFO - GECKO(4898) | [Child 5105: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f1204c77800 == 1 [pid = 5105] [id = 24]
[task 2022-04-05T17:54:05.606Z] 17:54:05     INFO - GECKO(4898) | [Child 5105: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f1220c95bc0) [pid = 5105] [serial = 55] [outer = 0]
[task 2022-04-05T17:54:05.606Z] 17:54:05     INFO - GECKO(4898) | [Child 5105: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f1204c77c00) [pid = 5105] [serial = 56] [outer = 7f1220c95bc0]
[task 2022-04-05T17:54:05.666Z] 17:54:05     INFO - checking window state
[task 2022-04-05T17:54:05.764Z] 17:54:05     INFO - TEST-START | browser/components/places/tests/browser/browser_default_bookmark_location.js

Comment 1

[Natalia Csoregi [:nataliaCs]]

Retriggers/backfills: https://treeherder.mozilla.org/jobs?repo=autoland&searchStr=Linux%2C18.04%2Cx64%2CWebRender%2Cdebug%2CMochitests%2Cwith%2Cnetworking%2Con%2Csocket%2Cprocess%2Cwithout%2Cfission%2Cenabled%2Ctest-linux1804-64-qr%2Fdebug-mochitest-browser-chrome-spi-nw-nofis-e10s%2Cbc11&tochange=0c9101715355521491635bfc7a9c39b02223a9f3&fromchange=25a2b9b2e120847840c054de7405cc1837e924d4&group_state=expanded&selectedTaskRun=VRYkWc2XS0mwPjP3CDKb1g.0

Comment 2

[Cosmin Sabou [:CosminS]]

Please see https://bugzilla.mozilla.org/show_bug.cgi?id=1757104#c5 for context.

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 13
• mozilla-central: 1
• try: 3

Platform and build breakdown:

• linux1804-64-qr: 17
  • debug: 17

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-04-04&endday=2022-04-10&tree=all

Comment 4

[Intermittent Failures Robot]

22 failures in 2948 pushes (0.007 failures/push) were associated with this bug in the last 7 days.

This is the #48 most frequent failure this week.

Repository breakdown:

• autoland: 15
• mozilla-central: 5
• try: 2

Platform and build breakdown:

• linux1804-64-qr: 22
  • debug: 22

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-04-11&endday=2022-04-17&tree=all

Comment 5

[Intermittent Failures Robot]

29 failures in 3159 pushes (0.009 failures/push) were associated with this bug in the last 7 days.

This is the #45 most frequent failure this week.

Repository breakdown:

• autoland: 22
• try: 1
• mozilla-central: 6

Platform and build breakdown:

• linux1804-64-qr: 29
  • debug: 29

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-04-18&endday=2022-04-24&tree=all

Comment 6

[Intermittent Failures Robot]

26 failures in 3289 pushes (0.008 failures/push) were associated with this bug in the last 7 days.

This is the #32 most frequent failure this week.

Repository breakdown:

• autoland: 15
• try: 7
• mozilla-central: 4

Platform and build breakdown:

• linux1804-64-qr: 26
  • debug: 26

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-04-25&endday=2022-05-01&tree=all

Comment 7

[Natalia Csoregi [:nataliaCs]]

Update:

There have been 31 failures within the last 7 days, all of them on Linux 18.04 x64 WebRender debug.

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

[task 2022-05-08T20:50:14.931Z] 20:50:14     INFO - TEST-PASS | browser/components/places/tests/browser/browser_copy_query_without_tree.js | Clipboard has the given value: '{"title":"Bookmarks Toolbar","id":-1,"itemGuid":"toolbar____v","instanceId":"tNHmdx-kPbDt","type":"text/x-moz-place","uri":"place:parent=toolbar_____","concreteId":3,"concreteGuid":"toolbar_____"}' - 
[task 2022-05-08T20:50:14.931Z] 20:50:14     INFO - Buffered messages finished
[task 2022-05-08T20:50:14.931Z] 20:50:14     INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_copy_query_without_tree.js | Test timed out - 
[task 2022-05-08T20:50:14.931Z] 20:50:14     INFO - GECKO(4975) | [Parent 4975, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:365
[task 2022-05-08T20:50:14.931Z] 20:50:14     INFO - GECKO(4975) | MEMORY STAT | vsize 4113MB | residentFast 782MB | heapAllocated 402MB
[task 2022-05-08T20:50:14.931Z] 20:50:14     INFO - TEST-OK | browser/components/places/tests/browser/browser_copy_query_without_tree.js | took 90153ms

Marko, can you help us assign this to someone?
Thank you.

Comment 8

[Intermittent Failures Robot]

32 failures in 3540 pushes (0.009 failures/push) were associated with this bug in the last 7 days.

This is the #39 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: 8
• autoland: 23
• try: 1

Platform and build breakdown:

• linux1804-64-qr: 32
  • debug: 32

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-05-02&endday=2022-05-08&tree=all

Comment 9

[Intermittent Failures Robot]

23 failures in 3317 pushes (0.007 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 4
• autoland: 16
• try: 3

Platform and build breakdown:

• linux1804-64-qr: 22
  • debug: 22
• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-05-09&endday=2022-05-15&tree=all

Comment 10

[Intermittent Failures Robot]

8 failures in 2694 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 7
• try: 1

Platform and build breakdown:

• linux1804-64-qr: 8
  • debug: 8

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-05-16&endday=2022-05-22&tree=all

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• linux1804-64-qr: 3
  • debug: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-05-23&endday=2022-05-29&tree=all

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4
• try: 1

Platform and build breakdown:

• linux1804-64-qr: 5
  • debug: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-05-30&endday=2022-06-05&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• autoland: 5

Platform and build breakdown:

• linux1804-64-qr: 6
  • debug: 6

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-06-06&endday=2022-06-12&tree=all

Comment 14

[Intermittent Failures Robot]

8 failures in 3170 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 7
• try: 1

Platform and build breakdown:

• linux1804-64-qr: 8
  • debug: 8

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-06-13&endday=2022-06-19&tree=all

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-qr: 3
  • debug: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1763209&startday=2022-06-27&endday=2022-07-03&tree=all

Comment 16

[Marco Bonardo [:mak] (Away Apr 25 - May 5)]

Apparently the paste operation at https://searchfox.org/mozilla-central/rev/3e1a721bce1da3ae04675539b39a4e95b25a046d/browser/components/places/tests/browser/browser_copy_query_without_tree.js#27 doesn't resolve nor reject. Not sure why though, sounds like some problem with PlacesTransactions, we'd need to log a bunch of stuff to the console to be able to see where we hang.

Comment 17

[Mark Banner (:standard8)]

Probably also worth waiting a bit - bug 1702806 may have helped these failures, but that only landed 2 days ago, so I think we should wait for a bit and see what failures we're now getting.