Closed Bug 1826521 Opened 3 years ago Closed 2 years ago

Intermittent toolkit/components/satchel/test/test_password_autocomplete.html | single tracking bug

Categories

(Toolkit :: Form Manager, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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


[task 2023-04-05T09:02:53.403Z] 09:02:53     INFO - TEST-START | toolkit/components/satchel/test/test_password_autocomplete.html
[task 2023-04-05T09:02:54.091Z] 09:02:54     INFO - GECKO(4048) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/7_/3mcvy6151jb4tm5l4f3bq3zr000014/T/tmphgizzzhp.mozrunner/runtests_leaks_tab_pid4056.log
[task 2023-04-05T09:02:54.091Z] 09:02:54     INFO - GECKO(4048) | [4056, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:345
[task 2023-04-05T09:02:54.126Z] 09:02:54     INFO - GECKO(4048) | [Child 4056, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:54.144Z] 09:02:54     INFO - GECKO(4048) | [Child 4056, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:54.145Z] 09:02:54     INFO - GECKO(4048) | [Child 4056, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:54.173Z] 09:02:54     INFO - GECKO(4048) | ###!!! ERROR: Potential deadlock detected:
[task 2023-04-05T09:02:54.173Z] 09:02:54     INFO - GECKO(4048) | === Cyclical dependency starts at
[task 2023-04-05T09:02:54.174Z] 09:02:54     INFO - GECKO(4048) | --- RecursiveMutex : gfxPlatformFontList lock calling context
[task 2023-04-05T09:02:54.174Z] 09:02:54     INFO - GECKO(4048) |   [stack trace unavailable]
[task 2023-04-05T09:02:54.175Z] 09:02:54     INFO - GECKO(4048) | --- Next dependency:
[task 2023-04-05T09:02:54.175Z] 09:02:54     INFO - GECKO(4048) | --- Mutex : gfxFontFamily lock (currently acquired)
[task 2023-04-05T09:02:54.175Z] 09:02:54     INFO - GECKO(4048) |  calling context
[task 2023-04-05T09:02:54.176Z] 09:02:54     INFO - GECKO(4048) |   [stack trace unavailable]
[task 2023-04-05T09:02:54.176Z] 09:02:54     INFO - GECKO(4048) | === Cycle completed at
[task 2023-04-05T09:02:54.176Z] 09:02:54     INFO - GECKO(4048) | --- RecursiveMutex : gfxPlatformFontList lock calling context
[task 2023-04-05T09:02:54.177Z] 09:02:54     INFO - GECKO(4048) |   [stack trace unavailable]
[task 2023-04-05T09:02:54.177Z] 09:02:54     INFO - GECKO(4048) | Deadlock may happen for some other execution
[task 2023-04-05T09:02:54.178Z] 09:02:54     INFO - GECKO(4048) | [Child 4049, Main Thread] WARNING: Potential deadlock detected:
[task 2023-04-05T09:02:54.178Z] 09:02:54     INFO - GECKO(4048) | Cyclical dependency starts at
[task 2023-04-05T09:02:54.178Z] 09:02:54     INFO - GECKO(4048) | RecursiveMutex : gfxPlatformFontList lock
[task 2023-04-05T09:02:54.179Z] 09:02:54     INFO - GECKO(4048) | Next dependency:
[task 2023-04-05T09:02:54.179Z] 09:02:54     INFO - GECKO(4048) | Mutex : gfxFontFamily lock (currently acquired)
[task 2023-04-05T09:02:54.179Z] 09:02:54     INFO - GECKO(4048) | Cycle completed at
[task 2023-04-05T09:02:54.180Z] 09:02:54     INFO - GECKO(4048) | RecursiveMutex : gfxPlatformFontList lock
[task 2023-04-05T09:02:54.180Z] 09:02:54     INFO - GECKO(4048) | Deadlock may happen for some other execution
[task 2023-04-05T09:02:54.180Z] 09:02:54     INFO - GECKO(4048) | : file /builds/worker/checkouts/gecko/xpcom/threads/BlockingResourceBase.cpp:247
[task 2023-04-05T09:02:54.181Z] 09:02:54     INFO - GECKO(4048) | [Child 4056, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:54.215Z] 09:02:54     INFO - GECKO(4048) | [Child 4049, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:54.215Z] 09:02:54     INFO - GECKO(4048) | [Child 4049, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:54.216Z] 09:02:54     INFO - GECKO(4048) | JavaScript error: resource://gre/modules/XULStore.sys.mjs, line 58: Error: Can't find profile directory.
[task 2023-04-05T09:02:54.216Z] 09:02:54     INFO - GECKO(4048) | [Child 4049, Main Thread] WARNING: '!mLocalStore', file /builds/worker/checkouts/gecko/dom/xul/XULPersist.cpp:146
[task 2023-04-05T09:02:54.509Z] 09:02:54     INFO - GECKO(4048) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.jsm", 407))
[task 2023-04-05T09:02:54.536Z] 09:02:54     INFO - GECKO(4048) | [Parent 4048, Main Thread] WARNING: WebProgress Ignored: no longer current window global: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3021
[task 2023-04-05T09:02:55.066Z] 09:02:55     INFO - GECKO(4048) | [Child 4054, Main Thread] WARNING: '!mBoundFrame', file /builds/worker/checkouts/gecko/dom/html/TextControlState.cpp:2354
[task 2023-04-05T09:02:55.066Z] 09:02:55     INFO - GECKO(4048) | [Child 4054, Main Thread] WARNING: '!mBoundFrame', file /builds/worker/checkouts/gecko/dom/html/TextControlState.cpp:2354
[task 2023-04-05T09:02:55.624Z] 09:02:55     INFO - GECKO(4048) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/7_/3mcvy6151jb4tm5l4f3bq3zr000014/T/tmphgizzzhp.mozrunner/runtests_leaks_tab_pid4061.log
[task 2023-04-05T09:02:55.625Z] 09:02:55     INFO - GECKO(4048) | [4061, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:345
[task 2023-04-05T09:02:55.660Z] 09:02:55     INFO - GECKO(4048) | [Child 4061, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:55.678Z] 09:02:55     INFO - GECKO(4048) | [Child 4061, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:55.679Z] 09:02:55     INFO - GECKO(4048) | [Child 4061, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:55.712Z] 09:02:55     INFO - GECKO(4048) | [Child 4061, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-04-05T09:02:56.264Z] 09:02:56     INFO - GECKO(4048) | JavaScript error: resource://services-settings/RemoteSettingsClient.sys.mjs, line 323: Error: Cannot instantiate Remote Settings client in child processes.
[task 2023-04-05T09:02:59.103Z] 09:02:59     INFO - GECKO(4048) | [Child 4054, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1681
[task 2023-04-05T09:03:19.859Z] 09:03:19     INFO - GECKO(4048) | 2023-04-05 09:03:19.858 firefox[4048:94456] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightlydebug.savedState/window_1.data: No such file or directory (2)
[task 2023-04-05T09:07:54.197Z] 09:07:54     INFO - TEST-INFO | started process screencapture
[task 2023-04-05T09:07:54.316Z] 09:07:54     INFO - TEST-INFO | screencapture: exit 0
[task 2023-04-05T09:07:54.317Z] 09:07:54     INFO - Buffered messages logged at 09:02:55
[task 2023-04-05T09:07:54.317Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Got autocomplete popup - {"mInput":null,"mPopupOpen":false,"_currentIndex":0,"_disabledItemClicked":false} == true 
[task 2023-04-05T09:07:54.318Z] 09:07:54     INFO - add_setup | Entering 
[task 2023-04-05T09:07:54.318Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | This test must run on HTTPS 
[task 2023-04-05T09:07:54.318Z] 09:07:54     INFO - add_setup | Leaving 
[task 2023-04-05T09:07:54.319Z] 09:07:54     INFO - add_task | Entering test_secure_noFormHistoryOrWarning
[task 2023-04-05T09:07:54.319Z] 09:07:54     INFO - Testing: () => input.focus()
[task 2023-04-05T09:07:54.320Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | A valid string reason is expected 
[task 2023-04-05T09:07:54.320Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Reason cannot be empty 
[task 2023-04-05T09:07:54.321Z] 09:07:54     INFO - TEST-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Giving a chance for an unexpected popupshown to occur 
[task 2023-04-05T09:07:54.321Z] 09:07:54     INFO - Testing: () => input.click()
[task 2023-04-05T09:07:54.321Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | A valid string reason is expected 
[task 2023-04-05T09:07:54.322Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Reason cannot be empty 
[task 2023-04-05T09:07:54.322Z] 09:07:54     INFO - TEST-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Giving a chance for an unexpected popupshown to occur 
[task 2023-04-05T09:07:54.322Z] 09:07:54     INFO - Buffered messages logged at 09:02:56
[task 2023-04-05T09:07:54.323Z] 09:07:54     INFO - Testing: () => synthesizeKey("KEY_ArrowDown")
[task 2023-04-05T09:07:54.323Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | A valid string reason is expected 
[task 2023-04-05T09:07:54.324Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Reason cannot be empty 
[task 2023-04-05T09:07:54.324Z] 09:07:54     INFO - TEST-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Giving a chance for an unexpected popupshown to occur 
[task 2023-04-05T09:07:54.325Z] 09:07:54     INFO - Testing: () => synthesizeKey("KEY_PageDown")
[task 2023-04-05T09:07:54.325Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | A valid string reason is expected 
[task 2023-04-05T09:07:54.326Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Reason cannot be empty 
[task 2023-04-05T09:07:54.326Z] 09:07:54     INFO - TEST-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Giving a chance for an unexpected popupshown to occur 
[task 2023-04-05T09:07:54.326Z] 09:07:54     INFO - Buffered messages logged at 09:02:57
[task 2023-04-05T09:07:54.327Z] 09:07:54     INFO - Testing: () => synthesizeKey("KEY_Enter")
[task 2023-04-05T09:07:54.327Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | A valid string reason is expected 
[task 2023-04-05T09:07:54.328Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Reason cannot be empty 
[task 2023-04-05T09:07:54.328Z] 09:07:54     INFO - TEST-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Giving a chance for an unexpected popupshown to occur 
[task 2023-04-05T09:07:54.329Z] 09:07:54     INFO - Buffered messages logged at 09:02:58
[task 2023-04-05T09:07:54.329Z] 09:07:54     INFO - Testing: () => sendString("v ")
[task 2023-04-05T09:07:54.329Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | A valid string reason is expected 
[task 2023-04-05T09:07:54.330Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Reason cannot be empty 
[task 2023-04-05T09:07:54.330Z] 09:07:54     INFO - TEST-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Giving a chance for an unexpected popupshown to occur 
[task 2023-04-05T09:07:54.331Z] 09:07:54     INFO - Testing: () => synthesizeKey("KEY_Backspace")
[task 2023-04-05T09:07:54.331Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | A valid string reason is expected 
[task 2023-04-05T09:07:54.332Z] 09:07:54     INFO - TEST-PASS | toolkit/components/satchel/test/test_password_autocomplete.html | Reason cannot be empty 
[task 2023-04-05T09:07:54.332Z] 09:07:54     INFO - TEST-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | The author of the test has indicated that flaky timeouts are expected.  Reason: Giving a chance for an unexpected popupshown to occur 
[task 2023-04-05T09:07:54.332Z] 09:07:54     INFO - Buffered messages logged at 09:02:59
[task 2023-04-05T09:07:54.333Z] 09:07:54     INFO - add_task | Leaving test_secure_noFormHistoryOrWarning
[task 2023-04-05T09:07:54.333Z] 09:07:54     INFO - add_task | Entering test_insecure_focusWarning
[task 2023-04-05T09:07:54.333Z] 09:07:54     INFO - Buffered messages finished
[task 2023-04-05T09:07:54.334Z] 09:07:54     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/satchel/test/test_password_autocomplete.html | Test timed out. - 
[task 2023-04-05T09:07:55.279Z] 09:07:55     INFO - GECKO(4048) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2023-04-05T09:07:55.279Z] 09:07:55     INFO - GECKO(4048) | MEMORY STAT | vsize 6684MB | residentFast 81MB | heapAllocated 6MB
[task 2023-04-05T09:07:55.295Z] 09:07:55     INFO - TEST-OK | toolkit/components/satchel/test/test_password_autocomplete.html | took 301892ms
[task 2023-04-05T09:07:55.388Z] 09:07:55     INFO - TEST-START | Shutdown
[task 2023-04-05T09:07:55.389Z] 09:07:55     INFO - Passed:  16
[task 2023-04-05T09:07:55.389Z] 09:07:55     INFO - Failed:  0
[task 2023-04-05T09:07:55.390Z] 09:07:55     INFO - Todo:    7
[task 2023-04-05T09:07:55.390Z] 09:07:55     INFO - Mode:    e10s
[task 2023-04-05T09:07:55.391Z] 09:07:55     INFO - Slowest: 301892ms - https://example.org:443/tests/toolkit/components/satchel/test/test_password_autocomplete.html
[task 2023-04-05T09:07:55.391Z] 09:07:55     INFO - SimpleTest FINISHED
[task 2023-04-05T09:07:55.393Z] 09:07:55     INFO - TEST-INFO | Ran 1 Loops
[task 2023-04-05T09:07:55.393Z] 09:07:55     INFO - SimpleTest FINISHED
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago3 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago2 years ago
Resolution: --- → INCOMPLETE
Summary: Intermittent [tier 2] toolkit/components/satchel/test/test_password_autocomplete.html | single tracking bug → Intermittent toolkit/components/satchel/test/test_password_autocomplete.html | single tracking bug
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.