Open Bug 1815477 Opened 2 years ago Updated 1 year ago

Intermittent dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | single tracking bug

Categories

(Core :: DOM: Credential Management, defect, P5)

defect

Tracking

()

REOPENED

People

(Reporter: intermittent-bug-filer, Assigned: bvandersloot)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, intermittent-testcase, leave-open, Whiteboard: [retriggered][stockwell unknown])

Attachments

(1 file)

Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=404882617&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Y3XQp-fIRQ-hyUX81d7DuA/runs/0/artifacts/public/logs/live_backing.log


[task 2023-02-07T14:12:14.647Z] 14:12:14     INFO - TEST-PASS | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | Must set the right test name when setting up. Test name "accounts_error" must be in URL path "/tests/dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html" 
[task 2023-02-07T14:12:14.647Z] 14:12:14     INFO - must wait for load
[task 2023-02-07T14:12:14.648Z] 14:12:14     INFO - must wait for focus
[task 2023-02-07T14:12:14.648Z] 14:12:14     INFO - Buffered messages finished
[task 2023-02-07T14:12:14.648Z] 14:12:14     INFO - TEST-UNEXPECTED-FAIL | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | Test timed out. - 
[task 2023-02-07T14:12:15.695Z] 14:12:15     INFO - GECKO(1377) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2023-02-07T14:12:15.695Z] 14:12:15     INFO - GECKO(1377) | MEMORY STAT | vsize 6655MB | residentFast 85MB | heapAllocated 7MB
[task 2023-02-07T14:12:15.707Z] 14:12:15     INFO - TEST-OK | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | took 302023ms
[task 2023-02-07T14:12:19.036Z] 14:12:19     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2023-02-07T14:12:19.078Z] 14:12:19     INFO - TEST-START | dom/credentialmanagement/identity/tests/mochitest/test_accounts_redirect.html
[task 2023-02-07T14:12:22.607Z] 14:12:22     INFO - GECKO(1377) | [Parent 1377, Main Thread] WARNING: WebProgress Ignored: BrowsingContext is null or discarded: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3001
[task 2023-02-07T14:12:22.612Z] 14:12:22     INFO - GECKO(1377) | [Child 1388, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:826
[task 2023-02-07T14:12:22.613Z] 14:12:22     INFO - GECKO(1377) | [Parent 1377, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-02-07T14:12:22.613Z] 14:12:22     INFO - GECKO(1377) | [Parent 1377, Compositor] WARNING: IPC Connection Error: [Parent][PImageBridgeParent] RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-02-07T14:12:22.643Z] 14:12:22     INFO - GECKO(1377) | [Child 1388, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2023-02-07T14:12:22.644Z] 14:12:22     INFO - GECKO(1377) | [Child 1388, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-02-07T14:12:22.649Z] 14:12:22     INFO - GECKO(1377) | [Child 1388, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2023-02-07T14:12:23.675Z] 14:12:23     INFO - GECKO(1377) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/3g/b2pt77dn3c3f23bvvc446v04000014/T/tmp696op31g.mozrunner/runtests_leaks_tab_pid1576.log
[task 2023-02-07T14:12:23.675Z] 14:12:23     INFO - GECKO(1377) | [1576, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:345
[task 2023-02-07T14:12:23.710Z] 14:12:23     INFO - GECKO(1377) | [Child 1576, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:12:23.729Z] 14:12:23     INFO - GECKO(1377) | [Child 1576, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:12:23.729Z] 14:12:23     INFO - GECKO(1377) | [Child 1576, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:12:23.763Z] 14:12:23     INFO - GECKO(1377) | [Child 1576, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:13:40.025Z] 14:13:40     INFO - GECKO(1377) | [WARN  rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2023-02-07T14:13:40.032Z] 14:13:40     INFO - GECKO(1377) | console.error: (new Error("Polling for changes failed: Unexpected content-type \"text/plain;charset=US-ASCII\".", "resource://services-settings/remote-settings.js", 334))
[task 2023-02-07T14:15:40.138Z] 14:15:40     INFO - GECKO(1377) | 1675779340137	addons.xpi	ERROR	System addon update list error Error: got node name: html, expected: updates
[task 2023-02-07T14:17:45.283Z] 14:17:45     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-02-07T14:17:45.284Z] 14:17:45     INFO - Buffered messages logged at 14:12:22
[task 2023-02-07T14:17:45.284Z] 14:17:45     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2023-02-07T14:17:45.285Z] 14:17:45     INFO - TEST-PASS | dom/credentialmanagement/identity/tests/mochitest/test_accounts_redirect.html | Must set the right test name when setting up. Test name "accounts_redirect" must be in URL path "/tests/dom/credentialmanagement/identity/tests/mochitest/test_accounts_redirect.html" 
[task 2023-02-07T14:17:45.285Z] 14:17:45     INFO - must wait for load
[task 2023-02-07T14:17:45.285Z] 14:17:45     INFO - must wait for focus
[task 2023-02-07T14:17:45.286Z] 14:17:45     INFO - Buffered messages finished
[task 2023-02-07T14:17:45.286Z] 14:17:45     INFO - TEST-UNEXPECTED-FAIL | dom/credentialmanagement/identity/tests/mochitest/test_accounts_redirect.html | Test timed out. - 
[task 2023-02-07T14:17:46.344Z] 14:17:46     INFO - GECKO(1377) | MEMORY STAT | vsize 6655MB | residentFast 86MB | heapAllocated 7MB
[task 2023-02-07T14:17:46.355Z] 14:17:46     INFO - TEST-OK | dom/credentialmanagement/identity/tests/mochitest/test_accounts_redirect.html | took 327276ms
[task 2023-02-07T14:17:49.465Z] 14:17:49     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2023-02-07T14:17:49.490Z] 14:17:49     INFO - TEST-START | dom/credentialmanagement/identity/tests/mochitest/test_delay_reject.html
[task 2023-02-07T14:17:52.911Z] 14:17:52     INFO - GECKO(1377) | MEMORY STAT | vsize 6655MB | residentFast 86MB | heapAllocated 8MB
[task 2023-02-07T14:17:52.924Z] 14:17:52     INFO - TEST-OK | dom/credentialmanagement/identity/tests/mochitest/test_delay_reject.html | took 3434ms
[task 2023-02-07T14:17:52.991Z] 14:17:52     INFO - GECKO(1377) | [Parent 1377, Main Thread] WARNING: WebProgress Ignored: BrowsingContext is null or discarded: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3001
[task 2023-02-07T14:17:52.996Z] 14:17:52     INFO - GECKO(1377) | [Parent 1377, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-02-07T14:17:52.996Z] 14:17:52     INFO - GECKO(1377) | [Child 1389, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:826
[task 2023-02-07T14:17:52.997Z] 14:17:52     INFO - GECKO(1377) | [Parent 1377, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-02-07T14:17:53.027Z] 14:17:53     INFO - GECKO(1377) | [Child 1389, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2023-02-07T14:17:53.028Z] 14:17:53     INFO - GECKO(1377) | [Child 1389, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-02-07T14:17:53.033Z] 14:17:53     INFO - GECKO(1377) | [Child 1389, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2023-02-07T14:17:54.025Z] 14:17:54     INFO - GECKO(1377) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/3g/b2pt77dn3c3f23bvvc446v04000014/T/tmp696op31g.mozrunner/runtests_leaks_tab_pid1752.log
[task 2023-02-07T14:17:54.025Z] 14:17:54     INFO - GECKO(1377) | [1752, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:345
[task 2023-02-07T14:17:54.059Z] 14:17:54     INFO - GECKO(1377) | [Child 1752, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:17:54.078Z] 14:17:54     INFO - GECKO(1377) | [Child 1752, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:17:54.078Z] 14:17:54     INFO - GECKO(1377) | [Child 1752, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:17:54.112Z] 14:17:54     INFO - GECKO(1377) | [Child 1752, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:17:56.226Z] 14:17:56     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2023-02-07T14:17:56.254Z] 14:17:56     INFO - TEST-START | dom/credentialmanagement/identity/tests/mochitest/test_empty_provider_list.html
[task 2023-02-07T14:17:59.918Z] 14:17:59     INFO - GECKO(1377) | [Parent 1377, Main Thread] WARNING: WebProgress Ignored: BrowsingContext is null or discarded: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3001
[task 2023-02-07T14:17:59.923Z] 14:17:59     INFO - GECKO(1377) | [Child 1390, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:826
[task 2023-02-07T14:17:59.923Z] 14:17:59     INFO - GECKO(1377) | [Parent 1377, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-02-07T14:17:59.924Z] 14:17:59     INFO - GECKO(1377) | [Parent 1377, Compositor] WARNING: IPC Connection Error: [Parent][PImageBridgeParent] RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-02-07T14:17:59.953Z] 14:17:59     INFO - GECKO(1377) | [Child 1390, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3384
[task 2023-02-07T14:17:59.955Z] 14:17:59     INFO - GECKO(1377) | [Child 1390, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-02-07T14:17:59.960Z] 14:17:59     INFO - GECKO(1377) | [Child 1390, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4663
[task 2023-02-07T14:18:00.993Z] 14:18:00     INFO - GECKO(1377) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/3g/b2pt77dn3c3f23bvvc446v04000014/T/tmp696op31g.mozrunner/runtests_leaks_tab_pid1763.log
[task 2023-02-07T14:18:00.994Z] 14:18:00     INFO - GECKO(1377) | [1763, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:345
[task 2023-02-07T14:18:01.028Z] 14:18:01     INFO - GECKO(1377) | [Child 1763, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:18:01.046Z] 14:18:01     INFO - GECKO(1377) | [Child 1763, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:18:01.047Z] 14:18:01     INFO - GECKO(1377) | [Child 1763, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:18:01.081Z] 14:18:01     INFO - GECKO(1377) | [Child 1763, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:478
[task 2023-02-07T14:18:14.875Z] 14:18:14     INFO - GECKO(1377) | [Child 1385, Main Thread] WARNING: IPC message 'PSessionStore::Msg_SessionStoreUpdate' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:504
[task 2023-02-07T14:23:16.145Z] 14:23:16     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-02-07T14:23:16.145Z] 14:23:16     INFO - Buffered messages logged at 14:17:59
[task 2023-02-07T14:23:16.146Z] 14:23:16     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2023-02-07T14:23:16.146Z] 14:23:16     INFO - TEST-PASS | dom/credentialmanagement/identity/tests/mochitest/test_empty_provider_list.html | Must set the right test name when setting up. Test name "empty_provider_list" must be in URL path "/tests/dom/credentialmanagement/identity/tests/mochitest/test_empty_provider_list.html" 
[task 2023-02-07T14:23:16.147Z] 14:23:16     INFO - must wait for load
[task 2023-02-07T14:23:16.147Z] 14:23:16     INFO - must wait for focus
[task 2023-02-07T14:23:16.147Z] 14:23:16     INFO - Buffered messages finished
[task 2023-02-07T14:23:16.148Z] 14:23:16     INFO - TEST-UNEXPECTED-FAIL | dom/credentialmanagement/identity/tests/mochitest/test_empty_provider_list.html | Test timed out. - 
[task 2023-02-07T14:23:17.165Z] 14:23:17     INFO - GECKO(1377) | MEMORY STAT | vsize 6656MB | residentFast 86MB | heapAllocated 7MB
[task 2023-02-07T14:23:17.175Z] 14:23:17     INFO - TEST-OK | dom/credentialmanagement/identity/tests/mochitest/test_empty_provider_list.html | took 320921ms
[task 2023-02-07T14:23:20.394Z] 14:23:20     INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2023-02-07T14:23:20.419Z] 14:23:20     INFO - TEST-START | dom/credentialmanagement/identity/tests/mochitest/test_get_without_providers.html

First occurrence so far: retriggers and backfills range

Whiteboard: [retriggered]
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

There have been 33 total failures in the last 7 days and all of them on Linux 18.04 x64 WebRender debug and all of them with Test timed out as failure line that was classified with this bug.

Recent failure log.

[task 2023-04-27T14:40:37.760Z] 14:40:37     INFO - TEST-PASS | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | Must set the right test name when setting up. Test name "accounts_error" must be in URL path "/tests/dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html" 
[task 2023-04-27T14:40:37.761Z] 14:40:37     INFO - must wait for load
[task 2023-04-27T14:40:37.761Z] 14:40:37     INFO - must wait for focus
[task 2023-04-27T14:40:37.762Z] 14:40:37     INFO - Buffered messages finished
[task 2023-04-27T14:40:37.762Z] 14:40:37     INFO - TEST-UNEXPECTED-FAIL | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | Test timed out. - 
[task 2023-04-27T14:40:38.654Z] 14:40:38     INFO - GECKO(2532) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2023-04-27T14:40:38.656Z] 14:40:38     INFO - GECKO(2532) | MEMORY STAT | vsize 2568MB | residentFast 140MB | heapAllocated 6MB
[task 2023-04-27T14:40:38.678Z] 14:40:38     INFO - TEST-OK | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | took 301040ms
[task 2023-04-27T14:40:38.704Z] 14:40:38     INFO - TEST-PASS | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | correctly got an error 
[task 2023-04-27T14:40:38.706Z] 14:40:38    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2023-04-27T14:40:38.723Z] 14:40:38     INFO - TEST-UNEXPECTED-ERROR | dom/credentialmanagement/identity/tests/mochitest/test_accounts_error.html | called finish() multiple times
[task 2023-04-27T14:40:38.723Z] 14:40:38     INFO - TEST-INFO 
[task 2023-04-27T14:40:39.978Z] 14:40:39     INFO - TEST-START | dom/credentialmanagement/identity/tests/mochitest/test_accounts_redirect.html

Hello Benjamin! As the owner of this component, could you please help us assign the bug to someone?

Thank you!

Flags: needinfo?(bvandersloot)
Whiteboard: [retriggered] → [retriggered][stockwell needswork:owner]

FWIW, the recent errors here are all on the new http3 configuration, so it could be disabled there if the failure rate is an issue.

I don't have any particular opinion about these tests, but it seems reasonable to me to disable them with http3, as they'll be running in other configurations, and bvandersloot can take a look when they have a chance.

Flags: needinfo?(continuation)
Keywords: leave-open
Pushed by imoraru@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/817f9f5d1741 disable test_accounts_error.html on http3 for frequent failures. r=intermittent-reviewers,jmaher

Taking myself- Disabled for http3 is fine for now.

Assignee: nobody → bvandersloot
Flags: needinfo?(bvandersloot)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: