Closed
Bug 1732309
Opened 3 years ago
Closed 3 years ago
Intermittent SUMMARY: ThreadSanitizer: data race /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSCallbacks.cpp:716:32 in PreliminaryHandshakeDone(PRFileDesc*)
Categories
(Core :: Security: PSM, defect, P5)
Core
Security: PSM
Tracking
()
RESOLVED
DUPLICATE
of bug 1742205
People
(Reporter: intermittent-bug-filer, Unassigned)
References
(Blocks 1 open bug)
Details
(Keywords: csectype-race, intermittent-failure, sec-moderate)
Filed by: mlaza [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=352498151&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Dg9smSQHQOSJH8mNVMMvgg/runs/0/artifacts/public/logs/live_backing.log
[task 2021-09-23T11:10:17.742Z] 11:10:17 INFO - TEST-START | /fetch/metadata/serviceworker-accessors.https.sub.html
[task 2021-09-23T11:10:17.742Z] 11:10:17 INFO - Clearing pref dom.security.secFetch.enabled
[task 2021-09-23T11:10:17.811Z] 11:10:17 INFO - Setting pref dom.security.secFetch.enabled (true)
[task 2021-09-23T11:10:17.857Z] 11:10:17 INFO - Closing window cdb4d99d-b473-4768-84dc-578dd6be2cbe
[task 2021-09-23T11:10:19.731Z] 11:10:19 INFO - PID 6075 | JavaScript error: , line 0: TypeError: NetworkError when attempting to fetch resource.
[task 2021-09-23T11:10:19.920Z] 11:10:19 INFO - PID 6075 | ==================
[task 2021-09-23T11:10:19.922Z] 11:10:19 INFO - PID 6075 | WARNING: ThreadSanitizer: data race (pid=6075)
[task 2021-09-23T11:10:19.923Z] 11:10:19 INFO - PID 6075 | Write of size 2 at 0x7b54001ebe30 by thread T6 (mutexes: write M874115231596732576):
[task 2021-09-23T11:10:19.924Z] 11:10:19 INFO - PID 6075 | #0 PreliminaryHandshakeDone(PRFileDesc*) /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSCallbacks.cpp:716:32 (libxul.so+0x676ebc2)
[task 2021-09-23T11:10:19.925Z] 11:10:19 INFO - PID 6075 | #1 HandshakeCallback(PRFileDesc*, void*) /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSCallbacks.cpp:1146:3 (libxul.so+0x676ede8)
[task 2021-09-23T11:10:19.925Z] 11:10:19 INFO - PID 6075 | #2 ssl_FinishHandshake /builds/worker/checkouts/gecko/security/nss/lib/ssl/sslsecur.c:68:9 (libssl3.so+0x412dd)
[task 2021-09-23T11:10:19.926Z] 11:10:19 INFO - PID 6075 | #3 tls13_FinishHandshake /builds/worker/checkouts/gecko/security/nss/lib/ssl/tls13con.c:5009:5 (libssl3.so+0x5fa9c)
[task 2021-09-23T11:10:19.927Z] 11:10:19 INFO - PID 6075 | #4 tls13_SendClientSecondRound /builds/worker/checkouts/gecko/security/nss/lib/ssl/tls13con.c:5196:12 (libssl3.so+0x5f915)
[task 2021-09-23T11:10:19.934Z] 11:10:19 INFO - PID 6075 | #5 tls13_ClientHandleFinished /builds/worker/checkouts/gecko/security/nss/lib/ssl/tls13con.c:4863:12 (libssl3.so+0x56584)
[task 2021-09-23T11:10:19.935Z] 11:10:19 INFO - PID 6075 | #6 tls13_HandlePostHelloHandshakeMessage /builds/worker/checkouts/gecko/security/nss/lib/ssl/tls13con.c:968:24 (libssl3.so+0x56584)
[task 2021-09-23T11:10:19.936Z] 11:10:19 INFO - PID 6075 | #7 ssl3_HandleHandshakeMessage /builds/worker/checkouts/gecko/security/nss/lib/ssl/ssl3con.c:12442:22 (libssl3.so+0x2382a)
[task 2021-09-23T11:10:19.937Z] 11:10:19 INFO - PID 6075 | #8 ssl3_HandleHandshake /builds/worker/checkouts/gecko/security/nss/lib/ssl/ssl3con.c:12614:18 (libssl3.so+0x26f65)
[task 2021-09-23T11:10:19.938Z] 11:10:19 INFO - PID 6075 | #9 ssl3_HandleNonApplicationData /builds/worker/checkouts/gecko/security/nss/lib/ssl/ssl3con.c:13139:22 (libssl3.so+0x26f65)
[task 2021-09-23T11:10:19.939Z] 11:10:19 INFO - PID 6075 | #10 ssl3_HandleRecord /builds/worker/checkouts/gecko/security/nss/lib/ssl/ssl3con.c:13436:12 (libssl3.so+0x27d8a)
[task 2021-09-23T11:10:19.939Z] 11:10:19 INFO - PID 6075 | #11 ssl3_GatherCompleteHandshake /builds/worker/checkouts/gecko/security/nss/lib/ssl/ssl3gthr.c:523:18 (libssl3.so+0x36fbe)
[task 2021-09-23T11:10:19.940Z] 11:10:19 INFO - PID 6075 | #12 ssl_GatherRecord1stHandshake /builds/worker/checkouts/gecko/security/nss/lib/ssl/sslcon.c:73:10 (libssl3.so+0x3a334)
[task 2021-09-23T11:10:19.941Z] 11:10:19 INFO - PID 6075 | #13 ssl_Do1stHandshake /builds/worker/checkouts/gecko/security/nss/lib/ssl/sslsecur.c:42:14 (libssl3.so+0x42914)
[task 2021-09-23T11:10:19.942Z] 11:10:19 INFO - PID 6075 | #14 ssl_SecureRecv /builds/worker/checkouts/gecko/security/nss/lib/ssl/sslsecur.c:820:18 (libssl3.so+0x42914)
[task 2021-09-23T11:10:19.943Z] 11:10:19 INFO - PID 6075 | #15 ssl_Recv /builds/worker/checkouts/gecko/security/nss/lib/ssl/sslsock.c:3173:10 (libssl3.so+0x528aa)
[task 2021-09-23T11:10:19.943Z] 11:10:19 INFO - PID 6075 | #16 PSMRecv(PRFileDesc*, void*, int, int, unsigned int) /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSIOLayer.cpp:1300:7 (libxul.so+0x678b9a4)
[task 2021-09-23T11:10:19.944Z] 11:10:19 INFO - PID 6075 | #17 nsSSLIOLayerRead(PRFileDesc*, void*, int) /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSIOLayer.cpp:1406:10 (libxul.so+0x678c53c)
[task 2021-09-23T11:10:19.945Z] 11:10:19 INFO - PID 6075 | #18 PR_Read /builds/worker/checkouts/gecko/nsprpub/pr/src/io/priometh.c:109:12 (libnspr4.so+0xdd1d)
[task 2021-09-23T11:10:19.946Z] 11:10:19 INFO - PID 6075 | #19 mozilla::net::nsSocketInputStream::Read(char*, unsigned int, unsigned int*) /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransport2.cpp:379:15 (libxul.so+0xe4dd89)
[task 2021-09-23T11:10:19.947Z] 11:10:19 INFO - PID 6075 | #20 mozilla::net::nsHttpConnection::Close(nsresult, bool) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnection.cpp:881:27 (libxul.so+0x1382c32)
[task 2021-09-23T11:10:19.947Z] 11:10:19 INFO - PID 6075 | #21 mozilla::net::nsHttpConnection::CloseTransaction(mozilla::net::nsAHttpTransaction*, nsresult, bool) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnection.cpp:1662:5 (libxul.so+0x13814eb)
[task 2021-09-23T11:10:19.948Z] 11:10:19 INFO - PID 6075 | #22 mozilla::net::ConnectionHandle::CloseTransaction(mozilla::net::nsAHttpTransaction*, nsresult) /builds/worker/checkouts/gecko/netwerk/protocol/http/ConnectionHandle.cpp:42:10 (libxul.so+0x124621d)
[task 2021-09-23T11:10:19.949Z] 11:10:19 INFO - PID 6075 | #23 mozilla::net::nsHttpConnectionMgr::OnMsgCancelTransaction(int, mozilla::net::ARefBase*) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:2064:11 (libxul.so+0x139d377)
[task 2021-09-23T11:10:19.950Z] 11:10:19 INFO - PID 6075 | #24 operator()<int &, RefPtr<mozilla::net::ARefBase> &> /builds/worker/workspace/obj-build/dist/include/mozilla/RefPtr.h:330:14 (libxul.so+0x13cdcc1)
[task 2021-09-23T11:10:19.951Z] 11:10:19 INFO - PID 6075 | #25 mozilla::net::ConnEvent::Run() /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:175:5 (libxul.so+0x13cdcc1)
[task 2021-09-23T11:10:19.952Z] 11:10:19 INFO - PID 6075 | #26 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1142:16 (libxul.so+0xc8f9f2)
[task 2021-09-23T11:10:19.952Z] 11:10:19 INFO - PID 6075 | #27 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:466:10 (libxul.so+0xc967a2)
[task 2021-09-23T11:10:19.953Z] 11:10:19 INFO - PID 6075 | #28 mozilla::net::nsSocketTransportService::Run() /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransportService2.cpp:1190:11 (libxul.so+0xe61327)
[task 2021-09-23T11:10:19.954Z] 11:10:19 INFO - PID 6075 | #29 non-virtual thunk to mozilla::net::nsSocketTransportService::Run() /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransportService2.cpp (libxul.so+0xe627b9)
[task 2021-09-23T11:10:19.955Z] 11:10:19 INFO - PID 6075 | #30 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1142:16 (libxul.so+0xc8f9f2)
[task 2021-09-23T11:10:19.956Z] 11:10:19 INFO - PID 6075 | #31 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:466:10 (libxul.so+0xc967a2)
[task 2021-09-23T11:10:19.957Z] 11:10:19 INFO - PID 6075 | #32 mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:300:20 (libxul.so+0x15cb07e)
[task 2021-09-23T11:10:19.957Z] 11:10:19 INFO - PID 6075 | #33 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.958Z] 11:10:19 INFO - PID 6075 | #34 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.959Z] 11:10:19 INFO - PID 6075 | #35 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.960Z] 11:10:19 INFO - PID 6075 | #36 nsThread::ThreadFunc(void*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:390:10 (libxul.so+0xc8c1f8)
[task 2021-09-23T11:10:19.961Z] 11:10:19 INFO - PID 6075 | #37 _pt_root /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201:5 (libnspr4.so+0x44cd6)
[task 2021-09-23T11:10:19.962Z] 11:10:19 INFO - PID 6075 | Previous read of size 2 at 0x7b54001ebe30 by main thread (mutexes: write M871863603582385792):
[task 2021-09-23T11:10:19.962Z] 11:10:19 INFO - PID 6075 | #0 mozilla::psm::TransportSecurityInfo::Write(nsIObjectOutputStream*) /builds/worker/checkouts/gecko/security/manager/ssl/TransportSecurityInfo.cpp:208:25 (libxul.so+0x6759ec0)
[task 2021-09-23T11:10:19.963Z] 11:10:19 INFO - PID 6075 | #1 non-virtual thunk to mozilla::psm::TransportSecurityInfo::Write(nsIObjectOutputStream*) /builds/worker/checkouts/gecko/security/manager/ssl/TransportSecurityInfo.cpp (libxul.so+0x675a485)
[task 2021-09-23T11:10:19.964Z] 11:10:19 INFO - PID 6075 | #2 nsBinaryOutputStream::WriteCompoundObject(nsISupports*, nsID const&, bool) /builds/worker/checkouts/gecko/xpcom/io/nsBinaryStream.cpp:327:24 (libxul.so+0xc241ef)
[task 2021-09-23T11:10:19.965Z] 11:10:19 INFO - PID 6075 | #3 NS_SerializeToString(nsISerializable*, nsTSubstring<char>&) /builds/worker/checkouts/gecko/netwerk/base/nsSerializationHelper.cpp:24:18 (libxul.so+0xe4527e)
[task 2021-09-23T11:10:19.966Z] 11:10:19 INFO - PID 6075 | #4 mozilla::net::HttpChannelParent::UpdateAndSerializeSecurityInfo(nsTSubstring<char>&) /builds/worker/checkouts/gecko/netwerk/protocol/http/HttpChannelParent.cpp:1838:7 (libxul.so+0x12e72c0)
[task 2021-09-23T11:10:19.967Z] 11:10:19 INFO - PID 6075 | #5 mozilla::net::HttpChannelParent::OnStartRequest(nsIRequest*) /builds/worker/checkouts/gecko/netwerk/protocol/http/HttpChannelParent.cpp:1141:3 (libxul.so+0x12e69b1)
[task 2021-09-23T11:10:19.968Z] 11:10:19 INFO - PID 6075 | #6 non-virtual thunk to mozilla::net::HttpChannelParent::OnStartRequest(nsIRequest*) /builds/worker/checkouts/gecko/netwerk/protocol/http/HttpChannelParent.cpp (libxul.so+0x12e7735)
[task 2021-09-23T11:10:19.968Z] 11:10:19 INFO - PID 6075 | #7 mozilla::net::ParentChannelListener::OnStartRequest(nsIRequest*) /builds/worker/checkouts/gecko/netwerk/protocol/http/ParentChannelListener.cpp:88:25 (libxul.so+0x130f372)
[task 2021-09-23T11:10:19.969Z] 11:10:19 INFO - PID 6075 | #8 non-virtual thunk to mozilla::net::ParentChannelListener::OnStartRequest(nsIRequest*) /builds/worker/checkouts/gecko/netwerk/protocol/http/ParentChannelListener.cpp (libxul.so+0x130f445)
[task 2021-09-23T11:10:19.970Z] 11:10:19 INFO - PID 6075 | #9 mozilla::net::nsHttpChannel::CallOnStartRequest() /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:1630:27 (libxul.so+0x135307a)
[task 2021-09-23T11:10:19.971Z] 11:10:19 INFO - PID 6075 | #10 mozilla::net::nsHttpChannel::ContinueOnStartRequest4(nsresult) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:6970:10 (libxul.so+0x136f14e)
[task 2021-09-23T11:10:19.972Z] 11:10:19 INFO - PID 6075 | #11 ContinueOnStartRequest3 /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:6953:10 (libxul.so+0x136f012)
[task 2021-09-23T11:10:19.973Z] 11:10:19 INFO - PID 6075 | #12 mozilla::net::nsHttpChannel::ContinueOnStartRequest2(nsresult) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:6942:10 (libxul.so+0x136f012)
[task 2021-09-23T11:10:19.974Z] 11:10:19 INFO - PID 6075 | #13 mozilla::net::nsHttpChannel::ContinueOnStartRequest1(nsresult) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:6915:10 (libxul.so+0x136ebe9)
[task 2021-09-23T11:10:19.974Z] 11:10:19 INFO - PID 6075 | #14 mozilla::net::nsHttpChannel::OnStartRequest(nsIRequest*) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:6879:10 (libxul.so+0x136e6e1)
[task 2021-09-23T11:10:19.976Z] 11:10:19 INFO - PID 6075 | #15 non-virtual thunk to mozilla::net::nsHttpChannel::OnStartRequest(nsIRequest*) /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp (libxul.so+0x136eec8)
[task 2021-09-23T11:10:19.977Z] 11:10:19 INFO - PID 6075 | #16 nsInputStreamPump::OnStateStart() /builds/worker/checkouts/gecko/netwerk/base/nsInputStreamPump.cpp:465:21 (libxul.so+0xe15f02)
[task 2021-09-23T11:10:19.978Z] 11:10:19 INFO - PID 6075 | #17 nsInputStreamPump::OnInputStreamReady(nsIAsyncInputStream*) /builds/worker/checkouts/gecko/netwerk/base/nsInputStreamPump.cpp:374:21 (libxul.so+0xe159f1)
[task 2021-09-23T11:10:19.979Z] 11:10:19 INFO - PID 6075 | #18 non-virtual thunk to nsInputStreamPump::OnInputStreamReady(nsIAsyncInputStream*) /builds/worker/checkouts/gecko/netwerk/base/nsInputStreamPump.cpp (libxul.so+0xe16d29)
[task 2021-09-23T11:10:19.979Z] 11:10:19 INFO - PID 6075 | #19 nsInputStreamReadyEvent::Run() /builds/worker/checkouts/gecko/xpcom/io/nsStreamUtils.cpp:94:20 (libxul.so+0xc49b3c)
[task 2021-09-23T11:10:19.980Z] 11:10:19 INFO - PID 6075 | #20 mozilla::RunnableTask::Run() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:467:16 (libxul.so+0xca1bc7)
[task 2021-09-23T11:10:19.981Z] 11:10:19 INFO - PID 6075 | #21 mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:770:26 (libxul.so+0xc7da62)
[task 2021-09-23T11:10:19.982Z] 11:10:19 INFO - PID 6075 | #22 mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:606:15 (libxul.so+0xc7c0b6)
[task 2021-09-23T11:10:19.983Z] 11:10:19 INFO - PID 6075 | #23 mozilla::TaskController::ProcessPendingMTTask(bool) /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:390:36 (libxul.so+0xc7c384)
[task 2021-09-23T11:10:19.984Z] 11:10:19 INFO - PID 6075 | #24 operator() /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:123:37 (libxul.so+0xca5a27)
[task 2021-09-23T11:10:19.985Z] 11:10:19 INFO - PID 6075 | #25 mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_0>::Run() /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.h:531:5 (libxul.so+0xca5a27)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #26 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1148:16 (libxul.so+0xc8f7ca)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #27 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:466:10 (libxul.so+0xc967a2)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #28 mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:85:21 (libxul.so+0x15ca4ed)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #29 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #30 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #31 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #32 nsBaseAppShell::Run() /builds/worker/checkouts/gecko/widget/nsBaseAppShell.cpp:137:27 (libxul.so+0x4bfddd6)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #33 nsAppStartup::Run() /builds/worker/checkouts/gecko/toolkit/components/startup/nsAppStartup.cpp:289:30 (libxul.so+0x692e4b9)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #34 XREMain::XRE_mainRun() /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5291:22 (libxul.so+0x6a4a0b3)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #35 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5476:8 (libxul.so+0x6a4ae26)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #36 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5535:21 (libxul.so+0x6a4b3f4)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #37 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x6a55ab2)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #38 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:225:22 (firefox+0xca390)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #39 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:386:16 (firefox+0xca390)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | Location is heap block of size 520 at 0x7b54001ebe00 allocated by thread T6:
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #0 malloc /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:651:5 (firefox+0x5600b)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #1 moz_xmalloc /builds/worker/checkouts/gecko/memory/mozalloc/mozalloc.cpp:52:15 (firefox+0xcc48b)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #2 operator new /builds/worker/workspace/obj-build/dist/include/mozilla/cxxalloc.h:33:10 (libxul.so+0x678d37d)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #3 nsSSLIOLayerAddToSocket(int, char const*, int, nsIProxyInfo*, mozilla::OriginAttributes const&, PRFileDesc*, nsISupports**, bool, unsigned int, unsigned int) /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSIOLayer.cpp:2852:7 (libxul.so+0x678d37d)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #4 nsSSLIOLayerNewSocket /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSIOLayer.cpp:1729:7 (libxul.so+0x6799ead)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #5 nsSSLSocketProvider::NewSocket(int, char const*, int, nsIProxyInfo*, mozilla::OriginAttributes const&, unsigned int, unsigned int, PRFileDesc**, nsISupports**) /builds/worker/checkouts/gecko/security/manager/ssl/nsSSLSocketProvider.cpp:28:7 (libxul.so+0x6799ead)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #6 mozilla::net::nsSocketTransport::BuildSocket(PRFileDesc*&, bool&, bool&) /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransport2.cpp:1133:22 (libxul.so+0xe51801)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #7 mozilla::net::nsSocketTransport::InitiateSocket() /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransport2.cpp:1298:8 (libxul.so+0xe526e0)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #8 mozilla::net::nsSocketTransport::OnSocketEvent(unsigned int, nsresult, nsISupports*) /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransport2.cpp (libxul.so+0xe55b42)
[task 2021-09-23T11:10:19.986Z] 11:10:19 INFO - PID 6075 | #9 mozilla::net::nsSocketEvent::Run() /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransport2.cpp:94:17 (libxul.so+0xe811b6)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #10 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1142:16 (libxul.so+0xc8f9f2)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #11 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:466:10 (libxul.so+0xc967a2)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #12 mozilla::net::nsSocketTransportService::Run() /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransportService2.cpp:1190:11 (libxul.so+0xe61327)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #13 non-virtual thunk to mozilla::net::nsSocketTransportService::Run() /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransportService2.cpp (libxul.so+0xe627b9)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #14 nsThread::ProcessNextEvent(bool, bool*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1142:16 (libxul.so+0xc8f9f2)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #15 NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:466:10 (libxul.so+0xc967a2)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #16 mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:300:20 (libxul.so+0x15cb07e)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #17 RunInternal /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:331:10 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #18 RunHandler /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:324:3 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #19 MessageLoop::Run() /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:306:3 (libxul.so+0x1544f8c)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #20 nsThread::ThreadFunc(void*) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:390:10 (libxul.so+0xc8c1f8)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #21 _pt_root /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201:5 (libnspr4.so+0x44cd6)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | Mutex M874115231596732576 is already destroyed.
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | Mutex M871863603582385792 is already destroyed.
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | Thread T6 'Socket Thread' (tid=6091, running) created by main thread at:
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #0 pthread_create /builds/worker/fetches/llvm-project/llvm/projects/compiler-rt/lib/tsan/rtl/tsan_interceptors_posix.cpp:965:3 (firefox+0x5783b)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #1 _PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:458:14 (libnspr4.so+0x3be33)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #2 PR_CreateThread /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:533:12 (libnspr4.so+0x30915)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #3 nsThread::Init(nsTSubstring<char> const&) /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:602:18 (libxul.so+0xc8d562)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #4 nsThreadManager::NewNamedThread(nsTSubstring<char> const&, unsigned int, nsIThread**) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadManager.cpp:574:12 (libxul.so+0xc9577a)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #5 NS_NewNamedThread(nsTSubstring<char> const&, nsIThread**, already_AddRefed<nsIRunnable>, unsigned int) /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:162:57 (libxul.so+0xc9d474)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #6 NS_NewNamedThread<14> /builds/worker/workspace/obj-build/dist/include/nsThreadUtils.h:85:10 (libxul.so+0xe5fa4f)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #7 mozilla::net::nsSocketTransportService::Init() /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransportService2.cpp:760:7 (libxul.so+0xe5fa4f)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #8 mozilla::xpcom::CreateInstanceImpl(mozilla::xpcom::ModuleID, nsISupports*, nsID const&, void**) /builds/worker/workspace/obj-build/xpcom/components/StaticComponents.cpp:9134:7 (libxul.so+0xc57549)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #9 mozilla::xpcom::StaticModule::CreateInstance(nsISupports*, nsID const&, void**) const /builds/worker/workspace/obj-build/xpcom/components/StaticComponents.cpp:12087:10 (libxul.so+0xc4f773)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #10 CreateInstance /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:177:46 (libxul.so+0xc668c9)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #11 nsComponentManagerImpl::GetServiceLocked(mozilla::Maybe<mozilla::MonitorAutoLock>&, (anonymous namespace)::EntryWrapper&, nsID const&, void**) /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:1276:17 (libxul.so+0xc668c9)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #12 nsComponentManagerImpl::GetServiceByContractID(char const*, nsID const&, void**) /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:1465:10 (libxul.so+0xc67580)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #13 CallGetService /builds/worker/checkouts/gecko/xpcom/components/nsComponentManagerUtils.cpp:61:43 (libxul.so+0xc6a47d)
[task 2021-09-23T11:10:19.987Z] 11:10:19 INFO - PID 6075 | #14 nsGetServiceByContractIDWithError::operator()(nsID const&, void**) const /builds/worker/checkouts/gecko/xpcom/components/nsComponentManagerUtils.cpp:253:21 (libxul.so+0xc6a47d)
[task 2021-09-23T11:10:19.988Z] 11:10:19 INFO - PID 6075 | #15 nsCOMPtr_base::assign_from_gs_contractid_with_error(nsGetServiceByContractIDWithError const&, nsID const&) /builds/worker/checkouts/gecko/xpcom/base/nsCOMPtr.cpp:91:7 (libxul.so+0xba8267)
[task 2021-09-23T11:10:19.988Z] 11:10:19 INFO - PID 6075 | #16 operator= /builds/worker/workspace/obj-build/dist/include/nsCOMPtr.h:774:5 (libxul.so+0xe04941)
[task 2021-09-23T11:10:19.989Z] 11:10:19 INFO - PID 6075 | #17 InitializeSocketTransportService /builds/worker/checkouts/gecko/netwerk/base/nsIOService.cpp:420:29 (libxul.so+0xe04941)
[task 2021-09-23T11:10:19.990Z] 11:10:19 INFO - PID 6075 | #18 mozilla::net::nsIOService::SetOffline(bool) /builds/worker/checkouts/gecko/netwerk/base/nsIOService.cpp:1271:7 (libxul.so+0xe04941)
[task 2021-09-23T11:10:19.990Z] 11:10:19 INFO - PID 6075 | #19 mozilla::net::nsIOService::Init() /builds/worker/checkouts/gecko/netwerk/base/nsIOService.cpp:304:3 (libxul.so+0xe03b7d)
[task 2021-09-23T11:10:19.991Z] 11:10:19 INFO - PID 6075 | #20 mozilla::net::nsIOService::GetInstance() /builds/worker/checkouts/gecko/netwerk/base/nsIOService.cpp:477:9 (libxul.so+0xe05701)
[task 2021-09-23T11:10:19.991Z] 11:10:19 INFO - PID 6075 | #21 mozilla::xpcom::CreateInstanceImpl(mozilla::xpcom::ModuleID, nsISupports*, nsID const&, void**) /builds/worker/workspace/obj-build/xpcom/components/StaticComponents.cpp:9538:48 (libxul.so+0xc506e7)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #22 mozilla::xpcom::StaticModule::CreateInstance(nsISupports*, nsID const&, void**) const /builds/worker/workspace/obj-build/xpcom/components/StaticComponents.cpp:12087:10 (libxul.so+0xc4f773)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #23 CreateInstance /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:177:46 (libxul.so+0xc668c9)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #24 nsComponentManagerImpl::GetServiceLocked(mozilla::Maybe<mozilla::MonitorAutoLock>&, (anonymous namespace)::EntryWrapper&, nsID const&, void**) /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:1276:17 (libxul.so+0xc668c9)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #25 nsComponentManagerImpl::GetServiceByContractID(char const*, nsID const&, void**) /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:1465:10 (libxul.so+0xc67580)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #26 CallGetService(char const*, nsID const&, void**) /builds/worker/checkouts/gecko/xpcom/components/nsComponentManagerUtils.cpp:61:43 (libxul.so+0xc69f8d)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #27 CallGetService<nsIIOService> /builds/worker/workspace/obj-build/dist/include/nsServiceManagerUtils.h:52:10 (libxul.so+0x1d43cd5)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #28 nsScriptSecurityManager::Init() /builds/worker/checkouts/gecko/caps/nsScriptSecurityManager.cpp:1476:17 (libxul.so+0x1d43cd5)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #29 nsScriptSecurityManager::InitStatics() /builds/worker/checkouts/gecko/caps/nsScriptSecurityManager.cpp:1537:28 (libxul.so+0x1d442d1)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #30 nsXPConnect::InitStatics() /builds/worker/checkouts/gecko/js/xpconnect/src/nsXPConnect.cpp:153:3 (libxul.so+0x1c186e3)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #31 xpcModuleCtor() /builds/worker/checkouts/gecko/js/xpconnect/src/XPCModule.cpp:11:3 (libxul.so+0x1beb302)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #32 nsLayoutModuleInitialize() /builds/worker/checkouts/gecko/layout/build/nsLayoutModule.cpp:100:7 (libxul.so+0x53df31b)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #33 nsComponentManagerImpl::Init() /builds/worker/checkouts/gecko/xpcom/components/nsComponentManager.cpp:408:5 (libxul.so+0xc623af)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #34 NS_InitXPCOM /builds/worker/checkouts/gecko/xpcom/build/XPCOMInit.cpp:446:51 (libxul.so+0xccf54a)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #35 ScopedXPCOMStartup::Initialize(bool) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:1717:8 (libxul.so+0x6a3ff9d)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #36 XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5472:22 (libxul.so+0x6a4ae0b)
[task 2021-09-23T11:10:20.008Z] 11:10:19 INFO - PID 6075 | #37 XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:5535:21 (libxul.so+0x6a4b3f4)
[task 2021-09-23T11:10:20.008Z] 11:10:20 INFO - PID 6075 | #38 mozilla::BootstrapImpl::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/checkouts/gecko/toolkit/xre/Bootstrap.cpp:45:12 (libxul.so+0x6a55ab2)
[task 2021-09-23T11:10:20.008Z] 11:10:20 INFO - PID 6075 | #39 do_main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:225:22 (firefox+0xca390)
[task 2021-09-23T11:10:20.008Z] 11:10:20 INFO - PID 6075 | #40 main /builds/worker/checkouts/gecko/browser/app/nsBrowserApp.cpp:386:16 (firefox+0xca390)
[task 2021-09-23T11:10:20.008Z] 11:10:20 INFO - PID 6075 | SUMMARY: ThreadSanitizer: data race /builds/worker/checkouts/gecko/security/manager/ssl/nsNSSCallbacks.cpp:716:32 in PreliminaryHandshakeDone(PRFileDesc*)
[task 2021-09-23T11:10:20.008Z] 11:10:20 INFO - PID 6075 | ==================
[task 2021-09-23T11:10:20.065Z] 11:10:20 INFO - PID 6075 | Exiting due to channel error.
[task 2021-09-23T11:10:20.065Z] 11:10:20 INFO - PID 6075 | Exiting due to channel error.
[task 2021-09-23T11:10:20.065Z] 11:10:20 INFO - PID 6075 | Exiting due to channel error.
[task 2021-09-23T11:10:20.065Z] 11:10:20 INFO - PID 6075 | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=4.803) Exiting due to channel error.
[task 2021-09-23T11:10:20.066Z] 11:10:20 INFO - IOError on command, setting status to CRASH
[task 2021-09-23T11:10:20.067Z] 11:10:20 INFO - TEST-UNEXPECTED-CRASH | /fetch/metadata/serviceworker-accessors.https.sub.html | expected OK
[task 2021-09-23T11:10:20.067Z] 11:10:20 INFO - TEST-INFO took 2329ms
[task 2021-09-23T11:10:21.083Z] 11:10:21 INFO - PID 6075 | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=1991.1) Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=1992.37) Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=11.3111)
[task 2021-09-23T11:10:21.083Z] 11:10:21 INFO - Browser exited with return code -6
[task 2021-09-23T11:10:21.085Z] 11:10:21 INFO - Closing logging queue
[task 2021-09-23T11:10:21.085Z] 11:10:21 INFO - queue closed
[task 2021-09-23T11:10:21.106Z] 11:10:21 INFO - INFO | runtests.py | TSan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2021-09-23T11:10:21.107Z] 11:10:21 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmpjwl89p33
[task 2021-09-23T11:10:21.124Z] 11:10:21 INFO - PID 18146 | 1632395312646 Marionette INFO Marionette enabled
[task 2021-09-23T11:10:21.124Z] 11:10:21 INFO - PID 18146 | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpgh6yxhlp/search.json.mozlz4", (void 0)))
[task 2021-09-23T11:10:21.125Z] 11:10:21 INFO - PID 18146 | 1632395333217 Marionette INFO Listening on port 42268
[task 2021-09-23T11:10:21.125Z] 11:10:21 INFO - Starting runner
[task 2021-09-23T11:10:23.086Z] 11:10:23 INFO - TEST-START | /fetch/metadata/serviceworker.https.sub.html
|
||
Comment 1•3 years ago
|
||
Write in PreliminaryHandshakeDone from nsNSSCallbacks.cpp on the socket thread racing with a read in psm::TransportSecurityInfo::Write in TransportSecurityInfo.cpp on the main thread.
Component: DOM: Networking → Security: PSM
|
|
||
Comment 2•3 years ago
|
||
"TypeError: NetworkError when attempting to fetch resource." in the log, so maybe we're hitting some error handling case? Though nothing in the stacks looks obviously error-related.
|
||
Comment 3•3 years ago
|
||
bug 1742205 should have fixed this.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → DUPLICATE
|
||
Updated•2 years ago
|
Group: crypto-core-security
You need to log in
before you can comment on or make changes to this bug.
Description
•