Profile compiling with clang -ftime-trace flag

Open timosachsenberg opened this issue 5 years ago • 2 comments

Might reveal some bottlenecks. "Clang 9 (and newer) has a -ftime-trace flag, which makes it output a profiling report as JSON (in addition to an object file). You can import this file into a profiler that comes with Chrome (chrome://tracing) to get a nice visualisation"

Nov 20 '20 15:11 timosachsenberg

To do this I used (adapt as needed)

export CC=/usr/bin/clang
export CXX=/usr/bin/clang++
cmake -G Ninja -DGIT_TRACKING=Off -DMY_CXX_FLAGS="-ftime-trace" -DENABLE_UPDATE_CHECK=Off -DCMAKE_BUILD_TYPE=Release -DOPENMS_CONTRIB_LIBS="/buffer/ag_bsc/pmsb/contrib_build" -DBOOST_USE_STATIC=OFF -DQt5_DIR=/buffer/ag_bsc/pmsb/qt/5.9.7/gcc_64/lib/cmake/Qt5 ../openms
ninja

With this, you can inspect individual json files for each compilation unit. To get a summary, https://github.com/aras-p/ClangBuildAnalyzer comes in very handy:

./ClangBuildAnalyzer --all <path> openms.capture
./ClangBuildAnalyzer --analyze openms.capture > openms.capture.log

here is the output, and yes, there are some bottlenecks :)

Analyzing build trace from 'openms.capture'...
**** Time summary:
Compilation (3404 times):
  Parsing (frontend):         8886.9 s
  Codegen & opts (backend):   2708.9 s

**** Files that took longest to parse (compiler frontend):
 20729 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/ANALYSIS/ID/IDBoostGraph.cpp.o
 19745 ms: /buffer/ag_bsc/build/openms_build_tmp//src/utils/CMakeFiles/ProteomicsLFQ.dir/ProteomicsLFQ.cpp.o
 17955 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/ANALYSIS/ID/BayesianProteinInferenceAlgorithm.cpp.o
 16933 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/ANALYSIS/ID/FalseDiscoveryRate.cpp.o
 16271 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/ANALYSIS/ID/SiriusAdapterAlgorithm.cpp.o
 15291 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/ANALYSIS/ID/BasicProteinInferenceAlgorithm.cpp.o
 14330 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/TRANSFORMATIONS/FEATUREFINDER/LevMarqFitter1D.cpp.o
 13785 ms: /buffer/ag_bsc/build/openms_build_tmp//src/utils/CMakeFiles/MetaProSIP.dir/MetaProSIP.cpp.o
 13769 ms: /buffer/ag_bsc/build/openms_build_tmp//src/tests/class_tests/openms/CMakeFiles/IsotopeWaveletTransform_test.dir/source/IsotopeWaveletTransform_test.cpp.o
 13677 ms: /buffer/ag_bsc/build/openms_build_tmp//src/utils/CMakeFiles/NucleicAcidSearchEngine.dir/NucleicAcidSearchEngine.cpp.o

**** Files that took longest to codegen (compiler backend):
 60821 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/ANALYSIS/ID/BayesianProteinInferenceAlgorithm.cpp.o
 33484 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/FORMAT/MzTabFile.cpp.o
 20889 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/FORMAT/MzTab.cpp.o
 20381 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/FORMAT/HANDLERS/MzIdentMLHandler.cpp.o
 19059 ms: /buffer/ag_bsc/build/openms_build_tmp//src/utils/CMakeFiles/NucleicAcidSearchEngine.dir/NucleicAcidSearchEngine.cpp.o
 18656 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/METADATA/ID/IdentificationDataConverter.cpp.o
 17975 ms: /buffer/ag_bsc/build/openms_build_tmp//src/utils/CMakeFiles/RNPxlSearch.dir/RNPxlSearch.cpp.o
 16846 ms: /buffer/ag_bsc/build/openms_build_tmp//src/utils/CMakeFiles/MetaProSIP.dir/MetaProSIP.cpp.o
 16628 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/FORMAT/MzTabM.cpp.o
 15865 ms: /buffer/ag_bsc/build/openms_build_tmp//src/openms/CMakeFiles/OpenMS.dir/source/TRANSFORMATIONS/FEATUREFINDER/FeatureFinderIdentificationAlgorithm.cpp.o

**** Templates that took longest to instantiate:
 63286 ms: std::stable_sort<__gnu_cxx::__normal_iterator<OpenMS::PeptideHit::Pe... (969 times, avg 65 ms)
 62937 ms: std::__stable_sort<__gnu_cxx::__normal_iterator<OpenMS::PeptideHit::... (969 times, avg 64 ms)
 56126 ms: std::vector<OpenMS::DataArrays::FloatDataArray, std::allocator<OpenM... (827 times, avg 67 ms)
 40391 ms: std::operator<<const OpenMS::IdentificationDataInternal::MoleculeTyp... (513 times, avg 78 ms)
 40220 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 78 ms)
 38087 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 74 ms)
 36164 ms: std::tie<const OpenMS::IdentificationDataInternal::MoleculeType, con... (513 times, avg 70 ms)
 35977 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 70 ms)
 34789 ms: std::vector<OpenMS::MSSpectrum, std::allocator<OpenMS::MSSpectrum>>:... (736 times, avg 47 ms)
 34609 ms: boost::basic_regex<char, boost::regex_traits<char, boost::cpp_regex_... (50 times, avg 692 ms)
 34369 ms: std::vector<OpenMS::MSSpectrum, std::allocator<OpenMS::MSSpectrum>>:... (736 times, avg 46 ms)
 33703 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 65 ms)
 31427 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 61 ms)
 30395 ms: std::vector<OpenMS::DataArrays::IntegerDataArray, std::allocator<Ope... (827 times, avg 36 ms)
 29212 ms: std::map<OpenMS::String, std::vector<OpenMS::String, std::allocator<... (817 times, avg 35 ms)
 29095 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 56 ms)
 28874 ms: boost::multi_index::multi_index_container<OpenMS::IdentificationData... (517 times, avg 55 ms)
 28292 ms: std::set<unsigned long, std::less<unsigned long>, std::allocator<uns... (888 times, avg 31 ms)
 27612 ms: std::unordered_map<int, int, std::hash<int>, std::equal_to<int>, std... (1624 times, avg 17 ms)
 27078 ms: boost::multi_index::multi_index_container<OpenMS::IdentificationData... (513 times, avg 52 ms)
 26648 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 51 ms)
 26295 ms: std::map<std::vector<OpenMS::String, std::allocator<OpenMS::String>>... (810 times, avg 32 ms)
 26024 ms: std::copy<__gnu_cxx::__normal_iterator<const OpenMS::DataArrays::Flo... (762 times, avg 34 ms)
 25337 ms: std::__copy_move_a<false, __gnu_cxx::__normal_iterator<const OpenMS:... (762 times, avg 33 ms)
 25087 ms: boost::multi_index::detail::sequenced_index<boost::multi_index::deta... (515 times, avg 48 ms)
 25073 ms: std::_Temporary_buffer<__gnu_cxx::__normal_iterator<OpenMS::PeptideH... (969 times, avg 25 ms)
 24170 ms: boost::multi_index::detail::sequenced_index<boost::multi_index::deta... (515 times, avg 46 ms)
 24130 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (513 times, avg 47 ms)
 23978 ms: std::vector<OpenMS::DataArrays::FloatDataArray, std::allocator<OpenM... (758 times, avg 31 ms)
 23552 ms: std::vector<OpenMS::MSSpectrum, std::allocator<OpenMS::MSSpectrum>>:... (738 times, avg 31 ms)

