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

Test 'TraceEventDataSourceTest.EventWithDoubleArgs' completed with the following status(es): 'FAILURE_ON_EXIT','SUCCESS' Test 'TraceEventDataSourceTest.EventWithDoubleArgs' had the following logs when run: ================================================================================ [ RUN ] TraceEventDataSourceTest.EventWithDoubleArgs [ OK ] TraceEventDataSourceTest.EventWithDoubleArgs (6 ms) [ RUN ] TraceEventDataSourceTest.EventWithPointerArgs [ OK ] TraceEventDataSourceTest.EventWithPointerArgs (7 ms) [ RUN ] TraceEventDataSourceTest.EventWithConvertableArgs [ OK ] TraceEventDataSourceTest.EventWithConvertableArgs (6 ms) [ RUN ] TraceEventDataSourceTest.TaskExecutionEvent [ OK ] TraceEventDataSourceTest.TaskExecutionEvent (10 ms) [ RUN ] TraceEventDataSourceTest.TaskExecutionEventWithoutFunction [ OK ] TraceEventDataSourceTest.TaskExecutionEventWithoutFunction (7 ms) [ RUN ] TraceEventDataSourceTest.UpdateDurationOfCompleteEvent ================== WARNING: ThreadSanitizer: data race (pid=16336) Atomic read of size 1 at 0x55e08a325958 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:4134:3 (services_unittests+0x1af1396) #1 base::internal::LockImpl::Lock() base/synchronization/lock_impl_posix.cc:102:12 (services_unittests+0x44d13cd) #2 Acquire base/synchronization/lock.h:31:26 (services_unittests+0x4829a78) #3 BasicAutoLock base/synchronization/lock_impl.h:84 (services_unittests+0x4829a78) #4 tracing::TraceEventDataSource::CreateThreadLocalEventSink(bool) services/tracing/public/cpp/perfetto/trace_event_data_source.cc:393 (services_unittests+0x4829a78) #5 tracing::TraceEventDataSource::OnAddTraceEvent(base::trace_event::TraceEvent*, bool, base::trace_event::TraceEventHandle*) services/tracing/public/cpp/perfetto/trace_event_data_source.cc:472:24 (services_unittests+0x48289cc) #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+0x44a6493) #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+0x44a86e5) #8 AddTraceEventWithThreadIdAndTimestamp<const char *, const char *> base/trace_event/trace_event.h:873:10 (services_unittests+0x447ec80) #9 AddTraceEvent<const char *, const char *> base/trace_event/trace_event.h:942 (services_unittests+0x447ec80) #10 base::ScopedBlockingCall::ScopedBlockingCall(base::Location const&, base::BlockingType) base/threading/scoped_blocking_call.cc:77 (services_unittests+0x447ec80) #11 base::DirectoryExists(base::FilePath const&) base/files/file_util_posix.cc:487:22 (services_unittests+0x44ca9ea) #12 base::(anonymous namespace)::SetThreadCgroupForThreadPriority(int, base::FilePath const&, base::ThreadPriority) base/threading/platform_thread_linux.cc:67:8 (services_unittests+0x447e082) #13 SetThreadCgroupsForThreadPriority base/threading/platform_thread_linux.cc:76:3 (services_unittests+0x447deb3) #14 base::internal::SetCurrentThreadPriorityForPlatform(base::ThreadPriority) base/threading/platform_thread_linux.cc:116 (services_unittests+0x447deb3) #15 base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority) base/threading/platform_thread_posix.cc:309:7 (services_unittests+0x44d58c7) #16 base::PlatformThread::SetCurrentThreadPriority(base::ThreadPriority) base/threading/platform_thread.cc:32:5 (services_unittests+0x447dd92) #17 base::(anonymous namespace)::ThreadFunc(void*) base/threading/platform_thread_posix.cc:73:5 (services_unittests+0x44d5925) Previous write of size 1 at 0x55e08a325958 by main thread: #0 pthread_mutex_destroy /b/swarming/w/ir/k/src/third_party/llvm/compiler-rt/lib/tsan/rtl/tsan_interceptors.cc:1251:3 (services_unittests+0x1ad48a6) #1 base::internal::LockImpl::~LockImpl() base/synchronization/lock_impl_posix.cc:79:12 (services_unittests+0x44d1329) #2 ~Lock base/synchronization/lock.h:26:12 (services_unittests+0x48287da) #3 tracing::TraceEventDataSource::~TraceEventDataSource() services/tracing/public/cpp/perfetto/trace_event_data_source.cc:209 (services_unittests+0x48287da) #4 tracing::TraceEventDataSource::ResetForTesting() services/tracing/public/cpp/perfetto/trace_event_data_source.cc:198:42 (services_unittests+0x4828516) #5 CreateTraceEventDataSource services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:208:5 (services_unittests+0x2379778) #6 tracing::(anonymous namespace)::TraceEventDataSourceTest_UpdateDurationOfCompleteEvent_Test::TestBody() services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:804 (services_unittests+0x2379778) #7 HandleExceptionsInMethodIfSupported<testing::Test, void> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2dd0dff) #8 testing::Test::Run() third_party/googletest/src/googletest/src/gtest.cc:2512 (services_unittests+0x2dd0dff) #9 testing::TestInfo::Run() third_party/googletest/src/googletest/src/gtest.cc:2688:11 (services_unittests+0x2dd1f78) #10 testing::TestSuite::Run() third_party/googletest/src/googletest/src/gtest.cc:2818:28 (services_unittests+0x2dd2b56) #11 testing::internal::UnitTestImpl::RunAllTests() third_party/googletest/src/googletest/src/gtest.cc:5276:44 (services_unittests+0x2de4fd6) #12 HandleExceptionsInMethodIfSupported<testing::internal::UnitTestImpl, bool> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2de4439) #13 testing::UnitTest::Run() third_party/googletest/src/googletest/src/gtest.cc:4864 (services_unittests+0x2de4439) #14 RUN_ALL_TESTS third_party/googletest/src/googletest/include/gtest/gtest.h:2448:46 (services_unittests+0x5de7392) #15 base::TestSuite::Run() base/test/test_suite.cc:316 (services_unittests+0x5de7392) #16 Invoke<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:499:12 (services_unittests+0x1fdba18) #17 MakeItSo<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:599 (services_unittests+0x1fdba18) #18 RunImpl<int (base::TestSuite::*)(), std::__1::tuple<base::internal::UnretainedWrapper<(anonymous namespace)::ServiceTestSuite> >, 0> base/bind_internal.h:672 (services_unittests+0x1fdba18) #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+0x1fdba18) #20 Run base/callback.h:97:12 (services_unittests+0x5df092d) #21 base::(anonymous namespace)::LaunchUnitTestsInternal(base::OnceCallback<int ()>, unsigned long, int, bool, base::OnceCallback<void ()>) base/test/launcher/unit_test_launcher.cc:225 (services_unittests+0x5df092d) #22 base::LaunchUnitTests(int, char**, base::OnceCallback<int ()>) base/test/launcher/unit_test_launcher.cc:575:10 (services_unittests+0x5df0790) #23 main services/test/run_all_unittests.cc:97:10 (services_unittests+0x1fdb64f) Location is global 'tracing::TraceEventDataSource::GetInstance()::instance' of size 152 at 0x55e08a325918 (services_unittests+0x00000989f958) Thread T8 (tid=16427, 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:976:3 (services_unittests+0x1ad305b) #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+0x44d54d7) #2 base::PlatformThread::CreateWithPriority(unsigned long, base::PlatformThread::Delegate*, base::PlatformThreadHandle*, base::ThreadPriority) base/threading/platform_thread_posix.cc:246:10 (services_unittests+0x44d53d5) #3 base::internal::SchedulerWorker::Start(base::SchedulerWorkerObserver*) base/task/thread_pool/scheduler_worker.cc:79:3 (services_unittests+0x446d71d) #4 operator() base/task/thread_pool/scheduler_worker_pool_impl.cc:186:15 (services_unittests+0x446c23b) #5 ForEachWorker<(lambda at ../../base/task/thread_pool/scheduler_worker_pool_impl.cc:185:37)> base/task/thread_pool/scheduler_worker_pool_impl.cc:151 (services_unittests+0x446c23b) #6 base::internal::SchedulerWorkerPoolImpl::ScopedWorkersExecutor::FlushImpl() base/task/thread_pool/scheduler_worker_pool_impl.cc:185 (services_unittests+0x446c23b) #7 base::internal::SchedulerWorkerPoolImpl::ScopedWorkersExecutor::~ScopedWorkersExecutor() base/task/thread_pool/scheduler_worker_pool_impl.cc:104:30 (services_unittests+0x4468ce4) #8 base::internal::SchedulerWorkerPoolImpl::Start(base::SchedulerWorkerPoolParams const&, int, scoped_refptr<base::TaskRunner>, base::SchedulerWorkerObserver*, base::internal::SchedulerWorkerPool::WorkerEnvironment, base::Optional<base::TimeDelta>) base/task/thread_pool/scheduler_worker_pool_impl.cc:427:1 (services_unittests+0x4468c92) #9 base::internal::ThreadPoolImpl::Start(base::ThreadPool::InitParams const&, base::SchedulerWorkerObserver*) base/task/thread_pool/thread_pool_impl.cc:175:23 (services_unittests+0x445c9f8) #10 base::test::ScopedTaskEnvironment::ScopedTaskEnvironment(base::test::ScopedTaskEnvironment::MainThreadType, base::test::ScopedTaskEnvironment::ExecutionMode, base::test::ScopedTaskEnvironment::NowSource, bool, base::trait_helpers::NotATraitTag) base/test/scoped_task_environment.cc:377:30 (services_unittests+0x5de1de9) #11 base::test::ScopedTaskEnvironment::ScopedTaskEnvironment<void>() base/test/scoped_task_environment.h:143:9 (services_unittests+0x1b44985) #12 TraceEventDataSourceTest services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:179:7 (services_unittests+0x2379693) #13 TraceEventDataSourceTest_UpdateDurationOfCompleteEvent_Test services/tracing/public/cpp/perfetto/trace_event_data_source_unittest.cc:803 (services_unittests+0x2379693) #14 testing::internal::TestFactoryImpl<tracing::(anonymous namespace)::TraceEventDataSourceTest_UpdateDurationOfCompleteEvent_Test>::CreateTest() third_party/googletest/src/googletest/include/gtest/internal/gtest-internal.h:460 (services_unittests+0x2379693) #15 HandleExceptionsInMethodIfSupported<testing::internal::TestFactoryBase, testing::Test *> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2dd1dcf) #16 testing::TestInfo::Run() third_party/googletest/src/googletest/src/gtest.cc:2678 (services_unittests+0x2dd1dcf) #17 testing::TestSuite::Run() third_party/googletest/src/googletest/src/gtest.cc:2818:28 (services_unittests+0x2dd2b56) #18 testing::internal::UnitTestImpl::RunAllTests() third_party/googletest/src/googletest/src/gtest.cc:5276:44 (services_unittests+0x2de4fd6) #19 HandleExceptionsInMethodIfSupported<testing::internal::UnitTestImpl, bool> third_party/googletest/src/googletest/src/gtest.cc (services_unittests+0x2de4439) #20 testing::UnitTest::Run() third_party/googletest/src/googletest/src/gtest.cc:4864 (services_unittests+0x2de4439) #21 RUN_ALL_TESTS third_party/googletest/src/googletest/include/gtest/gtest.h:2448:46 (services_unittests+0x5de7392) #22 base::TestSuite::Run() base/test/test_suite.cc:316 (services_unittests+0x5de7392) #23 Invoke<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:499:12 (services_unittests+0x1fdba18) #24 MakeItSo<int (base::TestSuite::*)(), (anonymous namespace)::ServiceTestSuite *> base/bind_internal.h:599 (services_unittests+0x1fdba18) #25 RunImpl<int (base::TestSuite::*)(), std::__1::tuple<base::internal::UnretainedWrapper<(anonymous namespace)::ServiceTestSuite> >, 0> base/bind_internal.h:672 (services_unittests+0x1fdba18) #26 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+0x1fdba18) #27 Run base/callback.h:97:12 (services_unittests+0x5df092d) #28 base::(anonymous namespace)::LaunchUnitTestsInternal(base::OnceCallback<int ()>, unsigned long, int, bool, base::OnceCallback<void ()>) base/test/launcher/unit_test_launcher.cc:225 (services_unittests+0x5df092d) #29 base::LaunchUnitTests(int, char**, base::OnceCallback<int ()>) base/test/launcher/unit_test_launcher.cc:575:10 (services_unittests+0x5df0790) #30 main services/test/run_all_unittests.cc:97:10 (services_unittests+0x1fdb64f) SUMMARY: ThreadSanitizer: data race base/synchronization/lock_impl_posix.cc:102:12 in base::internal::LockImpl::Lock() ================== [ OK ] TraceEventDataSourceTest.UpdateDurationOfCompleteEvent (754 ms) [ RUN ] TraceEventDataSourceTest.InternedStrings [ OK ] TraceEventDataSourceTest.InternedStrings (10 ms) [----------] 10 tests from TraceEventDataSourceTest (829 ms total) [----------] Global test environment tear-down [==========] 10 tests from 1 test suite ran. (831 ms total) [ PASSED ] 10 tests. ThreadSanitizer: reported 1 warnings [ RUN ] TraceEventDataSourceTest.EventWithDoubleArgs [ OK ] TraceEventDataSourceTest.EventWithDoubleArgs (12 ms) ================================================================================