900812 - Intermittent test_provider_appinfo.js | test failed (with xpcshell return code: 0) | 1 == 3

Status: RESOLVED WORKSFORME

(Firefox Health Report Graveyard :: Client: Desktop, defect)

Description

[Ryan VanderMeulen [:RyanVM]]

https://tbpl.mozilla.org/php/getParsedLog.php?id=26045084&tree=Mozilla-Inbound

Ubuntu VM 12.04 mozilla-inbound debug test xpcshell on 2013-08-01 16:39:39 PDT for push 6d6e336d0376
slave: tst-linux32-ec2-303

16:59:52     INFO -  TEST-INFO | /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js | running test ...
17:00:00  WARNING -  TEST-UNEXPECTED-FAIL | /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js | test failed (with xpcshell return code: 0), see following log:
17:00:00     INFO -  >>>>>>>

yadda yadda yadda...

17:00:08     INFO -  TEST-PASS | /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js | [test_healthreporter_integration : 266] 3 == 3
17:00:08     INFO -  TEST-PASS | /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js | [test_healthreporter_integration : 267] true == true
17:00:08     INFO -  TEST-PASS | /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js | [test_healthreporter_integration : 268] true == true
17:00:08     INFO -  TEST-PASS | /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js | [test_healthreporter_integration : 269] true == true
17:00:08  WARNING -  TEST-UNEXPECTED-FAIL | /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js | 1 == 3 - See following stack:
17:00:08     INFO -  JS frame :: /builds/slave/test/build/tests/xpcshell/tests/services/healthreport/tests/xpcshell/test_provider_appinfo.js :: test_healthreporter_integration :: line 266
17:00:08     INFO -  JS frame :: resource://gre/modules/Task.jsm :: TaskImpl_run :: line 192
17:00:08     INFO -  JS frame :: resource://gre/modules/Promise.jsm :: <TOP_LEVEL> :: line 554
17:00:08     INFO -  JS frame :: resource://gre/modules/Promise.jsm :: <TOP_LEVEL> :: line 336
17:00:08     INFO -  native frame :: <unknown filename> :: <TOP_LEVEL> :: line 0
17:00:08     INFO -  TEST-INFO | (xpcshell/head.js) | exiting test
17:00:08     INFO -  Services.HealthReport.HealthReporter	INFO	Request to shut down.
17:00:08     INFO -  Services.HealthReport.HealthReporter	WARN	Initiating main shutdown procedure.
17:00:08     INFO -  Services.HealthReport.HealthReporter	INFO	Shutting down provider manager.
17:00:08     INFO -  Services.HealthReport.HealthReporter	INFO	Provider manager shut down.
17:00:08     INFO -  Services.HealthReport.HealthReporter	INFO	Shutting down storage.
17:00:08     INFO -  Sqlite.Connection.healthreporter_integration	TRACE	Conn #0: Stmt #180 SELECT 1
17:00:08     INFO -  Sqlite.Connection.healthreporter_integration	DEBUG	Conn #0: Stmt #180 finished.
17:00:08     INFO -  Sqlite.Connection.healthreporter_integration	DEBUG	Conn #0: Request to close connection.
17:00:08     INFO -  Sqlite.Connection.healthreporter_integration	DEBUG	Conn #0: Finalizing connection.
17:00:08     INFO -  Sqlite.Connection.healthreporter_integration	DEBUG	Conn #0: Calling asyncClose().
17:00:08     INFO -  Sqlite.Connection.healthreporter_integration	INFO	Conn #0: Closed
17:00:08     INFO -  Services.HealthReport.HealthReporter	INFO	Storage has been closed.
17:00:08     INFO -  Services.HealthReport.HealthReporter	WARN	Shutdown complete.
17:00:08  WARNING -  TEST-UNEXPECTED-FAIL | resource://gre/modules/commonjs/sdk/core/promise.js | Unexpected exception 2147500036, see following stack:
17:00:08     INFO -  undefined
17:00:08     INFO -  TEST-INFO | (xpcshell/head.js) | exiting test
17:00:08     INFO -  WARNING: nsExceptionService ignoring thread destruction after shutdown: file ../../../xpcom/base/nsExceptionService.cpp, line 168
17:00:08     INFO -  WARNING: NS_ENSURE_TRUE(compMgr) failed: file nsComponentManagerUtils.cpp, line 58
17:00:08     INFO -  WARNING: OOPDeinit() without successful OOPInit(): file ../../../toolkit/crashreporter/nsExceptionHandler.cpp, line 2304
17:00:08     INFO -  nsStringStats
17:00:08     INFO -   => mAllocCount:          10189
17:00:08     INFO -   => mReallocCount:          306
17:00:08     INFO -   => mFreeCount:           10189
17:00:08     INFO -   => mShareCount:          12052
17:00:08     INFO -   => mAdoptCount:            402
17:00:08     INFO -   => mAdoptFreeCount:        402
17:00:08     INFO -  <<<<<<<

Comment 1

[Gregory Szorc [:gps]]

This bug will occur if the test runs across a UTC day boundary. We currently iterate of the days in the payload. We should adjust the clock before collecting measurements to ensure there is enough time before the next UTC day and we should verify there is only 1 day in the payload.

This should be simple to fix. But, I doubt we'll see this very often, so low priority.

Comment 2

[Ed Morley [:emorley]]

Intermittent failure not seen for >3 months; filter on mass-intermittent-wfm-20140812.