**** Template sets that took longest to instantiate:
330451 ms: std::__and_<$> (214719 times, avg 1 ms)
213081 ms: std::vector<$> (58209 times, avg 3 ms)
210423 ms: std::__or_<$> (221571 times, avg 0 ms)
153809 ms: std::map<$> (20439 times, avg 7 ms)
143072 ms: boost::multi_index::multi_index_container<$> (5138 times, avg 27 ms)
126620 ms: std::_Rb_tree<$> (32118 times, avg 3 ms)
122972 ms: std::pair<$> (31537 times, avg 3 ms)
114717 ms: std::_Vector_base<$> (57905 times, avg 1 ms)
110763 ms: std::__uninitialized_copy_a<$> (17442 times, avg 6 ms)
106927 ms: std::uninitialized_copy<$> (17346 times, avg 6 ms)
105474 ms: boost::multi_index::multi_index_container<$>::multi_index_container (9756 times, avg 10 ms)
101268 ms: std::tie<$> (4730 times, avg 21 ms)
100680 ms: std::_Rb_tree<$>::_M_erase (14951 times, avg 6 ms)
 99083 ms: std::vector<$>::vector (11485 times, avg 8 ms)
 97712 ms: std::allocator<$> (119415 times, avg 0 ms)
 93757 ms: std::copy<$> (13973 times, avg 6 ms)
 91217 ms: std::_Rb_tree<$>::~_Rb_tree (10881 times, avg 8 ms)
 90352 ms: std::tuple<$> (9937 times, avg 9 ms)
 88392 ms: std::__copy_move_a<$> (16453 times, avg 5 ms)
 85183 ms: std::_Hashtable<$> (8002 times, avg 10 ms)
 82544 ms: std::is_convertible<$> (118852 times, avg 0 ms)
 82123 ms: std::_Destroy<$> (33003 times, avg 2 ms)
 80266 ms: std::unordered_map<$> (4779 times, avg 16 ms)
 79657 ms: std::__uninitialized_copy<$>::__uninit_copy<$> (14599 times, avg 5 ms)
 78183 ms: std::_Rb_tree<$>::_Rb_tree (5075 times, avg 15 ms)
 74155 ms: std::set<$> (11587 times, avg 6 ms)
 72054 ms: std::is_nothrow_default_constructible<$> (38483 times, avg 1 ms)
 69884 ms: std::_Rb_tree<$>::_M_emplace_hint_unique<$> (3179 times, avg 21 ms)
 69802 ms: std::allocator_traits<$>::construct<$> (16322 times, avg 4 ms)
 69610 ms: std::__tuple_compare<$>::__less (3270 times, avg 21 ms)

