Open Bug 1333264 Opened 7 years ago Updated 1 year ago

Intermittent macOS test_master_password.html | Test timed out.

Categories

(Toolkit :: Password Manager, defect, P3)

defect

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, leave-open, Whiteboard: [stockwell disabled])

Attachments

(5 files)

Summary: Intermittent toolkit/components/passwordmgr/test/test_master_password.html | Test timed out. → Intermittent test_master_password.html | Test timed out.
At the current rate I don't think it deserves my attention.
Status: REOPENED → NEW
Flags: needinfo?(MattN+bmo)
Priority: -- → P5
There are 30 failures in the last 7 days, all of them occurred on Linux debug.
Recent log failure: https://treeherder.mozilla.org/logviewer.html#?repo=autoland&job_id=167161350

Relevant part of the log:
[task 2018-03-10T11:29:07.678Z] 11:29:07     INFO - Buffered messages finished
[task 2018-03-10T11:29:07.678Z] 11:29:07     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/test_master_password.html | Test timed out. 
[task 2018-03-10T11:29:07.679Z] 11:29:07     INFO -     reportError@SimpleTest/TestRunner.js:121:7
[task 2018-03-10T11:29:07.679Z] 11:29:07     INFO -     TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7
[task 2018-03-10T11:29:08.372Z] 11:29:08     INFO - MP change from omgsecret! to 
[task 2018-03-10T11:29:08.374Z] 11:29:08     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-03-10T11:29:08.375Z] 11:29:08     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/test_master_password.html | Cleanup function threw exception: [Exception... "Component returned failure code: 0x805a1ff1 [nsIPK11Token.changePassword]"  nsresult: "0x805a1ff1 (<unknown>)"  location: "JS frame :: chrome://specialpowers/content/specialpowersAPI.js :: doApply :: line 143"  data: no] 
[task 2018-03-10T11:29:08.376Z] 11:29:08     INFO -     executeCleanupFunction@SimpleTest/SimpleTest.js:1219:13
[task 2018-03-10T11:29:08.377Z] 11:29:08     INFO -     SimpleTest.finish@SimpleTest/SimpleTest.js:1230:5
[task 2018-03-10T11:29:08.378Z] 11:29:08     INFO -     killTest@SimpleTest/TestRunner.js:130:7
[task 2018-03-10T11:29:08.379Z] 11:29:08     INFO -     delayedKillTest@SimpleTest/TestRunner.js:157:47
[task 2018-03-10T11:29:08.449Z] 11:29:08     INFO - GECKO(2251) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2018-03-10T11:29:08.450Z] 11:29:08     INFO - GECKO(2251) | MEMORY STAT | vsize 846MB | residentFast 255MB | heapAllocated 68MB
[task 2018-03-10T11:29:08.486Z] 11:29:08     INFO - TEST-OK | toolkit/components/passwordmgr/test/test_master_password.html | took 301138ms
[task 2018-03-10T11:29:11.528Z] 11:29:11     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2018-03-10T11:29:11.611Z] 11:29:11    ERROR - /tests/toolkit/components/passwordmgr/test/test_master_password.html logged result after SimpleTest.finish(): Cleanup function threw exception: [Exception... "Component returned failure code: 0x805a1ff1 [nsIPK11Token.changePassword]"  nsresult: "0x805a1ff1 (<unknown>)"  location: "JS frame :: chrome://specialpowers/content/specialpowersAPI.js :: doApply :: line 143"  data: no]
[task 2018-03-10T11:29:11.619Z] 11:29:11     INFO - GECKO(2251) | ++DOMWINDOW == 17 (0xcfcd1000) [pid = 2251] [serial = 31] [outer = 0xcfb196c0]

:MattN Could you please take a look here?
Flags: needinfo?(MattN+bmo)
Whiteboard: [stockwell needswork]
This test only fails on linux32 since that's the only place it runs due to not running with e10s yet (bug 1269039).
Depends on: 1269039
Flags: needinfo?(MattN+bmo)
Priority: P5 → P3
Over the last 7 days there are 36 failures on this bug. These happen on only on Linux.

Here is the most recent log example: https://treeherder.mozilla.org/logviewer.html#?repo=mozilla-inbound&job_id=173623190&lineNumber=9644

Here is the relevant part of that log: 

