Closed Bug 1712371 Opened 3 years ago Closed 3 years ago

Intermittent [TV] toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | Test timed out -

Categories

(Toolkit :: Password Manager, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=340458764&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/RONG3yT6TAK41paqkxemBw/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/RONG3yT6TAK41paqkxemBw/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1


INFO - TEST-START | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js
[task 2021-05-21T17:01:12.994Z] 17:01:12     INFO - GECKO(14382) | [Child 14555: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f24dd68d800 == 1 [pid = 14555] [id = 0]
[task 2021-05-21T17:01:12.995Z] 17:01:12     INFO - GECKO(14382) | [Child 14555: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f24f3d64200) [pid = 14555] [serial = 1] [outer = 0]
[task 2021-05-21T17:01:13.002Z] 17:01:13     INFO - GECKO(14382) | [Child 14555: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f24dd692400) [pid = 14555] [serial = 2] [outer = 7f24f3d64200]
[task 2021-05-21T17:01:13.025Z] 17:01:13     INFO - GECKO(14382) | [Parent 14382, Main Thread] WARNING: '!mPresContext', file /builds/worker/checkouts/gecko/dom/events/UIEvent.cpp:138
[task 2021-05-21T17:01:13.771Z] 17:01:13     INFO - GECKO(14382) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpux0l05.mozrunner/runtests_leaks_tab_pid14578.log
[task 2021-05-21T17:01:13.771Z] 17:01:13     INFO - GECKO(14382) | [14578, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:254
[task 2021-05-21T17:01:13.831Z] 17:01:13     INFO - GECKO(14382) | [Child 14578, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-05-21T17:01:17.488Z] 17:01:17     INFO - GECKO(14382) | [Child 14446: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f120e7b9400 == 0 [pid = 14446] [id = 0] [url = about:blank]
[task 2021-05-21T17:01:21.583Z] 17:01:21     INFO - GECKO(14382) | [Child 14446: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7f120e7ba400) [pid = 14446] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:21.603Z] 17:01:21     INFO - GECKO(14382) | [Child 14446: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f1224e64200) [pid = 14446] [serial = 1] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:22.362Z] 17:01:22     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (7f4521c97c00) [pid = 14468] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:22.362Z] 17:01:22     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (7f4521c9d800) [pid = 14468] [serial = 4] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:22.363Z] 17:01:22     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (7f4521c9fc00) [pid = 14468] [serial = 6] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:22.363Z] 17:01:22     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (7f451bac0c00) [pid = 14468] [serial = 8] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:22.364Z] 17:01:22     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (7f451bac3000) [pid = 14468] [serial = 10] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:22.419Z] 17:01:22     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f4521c9e800 == 4 [pid = 14468] [id = 2] [url = moz-extension://5a68b40a-1274-4a72-8837-cbce0d0f0cec/_generated_background_page.html]
[task 2021-05-21T17:01:22.420Z] 17:01:22     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 9 (7f4521c7cac0) [pid = 14468] [serial = 5] [outer = 0] [url = moz-extension://5a68b40a-1274-4a72-8837-cbce0d0f0cec/_generated_background_page.html]
[task 2021-05-21T17:01:23.821Z] 17:01:23     INFO - GECKO(14382) | [Parent 14382: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (7fe0c09f8000) [pid = 14382] [serial = 8] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:23.942Z] 17:01:23     INFO - GECKO(14382) | [Child 14524: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7fe15f7d3000) [pid = 14524] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:25.655Z] 17:01:25     INFO - GECKO(14382) | [Child 14446: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f12085b4000) [pid = 14446] [serial = 4] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:25.655Z] 17:01:25     INFO - GECKO(14382) | [Child 14446: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f120e7c1c00) [pid = 14446] [serial = 3] [outer = 0] [url = about:blank]
[task 2021-05-21T17:01:26.459Z] 17:01:26     INFO - GECKO(14382) | [Child 14468: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 8 (7f451b173000) [pid = 14468] [serial = 13] [outer = 0] [url = moz-extension://5a68b40a-1274-4a72-8837-cbce0d0f0cec/_generated_background_page.html]
[task 2021-05-21T17:02:42.904Z] 17:02:42     INFO - TEST-INFO | started process screentopng
[task 2021-05-21T17:02:43.186Z] 17:02:43     INFO - TEST-INFO | screentopng: exit 0
[task 2021-05-21T17:02:43.187Z] 17:02:43     INFO - Buffered messages logged at 17:01:12
[task 2021-05-21T17:02:43.188Z] 17:02:43     INFO - Entering test bound common_initialize
[task 2021-05-21T17:02:43.188Z] 17:02:43     INFO - Leaving test bound common_initialize
[task 2021-05-21T17:02:43.189Z] 17:02:43     INFO - Entering test bound setup
[task 2021-05-21T17:02:43.189Z] 17:02:43     INFO - Leaving test bound setup
[task 2021-05-21T17:02:43.189Z] 17:02:43     INFO - Entering test bound mainMenu_entryPoint
[task 2021-05-21T17:02:43.190Z] 17:02:43     INFO - mainMenu_entryPoint, got focus
[task 2021-05-21T17:02:43.190Z] 17:02:43     INFO - mainMenu_entryPoint, Main menu button is visible
[task 2021-05-21T17:02:43.191Z] 17:02:43     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | Menu panel (appMenu-popup) is initally closed. - 
[task 2021-05-21T17:02:43.191Z] 17:02:43     INFO - mainMenu_entryPoint, clicking target and waiting for popup
[task 2021-05-21T17:02:43.192Z] 17:02:43     INFO - Buffered messages finished
[task 2021-05-21T17:02:43.192Z] 17:02:43     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | Test timed out - 
[task 2021-05-21T17:02:43.192Z] 17:02:43     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-05-21T17:02:43.202Z] 17:02:43     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | Uncaught exception received from previously timed out test - popupshown listener on #appMenu-popup not removed before the end of test
[task 2021-05-21T17:02:43.202Z] 17:02:43     INFO - GECKO(14382) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2021-05-21T17:02:43.203Z] 17:02:43     INFO - GECKO(14382) | MEMORY STAT | vsize 2906MB | residentFast 319MB | heapAllocated 99MB
INFO - TEST-OK | toolkit/components/passwordmgr/test/browser/browser_entry_point_telemetry.js | took 90172ms```
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.