**** Functions that took longest to compile:
  8603 ms: OpenMS::MzTabFile::load(OpenMS::String const&, OpenMS::MzTab&) (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/MzTabFile.cpp)
  5765 ms: OpenMS::ToolHandler::getTOPPToolList(bool) (/buffer/ag_bsc/build/openms/src/openms/source/APPLICATIONS/ToolHandler.cpp)
  5116 ms: OpenMS::OpenSwathTSVWriter::prepareLine(OpenSwath::LightCompound con... (/buffer/ag_bsc/build/openms/src/openms/source/ANALYSIS/OPENSWATH/OpenSwathTSVWriter.cpp)
  4208 ms: OpenMS::QcMLFile::collectQCData(std::vector<OpenMS::ProteinIdentific... (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/QcMLFile.cpp)
  4145 ms: OpenMS::MzTabFile::generateMzTabMetaDataSection_(OpenMS::MzTabMetaDa... (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/MzTabFile.cpp)
  3632 ms: OpenMS::MzTabMFile::generateMzTabMMetaDataSection_(OpenMS::MzTabMMet... (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/MzTabMFile.cpp)
  3152 ms: OpenMS::Internal::MzQuantMLHandler::writeTo(std::ostream&) (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/HANDLERS/MzQuantMLHandler.cpp)
  3147 ms: OpenMS::ToolHandler::getUtilList() (/buffer/ag_bsc/build/openms/src/openms/source/APPLICATIONS/ToolHandler.cpp)
  3061 ms: OpenMS::Internal::MzIdentMLHandler::writeXLMSPeptideHit(OpenMS::Pept... (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/HANDLERS/MzIdentMLHandler.cpp)
  3021 ms: TOPPFileInfo::outputTo_(std::ostream&, std::ostream&) (/buffer/ag_bsc/build/openms/src/topp/FileInfo.cpp)
  2827 ms: TOPPOMSSAAdapter::main_(int, char const**) (/buffer/ag_bsc/build/openms/src/topp/OMSSAAdapter.cpp)
  2701 ms: OpenMS::Internal::MzIdentMLHandler::writeTo(std::ostream&) (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/HANDLERS/MzIdentMLHandler.cpp)
  2654 ms: OpenMS::Internal::MzMLHandler::handleCVParam_(OpenMS::String const&,... (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/HANDLERS/MzMLHandler.cpp)
  2632 ms: OpenMS::MzTabM::exportFeatureMapToMzTabM(OpenMS::FeatureMap const&) (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/MzTabM.cpp)
  2459 ms: OpenMS::SvmTheoreticalSpectrumGeneratorTrainer::trainModel(OpenMS::M... (/buffer/ag_bsc/build/openms/src/openms/source/CHEMISTRY/SvmTheoreticalSpectrumGeneratorTrainer.cpp)
  2361 ms: OpenMS::Internal::MzIdentMLDOMHandler::parseSpectrumIdentificationIt... (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/HANDLERS/MzIdentMLDOMHandler.cpp)
  2310 ms: OpenMS::TOPPTextExporter::main_(int, char const**) (/buffer/ag_bsc/build/openms/src/topp/TextExporter.cpp)
  2224 ms: OpenMS::ResidueDB::buildResidues_() (/buffer/ag_bsc/build/openms/src/openms/source/CHEMISTRY/ResidueDB.cpp)
  2118 ms: OpenMS::OpenSwathOSWWriter::prepareLine(OpenSwath::LightCompound con... (/buffer/ag_bsc/build/openms/src/openms/source/ANALYSIS/OPENSWATH/OpenSwathOSWWriter.cpp)
  1973 ms: OpenMS::SvmTheoreticalSpectrumGeneratorTrainer::SvmTheoreticalSpectr... (/buffer/ag_bsc/build/openms/src/openms/source/CHEMISTRY/SvmTheoreticalSpectrumGeneratorTrainer.cpp)
  1922 ms: OpenMS::ElementDB::storeElements_() (/buffer/ag_bsc/build/openms/src/openms/source/CHEMISTRY/ElementDB.cpp)
  1910 ms: OpenMS::MRMFeatureFinderScoring::MRMFeatureFinderScoring() (/buffer/ag_bsc/build/openms/src/openms/source/ANALYSIS/OPENSWATH/MRMFeatureFinderScoring.cpp)
  1907 ms: OpenMS::FeatureDeconvolution::compute(OpenMS::FeatureMap const&, Ope... (/buffer/ag_bsc/build/openms/src/openms/source/ANALYSIS/DECHARGING/FeatureDeconvolution.cpp)
  1869 ms: TOPPFileFilter::main_(int, char const**) (/buffer/ag_bsc/build/openms/src/topp/FileFilter.cpp)
  1854 ms: PercolatorAdapter::main_(int, char const**) (/buffer/ag_bsc/build/openms/src/topp/PercolatorAdapter.cpp)
  1842 ms: MetaProSIP::main_(int, char const**) (/buffer/ag_bsc/build/openms/src/utils/MetaProSIP.cpp)
  1739 ms: OpenMS::OpenPepXLAlgorithm::run(OpenMS::MSExperiment&, OpenMS::Conse... (/buffer/ag_bsc/build/openms/src/openms/source/ANALYSIS/XLMS/OpenPepXLAlgorithm.cpp)
  1703 ms: .omp_outlined..329 (/buffer/ag_bsc/build/openms/src/utils/RNPxlSearch.cpp)
  1693 ms: OpenMS::Internal::XQuestResultXMLHandler::writeTo(std::ostream&) (/buffer/ag_bsc/build/openms/src/openms/source/FORMAT/HANDLERS/XQuestResultXMLHandler.cpp)
  1615 ms: TOPPRTModel::main_(int, char const**) (/buffer/ag_bsc/build/openms/src/topp/RTModel.cpp)

**** Function sets that took longest to compile / optimize:
 17550 ms: boost::re_detail_107400::basic_regex_parser<$>::parse_perl_extension() (56 times, avg 313 ms)
 16952 ms: std::vector<$>::vector(std::vector<$> const&) (4225 times, avg 4 ms)
 13092 ms: std::_Rb_tree<$>::_M_erase(std::_Rb_tree_node<$>*) (2844 times, avg 4 ms)
 12854 ms: std::vector<$>::~vector() (9941 times, avg 1 ms)
 12117 ms: std::_Rb_tree_node<$>* std::_Rb_tree<$>::_M_copy<$>(std::_Rb_tree_no... (1435 times, avg 8 ms)
 11503 ms: void std::vector<$>::_M_range_insert<$>(__gnu_cxx::__normal_iterator... (319 times, avg 36 ms)
  9905 ms: Eigen::internal::general_matrix_vector_product<$>::run(long, long, E... (102 times, avg 97 ms)
  8570 ms: boost::re_detail_107400::basic_regex_creator<$>::append_set(boost::r... (112 times, avg 76 ms)
  8476 ms: std::_Rb_tree_iterator<$> std::_Rb_tree<$>::_M_emplace_hint_unique<$... (932 times, avg 9 ms)
  7129 ms: std::_Vector_base<$>::~_Vector_base() (10130 times, avg 0 ms)
  6423 ms: boost::re_detail_107400::basic_regex_creator<$>::create_startmap(boo... (56 times, avg 114 ms)
  6415 ms: std::_Rb_tree<$>::_M_get_insert_hint_unique_pos(std::_Rb_tree_const_... (333 times, avg 19 ms)
  6286 ms: std::_Rb_tree_node<$>* std::_Rb_tree<$>::_M_copy<$>(std::_Rb_tree_no... (550 times, avg 11 ms)
  6155 ms: std::_Rb_tree<$>::_M_get_insert_unique_pos(OpenMS::String const&) (495 times, avg 12 ms)
  6063 ms: std::vector<$>::_M_default_append(unsigned long) (405 times, avg 14 ms)
  6017 ms: boost::re_detail_107400::basic_regex_parser<$>::parse_extended_escap... (56 times, avg 107 ms)
  5470 ms: OpenMS::String* std::__uninitialized_copy<$>::__uninit_copy<$>(__gnu... (445 times, avg 12 ms)
  4917 ms: void OpenMS::SpectrumAlignment::getSpectrumAlignment<$>(std::vector<... (22 times, avg 223 ms)
  4646 ms: boost::re_detail_107400::basic_regex_parser<$>::parse_repeat_range(b... (56 times, avg 82 ms)
  4625 ms: std::_Rb_tree<$>::_M_get_insert_hint_unique_pos(std::_Rb_tree_const_... (244 times, avg 18 ms)
  4428 ms: __gnu_cxx::new_allocator<$>::allocate(unsigned long, void const*) (6897 times, avg 0 ms)
  4311 ms: void std::__final_insertion_sort<$>(__gnu_cxx::__normal_iterator<$>,... (111 times, avg 38 ms)
  4260 ms: void std::vector<$>::_M_realloc_insert<$>(__gnu_cxx::__normal_iterat... (144 times, avg 29 ms)
  4232 ms: OpenMS::QcMLFile::collectQCData(std::vector<$>&, std::vector<$>&, Op... (2 times, avg 2116 ms)
  4158 ms: OpenMS::MzTabFile::generateMzTabMetaDataSection_(OpenMS::MzTabMetaDa... (2 times, avg 2079 ms)
  3984 ms: std::allocator_traits<$>::allocate(std::allocator<$>&, unsigned long) (6621 times, avg 0 ms)
  3853 ms: boost::re_detail_107400::basic_regex_parser<$>::parse_perl_verb() (56 times, avg 68 ms)
  3750 ms: std::_Vector_base<$>::_Vector_base(unsigned long, std::allocator<$> ... (4282 times, avg 0 ms)
  3647 ms: OpenMS::MzTabMFile::generateMzTabMMetaDataSection_(OpenMS::MzTabMMet... (2 times, avg 1823 ms)
  3640 ms: void std::vector<$>::_M_realloc_insert<$>(__gnu_cxx::__normal_iterat... (186 times, avg 19 ms)

*** Expensive headers:
2100330 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/KERNEL/BaseFeature.h (included 508 times, avg 4134 ms), included via:
  SiriusMSConverter.cpp.o SiriusMSConverter.h FeatureMapping.h  (6614 ms)
  MultiplexFilteringCentroided.cpp.o  (6608 ms)
  AssayGeneratorMetabo.cpp.o SiriusAdapterAlgorithm.h FeatureMapping.h  (6434 ms)
  SiriusAdapterAlgorithm.cpp.o SiriusAdapterAlgorithm.h FeatureMapping.h  (6381 ms)
  FeatureMapping.cpp.o FeatureMapping.h  (6362 ms)
  BaseFeature.cpp.o  (6335 ms)
  ...

2033484 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/METADATA/ID/IdentificationData.h (included 513 times, avg 3963 ms), included via:
  IdentificationDataConverter.cpp.o IdentificationDataConverter.h  (6213 ms)
  IdentificationData.cpp.o  (6120 ms)
  RNPxlSearch.cpp.o FalseDiscoveryRate.h  (5678 ms)
  IDScoreGetterSetter.cpp.o IDScoreGetterSetter.h  (5637 ms)
  FalseDiscoveryRate.cpp.o FalseDiscoveryRate.h  (5373 ms)
  DBSuitability.cpp.o FalseDiscoveryRate.h  (5372 ms)
  ...

1220671 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/KERNEL/Feature.h (included 403 times, avg 3028 ms), included via:
  MetaboliteFeatureDeconvolution.cpp.o MetaboliteFeatureDeconvolution.h FeatureMap.h  (6642 ms)
  MapAlignmentAlgorithmKD.cpp.o MapAlignmentAlgorithmKD.h KDTreeFeatureMaps.h  (6639 ms)
  PrecursorIonSelection.cpp.o PrecursorIonSelection.h FeatureMap.h  (6617 ms)
  MRMFeatureFilter.cpp.o MRMFeatureFilter.h MRMFeatureQC.h MRMFeature.h  (6604 ms)
  MRMFeatureQC.cpp.o MRMFeatureQC.h MRMFeature.h  (6568 ms)
  Contaminants.cpp.o Contaminants.h FeatureMap.h  (6530 ms)
  ...

923169 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/KERNEL/FeatureMap.h (included 359 times, avg 2571 ms), included via:
  MetaboliteFeatureDeconvolution.cpp.o MetaboliteFeatureDeconvolution.h  (7100 ms)
  PrecursorIonSelection.cpp.o PrecursorIonSelection.h  (6948 ms)
  Contaminants.cpp.o Contaminants.h  (6837 ms)
  MetaProSIP.cpp.o  (6834 ms)
  OfflinePrecursorIonSelection.cpp.o OfflinePrecursorIonSelection.h  (6777 ms)
  OMSFile.cpp.o OMSFile.h  (6774 ms)
  ...

894988 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/KERNEL/ConsensusMap.h (included 298 times, avg 3003 ms), included via:
  SimplePairFinder.cpp.o SimplePairFinder.h BaseGroupFinder.h  (6974 ms)
  ConsensusMap.cpp.o  (6921 ms)
  ConsensusMapNormalizerAlgorithmMedian.cpp.o ConsensusMapNormalizerAlgorithmMedian.h  (6884 ms)
  MultiplexClustering.cpp.o  (6874 ms)
  ConsensusMapNormalizerAlgorithmQuantile.cpp.o ConsensusMapNormalizerAlgorithmQuantile.h  (6848 ms)
  QTClusterFinder.cpp.o QTClusterFinder.h BaseGroupFinder.h  (6825 ms)
  ...

808429 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/CONCEPT/ClassTest.h (included 643 times, avg 1257 ms), included via:
  ProteinResolver_test.cpp.o  (1466 ms)
  MRMRTNormalizer_test.cpp.o  (1464 ms)
  MassExplainer_test.cpp.o  (1446 ms)
  OpenSwathMRMFeatureAccessOpenMS_test.cpp.o  (1427 ms)
  PeakIntegrator_test.cpp.o  (1418 ms)
  DefaultParamHandler_test.cpp.o  (1415 ms)
  ...

806974 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/KERNEL/ConsensusFeature.h (included 303 times, avg 2663 ms), included via:
  ConsensusFeature.cpp.o  (6347 ms)
  MQEvidenceExporter.cpp.o MQEvidenceExporter.h  (5976 ms)
  IsobaricNormalizer.cpp.o IsobaricNormalizer.h  (5393 ms)
  ConsensusMap_test.cpp.o  (5350 ms)
  IsobaricNormalizer_test.cpp.o IsobaricNormalizer.h  (5107 ms)
  ConsensusFeature_test.cpp.o  (5105 ms)
  ...

712797 ms: /usr/include/boost/regex.hpp (included 877 times, avg 812 ms), included via:
  IndexedMzMLDecoder.cpp.o  (1801 ms)
  IDFilter.cpp.o IDFilter.h ProteaseDigestion.h EnzymaticDigestion.h  (1619 ms)
  DecoyGenerator.cpp.o ProteaseDigestion.h EnzymaticDigestion.h  (1616 ms)
  EnzymaticDigestion.cpp.o EnzymaticDigestion.h  (1598 ms)
  ProteaseDigestion.cpp.o ProteaseDigestion.h EnzymaticDigestion.h  (1583 ms)
  Tutorial_Enzyme.cpp.o ProteaseDigestion.h EnzymaticDigestion.h  (1274 ms)
  ...

699469 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/CHEMISTRY/EnzymaticDigestion.h (included 864 times, avg 809 ms), included via:
  EnzymaticDigestion.cpp.o  (2333 ms)
  IDFilter.cpp.o IDFilter.h ProteaseDigestion.h  (1625 ms)
  DecoyGenerator.cpp.o ProteaseDigestion.h  (1622 ms)
  ProteaseDigestion.cpp.o ProteaseDigestion.h  (1589 ms)
  Tutorial_Enzyme.cpp.o ProteaseDigestion.h  (1279 ms)
  PeptideProteinResolution.cpp.o PeptideProteinResolution.h ProteinIdentification.h  (1231 ms)
  ...

687966 ms: /buffer/ag_bsc/build/openms/src/openms/include/OpenMS/KERNEL/MSExperiment.h (included 735 times, avg 936 ms), included via:
  PeakPickerSH.cpp.o PeakPickerSH.h  (3563 ms)
  PercolatorOutfile.cpp.o PercolatorOutfile.h  (3501 ms)
  PrecursorCorrection.cpp.o PrecursorCorrection.h  (3486 ms)
  MascotInfile.cpp.o MascotInfile.h  (3472 ms)
  PeakPickerHiRes.cpp.o PeakPickerHiRes.h  (3460 ms)
  MzQCFile.cpp.o MzQCFile.h  (3459 ms)
  ...

  done in 16.3s.

Jul 01 '22 14:07 cbielow

To put the numbers into perspective: the whole build took 11600 seconds (190min).

A whopping 2033 (of 11600) seconds is simply the FrontEnd work of including IdentificationData.h (which is mainly used in BaseFeature.h). But it's not easy to get rid of :)

Jul 01 '22 14:07 cbielow

sachsenb@DESKTOP-TPBSG5G:/mnt/d/development/WSL_OpenMS/build$ ../ClangBuildAnalyzer/ClangBuildAnalyzer --all src/ all_openms
Processing all files and saving to 'all_openms'...
  done in 116.0s. Run 'ClangBuildAnalyzer --analyze all_openms' to analyze it.
sachsenb@DESKTOP-TPBSG5G:/mnt/d/development/WSL_OpenMS/build$ ../ClangBuildAnalyzer/ClangBuildAnalyzer --analyze all_openms
Analyzing build trace from 'all_openms'...
**** Time summary:
Compilation (3429 times):
  Parsing (frontend):        12485.1 s
  Codegen & opts (backend):   5685.1 s

**** Files that took longest to parse (compiler frontend):
 41944 ms: src//tests/class_tests/openms/CMakeFiles/MSSim_test.dir/source/MSSim_test.cpp.o
 38194 ms: src//tests/class_tests/openms/CMakeFiles/EmgScoring_test.dir/source/EmgScoring_test.cpp.o
 37696 ms: src//tests/class_tests/openms/CMakeFiles/IonizationSimulation_test.dir/source/IonizationSimulation_test.cpp.o
 37034 ms: src//tests/class_tests/openms/CMakeFiles/DetectabilitySimulation_test.dir/source/DetectabilitySimulation_test.cpp.o
 34170 ms: src//tests/class_tests/openms/CMakeFiles/RTSimulation_test.dir/source/RTSimulation_test.cpp.o
 32742 ms: src//tests/class_tests/openms/CMakeFiles/EGHFitter1D_test.dir/source/EGHFitter1D_test.cpp.o
 32246 ms: src//tests/class_tests/openms/CMakeFiles/IsotopeFitter1D_test.dir/source/IsotopeFitter1D_test.cpp.o
 30978 ms: src//tests/class_tests/openms/CMakeFiles/IsotopeWaveletTransform_test.dir/source/IsotopeWaveletTransform_test.cpp.o
 30737 ms: src//tests/class_tests/openms/CMakeFiles/FeatureFinderIdentificationAlgorithm_test.dir/source/FeatureFinderIdentificationAlgorithm_test.cpp.o
 30257 ms: src//tests/class_tests/openms/CMakeFiles/IDBoostGraph_test.dir/source/IDBoostGraph_test.cpp.o

**** Files that took longest to codegen (compiler backend):
 69984 ms: src//openms/CMakeFiles/OpenMS.dir/source/ANALYSIS/ID/BayesianProteinInferenceAlgorithm.cpp.o
 53797 ms: src//tests/class_tests/openms/CMakeFiles/Param_test.dir/source/Param_test.cpp.o
 49699 ms: src//tests/class_tests/openms/CMakeFiles/TheoreticalSpectrumGenerator_test.dir/source/TheoreticalSpectrumGenerator_test.cpp.o
 42456 ms: src//tests/class_tests/openms/CMakeFiles/TheoreticalSpectrumGeneratorXLMS_test.dir/source/TheoreticalSpectrumGeneratorXLMS_test.cpp.o
 37117 ms: src//utils/CMakeFiles/NucleicAcidSearchEngine.dir/NucleicAcidSearchEngine.cpp.o
 35142 ms: src//utils/CMakeFiles/RNPxlSearch.dir/RNPxlSearch.cpp.o
 33375 ms: src//openms/CMakeFiles/OpenMS.dir/source/FORMAT/MzTabFile.cpp.o
 32297 ms: src//utils/CMakeFiles/MetaProSIP.dir/MetaProSIP.cpp.o
 31772 ms: src//tests/class_tests/openms/CMakeFiles/MRMFeatureFilter_test.dir/source/MRMFeatureFilter_test.cpp.o
 26751 ms: src//tests/class_tests/openms/CMakeFiles/AbsoluteQuantitation_test.dir/source/AbsoluteQuantitation_test.cpp.o

**** Templates that took longest to instantiate:
 66622 ms: std::stable_sort<__gnu_cxx::__normal_iterator<OpenMS::PeptideHit::Pe... (994 times, avg 67 ms)
 66205 ms: std::__stable_sort<__gnu_cxx::__normal_iterator<OpenMS::PeptideHit::... (994 times, avg 66 ms)
 60635 ms: std::vector<OpenMS::DataArrays::FloatDataArray, std::allocator<OpenM... (854 times, avg 71 ms)
 45611 ms: std::operator<<const OpenMS::IdentificationDataInternal::MoleculeTyp... (539 times, avg 84 ms)
 45445 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 84 ms)
 42943 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 79 ms)
 40560 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 75 ms)
 39512 ms: std::tie<const OpenMS::IdentificationDataInternal::MoleculeType, con... (539 times, avg 73 ms)
 37906 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 70 ms)
 35820 ms: std::vector<OpenMS::MSSpectrum, std::allocator<OpenMS::MSSpectrum> >... (747 times, avg 47 ms)
 35366 ms: std::vector<OpenMS::MSSpectrum, std::allocator<OpenMS::MSSpectrum> >... (747 times, avg 47 ms)
 35179 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 65 ms)
 32974 ms: std::vector<OpenMS::DataArrays::IntegerDataArray, std::allocator<Ope... (854 times, avg 38 ms)
 32518 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 60 ms)
 32442 ms: std::map<OpenMS::String, std::vector<OpenMS::String, std::allocator<... (835 times, avg 38 ms)
 30963 ms: boost::multi_index::multi_index_container<OpenMS::IdentificationData... (543 times, avg 57 ms)
 29724 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 55 ms)
 28313 ms: std::unordered_map<int, int, std::hash<int>, std::equal_to<int>, std... (1635 times, avg 17 ms)
 27697 ms: std::copy<__gnu_cxx::__normal_iterator<const OpenMS::DataArrays::Flo... (775 times, avg 35 ms)
 27314 ms: std::map<std::vector<OpenMS::String, std::allocator<OpenMS::String> ... (828 times, avg 32 ms)
 27041 ms: std::_Temporary_buffer<__gnu_cxx::__normal_iterator<OpenMS::PeptideH... (994 times, avg 27 ms)
 26912 ms: std::__copy_move_a<false, __gnu_cxx::__normal_iterator<const OpenMS:... (775 times, avg 34 ms)
 26813 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 49 ms)
 26376 ms: std::vector<OpenMS::DataArrays::FloatDataArray, std::allocator<OpenM... (772 times, avg 34 ms)
 25966 ms: boost::multi_index::detail::sequenced_index<boost::multi_index::deta... (541 times, avg 47 ms)
 25754 ms: std::__uninitialized_copy_a<__gnu_cxx::__normal_iterator<const OpenM... (781 times, avg 32 ms)
 25574 ms: std::uninitialized_copy<__gnu_cxx::__normal_iterator<const OpenMS::D... (781 times, avg 32 ms)
 25530 ms: boost::multi_index::detail::sequenced_index<boost::multi_index::deta... (541 times, avg 47 ms)
 24079 ms: std::vector<OpenMS::MSSpectrum, std::allocator<OpenMS::MSSpectrum> >... (749 times, avg 32 ms)
 23970 ms: std::__tuple_compare<std::tuple<const OpenMS::IdentificationDataInte... (539 times, avg 44 ms)

**** Template sets that took longest to instantiate:
331426 ms: std::__and_<$> (192220 times, avg 1 ms)
193042 ms: std::vector<$> (51762 times, avg 3 ms)
189335 ms: std::__or_<$> (157904 times, avg 1 ms)
158848 ms: boost::multi_index::multi_index_container<$> (5398 times, avg 29 ms)
149788 ms: std::map<$> (20511 times, avg 7 ms)
123624 ms: std::tuple<$> (13005 times, avg 9 ms)
123104 ms: std::pair<$> (29968 times, avg 4 ms)
120006 ms: std::_Rb_tree<$> (31514 times, avg 3 ms)
117353 ms: std::_Rb_tree<$>::_M_erase (14830 times, avg 7 ms)
112270 ms: std::__uninitialized_copy_a<$> (16576 times, avg 6 ms)
111343 ms: boost::multi_index::multi_index_container<$>::multi_index_container (10249 times, avg 10 ms)
109633 ms: std::tie<$> (4941 times, avg 22 ms)
109236 ms: std::_Rb_tree<$>::~_Rb_tree (11339 times, avg 9 ms)
108452 ms: std::uninitialized_copy<$> (16370 times, avg 6 ms)
103173 ms: std::_Vector_base<$> (50719 times, avg 2 ms)
 97855 ms: std::vector<$>::vector (10313 times, avg 9 ms)
 87160 ms: std::_Hashtable<$> (8149 times, avg 10 ms)
 85554 ms: std::allocator<$> (78176 times, avg 1 ms)
 84183 ms: std::copy<$> (11501 times, avg 7 ms)
 81266 ms: std::unordered_map<$> (4836 times, avg 16 ms)
 80369 ms: std::__uninitialized_copy<$>::__uninit_copy<$> (11622 times, avg 6 ms)
 80040 ms: std::_Destroy<$> (29196 times, avg 2 ms)
 79094 ms: std::__copy_move_a<$> (12653 times, avg 6 ms)
 78216 ms: std::_Rb_tree<$>::_Rb_tree (5241 times, avg 14 ms)
 77100 ms: std::__tuple_compare<$>::__less (3401 times, avg 22 ms)
 74132 ms: std::_Rb_tree<$>::_M_emplace_hint_unique<$> (3420 times, avg 21 ms)
 73109 ms: std::_Rb_tree<$>::_M_drop_node (14968 times, avg 4 ms)
 71677 ms: std::set<$> (10911 times, avg 6 ms)
 69150 ms: std::is_nothrow_default_constructible<$> (34988 times, avg 1 ms)
 68068 ms: std::is_convertible<$> (63469 times, avg 1 ms)

**** Functions that took longest to compile:
 44510 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/Param_test.cpp)
 27934 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/TheoreticalSpectrumGeneratorXLMS_test.cpp)
 26478 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/TheoreticalSpectrumGenerator_test.cpp)
 23907 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MRMFeatureFilter_test.cpp)
 21652 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MRMAssay_test.cpp)
 15750 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/AbsoluteQuantitation_test.cpp)
 12185 ms: OpenMS::MzTabFile::load(OpenMS::String const&, OpenMS::MzTab&) (/mnt/d/development/WSL_OpenMS/OpenMS/src/openms/source/FORMAT/MzTabFile.cpp)
 11916 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MSSpectrum_test.cpp)
 10574 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/TargetedSpectraExtractor_test.cpp)
  9704 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/String_test.cpp)
  9663 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/TOPPBase_test.cpp)
  9086 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/IDMapper_test.cpp)
  9008 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/AASequence_test.cpp)
  8560 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/SimpleTSGXLMS_test.cpp)
  8460 ms: OpenMS::ToolHandler::getTOPPToolList(bool) (/mnt/d/development/WSL_OpenMS/OpenMS/src/openms/source/APPLICATIONS/ToolHandler.cpp)
  8446 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/IsotopeLabelingMDVs_test.cpp)
  8435 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/IsobaricChannelExtractor_test.cpp)
  8361 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/SVMWrapper_test.cpp)
  8196 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/PeptideIndexing_test.cpp)
  7706 ms: OpenMS::OpenSwathTSVWriter::prepareLine(OpenSwath::LightCompound con... (/mnt/d/development/WSL_OpenMS/OpenMS/src/openms/source/ANALYSIS/OPENSWATH/OpenSwathTSVWriter.cpp)
  7647 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/ClassTest_test.cpp)
  7244 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MRMTransitionGroupPicker_test.cpp)
  6519 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MSSim_test.cpp)
  6363 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/PeakIntegrator_test.cpp)
  6313 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MzMLFile_test.cpp)
  6212 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MetaboliteFeatureDeconvolution_test.cpp)
  6047 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/MSChromatogram_test.cpp)
  5952 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/IdentificationData_test.cpp)
  5614 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/AccurateMassSearchEngine_test.cpp)
  5382 ms: main (/mnt/d/development/WSL_OpenMS/OpenMS/src/tests/class_tests/openms/source/ModificationDefinitionsSet_test.cpp)

