1632024 - Intermittent toolkit/components/passwordmgr/test/<test name> | A promise chain failed to handle a rejection: An attempt was made to use an object that is not, or is no longer, usable - stack: sendMessageFn@resource:///actors/AboutLoginsParent.jsm:859:57

Status: RESOLVED FIXED

(Toolkit :: Password Manager, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=298748888&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/T2JH3_FiRCOA-6djzyLWfA/runs/0/artifacts/public/logs/live_backing.log

---

...
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | Menu panel (appMenu-popup) is open. - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - mainMenu_entryPoint, clicking on Logins and passwords button
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - waiting for new tab to open
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - Buffered messages logged at 02:47:21
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | got password management tab - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - mainMenu_entryPoint, password manager dialog shown
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | waiting for telemetry event count - 1 == 1 - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | content must be in snapshot. Has [content]. - true == true - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | After filtering we must have the expected number of events. - 1 == 1 - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | category in event pwmgr#open_management#mainmenu must match. - "pwmgr" matches "pwmgr" - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | method in event pwmgr#open_management#mainmenu must match. - "open_management" matches "open_management" - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | object in event pwmgr#open_management#mainmenu must match. - "mainmenu" matches "mainmenu" - 
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - mainMenu_entryPoint, close dialog and main menu
[task 2020-04-22T02:47:22.944Z] 02:47:22     INFO - Leaving test bound mainMenu_entryPoint
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - Entering test bound pageInfo_entryPoint
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - Console message: [JavaScript Error: "Unknown Collection "main/fxmonitor-breaches"" {file: "resource://services-settings/RemoteSettingsClient.jsm" line: 137}]
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - UnknownCollectionError@resource://services-settings/RemoteSettingsClient.jsm:137:5
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - sync@resource://services-settings/RemoteSettingsClient.jsm:373:13
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - async*get@resource://services-settings/RemoteSettingsClient.jsm:315:22
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - async*getPotentialBreachesByLoginGUID@resource:///modules/LoginBreaches.jsm:51:74
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - _sendAllLoginRelatedObjects@resource:///actors/AboutLoginsParent.jsm:869:29
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - receiveMessage@resource:///actors/AboutLoginsParent.jsm:486:29
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - async*handleEvent@resource:///actors/AboutLoginsChild.jsm:41:14
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - @chrome://browser/content/aboutlogins/aboutLogins.js:171:12
[task 2020-04-22T02:47:22.945Z] 02:47:22     INFO - 
[task 2020-04-22T02:47:22.946Z] 02:47:22     INFO - Console message: [JavaScript Error: "InvalidStateError: An attempt was made to use an object that is not, or is no longer, usable" {file: "resource:///actors/AboutLoginsParent.jsm" line: 859}]
[task 2020-04-22T02:47:22.946Z] 02:47:22     INFO - pageInfo_entryPoint, opening pageinfo
[task 2020-04-22T02:47:22.946Z] 02:47:22     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-04-22T02:47:22.946Z] 02:47:22     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-04-22T02:47:22.946Z] 02:47:22     INFO - Vendor: Intel Inc.
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - Buffered messages logged at 02:47:22
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - pageInfo_entryPoint, got pageinfo, wait until password button is visible
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - pageInfo_entryPoint, clicking the show passwords button...
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - pageInfo_entryPoint, waiting for the passwords manager dialog
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - waiting for new tab to open
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | got password management tab - 
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | content must be in snapshot. Has [content]. - true == true - 
[task 2020-04-22T02:47:22.948Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | After filtering we must have the expected number of events. - 1 == 1 - 
[task 2020-04-22T02:47:22.949Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | category in event pwmgr#open_management#pageinfo must match. - "pwmgr" matches "pwmgr" - 
[task 2020-04-22T02:47:22.949Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | method in event pwmgr#open_management#pageinfo must match. - "open_management" matches "open_management" - 
[task 2020-04-22T02:47:22.949Z] 02:47:22     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | object in event pwmgr#open_management#pageinfo must match. - "pageinfo" matches "pageinfo" - 
[task 2020-04-22T02:47:22.949Z] 02:47:22     INFO - pageInfo_entryPoint, close dialog and pageInfo
[task 2020-04-22T02:47:22.949Z] 02:47:22     INFO - Buffered messages finished
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | A promise chain failed to handle a rejection: An attempt was made to use an object that is not, or is no longer, usable - stack: sendMessageFn@resource:///actors/AboutLoginsParent.jsm:859:57
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - _sendAllLoginRelatedObjects@resource:///actors/AboutLoginsParent.jsm:867:20
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - async*receiveMessage@resource:///actors/AboutLoginsParent.jsm:486:29
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - async*handleEvent@resource:///actors/AboutLoginsChild.jsm:41:14
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - @chrome://browser/content/aboutlogins/aboutLogins.js:171:12
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - Rejection date: Wed Apr 22 2020 02:47:21 GMT+0000 (Greenwich Mean Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 265
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - Stack trace:
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:265
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1070
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1074
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:904
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:918
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - Leaving test bound pageInfo_entryPoint
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - GECKO(2003) | [Parent 2003, Main Thread] WARNING: 'aOwner->IsDiscarded()', file /builds/worker/workspace/obj-build/dist/include/mozilla/dom/SyncedContextInlines.h, line 37
[task 2020-04-22T02:47:22.955Z] 02:47:22     INFO - GECKO(2003) | [Parent 2003, Main Thread] WARNING: 'aOwner->IsDiscarded()', file /builds/worker/workspace/obj-build/dist/include/mozilla/dom/SyncedContextInlines.h, line 37
[task 2020-04-22T02:47:22.956Z] 02:47:22     INFO - GECKO(2003) | [Parent 2003, Main Thread] WARNING: 'aOwner->IsDiscarded()', file /builds/worker/workspace/obj-build/dist/include/mozilla/dom/SyncedContextInlines.h, line 37
[task 2020-04-22T02:47:22.957Z] 02:47:22     INFO - TEST-FAIL | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | Assertion count 2 is greater than expected range 0-0 assertions. - 
[task 2020-04-22T02:47:22.957Z] 02:47:22     INFO - GECKO(2003) | MEMORY STAT | vsize 7747MB | residentFast 398MB | heapAllocated 176MB
[task 2020-04-22T02:47:22.957Z] 02:47:22     INFO - TEST-OK | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | took 2964ms

Comment 1

[Bogdan Tara[:bogdan_tara | bogdant]]

Caused by bug 1580565 and fixed by backout.
https://hg.mozilla.org/integration/autoland/rev/5db64345bebd6d588f256e8ce830cb81c38d73a4