pramodk
commented
4 years ago Compilation time using Apple Clang 10 on my MacBook
2020-04-16 21:51:54 ☆ bluebrain355 in ~/workarena/repos/bbp/incubator/nocmodl/build
± |master → origin {32} ?:4 ✗| → cmake .. -DCMAKE_INSTALL_PREFIX=`pwd`/install -DPYTHON_EXECUTABLE=`which python3.6` -DCMAKE_CXX_FLAGS="-ftime-report"
-- The CXX compiler identification is AppleClang 10.0.1.10010046
-- Check for working CXX compiler: /Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/c++
-- Check for working CXX compiler: /Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/c++ -- works
-- Detecting CXX compiler ABI info
-- Detecting CXX compiler ABI info - done
-- Detecting CXX compile features
-- Detecting CXX compile features - done
-- CHECKING FOR FLEX/BISON
-- Found FLEX: /usr/local/opt/flex/bin/flex (found suitable version "2.6.4", minimum required is "2.6")
-- Found BISON: /usr/local/opt/bison/bin/bison (found suitable version "3.5.2", minimum required is "3.0")
-- NMODL_FORMATTING: OFF
-- NMODL_FORMATTING_ON: all
-- NMODL_FORMATTING_CPP_CHANGES_ONLY: OFF
-- NMODL_TEST_FORMATTING: OFF
-- NMODL_FORMATTING_NO_SUBMODULES: ON
-- NMODL_CLANG_FORMAT: OFF
-- NMODL_CMAKE_FORMAT: OFF
-- NMODL_PRECOMMIT: OFF
-- NMODL_PRECOMMIT_REGEN: OFF
-- NMODL_STATIC_ANALYSIS: OFF
-- NMODL_TEST_STATIC_ANALYSIS: OFF
-- Found PythonInterp: /Library/Frameworks/Python.framework/Versions/3.6/bin/python3.6 (found suitable version "3.6.8", minimum required is "3.5")
-- Found ClangFormat: /usr/local/opt/llvm@7/bin/clang-format (found version "7.0.1")
-- Adding Flex include path as : /usr/local/opt/flex/include/
-- Found Git: /usr/local/bin/git (found version "2.21.0")
-- CHECKING FOR PYTHON
-- Found PythonInterp: /Library/Frameworks/Python.framework/Versions/3.6/bin/python3.6 (found suitable version "3.6.8", minimum required is "3.6")
-- Found jinja2: /Users/kumbhar/Library/Python/3.6/lib/python/site-packages/jinja2 (found suitable version "2.10.3", minimum required is "2.9.3")
-- Found pytest: /Users/kumbhar/Library/Python/3.6/lib/python/site-packages/pytest.py (found suitable version "5.2.1", minimum required is "3.3.0")
-- Found sympy: /Users/kumbhar/Library/Python/3.6/lib/python/site-packages/sympy (found suitable version "1.4", minimum required is "1.2")
-- Found textwrap: /Library/Frameworks/Python.framework/Versions/3.6/lib/python3.6/textwrap.py (Required is at least version "0.9")
-- Found yaml: /Users/kumbhar/Library/Python/3.6/lib/python/site-packages/yaml (found suitable version "5.1.2", minimum required is "3.12")
-- INCLUDING PYBIND11
-- Found PythonInterp: /Library/Frameworks/Python.framework/Versions/3.6/bin/python3.6 (found version "3.6.8")
-- Found PythonLibs: /Library/Frameworks/Python.framework/Versions/3.6/lib/libpython3.6m.dylib
-- pybind11 v2.3.dev0
-- INCLUDING FMT
-- Version: 6.1.3
-- Build type:
-- CXX_STANDARD: 11
-- Performing Test has_std_11_flag
-- Performing Test has_std_11_flag - Success
-- Performing Test has_std_0x_flag
-- Performing Test has_std_0x_flag - Success
-- Performing Test SUPPORTS_USER_DEFINED_LITERALS
-- Performing Test SUPPORTS_USER_DEFINED_LITERALS - Success
-- Performing Test FMT_HAS_VARIANT
-- Performing Test FMT_HAS_VARIANT - Success
-- Required features: cxx_variadic_templates
-- Performing Test HAS_NULLPTR_WARNING
-- Performing Test HAS_NULLPTR_WARNING - Success
-- Looking for strtod_l
-- Looking for strtod_l - found
-- Configuring done
-- Generating done
-- Build files have been written to: /Users/kumbhar/workarena/repos/bbp/incubator/nocmodl/build
2020-04-16 21:52:22 ☆ bluebrain355 in ~/workarena/repos/bbp/incubator/nocmodl/build
± |master → origin {32} ?:4 ✗| → make -j
2020-04-16 22:36:08 ☆ bluebrain355 in ~/workarena/repos/bbp/incubator/nocmodl/build
± |master → origin {32} ?:4 ✗| → touch ../src/lexer/modtoken.cpp src/visitors/ast_visitor.cpp src/pybind/* src/ast/ast.cpp
2020-04-16 22:36:14 ☆ bluebrain355 in ~/workarena/repos/bbp/incubator/nocmodl/build
± |master → origin {32} ?:4 ✗| → make
[ 1%] Built target pyastgen
Scanning dependencies of target lexer_obj
[ 1%] Building CXX object src/lexer/CMakeFiles/lexer_obj.dir/modtoken.cpp.o
===-------------------------------------------------------------------------===
Miscellaneous Ungrouped Timers
===-------------------------------------------------------------------------===
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
0.0236 ( 56.5%) 0.0023 ( 51.2%) 0.0258 ( 56.0%) 0.0267 ( 56.0%) Code Generation Time
0.0182 ( 43.5%) 0.0022 ( 48.8%) 0.0203 ( 44.0%) 0.0209 ( 44.0%) LLVM IR Generation Time
0.0417 (100.0%) 0.0044 (100.0%) 0.0461 (100.0%) 0.0476 (100.0%) Total
===-------------------------------------------------------------------------===
Clang front-end time report
===-------------------------------------------------------------------------===
Total Execution Time: 0.3878 seconds (0.3971 wall clock)
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
0.3473 (100.0%) 0.0405 (100.0%) 0.3878 (100.0%) 0.3971 (100.0%) Clang front-end timer
0.3473 (100.0%) 0.0405 (100.0%) 0.3878 (100.0%) 0.3971 (100.0%) Total
[ 2%] Building CXX object src/lexer/CMakeFiles/lexer_obj.dir/__/ast/ast.cpp.o
===-------------------------------------------------------------------------===
Miscellaneous Ungrouped Timers
===-------------------------------------------------------------------------===
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
1.5418 ( 59.5%) 0.0978 ( 60.5%) 1.6397 ( 59.6%) 1.7453 ( 59.5%) Code Generation Time
1.0495 ( 40.5%) 0.0639 ( 39.5%) 1.1134 ( 40.4%) 1.1881 ( 40.5%) LLVM IR Generation Time
2.5913 (100.0%) 0.1618 (100.0%) 2.7531 (100.0%) 2.9333 (100.0%) Total
===-------------------------------------------------------------------------===
Clang front-end time report
===-------------------------------------------------------------------------===
Total Execution Time: 4.9952 seconds (5.2987 wall clock)
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
4.6568 (100.0%) 0.3384 (100.0%) 4.9952 (100.0%) 5.2987 (100.0%) Clang front-end timer
4.6568 (100.0%) 0.3384 (100.0%) 4.9952 (100.0%) 5.2987 (100.0%) Total
[ 20%] Built target lexer_obj
Scanning dependencies of target visitor_obj
[ 20%] Building CXX object src/visitors/CMakeFiles/visitor_obj.dir/ast_visitor.cpp.o
===-------------------------------------------------------------------------===
Miscellaneous Ungrouped Timers
===-------------------------------------------------------------------------===
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
0.0981 ( 84.5%) 0.0089 ( 83.0%) 0.1071 ( 84.4%) 0.1133 ( 85.0%) LLVM IR Generation Time
0.0180 ( 15.5%) 0.0018 ( 17.0%) 0.0198 ( 15.6%) 0.0201 ( 15.0%) Code Generation Time
0.1161 (100.0%) 0.0107 (100.0%) 0.1268 (100.0%) 0.1333 (100.0%) Total
===-------------------------------------------------------------------------===
Clang front-end time report
===-------------------------------------------------------------------------===
Total Execution Time: 1.2860 seconds (1.3594 wall clock)
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
1.1815 (100.0%) 0.1045 (100.0%) 1.2860 (100.0%) 1.3594 (100.0%) Clang front-end timer
1.1815 (100.0%) 0.1045 (100.0%) 1.2860 (100.0%) 1.3594 (100.0%) Total
[ 38%] Built target visitor_obj
[ 40%] Built target fmt
[ 41%] Linking CXX static library liblexer.a
[ 41%] Built target lexer
[ 45%] Built target util_obj
[ 45%] Built target util
[ 45%] Linking CXX static library libvisitor.a
[ 45%] Built target visitor
[ 52%] Built target codegen
[ 52%] Linking CXX executable ../../bin/units_lexer
[ 53%] Built target units_lexer
[ 54%] Linking CXX executable ../../bin/c_lexer
[ 54%] Built target c_lexer
[ 55%] Linking CXX executable ../../bin/nmodl_lexer
[ 55%] Built target nmodl_lexer
[ 57%] Built target printer_obj
[ 59%] Built target symtab_obj
Scanning dependencies of target _nmodl
[ 59%] Building CXX object src/pybind/CMakeFiles/_nmodl.dir/pyast.cpp.o
===-------------------------------------------------------------------------===
Miscellaneous Ungrouped Timers
===-------------------------------------------------------------------------===
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
10.1683 ( 60.9%) 0.6200 ( 58.9%) 10.7882 ( 60.8%) 11.0541 ( 60.5%) Code Generation Time
6.5264 ( 39.1%) 0.4332 ( 41.1%) 6.9596 ( 39.2%) 7.2269 ( 39.5%) LLVM IR Generation Time
16.6947 (100.0%) 1.0532 (100.0%) 17.7478 (100.0%) 18.2810 (100.0%) Total
===-------------------------------------------------------------------------===
Clang front-end time report
===-------------------------------------------------------------------------===
Total Execution Time: 38.1768 seconds (40.2616 wall clock)
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
35.6404 (100.0%) 2.5365 (100.0%) 38.1768 (100.0%) 40.2616 (100.0%) Clang front-end timer
35.6404 (100.0%) 2.5365 (100.0%) 38.1768 (100.0%) 40.2616 (100.0%) Total
[ 60%] Building CXX object src/pybind/CMakeFiles/_nmodl.dir/pyvisitor.cpp.o
===-------------------------------------------------------------------------===
Miscellaneous Ungrouped Timers
===-------------------------------------------------------------------------===
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
4.5729 ( 61.2%) 0.2550 ( 57.0%) 4.8279 ( 61.0%) 4.9273 ( 61.0%) Code Generation Time
2.8954 ( 38.8%) 0.1923 ( 43.0%) 3.0877 ( 39.0%) 3.1566 ( 39.0%) LLVM IR Generation Time
7.4683 (100.0%) 0.4473 (100.0%) 7.9156 (100.0%) 8.0838 (100.0%) Total
===-------------------------------------------------------------------------===
Clang front-end time report
===-------------------------------------------------------------------------===
Total Execution Time: 19.3881 seconds (19.7863 wall clock)
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
18.1302 (100.0%) 1.2579 (100.0%) 19.3881 (100.0%) 19.7863 (100.0%) Clang front-end timer
18.1302 (100.0%) 1.2579 (100.0%) 19.3881 (100.0%) 19.7863 (100.0%) Total
[ 60%] Building CXX object src/pybind/CMakeFiles/_nmodl.dir/pysymtab.cpp.o
===-------------------------------------------------------------------------===
Miscellaneous Ungrouped Timers
===-------------------------------------------------------------------------===
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
1.5917 ( 58.7%) 0.0948 ( 56.0%) 1.6865 ( 58.5%) 1.7251 ( 58.4%) Code Generation Time
1.1203 ( 41.3%) 0.0745 ( 44.0%) 1.1948 ( 41.5%) 1.2277 ( 41.6%) LLVM IR Generation Time
2.7120 (100.0%) 0.1692 (100.0%) 2.8812 (100.0%) 2.9528 (100.0%) Total
===-------------------------------------------------------------------------===
Clang front-end time report
===-------------------------------------------------------------------------===
Total Execution Time: 7.9596 seconds (8.1460 wall clock)
---User Time--- --System Time-- --User+System-- ---Wall Time--- --- Name ---
7.4244 (100.0%) 0.5352 (100.0%) 7.9596 (100.0%) 8.1460 (100.0%) Clang front-end timer
7.4244 (100.0%) 0.5352 (100.0%) 7.9596 (100.0%) 8.1460 (100.0%) Total
[ 61%] Linking CXX shared module ../../lib/python/nmodl/_nmodl.cpython-36m-darwin.so
[ 62%] Built target _nmodl
[ 62%] Built target printer
[ 63%] Built target symtab
[ 64%] Linking CXX executable ../../bin/nmodl
[ 65%] Built target nmodl
[ 66%] Linking CXX executable ../../bin/units_parser
[ 67%] Built target units_parser
[ 68%] Linking CXX executable ../../bin/nmodl_parser
[ 68%] Built target nmodl_parser
[ 68%] Linking CXX executable ../../bin/c_parser
[ 69%] Built target c_parser
[ 69%] Linking CXX executable ../../bin/nmodl_visitor
[ 70%] Built target nmodl_visitor
[ 71%] -- COPYING NMODL PYTHON FILES --
[ 71%] Built target copy_python_files
[ 72%] Linking CXX executable ../bin/testlexer
[ 73%] Built target testlexer
[ 75%] Linking CXX executable ../bin/testunitlexer
[ 76%] Built target testunitlexer
[ 77%] Built target testnewton
[ 78%] Built target config
[ 79%] Built target test_util
[ 80%] Linking CXX executable ../bin/testunitparser
[ 80%] Built target testunitparser
[ 80%] Linking CXX executable ../bin/testsymtab
[ 81%] Built target testsymtab
[ 82%] Built target testprinter
[ 83%] Linking CXX executable ../bin/testparser
[ 84%] Built target testparser
[ 85%] Linking CXX executable ../bin/testvisitor
[ 98%] Built target testvisitor
[100%] Linking CXX executable ../bin/testmodtoken
[100%] Built target testmodtoken
cattabiani
gabime
mgeplf
alkino
Multiple users have seen very high compilation times. We need to look into what is taking time to build the NMODL project. We should break the build time to make better decision in #298.