Closed
Bug 1227909
Opened 9 years ago
Closed 1 year ago
Intermittent test_ocsp_caching.js,test_ocsp_stapling_expired.js | xpcshell return code: 0 | should have made 8 OCSP requests - 7 == 8
Categories
(Core :: Security: PSM, defect, P3)
Core
Security: PSM
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: nigelb, Unassigned)
References
()
Details
(Keywords: intermittent-failure, Whiteboard: [psm-intermittent])
https://treeherder.mozilla.org/logviewer.html#?job_id=5902416&repo=fx-team 02:40:09 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_stapling_with_intermediate.js | took 59603ms 02:40:12 INFO - TEST-START | security/manager/ssl/tests/unit/test_ocsp_caching.js 02:42:04 WARNING - TEST-UNEXPECTED-FAIL | security/manager/ssl/tests/unit/test_ocsp_caching.js | xpcshell return code: 0 02:42:04 INFO - TEST-INFO took 112158ms 02:42:04 INFO - >>>>>>> 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | xpcw: cd /data/local/tests/xpcshell/security/manager/ssl/tests/unit 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | xpcw: xpcshell -r /data/local/tests/xpcshell/c/httpd.manifest -m -s -e const _HEAD_JS_PATH = "/data/local/tests/xpcshell/head.js"; -e const _MOZINFO_JS_PATH = "/data/local/tests/xpcshell/p/mozinfo.json"; -e const _TESTING_MODULES_DIR = "/data/local/tests/xpcshell/m"; -f /data/local/tests/xpcshell/head.js -e const _SERVER_ADDR = "localhost" -e const _HEAD_FILES = ["/data/local/tests/xpcshell/security/manager/ssl/tests/unit/head_psm.js"]; -e const _TAIL_FILES = []; -e const _JSDEBUGGER_PORT = 0; -e const _TEST_FILE = ["test_ocsp_caching.js"]; -e const _TEST_NAME = "security/manager/ssl/tests/unit/test_ocsp_caching.js" -e _execute_test(); quit(0); 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/xpcom/base/nsTraceRefcnt.cpp, line 167 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file /builds/slave/b2g_fx-team_emu-d_dep-00000000/build/gecko/toolkit/crashreporter/nsExceptionHandler.cpp, line 2339 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | ***************************************************************** 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | *** 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | *** This is stdout. Most of the useful output will be in logcat. 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | *** 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | ***************************************************************** 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: NS_ENSURE_TRUE(lowMemFd != -1) failed: file ../../../gecko/widget/gonk/GonkMemoryPressureMonitoring.cpp, line 130 02:42:04 INFO - (xpcshell/head.js) | test MAIN run_test pending (1) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 0 pending (2) 02:42:04 INFO - (xpcshell/head.js) | test MAIN run_test finished (2) 02:42:04 INFO - running event loop 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | [3704] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file ../../../../gecko/security/manager/ssl/nsNSSCertificateDB.cpp, line 1587 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - Binary util OCSPStaplingServer should exist - true == true 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - certificate folder (ocsp_certs) should exist - true == true 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 0 finished (2) 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | sending 'GET / HTTP/1.0 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | ' 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test finished (2) 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | HTTP/1.0 200 OK 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | content-type: text/plain 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | connection: close 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | server: httpd.js 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | date: Wed, 25 Nov 2015 10:41:00 GMT 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | content-length: 3 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 1 pending (2) 02:42:04 INFO - (xpcshell/head.js) | test finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 2 pending (3) 02:42:04 INFO - (xpcshell/head.js) | test finished (3) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 1 finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 2 finished (2) 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-none.example.com' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-none.example.com' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | read '0x30' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | sending '0' 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - Should have received ASCII '0' from server - "0" == "0" 02:42:04 INFO - "handling ocsp-stapling-none.example.com" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - Actual and expected connection result should match - 0 == 0 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - should have made 0 OCSP requests - 0 == 0 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 3 pending (2) 02:42:04 INFO - (xpcshell/head.js) | test finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 4 pending (3) 02:42:04 INFO - (xpcshell/head.js) | test finished (3) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 3 finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 4 finished (2) 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-none.example.com' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-none.example.com' 02:42:04 INFO - "gFetchCount: 0" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | read '0x30' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | sending '0' 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - Should have received ASCII '0' from server - "0" == "0" 02:42:04 INFO - "handling ocsp-stapling-none.example.com" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - Actual and expected connection result should match - 0 == 0 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - should have made 1 OCSP request - 1 == 1 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 5 pending (2) 02:42:04 INFO - (xpcshell/head.js) | test finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 6 pending (3) 02:42:04 INFO - (xpcshell/head.js) | test finished (3) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 5 finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 7 pending (3) 02:42:04 INFO - (xpcshell/head.js) | test finished (3) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 6 finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 7 finished (2) 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-unknown.example.com' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-unknown.example.com' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | PR_Recv failed: SSL_ERROR_BAD_CERT_ALERT 02:42:04 INFO - "handling ocsp-stapling-unknown.example.com" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - Actual and expected connection result should match - 2153389954 == 2153389954 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - should have made 0 OCSP requests - 0 == 0 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 8 pending (2) 02:42:04 INFO - (xpcshell/head.js) | test finished (2) 02:42:04 INFO - security/manager/ssl/tests/unit/test_ocsp_caching.js | Starting 02:42:04 INFO - (xpcshell/head.js) | test pending (2) 02:42:04 INFO - (xpcshell/head.js) | test run_next_test 8 finished (2) 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-none.example.com' 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | found pre-defined host 'ocsp-stapling-none.example.com' 02:42:04 INFO - "gFetchCount: 0" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - "gFetchCount: 1" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - "gFetchCount: 2" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - "gFetchCount: 3" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - "gFetchCount: 4" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - "gFetchCount: 5" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - PROCESS | security/manager/ssl/tests/unit/test_ocsp_caching.js | PR_Recv failed: SSL_ERROR_BAD_CERT_ALERT 02:42:04 INFO - "gFetchCount: 6" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - "handling ocsp-stapling-none.example.com" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - Actual and expected connection result should match - 2153389954 == 2153389954 02:42:04 WARNING - TEST-UNEXPECTED-FAIL | security/manager/ssl/tests/unit/test_ocsp_caching.js | - should have made 8 OCSP requests - 7 == 8 02:42:04 INFO - test_ocsp_caching.js:add_ocsp_test/<:55 02:42:04 INFO - /data/local/tests/xpcshell/security/manager/ssl/tests/unit/head_psm.js:add_connection_test/</<:399 02:42:04 INFO - resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:Handler.prototype.process:934 02:42:04 INFO - resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:this.PromiseWalker.walkerLoop:813 02:42:04 INFO - resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:this.PromiseWalker.scheduleWalkerLoop/<:747 02:42:04 INFO - /data/local/tests/xpcshell/head.js:_do_main:208 02:42:04 INFO - /data/local/tests/xpcshell/head.js:_execute_test:520 02:42:04 INFO - -e:null:1 02:42:04 INFO - exiting test 02:42:04 INFO - "gFetchCount: 7" 02:42:04 INFO - TEST-PASS | security/manager/ssl/tests/unit/test_ocsp_caching.js | - "undefined" != "function respondWithError(request, response) {\\n\\"use strict\\";\\n\\n do_print(\\"returning 500 Internal Server Error\\");\\n resp 02:42:04 INFO - "returning 500 Internal Server Error" 02:42:04 INFO - A promise chain failed to handle a rejection: 2147500036 - rejection date: Wed Nov 25 2015 10:41:46 GMT+0000 (UTC) 02:42:04 INFO - JS frame :: resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js :: PendingErrors.register :: line 191 02:42:04 INFO - JS frame :: resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js :: this.PromiseWalker.completePromise :: line 715 02:42:04 INFO - JS frame :: resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js :: Handler.prototype.process :: line 970 02:42:04 INFO - JS frame :: resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js :: this.PromiseWalker.walkerLoop :: line 813 02:42:04 INFO - JS frame :: resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js :: this.PromiseWalker.scheduleWalkerLoop/< :: line 747 02:42:04 INFO - JS frame :: /data/local/tests/xpcshell/head.js :: _do_main :: line 208 02:42:04 INFO - JS frame :: /data/local/tests/xpcshell/head.js :: _execute_test :: line 520 02:42:04 INFO - JS frame :: -e :: <TOP_LEVEL> :: line 1
| Comment hidden (Intermittent Failures Robot) |
|
||
Updated•9 years ago
|
Summary: Intermittent test_ocsp_caching.js | xpcshell return code: 0 | should have made 8 OCSP requests - 7 == 8 → Intermittent test_ocsp_caching.js,test_ocsp_stapling_expired.js | xpcshell return code: 0 | should have made 8 OCSP requests - 7 == 8
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Mass whiteboard change to annotate PSM intermittent test failures as [psm-intermittent]. Filter on 31b932bd-1aad-4e29-9f4b-4cd864a3ffdc if that's important to you.
Whiteboard: [psm-intermittent]
|
||
Comment 12•8 years ago
|
||
Bulk assigning P3 to all open intermittent bugs without a priority set in Firefox components per bug 1298978.
Priority: -- → P3
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Updated•2 years ago
|
Severity: normal → S3
|
||
Comment 29•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•