[task 2018-04-13T23:03:21.352Z] 23:03:21     INFO - Buffered messages finished
[task 2018-04-13T23:03:21.353Z] 23:03:21     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/test_master_password.html | Test timed out. 
[task 2018-04-13T23:03:21.353Z] 23:03:21     INFO -     reportError@SimpleTest/TestRunner.js:121:7
[task 2018-04-13T23:03:21.354Z] 23:03:21     INFO -     TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7
[task 2018-04-13T23:03:22.020Z] 23:03:22     INFO - MP change from omgsecret! to 
[task 2018-04-13T23:03:22.038Z] 23:03:22     INFO - Not taking screenshot here: see the one that was previously logged
[task 2018-04-13T23:03:22.040Z] 23:03:22     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/test_master_password.html | Cleanup function threw exception: [Exception... "Component returned failure code: 0x805a1ff1 [nsIPK11Token.changePassword]"  nsresult: "0x805a1ff1 (<unknown>)"  location: "JS frame :: chrome://specialpowers/content/specialpowersAPI.js :: doApply :: line 132"  data: no] 
[task 2018-04-13T23:03:22.041Z] 23:03:22     INFO -     executeCleanupFunction@SimpleTest/SimpleTest.js:1229:13
[task 2018-04-13T23:03:22.042Z] 23:03:22     INFO -     SimpleTest.finish@SimpleTest/SimpleTest.js:1240:5
[task 2018-04-13T23:03:22.044Z] 23:03:22     INFO -     killTest@SimpleTest/TestRunner.js:130:7
[task 2018-04-13T23:03:22.045Z] 23:03:22     INFO -     delayedKillTest@SimpleTest/TestRunner.js:157:47
[task 2018-04-13T23:03:22.108Z] 23:03:22     INFO - GECKO(2310) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2018-04-13T23:03:22.108Z] 23:03:22     INFO - GECKO(2310) | MEMORY STAT | vsize 831MB | residentFast 239MB | heapAllocated 66MB
[task 2018-04-13T23:03:22.145Z] 23:03:22     INFO - TEST-OK | toolkit/components/passwordmgr/test/test_master_password.html | took 301136ms
[task 2018-04-13T23:03:25.187Z] 23:03:25     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2018-04-13T23:03:25.284Z] 23:03:25    ERROR - /tests/toolkit/components/passwordmgr/test/test_master_password.html logged result after SimpleTest.finish(): Cleanup function threw exception: [Exception... "Component returned failure code: 0x805a1ff1 [nsIPK11Token.changePassword]"  nsresult: "0x805a1ff1 (<unknown>)"  location: "JS frame :: chrome://specialpowers/content/specialpowersAPI.js :: doApply :: line 132"  data: no]
[task 2018-04-13T23:03:25.306Z] 23:03:25     INFO - GECKO(2310) | ++DOMWINDOW == 17 (0xdbb90c00) [pid = 2310] [serial = 31] [outer = 0xcf619800]
Flags: needinfo?(MattN+bmo)
Attachment #8970459 - Flags: review?(jmaher)
Comment on attachment 8970459 [details] [diff] [review]
Disabled on linux 32 debug

Review of attachment 8970459 [details] [diff] [review]:
-----------------------------------------------------------------

thanks!
Attachment #8970459 - Flags: review?(jmaher) → review+
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Pushed by shindli@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/0480e858c8ea
disabled test_master_password.html on Linux 32 debug for frequent failures. r=jmaher
Keywords: checkin-needed
Flags: needinfo?(MattN+bmo)

Those look like mostly test-verify jobs that got starred to this non-TV bug so I think the volume is much lower than it looked. It's expected that this volume increased because the test was just enabled for e10s. I'll keep an eye on it as I've been fixing other passwordmgr tests.

Flags: needinfo?(MattN+bmo)
Whiteboard: [stockwell disabled]
Whiteboard: [retriggered]

Matthew, 10 failures are TV the rest of them are tier1 mochitest failures - 23 failures in the last 7 days.

There are 53 total failures in the last 7 days. The failure rate is higher and seems to be increasing.

Matthew can you fix this or assign it to someone?

Whiteboard: [retriggered] → [retriggered][stockwell needswork:owner]
Assignee: nobody → MattN+bmo
Status: NEW → ASSIGNED
Priority: P3 → P2
Pushed by mozilla@noorenberghe.ca:
https://hg.mozilla.org/integration/mozilla-inbound/rev/215984141739
Disable test_master_password.html on Win/Linux pgo/asan/opt due to failures. r=intermittent
Whiteboard: [retriggered][stockwell needswork:owner] → [stockwell disabled]
Assignee: MattN+bmo → nobody
Status: ASSIGNED → NEW
Priority: P2 → P3

This bug has failed 40 times in the last 7 days. Occurs on linux platforms on opt build types.

Recent log:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=228529262&repo=mozilla-inbound&lineNumber=7689

