Closed Bug 1471023 Opened 7 years ago Closed 6 years ago

Intermittent dom/u2f/tests/browser/browser_abort_visibility.js | Test timed out -

Categories

(Core :: DOM: Device Interfaces, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: nerli [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=184777239&repo=mozilla-central https://queue.taskcluster.net/v1/task/BRHXv35LS_-M90LZ2q5hNw/runs/0/artifacts/public/logs/live_backing.log [task 2018-06-25T20:23:26.069Z] 20:23:26 INFO - TEST-START | dom/u2f/tests/browser/browser_abort_visibility.js [task 2018-06-25T20:24:56.439Z] 20:24:56 INFO - TEST-INFO | started process screentopng [task 2018-06-25T20:24:57.298Z] 20:24:57 INFO - TEST-INFO | screentopng: exit 0 [task 2018-06-25T20:24:57.300Z] 20:24:57 INFO - Buffered messages logged at 20:23:26 [task 2018-06-25T20:24:57.301Z] 20:24:57 INFO - Entering test bound test_abort [task 2018-06-25T20:24:57.302Z] 20:24:57 INFO - Buffered messages logged at 20:23:28 [task 2018-06-25T20:24:57.304Z] 20:24:57 INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/FileUtils.jsm" line: 170}] [task 2018-06-25T20:24:57.305Z] 20:24:57 INFO - Buffered messages finished [task 2018-06-25T20:24:57.307Z] 20:24:57 INFO - TEST-UNEXPECTED-FAIL | dom/u2f/tests/browser/browser_abort_visibility.js | Test timed out - [task 2018-06-25T20:24:57.308Z] 20:24:57 INFO - GECKO(3548) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration. [task 2018-06-25T20:24:57.311Z] 20:24:57 INFO - GECKO(3548) | MEMORY STAT heapAllocated not supported in this build configuration. [task 2018-06-25T20:24:57.312Z] 20:24:57 INFO - GECKO(3548) | MEMORY STAT | vsize 20973920MB | residentFast 974MB [task 2018-06-25T20:24:57.313Z] 20:24:57 INFO - TEST-OK | dom/u2f/tests/browser/browser_abort_visibility.js | took 90399ms [task 2018-06-25T20:24:57.314Z] 20:24:57 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-25T20:24:57.315Z] 20:24:57 INFO - TEST-UNEXPECTED-FAIL | dom/u2f/tests/browser/browser_abort_visibility.js | Found a tab after previous test timed out: https://example.com/browser/dom/u2f/tests/browser/tab_u2f_result.html - [task 2018-06-25T20:24:57.317Z] 20:24:57 INFO - checking window state [task 2018-06-25T20:24:57.318Z] 20:24:57 INFO - TEST-START | dom/u2f/tests/browser/browser_appid_localhost.js [task 2018-06-25T20:24:58.893Z] 20:24:58 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-25T20:24:58.894Z] 20:24:58 INFO - Buffered messages logged at 20:24:57 [task 2018-06-25T20:24:58.896Z] 20:24:58 INFO - Entering test bound [task 2018-06-25T20:24:58.898Z] 20:24:58 INFO - Buffered messages logged at 20:24:58 [task 2018-06-25T20:24:58.899Z] 20:24:58 INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/FileUtils.jsm" line: 170}] [task 2018-06-25T20:24:58.901Z] 20:24:58 INFO - Buffered messages finished [task 2018-06-25T20:24:58.902Z] 20:24:58 INFO - TEST-UNEXPECTED-FAIL | dom/u2f/tests/browser/browser_abort_visibility.js | Uncaught exception received from previously timed out test - at chrome://mochitests/content/browser/dom/u2f/tests/browser/browser_abort_visibility.js:30 - TypeError: ContentTask is null [task 2018-06-25T20:24:58.904Z] 20:24:58 INFO - Stack trace: [task 2018-06-25T20:24:58.905Z] 20:24:58 INFO - startMakeCredentialRequest@chrome://mochitests/content/browser/dom/u2f/tests/browser/browser_abort_visibility.js:30:3 [task 2018-06-25T20:24:58.906Z] 20:24:58 INFO - test_abort@chrome://mochitests/content/browser/dom/u2f/tests/browser/browser_abort_visibility.js:78:9 [task 2018-06-25T20:24:58.911Z] 20:24:58 INFO - Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1098:34 [task 2018-06-25T20:24:58.912Z] 20:24:58 INFO - async*Tester_execTest@chrome://mochikit/content/browser-test.js:1089:16 [task 2018-06-25T20:24:58.913Z] 20:24:58 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:991:9 [task 2018-06-25T20:24:58.915Z] 20:24:58 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:795:59 [task 2018-06-25T20:24:58.956Z] 20:24:58 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | Origin is https://localhost. U2F is available. - [task 2018-06-25T20:24:58.956Z] 20:24:58 INFO - Console message: [JavaScript Warning: "Sending message that cannot be cloned. Are you trying to send an XPCOM object?" {file: "resource://testing-common/content-task.js" line: 62}] [task 2018-06-25T20:24:59.236Z] 20:24:59 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | Null AppID should work. - [task 2018-06-25T20:24:59.436Z] 20:24:59 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | Empty AppID should work. - [task 2018-06-25T20:24:59.454Z] 20:24:59 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | Incorrect scheme. - [task 2018-06-25T20:24:59.462Z] 20:24:59 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | Incorrect TLD. - [task 2018-06-25T20:24:59.472Z] 20:24:59 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | Incorrect TLD. - [task 2018-06-25T20:24:59.660Z] 20:24:59 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | https://localhost/appId should work. - [task 2018-06-25T20:24:59.857Z] 20:24:59 INFO - TEST-PASS | dom/u2f/tests/browser/browser_appid_localhost.js | https://localhost:443/appId should work. - [task 2018-06-25T20:24:59.918Z] 20:24:59 INFO - Leaving test bound [task 2018-06-25T20:25:00.000Z] 20:25:00 INFO - GECKO(3548) | MEMORY STAT | vsize 20973914MB | residentFast 1084MB [task 2018-06-25T20:25:00.002Z] 20:25:00 INFO - TEST-OK | dom/u2f/tests/browser/browser_appid_localhost.js | took 2940ms
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE

This is still happening.

Recent failure: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=227748518&repo=mozilla-release&lineNumber=36061

21:57:00 INFO - TEST-PASS | dom/webauthn/tests/browser/browser_abort_visibility.js | webauthn request pending -
21:57:00 INFO - Buffered messages logged at 21:57:00
21:57:00 INFO - aborted: AbortError: The operation was aborted.
21:57:00 INFO - visbility state: hidden
21:57:00 INFO - docshell active: false
21:57:00 INFO - visbility state: hidden
21:57:00 INFO - docshell active: false
21:57:00 INFO - TEST-PASS | dom/webauthn/tests/browser/browser_abort_visibility.js | webauthn request aborted -
21:57:00 INFO - Leaving test bound test_switch_tab
21:57:00 INFO - Entering test bound test_new_window_make
21:57:00 INFO - Attempting to create credential for origin: https://example.com
21:57:00 INFO - visbility state: visible
21:57:00 INFO - docshell active: true
21:57:00 INFO - Buffered messages finished
21:57:00 INFO - TEST-UNEXPECTED-FAIL | dom/webauthn/tests/browser/browser_abort_visibility.js | webauthn request pending - Got aborted, expected pending
21:57:00 INFO - Stack trace:
21:57:00 INFO - chrome://mochikit/content/browser-test.js:test_is:1303
21:57:00 INFO - chrome://mochitests/content/browser/dom/webauthn/tests/browser/browser_abort_visibility.js:assertStatus:15
21:57:00 INFO - GECKO(5972) | ++DOCSHELL 0000028596C87000 == 10 [pid = 5972] [id = {bc2b019c-f647-4062-a89a-5b8cc63835a8}]
21:57:00 INFO - GECKO(5972) | ++DOMWINDOW == 24 (00000285991E1400) [pid = 5972] [serial = 24] [outer = 0000000000000000]
21:57:00 INFO - GECKO(5972) | ++DOMWINDOW == 25 (000002859977A800) [pid = 5972] [serial = 25] [outer = 00000285991E1400]
21:57:00 INFO - GECKO(5972) | [Parent 5972, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x805D0021: file z:/build/build/src/modules/libjar/nsJARChannel.cpp, line 1010
21:57:00 INFO - GECKO(5972) | ++DOCSHELL 0000028595479800 == 11 [pid = 5972] [id = {2bb4f66d-f16c-449c-b1b8-497b57f386b6}]
21:57:00 INFO - GECKO(5972) | ++DOMWINDOW == 26 (00000285954BF000) [pid = 5972] [serial = 26] [outer = 0000000000000000]
21:57:00 INFO - GECKO(5972) | ++DOCSHELL 00000206879AD000 == 2 [pid = 7044] [id = {5a217f1b-bbad-45e8-926a-6c9c120ffb44}]
21:57:20 INFO - GECKO(5972) | --DOMWINDOW == 7 (000002955ABDA400) [pid = 11052] [serial = 9] [outer = 0000000000000000] [url = about:blank]
21:57:20 INFO - GECKO(5972) | --DOMWINDOW == 6 (00000295525BA800) [pid = 11052] [serial = 1] [outer = 0000000000000000] [url = about:blank]
21:57:21 INFO - GECKO(5972) | --DOMWINDOW == 2 (000002068797F400) [pid = 7044] [serial = 3] [outer = 0000000000000000] [url = https://example.com/browser/dom/webauthn/tests/browser/tab_webauthn_result.html]
21:57:24 INFO - GECKO(5972) | --DOMWINDOW == 5 (0000029559DBBC00) [pid = 11052] [serial = 4] [outer = 0000000000000000] [url = about:blank]
21:57:24 INFO - GECKO(5972) | --DOMWINDOW == 4 (0000029557E79400) [pid = 11052] [serial = 3] [outer = 0000000000000000] [url = about:blank]
21:58:28 INFO - Not taking screenshot here: see the one that was previously logged
21:58:28 INFO - TEST-UNEXPECTED-FAIL | dom/webauthn/tests/browser/browser_abort_visibility.js | Test timed out -
21:58:28 INFO - GECKO(5972) | MEMORY STAT | vsize 5913MB | vsizeMaxContiguous 131526640MB | residentFast 245MB | heapAllocated 60MB
21:58:28 INFO - TEST-OK | dom/webauthn/tests/browser/browser_abort_visibility.js | took 90098ms
21:58:28 INFO - Not taking screenshot here: see the one that was previously logged
21:58:28 INFO - TEST-UNEXPECTED-FAIL | dom/webauthn/tests/browser/browser_abort_visibility.js | Found a tab after previous test timed out: https://example.com/browser/dom/webauthn/tests/browser/tab_webauthn_result.html -
21:58:28 INFO - GECKO(5972) | ++DOCSHELL 00000164E1A4A000 == 1 [pid = 212] [id = {a7e4be13-df4e-496f-9d14-f4e13f626cc9}]
21:58:28 INFO - GECKO(5972) | ++DOMWINDOW == 1 (00000164E1AC2C00) [pid = 212] [serial = 4] [outer = 0000000000000000]
21:58:28 INFO - GECKO(5972) | ++DOMWINDOW == 2 (00000164E7189000) [pid = 212] [serial = 5] [outer = 00000164E1AC2C00]
21:58:28 INFO - checking window state
21:58:28 INFO - Not taking screenshot here: see the one that was previously logged
21:58:28 INFO - TEST-UNEXPECTED-FAIL | dom/webauthn/tests/browser/browser_abort_visibility.js | Found a browser window after previous test timed out -
21:58:28 INFO - GECKO(5972) | ++DOMWINDOW == 3 (00000164E90A9000) [pid = 212] [serial = 6] [outer = 00000164E1AC2C00]
21:58:28 INFO - GECKO(5972) | must wait for focus
21:58:28 INFO - GECKO(5972) | [Parent 5972, Main Thread] WARNING: '!mSelection', file z:/build/build/src/editor/libeditor/EditorBase.cpp, line 4826
21:58:28 INFO - GECKO(5972) | [Parent 5972, Main Thread] WARNING: '!editActionData.CanHandle()', file z:/build/build/src/editor/libeditor/EditorBase.cpp, line 1263
21:58:28 INFO - TEST-START | dom/webauthn/tests/browser/browser_fido_appid_extension.js
21:58:28 INFO - GECKO(5972) | ++DOCSHELL 00000241C933F000 == 2 [pid = 5448] [id = {dd053174-aaeb-4817-a729-e748b88d6235}]
21:58:28 INFO - GECKO(5972) | ++DOMWINDOW == 3 (00000241CEA86000) [pid = 5448] [serial = 6] [outer = 0000000000000000]
21:58:28 INFO - GECKO(5972) | ++DOMWINDOW == 4 (00000241D08A8800) [pid = 5448] [serial = 7] [outer = 00000241CEA86000]
21:58:29 INFO - GECKO(5972) | ++DOMWINDOW == 5 (00000241D0B6E800) [pid = 5448] [serial = 8] [outer = 00000241CEA86000]
21:58:29 INFO - GECKO(5972) | [Parent 5972, IPDL Background] WARNING: '!keyListHead', file z:/build/build/src/dom/webauthn/U2FSoftTokenManager.cpp, line 90
21:58:29 INFO - GECKO(5972) | [Parent 5972, IPDL Background] WARNING: '!unwrappedKey', file z:/build/build/src/dom/webauthn/U2FSoftTokenManager.cpp, line 515
21:58:29 INFO - GECKO(5972) | [Parent 5972, IPDL Background] WARNING: '!unwrappedKey', file z:/build/build/src/dom/webauthn/U2FSoftTokenManager.cpp, line 515
21:58:29 INFO - GECKO(5972) | [Parent 5972, IPDL Background] WARNING: '!unwrappedKey', file z:/build/build/src/dom/webauthn/U2FSoftTokenManager.cpp, line 515
21:58:29 INFO - GECKO(5972) | [Parent 5972, IPDL Background] WARNING: '!unwrappedKey', file z:/build/build/src/dom/webauthn/U2FSoftTokenManager.cpp, line 515
21:58:29 INFO - GECKO(5972) | MEMORY STAT | vsize 5902MB | vsizeMaxContiguous 131526630MB | residentFast 242MB | heapAllocated 64MB
21:58:29 INFO - TEST-OK | dom/webauthn/tests/browser/browser_fido_appid_extension.js | took 688ms

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 7 years ago7 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 7 years ago6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.