1555392 - High Frequency security/manager/ssl/tests/unit/test_cert_storage.js | - A promise chain failed to handle a rejection: Unable to arm timer, the object has been finalized. - stack: arm@resource://gre/modules/DeferredTask.jsm:188:13

Status: RESOLVED FIXED

(Core :: Security: PSM, defect, P1)

Description

[Treeherder Bug Filer]

Filed by: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=248953652&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/Y2JwEqgLSsenS01kLPYUKA/runs/0/artifacts/public/logs/live_backing.log

---

[task 2019-05-29T13:42:50.382Z] 13:42:50 INFO - "CONSOLE_MESSAGE: (error) [JavaScript Error: "Error: Unable to arm timer, the object has been finalized." {file: "resource://gre/modules/DeferredTask.jsm" line: 188}]"
[task 2019-05-29T13:42:50.382Z] 13:42:50 WARNING - TEST-UNEXPECTED-FAIL | security/manager/ssl/tests/unit/test_cert_storage.js | - A promise chain failed to handle a rejection: Unable to arm timer, the object has been finalized. - stack: arm@resource://gre/modules/DeferredTask.jsm:188:13
[task 2019-05-29T13:42:50.382Z] 13:42:50 INFO - save@resource://gre/modules/ExtensionParent.jsm:1768:27
[task 2019-05-29T13:42:50.382Z] 13:42:50 INFO - get@resource://gre/modules/ExtensionParent.jsm:1864:20
[task 2019-05-29T13:42:50.382Z] 13:42:50 INFO - observe@resource://gre/modules/AsyncShutdown.jsm:532:16
[task 2019-05-29T13:42:50.382Z] 13:42:50 INFO - _execute_test@/sdcard/tests/xpc/head.js:613:19
[task 2019-05-29T13:42:50.382Z] 13:42:50 INFO - @-e:1:1
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - Rejection date: Wed May 29 2019 14:42:49 GMT+0100 (British Summer Time) - false == true
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:257
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - /sdcard/tests/xpc/head.js:_execute_test:621
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - -e:null:1
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - exiting test
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | JavaScript error: /sdcard/tests/xpc/head.js, line 742: NS_ERROR_ABORT:
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | 1559137370090 addons.xpi-utils WARN Synchronous load of XPI database due to getAddonsByType([theme]) Stack: getAddonsByType@resource://gre/modules/addons/XPIDatabase.jsm:1771:29
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | installBuiltinAddon@resource://gre/modules/addons/XPIInstall.jsm:3774:25
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | observe@resource://gre/modules/AsyncShutdown.jsm:532:16
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | JavaScript error: resource://gre/modules/AddonManager.jsm, line 1370: NS_ERROR_NOT_INITIALIZED: AddonManager is not initialized
[task 2019-05-29T13:42:50.383Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | [3426, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/workspace/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 3055
[task 2019-05-29T13:42:50.384Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | [3426, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-29T13:42:50.384Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | [3426, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-29T13:42:50.384Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | [3426, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-29T13:42:50.384Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | [3426, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 194
[task 2019-05-29T13:42:50.384Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | nsStringStats
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | => mAllocCount: 14873
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | => mReallocCount: 0
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | => mFreeCount: 14873
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | => mShareCount: 14181
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | => mAdoptCount: 377
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | => mAdoptFreeCount: 381
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - security/manager/ssl/tests/unit/test_cert_storage.js | => Process ID: 3426, Thread ID: 133097710541632
[task 2019-05-29T13:42:50.385Z] 13:42:50 INFO - <<<<<<<

Comment 1

[Intermittent Failures Robot]

1 failures in 4337 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• android-em-7-0-x86_64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1555392&startday=2019-05-27&endday=2019-06-02&tree=all

Comment 2

[Natalia Csoregi [:nataliaCs]]

It seems that the frequency has been increased once Bug 1555854 has landed.
Dana, is there any chance you could take a look at this? Should we disable this test for now?
Thank you.

Comment 3

[Dana Keeler (she/her) (use needinfo) [:keeler] (on leave)]

Nothing's immediately jumping out at me as to what's wrong, but I'm looking into it.

Comment 4

[Intermittent Failures Robot]

50 failures in 930 pushes (0.054 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 37
• mozilla-central: 4
• mozilla-inbound: 7
• try: 2

Platform breakdown:

• android-em-7-0-x86_64: 50

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1555392&startday=2019-06-04&endday=2019-06-04&tree=all

Comment 5

[Dana Keeler (she/her) (use needinfo) [:keeler] (on leave)]

Attachment: bug 1555392 - remove unnecessary things from test_cert_storage.js that were causing intermittent failures r?KevinJacobs

At some point in the past, test_cert_storage.js needed to initialize the add-on
system to start the blocklist system, which is where revocation updates used to
come from. This appears to no longer be the case and the code in question can be
removed (and it should be removed because it's causing intermittent failures).

Comment 6

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/b207dd14a93c
remove unnecessary things from test_cert_storage.js that were causing intermittent failures r=KevinJacobs

Comment 7

[Intermittent Failures Robot]

21 failures in 1101 pushes (0.019 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-inbound: 7
• autoland: 11
• mozilla-central: 3

Platform breakdown:

• android-em-7-0-x86_64: 21

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1555392&startday=2019-06-06&endday=2019-06-06&tree=all

Comment 8

[Daniel Varga [:dvarga]]

https://hg.mozilla.org/mozilla-central/rev/b207dd14a93c

Comment 10

[Intermittent Failures Robot]

86 failures in 5197 pushes (0.017 failures/push) were associated with this bug in the last 7 days.

This is the #15 most frequent failure this week.

** This failure happened more than 75 times this week! Resolving this bug is a very high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 1 week, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 59
• mozilla-central: 9
• mozilla-inbound: 15
• try: 3

Platform breakdown:

• android-em-7-0-x86_64: 86

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1555392&startday=2019-06-03&endday=2019-06-09&tree=all