Back to build
Raw log | Switch to full mode | Login

Test 'TraceEventDataSourceTest.TaskExecutionEvent' completed with the following status(es): 'FAILURE_ON_EXIT','SUCCESS' Test 'TraceEventDataSourceTest.TaskExecutionEvent' had the following logs when run: ================================================================================ [ RUN ] TraceEventDataSourceTest.TaskExecutionEvent [ OK ] TraceEventDataSourceTest.TaskExecutionEvent (8 ms) [ RUN ] TraceEventDataSourceTest.TaskExecutionEventWithoutFunction [ OK ] TraceEventDataSourceTest.TaskExecutionEventWithoutFunction (11 ms) [ RUN ] TraceEventDataSourceTest.UpdateDurationOfCompleteEvent [ OK ] TraceEventDataSourceTest.UpdateDurationOfCompleteEvent (9 ms) [ RUN ] TraceEventDataSourceTest.InternedStrings ================== WARNING: ThreadSanitizer: data race (pid=3429) Atomic read of size 1 at 0x55dfff58b0d0 by thread T8: #0 pthread_mutex_lock /b/swarming/w/ir/k/src/third_party/llvm/compiler-rt/lib/tsan/../sanitizer_common/sanitizer_common_interceptors.inc:4137:3 (services_unittests+0x190af86) #1 base::internal::LockImpl::Lock() base/synchronization/lock_impl_posix.cc:102:12 (services_unittests+0x415971d) #2 Acquire base/synchronization/lock.h:31:26 (services_unittests+0x4592229) #3 BasicAutoLock base/synchronization/lock_impl.h:84 (services_unittests+0x4592229) #4 tracing::TraceEventDataSource::CreateThreadLocalEventSink(bool) services/tracing/public/cpp/perfetto/trace_event_data_source.cc:381 (services_unittests+0x4592229) #5 tracing::TraceEventDataSource::OnAddTraceEvent(base::trace_event::TraceEvent*, bool, base::trace_event::TraceEventHandle*) services/tracing/public/cpp/perfetto/trace_event_data_source.cc:454:24 (services_unittests+0x4591111) #6 base::trace_event::TraceLog::AddTraceEventWithThreadIdAndTimestamp(char, unsigned char const*, char const*, char const*, unsigned long long, unsigned long long, int, base::TimeTicks const&, base::trace_event::TraceArguments*, unsigned int) base/trace_event/trace_log.cc:1240:7 (services_unittests+0x412df67) #7 trace_event_internal::AddTraceEventWithThreadIdAndTimestamp(char, unsigned char const*, char const*, char const*, unsigned long long, unsigned long long, int, base::TimeTicks const&, base::trace_event::TraceArguments*, unsigned int) base/trace_event/trace_log.cc:1775:9 (services_unittests+0x4130185) #8 AddTraceEventWithThreadIdAndTimestamp<const char *, const char *> base/trace_event/trace_event.h:761:10 (services_unittests+0x4107290) #9 AddTraceEvent<const char *, const char *> base/trace_event/trace_event.h:830 (services_unittests+0x4107290) #10 base::ScopedBlockingCall::ScopedBlockingCall(base::Location const&, base::BlockingType) base/threading/scoped_blocking_call.cc:77 (services_unittests+0x4107290) #11 base::DirectoryExists(base::FilePath const&) base/files/file_util_posix.cc:488:22 (services_unittests+0x4152dca) #12 base::(anonymous namespace)::SetThreadCgroupForThreadPriority(int, base::FilePath const&, base::ThreadPriority) base/threading/platform_thread_linux.cc:67:8 (services_unittests+0x4106692) #13 SetThreadCgroupsForThreadPriority base/threading/platform_thread_linux.cc:78:3 (services_unittests+0x41064f4) #14 base::internal::SetCurrentThreadPriorityForPlatform(base::ThreadPriority) base/threading/platform_thread_linux.cc:116 (services_unittests+0x41064f4) #15 base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority) base/threading/platform_thread_posix.cc:309:7 (services_unittests+0x415d817) #16 base::PlatformThread::SetCurrentThreadPriority(base::ThreadPriority) base/threading/platform_thread.cc:32:5 (services_unittests+0x41063a2) #17 base::(anonymous namespace)::ThreadFunc(void*) base/threading/platform_thread_posix.cc:73:5 (services_unittests+0x415d875) Previous write of size 1 at 0x55dfff58b0d0 by main thread: #0 pthread_mutex_destroy /b/swarming/w/ir/k/src/third_party/llvm/compiler-rt/lib/tsan/rtl/tsan_interceptors.cc:1264:3 (services_unittests+0x18ee446) #1 base::internal::LockImpl::~LockImpl() base/synchronization/lock_impl_posix.cc:79:12 (services_unittests+0x4159679) #2 ~Lock base/synchronization/lock.h:26:12 (services_unittests+0x4590f5e) #3 tracing::TraceEventDataSource::~TraceEventDataSource() services/tracing/public/cpp/perfetto/trace_event_data_source.cc:198 (services_unittests+0x4590f5e) #4 tracing::TraceEventDataSource::ResetForTesting() services/tracing/public/cpp/perfetto/trace_event_data_source.cc:187:42 (services_unittests+0x4590c46) #5 CreateTraceEventDataSource services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:212:5 (services_unittests+0x21c6914) #6 tracing::(anonymous namespace)::TraceEventDataSourceTest_InternedStrings_Test::TestBody() services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:862 (services_unittests+0x21c6914) #7 HandleExceptionsInMethodIfSupported<testing::Test, void> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2a2bdef) #8 testing::Test::Run() third_party/googletest/src/googletest/src/gtest.cc:2522 (services_unittests+0x2a2bdef) #9 testing::TestInfo::Run() third_party/googletest/src/googletest/src/gtest.cc:2698:11 (services_unittests+0x2a2cf68) #10 testing::TestSuite::Run() third_party/googletest/src/googletest/src/gtest.cc:2828:28 (services_unittests+0x2a2db36) #11 testing::internal::UnitTestImpl::RunAllTests() third_party/googletest/src/googletest/src/gtest.cc:5285:44 (services_unittests+0x2a3fee6) #12 HandleExceptionsInMethodIfSupported<testing::internal::UnitTestImpl, bool> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2a3f349) #13 testing::UnitTest::Run() third_party/googletest/src/googletest/src/gtest.cc:4873 (services_unittests+0x2a3f349) #14 RUN_ALL_TESTS third_party/googletest/src/googletest/include/gtest/gtest.h:2453:46 (services_unittests+0x517a712) #15 base::TestSuite::Run() base/test/test_suite.cc:316 (services_unittests+0x517a712) #16 Invoke<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:499:12 (services_unittests+0x1de0578) #17 MakeItSo<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:599 (services_unittests+0x1de0578) #18 RunImpl<int (base::TestSuite::*)(), std::__1::tuple<base::internal::UnretainedWrapper<(anonymous namespace)::ServiceTestSuite> >, 0> base/bind_internal.h:672 (services_unittests+0x1de0578) #19 base::internal::Invoker<base::internal::BindState<int (base::TestSuite::*)(), base::internal::UnretainedWrapper<(anonymous namespace)::ServiceTestSuite> >, int ()>::RunOnce(base::internal::BindStateBase*) base/bind_internal.h:641 (services_unittests+0x1de0578) #20 Run base/callback.h:97:12 (services_unittests+0x5183c8d) #21 base::(anonymous namespace)::LaunchUnitTestsInternal(base::OnceCallback<int ()>, unsigned long, int, bool, base::OnceCallback<void ()>) base/test/launcher/unit_test_launcher.cc:158 (services_unittests+0x5183c8d) #22 base::LaunchUnitTests(int, char**, base::OnceCallback<int ()>) base/test/launcher/unit_test_launcher.cc:508:10 (services_unittests+0x5183af0) #23 main services/test/run_all_unittests.cc:97:10 (services_unittests+0x1de01af) Location is global 'tracing::TraceEventDataSource::GetInstance()::instance' of size 184 at 0x55dfff58b090 (services_unittests+0x000008d2b0d0) Thread T8 (tid=3522, running) created by main thread at: #0 pthread_create /b/swarming/w/ir/k/src/third_party/llvm/compiler-rt/lib/tsan/rtl/tsan_interceptors.cc:989:3 (services_unittests+0x18ecbfb) #1 base::(anonymous namespace)::CreateThread(unsigned long, bool, base::PlatformThread::Delegate*, base::PlatformThreadHandle*, base::ThreadPriority) base/threading/platform_thread_posix.cc:120:13 (services_unittests+0x415d427) #2 base::PlatformThread::CreateWithPriority(unsigned long, base::PlatformThread::Delegate*, base::PlatformThreadHandle*, base::ThreadPriority) base/threading/platform_thread_posix.cc:246:10 (services_unittests+0x415d325) #3 base::internal::WorkerThread::Start(base::WorkerThreadObserver*) base/task/thread_pool/worker_thread.cc:68:3 (services_unittests+0x40f7e7d) #4 operator() base/task/thread_pool/thread_group_impl.cc:185:15 (services_unittests+0x40eff1b) #5 ForEachWorker<(lambda at ../../base/task/thread_pool/thread_group_impl.cc:184:37)> base/task/thread_pool/thread_group_impl.cc:150 (services_unittests+0x40eff1b) #6 base::internal::ThreadGroupImpl::ScopedWorkersExecutor::FlushImpl() base/task/thread_pool/thread_group_impl.cc:184 (services_unittests+0x40eff1b) #7 base::internal::ThreadGroupImpl::ScopedWorkersExecutor::~ScopedWorkersExecutor() base/task/thread_pool/thread_group_impl.cc:103:30 (services_unittests+0x40ec924) #8 base::internal::ThreadGroupImpl::Start(int, int, base::TimeDelta, scoped_refptr<base::TaskRunner>, base::WorkerThreadObserver*, base::internal::ThreadGroup::WorkerEnvironment, base::Optional<base::TimeDelta>) base/task/thread_pool/thread_group_impl.cc:425:1 (services_unittests+0x40ec8c9) #9 base::internal::ThreadPoolImpl::Start(base::ThreadPool::InitParams const&, base::WorkerThreadObserver*) base/task/thread_pool/thread_pool_impl.cc:192:11 (services_unittests+0x40e4d85) #10 base::test::ScopedTaskEnvironment::InitializeThreadPool() base/test/scoped_task_environment.cc:411:30 (services_unittests+0x51754df) #11 base::test::ScopedTaskEnvironment::ScopedTaskEnvironment(base::test::ScopedTaskEnvironment::MainThreadType, base::test::ScopedTaskEnvironment::ThreadPoolExecutionMode, base::test::ScopedTaskEnvironment::NowSource, base::test::ScopedTaskEnvironment::ThreadingMode, bool, base::trait_helpers::NotATraitTag) base/test/scoped_task_environment.cc:375:5 (services_unittests+0x5174f23) #12 base::test::ScopedTaskEnvironment::ScopedTaskEnvironment<void>() base/test/scoped_task_environment.h:161:9 (services_unittests+0x195d608) #13 TraceEventDataSourceTest services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:181:7 (services_unittests+0x21c6833) #14 TraceEventDataSourceTest_InternedStrings_Test services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:861 (services_unittests+0x21c6833) #15 testing::internal::TestFactoryImpl<tracing::(anonymous namespace)::TraceEventDataSourceTest_InternedStrings_Test>::CreateTest() third_party/googletest/src/googletest/include/gtest/internal/gtest-internal.h:460 (services_unittests+0x21c6833) #16 HandleExceptionsInMethodIfSupported<testing::internal::TestFactoryBase, testing::Test *> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2a2cdbf) #17 testing::TestInfo::Run() third_party/googletest/src/googletest/src/gtest.cc:2688 (services_unittests+0x2a2cdbf) #18 testing::TestSuite::Run() third_party/googletest/src/googletest/src/gtest.cc:2828:28 (services_unittests+0x2a2db36) #19 testing::internal::UnitTestImpl::RunAllTests() third_party/googletest/src/googletest/src/gtest.cc:5285:44 (services_unittests+0x2a3fee6) #20 HandleExceptionsInMethodIfSupported<testing::internal::UnitTestImpl, bool> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2a3f349) #21 testing::UnitTest::Run() third_party/googletest/src/googletest/src/gtest.cc:4873 (services_unittests+0x2a3f349) #22 RUN_ALL_TESTS third_party/googletest/src/googletest/include/gtest/gtest.h:2453:46 (services_unittests+0x517a712) #23 base::TestSuite::Run() base/test/test_suite.cc:316 (services_unittests+0x517a712) #24 Invoke<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:499:12 (services_unittests+0x1de0578) #25 MakeItSo<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:599 (services_unittests+0x1de0578) #26 RunImpl<int (base::TestSuite::*)(), std::__1::tuple<base::internal::UnretainedWrapper<(anonymous namespace)::ServiceTestSuite> >, 0> base/bind_internal.h:672 (services_unittests+0x1de0578) #27 base::internal::Invoker<base::internal::BindState<int (base::TestSuite::*)(), base::internal::UnretainedWrapper<(anonymous namespace)::ServiceTestSuite> >, int ()>::RunOnce(base::internal::BindStateBase*) base/bind_internal.h:641 (services_unittests+0x1de0578) #28 Run base/callback.h:97:12 (services_unittests+0x5183c8d) #29 base::(anonymous namespace)::LaunchUnitTestsInternal(base::OnceCallback<int ()>, unsigned long, int, bool, base::OnceCallback<void ()>) base/test/launcher/unit_test_launcher.cc:158 (services_unittests+0x5183c8d) #30 base::LaunchUnitTests(int, char**, base::OnceCallback<int ()>) base/test/launcher/unit_test_launcher.cc:508:10 (services_unittests+0x5183af0) #31 main services/test/run_all_unittests.cc:97:10 (services_unittests+0x1de01af) SUMMARY: ThreadSanitizer: data race base/synchronization/lock_impl_posix.cc:102:12 in base::internal::LockImpl::Lock() ================== [ OK ] TraceEventDataSourceTest.InternedStrings (983 ms) [ RUN ] TraceEventDataSourceTest.FilteringSimpleTraceEvent [ OK ] TraceEventDataSourceTest.FilteringSimpleTraceEvent (15 ms) [----------] 10 tests from TraceEventDataSourceTest (1082 ms total) [----------] Global test environment tear-down [==========] 10 tests from 1 test suite ran. (1083 ms total) [ PASSED ] 10 tests. ThreadSanitizer: reported 1 warnings [ RUN ] TraceEventDataSourceTest.TaskExecutionEvent [ OK ] TraceEventDataSourceTest.TaskExecutionEvent (12 ms) ================================================================================