Intermittent /components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | A promise chain failed to handle a rejection: can't access property "promise", this._batchBlockingDeferred is null - stack: beginBatch/<@/content/browser-places
Categories
(Firefox :: Bookmarks & History, defect, P5)
Tracking
()
Tracking | Status | |
---|---|---|
firefox90 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: standard8)
References
Details
(Keywords: intermittent-failure)
Attachments
(2 files)
Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=331208031&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MVmNWPvkRqe_iJExstePHQ/runs/0/artifacts/public/logs/live_backing.log
[task 2021-02-25T16:25:55.642Z] 16:25:55 INFO - TEST-OK | browser/components/places/tests/browser/browser_bookmarkProperties_editTagContainer.js | took 1528ms
[task 2021-02-25T16:25:55.650Z] 16:25:55 INFO - GECKO(4192) | [Child 4357: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7ff17e3da400 == 3 [pid = 4357] [id = 5]
[task 2021-02-25T16:25:55.650Z] 16:25:55 INFO - GECKO(4192) | [Child 4357: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x7ff17e317200) [pid = 4357] [serial = 12] [outer = (nil)]
[task 2021-02-25T16:25:55.650Z] 16:25:55 INFO - GECKO(4192) | [Child 4357: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (0x7ff17e3dd000) [pid = 4357] [serial = 13] [outer = 0x7ff17e317200]
[task 2021-02-25T16:25:55.689Z] 16:25:55 INFO - checking window state
[task 2021-02-25T16:25:55.689Z] 16:25:55 INFO - GECKO(4192) | must wait for focus
[task 2021-02-25T16:25:55.791Z] 16:25:55 INFO - TEST-START | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js
[task 2021-02-25T16:25:55.819Z] 16:25:55 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7fe641cbc800 == 2 [pid = 4257] [id = 2] [url = about:blank]
[task 2021-02-25T16:25:55.820Z] 16:25:55 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7fe641cbe000 == 1 [pid = 4257] [id = 4] [url = about:blank]
[task 2021-02-25T16:25:55.821Z] 16:25:55 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7fe641cbd000 == 0 [pid = 4257] [id = 3] [url = about:blank]
[task 2021-02-25T16:25:55.858Z] 16:25:55 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f10b09ac400 == 20 [pid = 4192] [id = 23]
[task 2021-02-25T16:25:55.858Z] 16:25:55 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 52 (0x7f10c64f4ac0) [pid = 4192] [serial = 58] [outer = (nil)]
[task 2021-02-25T16:25:55.858Z] 16:25:55 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 53 (0x7f10b0cafc00) [pid = 4192] [serial = 59] [outer = 0x7f10c64f4ac0]
[task 2021-02-25T16:25:55.894Z] 16:25:55 INFO - GECKO(4192) | [Parent 4192, Main Thread] WARNING: NS_ENSURE_TRUE(uri) failed: file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1327
[task 2021-02-25T16:25:55.894Z] 16:25:55 INFO - GECKO(4192) | [Parent 4192, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4253
[task 2021-02-25T16:25:55.896Z] 16:25:55 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (0x7fe640f15200) [pid = 4257] [serial = 9] [outer = (nil)] [url = about:blank]
[task 2021-02-25T16:25:55.896Z] 16:25:55 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (0x7fe640f15040) [pid = 4257] [serial = 7] [outer = (nil)] [url = about:blank]
[task 2021-02-25T16:25:56.065Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f10b1631800 == 21 [pid = 4192] [id = 24]
[task 2021-02-25T16:25:56.067Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 54 (0x7f10c703cac0) [pid = 4192] [serial = 60] [outer = (nil)]
[task 2021-02-25T16:25:56.112Z] 16:25:56 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7fe641cbcc00 == 1 [pid = 4257] [id = 5]
[task 2021-02-25T16:25:56.113Z] 16:25:56 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x7fe640f15040) [pid = 4257] [serial = 13] [outer = (nil)]
[task 2021-02-25T16:25:56.122Z] 16:25:56 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (0x7fe641cc0000) [pid = 4257] [serial = 14] [outer = 0x7fe640f15040]
[task 2021-02-25T16:25:56.164Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4251
[task 2021-02-25T16:25:56.172Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 55 (0x7f10b0afa800) [pid = 4192] [serial = 61] [outer = 0x7f10c703cac0]
[task 2021-02-25T16:25:56.463Z] 16:25:56 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 7 (0x7fe641cc4800) [pid = 4257] [serial = 15] [outer = 0x7fe640f15040]
[task 2021-02-25T16:25:56.565Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f10acef7c00 == 22 [pid = 4192] [id = 25]
[task 2021-02-25T16:25:56.566Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 56 (0x7f10c79ea740) [pid = 4192] [serial = 62] [outer = (nil)]
[task 2021-02-25T16:25:56.570Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 57 (0x7f10b162d800) [pid = 4192] [serial = 63] [outer = 0x7f10c79ea740]
[task 2021-02-25T16:25:56.619Z] 16:25:56 INFO - GECKO(4192) | Waiting for browser load
[task 2021-02-25T16:25:56.620Z] 16:25:56 INFO - GECKO(4192) | Waiting for browser state change
[task 2021-02-25T16:25:56.639Z] 16:25:56 INFO - GECKO(4192) | [Child 4331: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7fd43f13d000 == 2 [pid = 4331] [id = 2]
[task 2021-02-25T16:25:56.640Z] 16:25:56 INFO - GECKO(4192) | [Child 4331: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (0x7fd442436ac0) [pid = 4331] [serial = 7] [outer = (nil)]
[task 2021-02-25T16:25:56.641Z] 16:25:56 INFO - GECKO(4192) | [Child 4331: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (0x7fd43f13e000) [pid = 4331] [serial = 8] [outer = 0x7fd442436ac0]
[task 2021-02-25T16:25:56.695Z] 16:25:56 INFO - GECKO(4192) | Saw state 110001 and status 0
[task 2021-02-25T16:25:56.698Z] 16:25:56 INFO - GECKO(4192) | [Parent 4192: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 58 (0x7f10b136f000) [pid = 4192] [serial = 64] [outer = 0x7f10c79ea740]
[task 2021-02-25T16:25:56.707Z] 16:25:56 INFO - GECKO(4192) | [Child 4331: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x7fd43fc2bc00) [pid = 4331] [serial = 9] [outer = 0x7fd442436ac0]
[task 2021-02-25T16:25:56.789Z] 16:25:56 INFO - GECKO(4192) | Saw state c0010 and status 0
[task 2021-02-25T16:25:56.790Z] 16:25:56 INFO - GECKO(4192) | Browser got expected state change about:robots
[task 2021-02-25T16:25:57.394Z] 16:25:57 INFO - GECKO(4192) | [Parent 4192, Main Thread] WARNING: Scrolled rect smaller than scrollport?: file /builds/worker/checkouts/gecko/layout/generic/nsGfxScrollFrame.cpp:7053
[task 2021-02-25T16:25:57.515Z] 16:25:57 INFO - GECKO(4192) | [Child 4331, Main Thread] WARNING: Scrolled rect smaller than scrollport?: file /builds/worker/checkouts/gecko/layout/generic/nsGfxScrollFrame.cpp:7053
[task 2021-02-25T16:25:57.799Z] 16:25:57 INFO - GECKO(4192) | [Child 4357: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7ff17e3d9800 == 2 [pid = 4357] [id = 3] [url = about:blank]
[task 2021-02-25T16:25:57.800Z] 16:25:57 INFO - GECKO(4192) | [Child 4357: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7ff17e3d9c00 == 1 [pid = 4357] [id = 4] [url = about:blank]
[task 2021-02-25T16:25:57.938Z] 16:25:57 INFO - GECKO(4192) | console.assert: {addObserver:..,root:..,QueryInterface:..,sortingMode:..,suppressNotifications:..,removeObserver:..,onBeginUpdateBatch:..,onEndUpdateBatch:.., } Need to have a result to update
[task 2021-02-25T16:25:57.958Z] 16:25:57 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:57.959Z] 16:25:57 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:57.974Z] 16:25:57 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:58.023Z] 16:25:58 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:58.120Z] 16:25:58 INFO - GECKO(4192) | console.assert: {addObserver:..,root:..,QueryInterface:..,sortingMode:..,suppressNotifications:..,removeObserver:..,onBeginUpdateBatch:..,onEndUpdateBatch:.., } Need to have a result to update
[task 2021-02-25T16:25:58.123Z] 16:25:58 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:58.131Z] 16:25:58 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:58.319Z] 16:25:58 INFO - GECKO(4192) | console.assert: {addObserver:..,root:..,QueryInterface:..,sortingMode:..,suppressNotifications:..,removeObserver:..,onBeginUpdateBatch:..,onEndUpdateBatch:.., } Need to have a result to update
[task 2021-02-25T16:25:58.335Z] 16:25:58 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:58.351Z] 16:25:58 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:58.366Z] 16:25:58 INFO - GECKO(4192) | console.assert: {containerOpen:..,QueryInterface:..,parent:..,parentResult:..,uri:..,type:..,title:..,accessCount:..,time:..,icon:..,indentLevel:..,bookmarkIndex:..,itemId:..,dateAdded:..,lastModified:..,tags:..,pageGuid:..,bookmarkGuid:..,visitId:..,fromVisitId:..,visitType:..,state:..,hasChildren:..,childCount:..,getChild:..,getChildIndex:..,RESULT_TYPE_URI:..,RESULT_TYPE_QUERY:..,RESULT_TYPE_FOLDER:..,RESULT_TYPE_SEPARATOR:..,RESULT_TYPE_FOLDER_SHORTCUT:..,STATE_CLOSED:..,STATE_LOADING:..,STATE_OPENED:..,queryOptions:..,query:..,folderItemId:..,targetFolderGuid:.., } null container
[task 2021-02-25T16:25:58.987Z] 16:25:58 INFO - GECKO(4192) | [Parent 4192, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111 (NS_ERROR_NOT_AVAILABLE): file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1349
[task 2021-02-25T16:25:58.997Z] 16:25:58 INFO - GECKO(4192) | [Child 4331, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111 (NS_ERROR_NOT_AVAILABLE): file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1349
[task 2021-02-25T16:25:59.033Z] 16:25:59 INFO - GECKO(4192) | [Parent 4192, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:181
[task 2021-02-25T16:25:59.223Z] 16:25:59 INFO - GECKO(4192) | JavaScript error: chrome://browser/content/browser-places.js, line 382: TypeError: can't access property "promise", this._batchBlockingDeferred is null
[task 2021-02-25T16:25:59.567Z] 16:25:59 INFO - TEST-INFO | started process screentopng
[task 2021-02-25T16:26:00.055Z] 16:26:00 INFO - TEST-INFO | screentopng: exit 0
[task 2021-02-25T16:26:00.055Z] 16:26:00 INFO - Buffered messages logged at 16:25:55
[task 2021-02-25T16:26:00.058Z] 16:26:00 INFO - Entering test bound setup
[task 2021-02-25T16:26:00.059Z] 16:26:00 INFO - Buffered messages logged at 16:25:56
[task 2021-02-25T16:26:00.060Z] 16:26:00 INFO - Leaving test bound setup
[task 2021-02-25T16:26:00.061Z] 16:26:00 INFO - Entering test bound test_selectChoose
[task 2021-02-25T16:26:00.062Z] 16:26:00 INFO - Buffered messages logged at 16:25:57
[task 2021-02-25T16:26:00.062Z] 16:26:00 INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | Should have the other bookmarks folder selected by default - "Bookmarks Toolbar" == "Bookmarks Toolbar" -
<...>
[task 2021-02-25T16:26:00.069Z] 16:26:00 INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | The view should have been disconnected - true == true -
[task 2021-02-25T16:26:00.070Z] 16:26:00 INFO - Leaving test bound test_selectChoose
[task 2021-02-25T16:26:00.071Z] 16:26:00 INFO - Entering test bound test_selectBookmarksMenu
[task 2021-02-25T16:26:00.072Z] 16:26:00 INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | Should have updated the menu label - "Bookmarks Menu" == "Bookmarks Menu" -
[task 2021-02-25T16:26:00.072Z] 16:26:00 INFO - Leaving test bound test_selectBookmarksMenu
[task 2021-02-25T16:26:00.073Z] 16:26:00 INFO - Buffered messages logged at 16:25:59
[task 2021-02-25T16:26:00.074Z] 16:26:00 INFO - Console message: [JavaScript Error: "TypeError: can't access property "promise", this._batchBlockingDeferred is null" {file: "chrome://browser/content/browser-places.js" line: 382}]
[task 2021-02-25T16:26:00.075Z] 16:26:00 INFO - Buffered messages finished
[task 2021-02-25T16:26:00.075Z] 16:26:00 INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | A promise chain failed to handle a rejection: can't access property "promise", this._batchBlockingDeferred is null - stack: beginBatch/<@chrome://browser/content/browser-places.js:382:7
[task 2021-02-25T16:26:00.076Z] 16:26:00 INFO - batch/<@resource://gre/modules/PlacesTransactions.jsm:590:20
[task 2021-02-25T16:26:00.077Z] 16:26:00 INFO - enqueue/promise<@resource://gre/modules/PlacesTransactions.jsm:484:21
[task 2021-02-25T16:26:00.078Z] 16:26:00 INFO - Rejection date: Thu Feb 25 2021 16:25:59 GMT+0000 (Coordinated Universal Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 282
[task 2021-02-25T16:26:00.079Z] 16:26:00 INFO - Stack trace:
[task 2021-02-25T16:26:00.079Z] 16:26:00 INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:282
[task 2021-02-25T16:26:00.080Z] 16:26:00 INFO - chrome://mochikit/content/browser-test.js:nextTest:631
[task 2021-02-25T16:26:00.081Z] 16:26:00 INFO - GECKO(4192) | MEMORY STAT | vsize 3316MB | residentFast 454MB | heapAllocated 185MB
[task 2021-02-25T16:26:00.082Z] 16:26:00 INFO - TEST-OK | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | took 3794ms
[task 2021-02-25T16:26:00.083Z] 16:26:00 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7fe641cc0c00 == 2 [pid = 4257] [id = 6]
[task 2021-02-25T16:26:00.084Z] 16:26:00 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 8 (0x7fe640f15200) [pid = 4257] [serial = 16] [outer = (nil)]
[task 2021-02-25T16:26:00.084Z] 16:26:00 INFO - GECKO(4192) | [Child 4257: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 9 (0x7fe641cc1c00) [pid = 4257] [serial = 17] [outer = 0x7fe640f15200]
[task 2021-02-25T16:26:00.085Z] 16:26:00 INFO - checking window state
[task 2021-02-25T16:26:00.086Z] 16:26:00 INFO - TEST-START | browser/components/places/tests/browser/browser_bookmarkProperties_newFolder.js```
Comment hidden (Intermittent Failures Robot) |
Comment 2•4 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Comment 3•4 years ago
|
||
This becomes a high frequency intermittent on "Linux 18.04 x64 tsan opt" if I fix bug 1596165.
Comment hidden (Intermittent Failures Robot) |
Comment 5•4 years ago
|
||
(In reply to Florian Quèze [:florian] from comment #3)
This becomes a high frequency intermittent on "Linux 18.04 x64 tsan opt" if I fix bug 1596165.
I added this workaround to be able to land: https://searchfox.org/mozilla-central/rev/d58860eb739af613774c942c3bb61754123e449b/browser/components/places/tests/browser/head.js#12-37
It's likely that the frequency on other slow builds (asan, debug) increased too, and we'll need to figure out the root cause at some point.
Comment hidden (Intermittent Failures Robot) |
Comment 7•4 years ago
|
||
Update:
There have been 41 failures within the last * 7 days*:
- 9 failures on Windows 10 x64 WebRender debug/opt
- 8 failures on Windows 10 x64 debug/opt
- 8 failures on Linux 18.04 x64 asan opt
- 16 failures on Linux 18.04 x64 debug
Recent failure: https://treeherder.mozilla.org/logviewer?job_id=336089132&repo=autoland
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - TEST-PASS | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | Should have updated the menu label - "Bookmarks Menu" == "Bookmarks Menu" -
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - Leaving test bound test_selectBookmarksMenu
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - Console message: [JavaScript Error: "TypeError: can't access property "promise", this._batchBlockingDeferred is null" {file: "chrome://browser/content/browser-places.js" line: 376}]
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - Buffered messages finished
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - TEST-UNEXPECTED-FAIL | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | A promise chain failed to handle a rejection: can't access property "promise", this._batchBlockingDeferred is null - stack: beginBatch/<@chrome://browser/content/browser-places.js:376:7
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - batch/<@resource://gre/modules/PlacesTransactions.jsm:590:20
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - enqueue/promise<@resource://gre/modules/PlacesTransactions.jsm:484:21
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - Rejection date: Sat Apr 10 2021 22:39:40 GMT+0000 (Greenwich Mean Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 285
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - Stack trace:
[task 2021-04-10T22:39:40.631Z] 22:39:40 INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:285
[task 2021-04-10T22:39:40.632Z] 22:39:40 INFO - chrome://mochikit/content/browser-test.js:nextTest:631
[task 2021-04-10T22:39:40.632Z] 22:39:40 INFO - GECKO(8296) | MEMORY STAT | vsize 2104380MB | vsizeMaxContiguous 67848600MB | residentFast 401MB | heapAllocated 172MB
[task 2021-04-10T22:39:40.632Z] 22:39:40 INFO - TEST-OK | browser/components/places/tests/browser/browser_bookmarkProperties_folderSelection.js | took 2944ms
Florian, are you still looking into this?
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 11•4 years ago
|
||
I think I might have found a solution for this, but I need to run it through try server.
Assignee | ||
Comment 12•4 years ago
|
||
Updated•4 years ago
|
Assignee | ||
Comment 13•4 years ago
|
||
The patch here should reduce intermittents to around the previous level. We've still some work to do to figure out what exactly is going on here, I'll hopefully be able to look at that next week.
Note to self: Investigate why StarUI.endBatch
gets called before the added transaction/batch call in beginBatch
. Also what the side effects are for the other tests.
Comment 14•4 years ago
|
||
Comment 15•4 years ago
|
||
bugherder |
Comment hidden (Intermittent Failures Robot) |
Updated•4 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 20•3 years ago
|
||
Comment 21•3 years ago
|
||
Assignee | ||
Updated•3 years ago
|
Comment 22•3 years ago
|
||
bugherder |
Comment 23•3 years ago
|
||
Mark, seems like the first test browser_bookmarkProperties_folderSelection.js
was fixed https://tinyurl.com/ydlaqtre, but the unexpected-fails from https://treeherder.mozilla.org/intermittent-failures/bugdetails?startday=2021-05-05&endday=2021-05-12&tree=trunk&bug=1695011 cropped up and I ended up filling Bug 1710710 until I caught has actually happened.
Any chance you could tackle the other failing tests? Also should we close Bug 1710710 as a duplicate to this one as it's always been around since this was filed? Thank you.
Assignee | ||
Comment 24•3 years ago
|
||
Interesting, I didn't see any of those failures on the try run that I did.
In any case, it looks like we fixed something here, so lets deal with the new ones in bug 1710710 since that's where they'll get duped to.
Updated•3 years ago
|
Description
•