**** Function sets that took longest to compile / optimize:
 38152 ms: std::vector<$>::vector(std::vector<$> const&) (4275 times, avg 8 ms)
 24257 ms: std::_Rb_tree<$>::_M_erase(std::_Rb_tree_node<$>*) (3686 times, avg 6 ms)
 24055 ms: std::_Rb_tree_node<$>* std::_Rb_tree<$>::_M_copy<$>(std::_Rb_tree_no... (1511 times, avg 15 ms)
 19610 ms: std::vector<$>::~vector() (8255 times, avg 2 ms)
 14579 ms: std::_Rb_tree_iterator<$> std::_Rb_tree<$>::_M_emplace_hint_unique<$... (1142 times, avg 12 ms)
 14112 ms: void OpenMS::Internal::ClassTest::testEqual<$>(char const*, int, uns... (375 times, avg 37 ms)
 13677 ms: void OpenMS::Internal::ClassTest::testEqual<$>(char const*, int, boo... (357 times, avg 38 ms)
 12364 ms: void std::vector<$>::_M_range_insert<$>(__gnu_cxx::__normal_iterator... (240 times, avg 51 ms)
 10129 ms: void OpenMS::DTAFile::load<$>(OpenMS::String const&, OpenMS::MSSpect... (72 times, avg 140 ms)
 10071 ms: std::_Rb_tree<$>::_M_get_insert_hint_unique_pos(std::_Rb_tree_const_... (414 times, avg 24 ms)
  9804 ms: std::vector<$>::_M_default_append(unsigned long) (439 times, avg 22 ms)
  9766 ms: OpenMS::String* std::__uninitialized_copy<$>::__uninit_copy<$>(__gnu... (452 times, avg 21 ms)
  9355 ms: std::_Rb_tree_node<$>* std::_Rb_tree<$>::_M_copy<$>(std::_Rb_tree_no... (576 times, avg 16 ms)
  8788 ms: std::_Rb_tree<$>::_M_get_insert_unique_pos(OpenMS::String const&) (516 times, avg 17 ms)
  8021 ms: Eigen::internal::general_matrix_vector_product<$>::run(long, long, E... (102 times, avg 78 ms)
  7991 ms: std::__cxx11::basic_string<$>* std::__uninitialized_copy<$>::__unini... (310 times, avg 25 ms)
  7609 ms: std::_Vector_base<$>::~_Vector_base() (6791 times, avg 1 ms)
  7587 ms: std::_Rb_tree<$>::_M_get_insert_hint_unique_pos(std::_Rb_tree_const_... (308 times, avg 24 ms)
  6998 ms: void OpenMS::SpectrumAlignment::getSpectrumAlignment<$>(std::vector<... (26 times, avg 269 ms)
  6139 ms: void OpenMS::Internal::ClassTest::testEqual<$>(char const*, int, int... (160 times, avg 38 ms)
  5663 ms: __gnu_cxx::new_allocator<$>::allocate(unsigned long, void const*) (5635 times, avg 1 ms)
  5608 ms: OpenMS::SignalToNoiseEstimatorMedian<$>::SignalToNoiseEstimatorMedia... (26 times, avg 215 ms)
  5522 ms: std::vector<$>::_M_check_len(unsigned long, char const*) const (3729 times, avg 1 ms)
  5458 ms: std::_Vector_base<$>::_M_allocate(unsigned long) (5161 times, avg 1 ms)
  5363 ms: std::_Vector_base<$>::_Vector_base(unsigned long, std::allocator<$> ... (4584 times, avg 1 ms)
  5347 ms: void std::vector<$>::_M_realloc_insert<$>(__gnu_cxx::__normal_iterat... (177 times, avg 30 ms)
  5286 ms: void std::vector<$>::_M_realloc_insert<$>(__gnu_cxx::__normal_iterat... (147 times, avg 35 ms)
  5068 ms: std::vector<$> OpenMS::ListUtils::create<$>(std::vector<$> const&) (137 times, avg 36 ms)
  4909 ms: void std::_Rb_tree<$>::_M_construct_node<$>(std::_Rb_tree_node<$>*, ... (658 times, avg 7 ms)
  4855 ms: void std::__introsort_loop<$>(__gnu_cxx::__normal_iterator<$>, __gnu... (141 times, avg 34 ms)

*** Expensive headers:
2886390 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/KERNEL/BaseFeature.h (included 534 times, avg 5405 ms), included via:
  IsotopeFitter1D_test.cpp.o IsotopeFitter1D.h MaxLikeliFitter1D.h Fitter1D.h Feature.h  (18311 ms)
  EGHFitter1D_test.cpp.o EGHFitter1D.h LevMarqFitter1D.h Fitter1D.h Feature.h  (17361 ms)
  LevMarqFitter1D_test.cpp.o LevMarqFitter1D.h Fitter1D.h Feature.h  (16725 ms)
  Fitter1D_test.cpp.o Fitter1D.h Feature.h  (16494 ms)
  EmgScoring_test.cpp.o OpenSwathTestHelper.h MRMTransitionGroup.h MRMFeature.h Feature.h  (15755 ms)
  ProteinResolver_test.cpp.o ProteinResolver.h ConsensusMap.h ConsensusFeature.h  (15437 ms)
  ...

2824041 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/METADATA/ID/IdentificationData.h (included 539 times, avg 5239 ms), included via:
  IsotopeFitter1D_test.cpp.o IsotopeFitter1D.h MaxLikeliFitter1D.h Fitter1D.h Feature.h BaseFeature.h  (17084 ms)
  EGHFitter1D_test.cpp.o EGHFitter1D.h LevMarqFitter1D.h Fitter1D.h Feature.h BaseFeature.h  (16228 ms)
  LevMarqFitter1D_test.cpp.o LevMarqFitter1D.h Fitter1D.h Feature.h BaseFeature.h  (16195 ms)
  Fitter1D_test.cpp.o Fitter1D.h Feature.h BaseFeature.h  (15243 ms)
  EmgScoring_test.cpp.o OpenSwathTestHelper.h MRMTransitionGroup.h MRMFeature.h Feature.h BaseFeature.h  (15071 ms)
  ProteinResolver_test.cpp.o ProteinResolver.h ConsensusMap.h ConsensusFeature.h BaseFeature.h  (14246 ms)
  ...

1740749 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/CONCEPT/ClassTest.h (included 657 times, avg 2649 ms), included via:
  TheoreticalSpectrumGenerator_test.cpp.o  (11839 ms)
  MSSim_test.cpp.o  (11505 ms)
  DetectabilitySimulation_test.cpp.o  (11408 ms)
  TheoreticalSpectrumGeneratorXLMS_test.cpp.o  (10989 ms)
  IsotopeFitter1D_test.cpp.o  (9159 ms)
  EGHFitter1D_test.cpp.o  (8752 ms)
  ...

1674969 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/KERNEL/Feature.h (included 423 times, avg 3959 ms), included via:
  IsotopeFitter1D_test.cpp.o IsotopeFitter1D.h MaxLikeliFitter1D.h Fitter1D.h  (18514 ms)
  EGHFitter1D_test.cpp.o EGHFitter1D.h LevMarqFitter1D.h Fitter1D.h  (17553 ms)
  LevMarqFitter1D_test.cpp.o LevMarqFitter1D.h Fitter1D.h  (16808 ms)
  Fitter1D_test.cpp.o Fitter1D.h  (16730 ms)
  EmgScoring_test.cpp.o OpenSwathTestHelper.h MRMTransitionGroup.h MRMFeature.h  (16015 ms)
  IonizationSimulation_test.cpp.o IonizationSimulation.h SimTypes.h FeatureMap.h  (14669 ms)
  ...

1330918 ms: /usr/include/c++/10/string (included 1698 times, avg 783 ms), included via:
  DetectabilitySimulation_test.cpp.o ClassTest.h PrecisionWrapper.h String.h  (5314 ms)
  TheoreticalSpectrumGenerator_test.cpp.o ClassTest.h PrecisionWrapper.h String.h  (4551 ms)
  IsotopeFitter1D_test.cpp.o ClassTest.h PrecisionWrapper.h String.h  (4321 ms)
  IsotopeModel_test.cpp.o ClassTest.h PrecisionWrapper.h String.h  (4067 ms)
  MSSim_test.cpp.o ClassTest.h PrecisionWrapper.h String.h  (3964 ms)
  IsobaricChannelExtractor_test.cpp.o ClassTest.h PrecisionWrapper.h String.h  (3292 ms)
  ...

1306361 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/KERNEL/FeatureMap.h (included 378 times, avg 3455 ms), included via:
  IonizationSimulation_test.cpp.o IonizationSimulation.h SimTypes.h  (16485 ms)
  MSSim_test.cpp.o MSSim.h SimTypes.h  (15879 ms)
  FeatureGroupingAlgorithmQT_test.cpp.o FeatureGroupingAlgorithmQT.h FeatureGroupingAlgorithm.h  (15581 ms)
  RTSimulation_test.cpp.o RTSimulation.h SimTypes.h  (15157 ms)
  FeatureGroupingAlgorithm_test.cpp.o FeatureGroupingAlgorithm.h  (14618 ms)
  FeatureGroupingAlgorithmLabeled_test.cpp.o FeatureGroupingAlgorithmLabeled.h FeatureGroupingAlgorithm.h  (14518 ms)
  ...

1294112 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/CONCEPT/PrecisionWrapper.h (included 1320 times, avg 980 ms), included via:
  TheoreticalSpectrumGenerator_test.cpp.o ClassTest.h  (9656 ms)
  MSSim_test.cpp.o ClassTest.h  (9478 ms)
  DetectabilitySimulation_test.cpp.o ClassTest.h  (8079 ms)
  TheoreticalSpectrumGeneratorXLMS_test.cpp.o ClassTest.h  (7610 ms)
  IsotopeFitter1D_test.cpp.o ClassTest.h  (6864 ms)
  MaxLikeliFitter1D_test.cpp.o ClassTest.h  (6682 ms)
  ...

1225387 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/KERNEL/ConsensusMap.h (included 309 times, avg 3965 ms), included via:
  ProteinResolver_test.cpp.o ProteinResolver.h  (17305 ms)
  ConsensusMapMergerAlgorithm_test.cpp.o ConsensusMapMergerAlgorithm.h  (15515 ms)
  ConsensusMapNormalizerAlgorithmQuantile_test.cpp.o ConsensusMapNormalizerAlgorithmQuantile.h  (14711 ms)
  IDConflictResolverAlgorithm_test.cpp.o IDConflictResolverAlgorithm.h  (13900 ms)
  LabeledPairFinder_test.cpp.o LabeledPairFinder.h BaseGroupFinder.h  (13895 ms)
  ConsensusMapNormalizerAlgorithmMedian_test.cpp.o ConsensusMapNormalizerAlgorithmMedian.h  (12714 ms)
  ...

1103343 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/KERNEL/ConsensusFeature.h (included 315 times, avg 3502 ms), included via:
  ProteinResolver_test.cpp.o ProteinResolver.h ConsensusMap.h  (15588 ms)
  ConsensusMapMergerAlgorithm_test.cpp.o ConsensusMapMergerAlgorithm.h ConsensusMap.h  (13737 ms)
  ConsensusMapNormalizerAlgorithmQuantile_test.cpp.o ConsensusMapNormalizerAlgorithmQuantile.h ConsensusMap.h  (12886 ms)
  IDConflictResolverAlgorithm_test.cpp.o IDConflictResolverAlgorithm.h ConsensusMap.h  (12566 ms)
  LabeledPairFinder_test.cpp.o LabeledPairFinder.h BaseGroupFinder.h ConsensusMap.h  (11958 ms)
  IsobaricChannelExtractor_test.cpp.o ConsensusXMLFile.h ConsensusMap.h  (11894 ms)
  ...

1055092 ms: /mnt/d/development/WSL_OpenMS/OpenMS/src/openms/include/OpenMS/DATASTRUCTURES/String.h (included 1637 times, avg 644 ms), included via:
  TheoreticalSpectrumGenerator_test.cpp.o ClassTest.h PrecisionWrapper.h  (5843 ms)
  DetectabilitySimulation_test.cpp.o ClassTest.h PrecisionWrapper.h  (5727 ms)
  MaxLikeliFitter1D_test.cpp.o ClassTest.h PrecisionWrapper.h  (5025 ms)
  IsotopeFitter1D_test.cpp.o ClassTest.h PrecisionWrapper.h  (4821 ms)
  MSSim_test.cpp.o ClassTest.h PrecisionWrapper.h  (4507 ms)
  IsotopeModel_test.cpp.o ClassTest.h PrecisionWrapper.h  (4479 ms)
  ...

  done in 14.3s.

Jan 31 '23 16:01 timosachsenberg