I intended to disable it on linux opt in comment 80. Did I mess up the syntax?

Flags: needinfo?(dluca)

I'm not entirely sure, but I'm guessing this part here skip-if = os == "linux" is in the wrong place, since its only happening on linux.

Either that, or it needs to be added in another place in the ini so it skips on linux properly.

I use https://wiki.mozilla.org/Auto-tools/Projects/Stockwell/disable-recommended for reference.

Flags: needinfo?(dluca) → needinfo?(MattN+bmo)

Maybe add the skip-if before the scheme = https and also for the (os != 'mac' && (pgo || asan || opt)) isn't it easier to just add (os != 'mac' && !debug)

Also, it might be || instead of &&. Cosmin, can you look?

Flags: needinfo?(csabou)

Hi! We cannot skip on pgo/opt specifically, it's just debug or !debug. I guess the syntax you were looking for was:
skip-if = toolkit == 'android' || asan || os != 'mac' && !debug.
I would in the end go with skip-if = true cause it's affects too many platforms and builds.

Flags: needinfo?(csabou)

Pushed by nbeleuzu@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/3ae65fd31265
Disable test_master_password.html on all platforms due to frequent failures. r=jmaher

Keywords: checkin-needed

I think we want:
skip-if = toolkit == 'android' || (os != 'mac')

:narcis, can you look at this?

Flags: needinfo?(nbeleuzu)
Pushed by mozilla@noorenberghe.ca:
https://hg.mozilla.org/integration/autoland/rev/318b4b967e7c
Only skip test_master_password.html on platforms with failures.
Flags: needinfo?(MattN+bmo)

