File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 142828ms, 93.94% of 152035ms total Dropped 1106 nodes (cum <= 760.17ms) flat flat% sum% cum cum% 0 0% 0% 152007ms 100% __libc_start_call_main 0 0% 0% 152007ms 100% __libc_start_main_impl 0 0% 0% 152007ms 100% _start 0 0% 0% 152004ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 152004ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 152004ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 152004ms 100% main 0 0% 0% 151971ms 100% AbstractConvergenceTester::Converge 0 0% 0% 151971ms 100% CxxTest::RealTestDescription::run 0 0% 0% 151971ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 151971ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 151971ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 151971ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 2ms 0.0013% 0.0013% 150879ms 99.24% AbstractCardiacProblem::Solve 9ms 0.0059% 0.0072% 150194ms 98.79% AbstractDynamicLinearPdeSolver::Solve 2ms 0.0013% 0.0086% 104990ms 69.06% LinearSystem::Solve 2ms 0.0013% 0.0099% 104543ms 68.76% KSPSolve 10ms 0.0066% 0.016% 104542ms 68.76% KSPSolve_Private 7ms 0.0046% 0.021% 104191ms 68.53% KSPSolve_SYMMLQ 7ms 0.0046% 0.026% 72530ms 47.71% MatMult 290ms 0.19% 0.22% 72523ms 47.70% MatMult_SeqAIJ (partial-inline) 70635ms 46.46% 46.68% 72522ms 47.70% MatMult_SeqAIJ_Inode (inline) 5ms 0.0033% 46.68% 33413ms 21.98% PCApply 6ms 0.0039% 46.68% 33405ms 21.97% PCApply_BJacobi_Singleblock 1ms 0.00066% 46.68% 30751ms 20.23% KSPSolve_PREONLY (partial-inline) 2ms 0.0013% 46.69% 29567ms 19.45% PCApply_ICC 8ms 0.0053% 46.69% 29565ms 19.45% MatSolve 29122ms 19.15% 65.85% 29557ms 19.44% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 186ms 0.12% 65.97% 29505ms 19.41% AbstractCardiacTissue::SolveCellSystems 2ms 0.0013% 65.97% 28744ms 18.91% KSP_PCApply.lto_priv.18 492ms 0.32% 66.29% 23424ms 15.41% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 3618ms 2.38% 68.67% 19808ms 13.03% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 786ms 0.52% 69.19% 14779ms 9.72% BidomainSolver::SetupLinearSystem 1133ms 0.75% 69.93% 13117ms 8.63% CardiacNewtonSolver::Solve 4878ms 3.21% 73.14% 8709ms 5.73% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 0 0% 73.14% 6538ms 4.30% KSP_PCApply (partial-inline) 9ms 0.0059% 73.15% 5836ms 3.84% KSPConvergedDefault 43ms 0.028% 73.18% 5293ms 3.48% AbstractCardiacTissue::UpdateCaches (inline) 1178ms 0.77% 73.95% 4978ms 3.27% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 3512ms 2.31% 76.26% 3514ms 2.31% __ieee754_log_fma 3462ms 2.28% 78.54% 3462ms 2.28% __memcpy_avx512_unaligned_erms 0 0% 78.54% 3413ms 2.24% PetscMemcpy (inline) 12ms 0.0079% 78.55% 3197ms 2.10% MatNullSpaceRemove 11ms 0.0072% 78.55% 3049ms 2.01% VecAXPY 2179ms 1.43% 79.99% 3040ms 2.00% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 4ms 0.0026% 79.99% 3038ms 2.00% VecAXPY_Seq 3024ms 1.99% 81.98% 3024ms 1.99% daxpy_ 18ms 0.012% 81.99% 3009ms 1.98% VecCopy 3ms 0.002% 81.99% 2990ms 1.97% VecCopy_Seq (partial-inline) 0 0% 81.99% 2887ms 1.90% boost::numeric::ublas::norm_inf (inline) 2437ms 1.60% 83.60% 2887ms 1.90% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 83.60% 2887ms 1.90% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 83.60% 2887ms 1.90% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 276ms 0.18% 83.78% 2575ms 1.69% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 2428ms 1.60% 85.37% 2428ms 1.60% [libchaste_heart.so] 8ms 0.0053% 85.38% 2381ms 1.57% std::pow (inline) 171ms 0.11% 85.49% 2329ms 1.53% __pow 257ms 0.17% 85.66% 2119ms 1.39% __ieee754_pow_fma 1ms 0.00066% 85.66% 2034ms 1.34% VecMDot 19ms 0.012% 85.67% 2033ms 1.34% VecMXDot_Private 2006ms 1.32% 86.99% 2010ms 1.32% VecMDot_Seq 1923ms 1.26% 88.26% 1923ms 1.26% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 1856ms 1.22% 89.48% 1856ms 1.22% ddot_ 0 0% 89.48% 1745ms 1.15% AbstractFeVolumeIntegralAssembler::DoAssemble 1593ms 1.05% 90.53% 1593ms 1.05% _mm_prefetch (inline) 4ms 0.0026% 90.53% 1523ms 1.00% VecDot 1332ms 0.88% 91.41% 1521ms 1.00% exp_inline (inline) 0 0% 91.41% 1519ms 1% VecDot_Seq 6ms 0.0039% 91.41% 1519ms 1% VecXDot_Seq_Private.constprop.0 15ms 0.0099% 91.42% 1461ms 0.96% AbstractFeVolumeIntegralAssembler::AssembleOnElement 1323ms 0.87% 92.29% 1323ms 0.87% __memset_avx512_unaligned_erms 0 0% 92.29% 1316ms 0.87% PetscMemzero (inline) 0 0% 92.29% 1195ms 0.79% AbstractFeAssemblerInterface::AssembleMatrix (inline) 8ms 0.0053% 92.30% 1151ms 0.76% VecMAXPY 1139ms 0.75% 93.04% 1143ms 0.75% VecMAXPY_Seq 0 0% 93.04% 1095ms 0.72% VecDuplicate 358ms 0.24% 93.28% 1025ms 0.67% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 8ms 0.0053% 93.29% 951ms 0.63% boost::numeric::ublas::matrix_assign (inline) 116ms 0.076% 93.36% 938ms 0.62% boost::numeric::ublas::indexing_matrix_assign 13ms 0.0086% 93.37% 933ms 0.61% PetscMallocA 13ms 0.0086% 93.38% 920ms 0.61% PetscMallocAlign (partial-inline) 0 0% 93.38% 909ms 0.6% CuboidMeshConstructor::Construct 0 0% 93.38% 908ms 0.6% AbstractTetrahedralMesh::ConstructRegularSlabMesh 3ms 0.002% 93.38% 908ms 0.6% DistributedTetrahedralMesh::ConstructCuboid 5ms 0.0033% 93.38% 859ms 0.57% VecScale 6ms 0.0039% 93.39% 854ms 0.56% VecScale_Seq 844ms 0.56% 93.94% 844ms 0.56% dscal_ 2ms 0.0013% 93.94% 801ms 0.53% Element::Element 0 0% 93.94% 784ms 0.52% AbstractTetrahedralElement::CalculateJacobian