(In reply to Matthew N. [:MattN] (PM me if requests are blocking you) from comment #93)

Created attachment 9044902 [details]
Bug 1333264 - Only skip test_master_password.html on platforms with failures. r=jmaher

Uhmm, the toolkit condition is missing, is that how it's supposed to be? I was looking at Comment 92.

Flags: needinfo?(nbeleuzu) → needinfo?(jmaher)

Good eye :apavel, you would make a good sidekick to batman!

in this case, skip-if = !mac, is the same as skipping all platforms except mac. So toolkit == 'android' is covered by !mac.

Flags: needinfo?(jmaher)

(In reply to Joel Maher ( :jmaher ) (UTC-4) from comment #97)

Good eye :apavel, you would make a good sidekick to batman!

in this case, skip-if = !mac, is the same as skipping all platforms except mac. So toolkit == 'android' is covered by !mac.

:D

Thanks for clarifying this!

Summary: Intermittent test_master_password.html | Test timed out. → Intermittent macOS test_master_password.html | Test timed out.

There are 24 total failures in the last 7 days on macosx1015-64-qr and macosx1015-64-shippable-qr opt
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=349234198&repo=autoland&lineNumber=9154

[task 2021-08-23T10:51:13.554Z] 10:51:13     INFO - TEST-START | toolkit/components/passwordmgr/test/mochitest/test_master_password.html
[task 2021-08-23T10:51:13.635Z] 10:51:13     INFO - GECKO(10666) | MP change from  to omgsecret!
[task 2021-08-23T10:51:14.923Z] 10:51:14     INFO - GECKO(10666) | JavaScript error: resource://gre/modules/crypto-SDR.js, line 195: NS_ERROR_ABORT: User canceled master password entry
[task 2021-08-23T10:51:14.923Z] 10:51:14     INFO - GECKO(10666) | JavaScript error: resource://gre/modules/crypto-SDR.js, line 195: NS_ERROR_ABORT: User canceled master password entry
[task 2021-08-23T10:51:14.924Z] 10:51:14     INFO - GECKO(10666) | JavaScript error: resource://gre/modules/crypto-SDR.js, line 195: NS_ERROR_ABORT: User canceled master password entry
[task 2021-08-23T10:52:24.215Z] 10:52:24     INFO - GECKO(10666) | 1629715944214	addons.xpi	ERROR	System addon update list error Error: got node name: html, expected: updates
[task 2021-08-23T10:56:26.695Z] 10:56:26     INFO - TEST-INFO | started process screencapture
[task 2021-08-23T10:56:26.805Z] 10:56:26     INFO - TEST-INFO | screencapture: exit 0
[task 2021-08-23T10:56:26.805Z] 10:56:26     INFO - Buffered messages logged at 10:51:13
[task 2021-08-23T10:56:26.806Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Access LoginManager - true == true 
[task 2021-08-23T10:56:26.806Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Not expecting logins to be present - 0 == 0 
[task 2021-08-23T10:56:26.807Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking for successful init login - 1 == 1 
[task 2021-08-23T10:56:26.807Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking for no disabled hosts - 0 == 0 
[task 2021-08-23T10:56:26.808Z] 10:56:26     INFO - add_task | Entering test setup
[task 2021-08-23T10:56:26.808Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be initially logged in (no MP) 
[task 2021-08-23T10:56:26.809Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out after setting MP 
[task 2021-08-23T10:56:26.809Z] 10:56:26     INFO - add_task | Leaving test setup
[task 2021-08-23T10:56:26.809Z] 10:56:26     INFO - add_task | Entering test test_1
[task 2021-08-23T10:56:26.810Z] 10:56:26     INFO - Buffered messages logged at 10:51:14
[task 2021-08-23T10:56:26.810Z] 10:56:26     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-08-23T10:56:26.810Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-08-23T10:56:26.811Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-08-23T10:56:26.811Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-08-23T10:56:26.812Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-08-23T10:56:26.812Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-08-23T10:56:26.813Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-08-23T10:56:26.813Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-08-23T10:56:26.813Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-08-23T10:56:26.814Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-08-23T10:56:26.814Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-08-23T10:56:26.814Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-08-23T10:56:26.815Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-08-23T10:56:26.815Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-08-23T10:56:26.816Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-08-23T10:56:26.816Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | expected number of logins 
[task 2021-08-23T10:56:26.817Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged in after MP prompt 
[task 2021-08-23T10:56:26.817Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out 
[task 2021-08-23T10:56:26.817Z] 10:56:26     INFO - add_task | Leaving test test_1
[task 2021-08-23T10:56:26.818Z] 10:56:26     INFO - add_task | Entering test test_2
[task 2021-08-23T10:56:26.818Z] 10:56:26     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-08-23T10:56:26.818Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-08-23T10:56:26.819Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-08-23T10:56:26.819Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-08-23T10:56:26.820Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-08-23T10:56:26.820Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-08-23T10:56:26.820Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-08-23T10:56:26.821Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-08-23T10:56:26.821Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-08-23T10:56:26.821Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-08-23T10:56:26.822Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-08-23T10:56:26.822Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-08-23T10:56:26.823Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-08-23T10:56:26.823Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-08-23T10:56:26.823Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-08-23T10:56:26.824Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | shouldn't have gotten logins 
[task 2021-08-23T10:56:26.824Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should still be logged out 
[task 2021-08-23T10:56:26.824Z] 10:56:26     INFO - add_task | Leaving test test_2
[task 2021-08-23T10:56:26.825Z] 10:56:26     INFO - add_task | Entering test test_3
[task 2021-08-23T10:56:26.825Z] 10:56:26     INFO - Load a single window to trigger a MP
[task 2021-08-23T10:56:26.826Z] 10:56:26     INFO - Buffered messages logged at 10:51:15
[task 2021-08-23T10:56:26.826Z] 10:56:26     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-08-23T10:56:26.826Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-08-23T10:56:26.827Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-08-23T10:56:26.827Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-08-23T10:56:26.828Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-08-23T10:56:26.828Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-08-23T10:56:26.828Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-08-23T10:56:26.829Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-08-23T10:56:26.829Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-08-23T10:56:26.830Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-08-23T10:56:26.830Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-08-23T10:56:26.830Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-08-23T10:56:26.831Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-08-23T10:56:26.831Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-08-23T10:56:26.832Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-08-23T10:56:26.832Z] 10:56:26     INFO - promptDone
[task 2021-08-23T10:56:26.832Z] 10:56:26     INFO - filled
[task 2021-08-23T10:56:26.833Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected user to have been filled in - "user1" == "user1" 
[task 2021-08-23T10:56:26.833Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected pass to have been filled in - "pass1" == "pass1" 
[task 2021-08-23T10:56:26.834Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged in 
[task 2021-08-23T10:56:26.834Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out 
[task 2021-08-23T10:56:26.834Z] 10:56:26     INFO - add_task | Leaving test test_3
[task 2021-08-23T10:56:26.835Z] 10:56:26     INFO - add_task | Entering test test_4
[task 2021-08-23T10:56:26.835Z] 10:56:26     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-08-23T10:56:26.836Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-08-23T10:56:26.836Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-08-23T10:56:26.836Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-08-23T10:56:26.837Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-08-23T10:56:26.837Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-08-23T10:56:26.838Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-08-23T10:56:26.838Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-08-23T10:56:26.839Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-08-23T10:56:26.839Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-08-23T10:56:26.839Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-08-23T10:56:26.840Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-08-23T10:56:26.840Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-08-23T10:56:26.841Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-08-23T10:56:26.841Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-08-23T10:56:26.841Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected empty user - "" == "" 
[task 2021-08-23T10:56:26.842Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected empty pass - "" == "" 
[task 2021-08-23T10:56:26.842Z] 10:56:26     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out 
[task 2021-08-23T10:56:26.843Z] 10:56:26     INFO - Buffered messages finished
[task 2021-08-23T10:56:26.843Z] 10:56:26     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Test timed out. - 
[task 2021-08-23T10:56:27.828Z] 10:56:27     INFO - GECKO(10666) | MP change from omgsecret! to
[task 2021-08-23T10:56:27.831Z] 10:56:27     INFO - GECKO(10666) | MEMORY STAT | vsize 6590MB | residentFast 94MB | heapAllocated 9MB
[task 2021-08-23T10:56:27.853Z] 10:56:27     INFO - TEST-OK | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | took 314298ms
[task 2021-08-23T10:56:31.152Z] 10:56:31     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2021-08-23T10:56:31.163Z] 10:56:31     INFO - TEST-START | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html
[task 2021-08-23T10:56:34.477Z] 10:56:34     INFO - GECKO(10666) | JavaScript error: resource://specialpowers/SpecialPowersParent.jsm, line 26: Error: Error while executing chrome script 'https://example.com/tests/toolkit/components/passwordmgr/test/mochitest/parent_utils.js':
[task 2021-08-23T10:56:34.477Z] 10:56:34     INFO - GECKO(10666) | TypeError: can't access property "addEventListener", gAutocompletePopup is null
[task 2021-08-23T10:56:34.478Z] 10:56:34     INFO - GECKO(10666) | https://example.com/tests/toolkit/components/passwordmgr/test/mochitest/parent_utils.js:182
[task 2021-08-23T10:56:34.480Z] 10:56:34     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-23T10:56:34.480Z] 10:56:34     INFO - Buffered messages logged at 10:56:34
[task 2021-08-23T10:56:34.481Z] 10:56:34     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2021-08-23T10:56:34.481Z] 10:56:34     INFO - Buffered messages finished
[task 2021-08-23T10:56:34.482Z] 10:56:34     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | Got autocomplete popup - null == true - got null, expected true (operator ==)
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - @https://example.com/tests/toolkit/components/passwordmgr/test/mochitest/parent_utils.js:19:8
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - receiveMessage@resource://specialpowers/SpecialPowersParent.jsm:1009:16
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - openWindowPrompt@resource://gre/modules/Prompter.jsm:1291:17
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - openPrompt@resource://gre/modules/Prompter.jsm:1127:12
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - openPromptSync@resource://gre/modules/Prompter.jsm:1106:10
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - nsIPrompt_promptPassword@resource://gre/modules/Prompter.jsm:1647:10
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - promptPassword@resource://gre/modules/Prompter.jsm:1372:44
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - decrypt@resource://gre/modules/crypto-SDR.js:181:38
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - _decryptLogins@resource://gre/modules/storage-json.js:853:39
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - searchLogins@resource://gre/modules/storage-json.js:495:19
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - searchLoginsAsync@resource://gre/modules/storage-json.js:448:23
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - searchLoginsAsync@resource://gre/modules/LoginManager.jsm:513:26
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - searchAndDedupeLogins@resource://gre/modules/LoginManagerParent.jsm:230:38
[task 2021-08-23T10:56:34.483Z] 10:56:34     INFO - sendLoginDataToChild@resource://gre/modules/LoginManagerParent.jsm:563:41
[task 2021-08-23T10:56:34.488Z] 10:56:34     INFO - add_task | Entering test setup
[task 2021-08-23T10:56:34.488Z] 10:56:34     INFO - Waiting for setup and page and window loads
[task 2021-08-23T11:01:57.877Z] 11:01:57     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-23T11:01:57.877Z] 11:01:57     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | Test timed out. - 
[task 2021-08-23T11:02:27.967Z] 11:02:27     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-23T11:02:27.968Z] 11:02:27     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | Test timed out. - 
[task 2021-08-23T11:02:29.005Z] 11:02:29    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2021-08-23T11:02:29.008Z] 11:02:29     INFO - GECKO(10666) | MEMORY STAT | vsize 6589MB | residentFast 93MB | heapAllocated 10MB
[task 2021-08-23T11:02:29.011Z] 11:02:29     INFO - TEST-OK | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | took 357849ms
[task 2021-08-23T11:02:32.255Z] 11:02:32     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2021-08-23T11:02:32.258Z] 11:02:32     INFO - GECKO(10666) | console.warn: LoginRecipes: "getRecipes: falling back to a synchronous message for:" "https://example.com"

Sam can you assign someone to take a look?

Flags: needinfo?(sfoster)
Whiteboard: [stockwell disabled] → [stockwell disabled][stockwell needswork:owner]

Handing this over to :dimi

Assignee: nobody → dlee
Flags: needinfo?(sfoster)

There are 37 total failures in the last 7 days on

  • macosx1015-64-devedition-qr opt
  • macosx1015-64-qr opt
  • macosx1015-64-shippable-qr opt

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

[task 2021-10-12T05:44:33.042Z] 05:44:33     INFO - TEST-START | toolkit/components/passwordmgr/test/mochitest/test_master_password.html
[task 2021-10-12T05:44:33.132Z] 05:44:33     INFO - GECKO(3338) | MP change from  to omgsecret!
[task 2021-10-12T05:44:34.310Z] 05:44:34     INFO - GECKO(3338) | JavaScript error: resource://gre/modules/crypto-SDR.js, line 195: NS_ERROR_ABORT: User canceled master password entry
[task 2021-10-12T05:44:34.310Z] 05:44:34     INFO - GECKO(3338) | JavaScript error: resource://gre/modules/crypto-SDR.js, line 195: NS_ERROR_ABORT: User canceled master password entry
[task 2021-10-12T05:44:34.311Z] 05:44:34     INFO - GECKO(3338) | JavaScript error: resource://gre/modules/crypto-SDR.js, line 195: NS_ERROR_ABORT: User canceled master password entry
[task 2021-10-12T05:45:46.128Z] 05:45:46     INFO - GECKO(3338) | 1634017546127	addons.xpi	ERROR	System addon update list error Error: got node name: html, expected: updates
[task 2021-10-12T05:49:48.386Z] 05:49:48     INFO - TEST-INFO | started process screencapture
[task 2021-10-12T05:49:48.510Z] 05:49:48     INFO - TEST-INFO | screencapture: exit 0
[task 2021-10-12T05:49:48.510Z] 05:49:48     INFO - Buffered messages logged at 05:44:33
[task 2021-10-12T05:49:48.511Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Access LoginManager - true == true 
[task 2021-10-12T05:49:48.511Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Not expecting logins to be present - 0 == 0 
[task 2021-10-12T05:49:48.511Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking for successful init login - 1 == 1 
[task 2021-10-12T05:49:48.512Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking for no disabled hosts - 0 == 0 
[task 2021-10-12T05:49:48.512Z] 05:49:48     INFO - add_task | Entering test setup
[task 2021-10-12T05:49:48.513Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be initially logged in (no MP) 
[task 2021-10-12T05:49:48.513Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out after setting MP 
[task 2021-10-12T05:49:48.514Z] 05:49:48     INFO - add_task | Leaving test setup
[task 2021-10-12T05:49:48.514Z] 05:49:48     INFO - add_task | Entering test test_1
[task 2021-10-12T05:49:48.514Z] 05:49:48     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-10-12T05:49:48.515Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-10-12T05:49:48.515Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-10-12T05:49:48.516Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-10-12T05:49:48.516Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-10-12T05:49:48.517Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-10-12T05:49:48.517Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-10-12T05:49:48.518Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-10-12T05:49:48.518Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-10-12T05:49:48.518Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-10-12T05:49:48.519Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-10-12T05:49:48.519Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-10-12T05:49:48.520Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-10-12T05:49:48.520Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-10-12T05:49:48.520Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-10-12T05:49:48.521Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | expected number of logins 
[task 2021-10-12T05:49:48.521Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged in after MP prompt 
[task 2021-10-12T05:49:48.522Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out 
[task 2021-10-12T05:49:48.522Z] 05:49:48     INFO - add_task | Leaving test test_1
[task 2021-10-12T05:49:48.522Z] 05:49:48     INFO - add_task | Entering test test_2
[task 2021-10-12T05:49:48.523Z] 05:49:48     INFO - Buffered messages logged at 05:44:34
[task 2021-10-12T05:49:48.523Z] 05:49:48     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-10-12T05:49:48.524Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-10-12T05:49:48.524Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-10-12T05:49:48.524Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-10-12T05:49:48.525Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-10-12T05:49:48.525Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-10-12T05:49:48.525Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-10-12T05:49:48.526Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-10-12T05:49:48.526Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-10-12T05:49:48.527Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-10-12T05:49:48.527Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-10-12T05:49:48.528Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-10-12T05:49:48.528Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-10-12T05:49:48.528Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-10-12T05:49:48.529Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-10-12T05:49:48.529Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | shouldn't have gotten logins 
[task 2021-10-12T05:49:48.530Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should still be logged out 
[task 2021-10-12T05:49:48.530Z] 05:49:48     INFO - add_task | Leaving test test_2
[task 2021-10-12T05:49:48.530Z] 05:49:48     INFO - add_task | Entering test test_3
[task 2021-10-12T05:49:48.531Z] 05:49:48     INFO - Load a single window to trigger a MP
[task 2021-10-12T05:49:48.531Z] 05:49:48     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-10-12T05:49:48.532Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-10-12T05:49:48.532Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-10-12T05:49:48.532Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-10-12T05:49:48.532Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-10-12T05:49:48.533Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-10-12T05:49:48.533Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-10-12T05:49:48.534Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-10-12T05:49:48.534Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-10-12T05:49:48.534Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-10-12T05:49:48.535Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-10-12T05:49:48.535Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-10-12T05:49:48.535Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-10-12T05:49:48.536Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-10-12T05:49:48.536Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-10-12T05:49:48.536Z] 05:49:48     INFO - promptDone
[task 2021-10-12T05:49:48.536Z] 05:49:48     INFO - filled
[task 2021-10-12T05:49:48.537Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected user to have been filled in - "user1" == "user1" 
[task 2021-10-12T05:49:48.537Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected pass to have been filled in - "pass1" == "pass1" 
[task 2021-10-12T05:49:48.538Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged in 
[task 2021-10-12T05:49:48.538Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out 
[task 2021-10-12T05:49:48.538Z] 05:49:48     INFO - add_task | Leaving test test_3
[task 2021-10-12T05:49:48.539Z] 05:49:48     INFO - add_task | Entering test test_4
[task 2021-10-12T05:49:48.539Z] 05:49:48     INFO - Buffered messages logged at 05:44:35
[task 2021-10-12T05:49:48.539Z] 05:49:48     INFO - checkPromptState: Expected: Please enter your Primary Password.
[task 2021-10-12T05:49:48.540Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected message 
[task 2021-10-12T05:49:48.540Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking title always visible on OS X or when opened with common dialog 
[task 2021-10-12T05:49:48.541Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox visibility 
[task 2021-10-12T05:49:48.541Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox visibility 
[task 2021-10-12T05:49:48.541Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox visibility 
[task 2021-10-12T05:49:48.542Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox label 
[task 2021-10-12T05:49:48.542Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking checkbox checked 
[task 2021-10-12T05:49:48.543Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking expected icon CSS class 
[task 2021-10-12T05:49:48.543Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking textbox value 
[task 2021-10-12T05:49:48.544Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking passbox value 
[task 2021-10-12T05:49:48.544Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button0 default 
[task 2021-10-12T05:49:48.544Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button1 default 
[task 2021-10-12T05:49:48.545Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking button2 default 
[task 2021-10-12T05:49:48.545Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Checking focused element 
[task 2021-10-12T05:49:48.546Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected empty user - "" == "" 
[task 2021-10-12T05:49:48.546Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | checking expected empty pass - "" == "" 
[task 2021-10-12T05:49:48.546Z] 05:49:48     INFO - TEST-PASS | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | should be logged out 
[task 2021-10-12T05:49:48.547Z] 05:49:48     INFO - Buffered messages finished
[task 2021-10-12T05:49:48.547Z] 05:49:48     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | Test timed out. - 
[task 2021-10-12T05:49:49.519Z] 05:49:49     INFO - GECKO(3338) | MP change from omgsecret! to
[task 2021-10-12T05:49:49.523Z] 05:49:49     INFO - GECKO(3338) | MEMORY STAT | vsize 6584MB | residentFast 95MB | heapAllocated 12MB
[task 2021-10-12T05:49:49.546Z] 05:49:49     INFO - TEST-OK | toolkit/components/passwordmgr/test/mochitest/test_master_password.html | took 316504ms
[task 2021-10-12T05:49:52.822Z] 05:49:52     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2021-10-12T05:49:52.832Z] 05:49:52     INFO - TEST-START | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html
[task 2021-10-12T05:49:56.042Z] 05:49:56     INFO - GECKO(3338) | JavaScript error: resource://specialpowers/SpecialPowersParent.jsm, line 26: Error: Error while executing chrome script 'https://example.com/tests/toolkit/components/passwordmgr/test/mochitest/parent_utils.js':
[task 2021-10-12T05:49:56.042Z] 05:49:56     INFO - GECKO(3338) | TypeError: can't access property "addEventListener", gAutocompletePopup is null
[task 2021-10-12T05:49:56.043Z] 05:49:56     INFO - GECKO(3338) | https://example.com/tests/toolkit/components/passwordmgr/test/mochitest/parent_utils.js:182
[task 2021-10-12T05:49:56.045Z] 05:49:56     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-10-12T05:49:56.045Z] 05:49:56     INFO - Buffered messages logged at 05:49:56
[task 2021-10-12T05:49:56.045Z] 05:49:56     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2021-10-12T05:49:56.046Z] 05:49:56     INFO - Buffered messages finished
[task 2021-10-12T05:49:56.047Z] 05:49:56     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | Got autocomplete popup - null == true - got null, expected true (operator ==)
[task 2021-10-12T05:49:56.047Z] 05:49:56     INFO - @https://example.com/tests/toolkit/components/passwordmgr/test/mochitest/parent_utils.js:19:8
[task 2021-10-12T05:49:56.047Z] 05:49:56     INFO - receiveMessage@resource://specialpowers/SpecialPowersParent.jsm:1009:16
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - openWindowPrompt@resource://gre/modules/Prompter.jsm:1226:17
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - openPrompt@resource://gre/modules/Prompter.jsm:1067:12
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - openPromptSync@resource://gre/modules/Prompter.jsm:1046:10
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - nsIPrompt_promptPassword@resource://gre/modules/Prompter.jsm:1567:10
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - promptPassword@resource://gre/modules/Prompter.jsm:1307:44
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - decrypt@resource://gre/modules/crypto-SDR.js:181:38
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - _decryptLogins@resource://gre/modules/storage-json.js:846:39
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - searchLogins@resource://gre/modules/storage-json.js:488:19
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - searchLoginsAsync@resource://gre/modules/storage-json.js:441:23
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - searchLoginsAsync@resource://gre/modules/LoginManager.jsm:513:26
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - searchAndDedupeLogins@resource://gre/modules/LoginManagerParent.jsm:230:38
[task 2021-10-12T05:49:56.048Z] 05:49:56     INFO - sendLoginDataToChild@resource://gre/modules/LoginManagerParent.jsm:572:41
[task 2021-10-12T05:49:56.052Z] 05:49:56     INFO - add_task | Entering test setup
[task 2021-10-12T05:49:56.052Z] 05:49:56     INFO - Waiting for setup and page and window loads
[task 2021-10-12T05:55:19.459Z] 05:55:19     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-10-12T05:55:19.460Z] 05:55:19     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | Test timed out. - 
[task 2021-10-12T05:55:49.579Z] 05:55:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-10-12T05:55:49.579Z] 05:55:49     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | Test timed out. - 
[task 2021-10-12T05:55:50.677Z] 05:55:50    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2021-10-12T05:55:50.679Z] 05:55:50     INFO - GECKO(3338) | MEMORY STAT | vsize 6583MB | residentFast 94MB | heapAllocated 11MB
[task 2021-10-12T05:55:50.684Z] 05:55:50     INFO - TEST-OK | toolkit/components/passwordmgr/test/mochitest/test_munged_values.html | took 357852ms
[task 2021-10-12T05:55:53.825Z] 05:55:53     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2021-10-12T05:55:53.827Z] 05:55:53     INFO - GECKO(3338) | console.warn: LoginRecipes: "getRecipes: falling back to a synchronous message for:" "https://example.com"

Dimi are there any updates here?

Flags: needinfo?(dlee)
Pushed by abutkovits@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/a0e3151ae96d
disable test_master_password.html on Mac for frequent failures. r=intermittent-reviewers,MasterWayZ DONTBUILD
Whiteboard: [stockwell disabled][stockwell needswork:owner] → [stockwell disabled]

If the reference of the timer is released, the timer event won't be fired.

Pushed by dlee@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/113a3076aa17
Do not use a local variable to keep the reference of the timer. r=sfoster
Flags: needinfo?(dlee)

Backed out for causing mochitest failures on test_master_password.html

Flags: needinfo?(dlee)

okay, the failure was due to test_master_password.htmldoesn't work when fission xorigin is on, which should be fixed in Bug 1716412.

Flags: needinfo?(dlee)
Pushed by dlee@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/7abb5b788b2a
Do not use a local variable to keep the reference of the timer. r=sfoster

Not sure if this is a different timeout issue or the patch doesn't address the problem. I'll look into it.

Flags: needinfo?(dlee)

(In reply to Dimi Lee [:dimi] from comment #235)

Not sure if this is a different timeout issue or the patch doesn't address the problem. I'll look into it.

okay, this looks like a different timeout issue than the issue solved in the patch in Comment 233. I don't have time to dig into this right now, so I'll just keep the testcase only enabled in mac as it is before my patch.

Pushed by dlee@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/a2bced86a734
Do not use a local variable to keep the reference of the timer. r=sfoster
Assignee: dlee → nobody
Severity: normal → S3
You need to log in before you can comment on or make changes to this bug.