File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 153980ms, 93.75% of 164244ms total Dropped 1113 nodes (cum <= 821.22ms) flat flat% sum% cum cum% 0 0% 0% 164226ms 100% __libc_start_call_main 0 0% 0% 164226ms 100% __libc_start_main_impl 0 0% 0% 164226ms 100% _start 0 0% 0% 164223ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 164223ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 164223ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 164223ms 100% main 0 0% 0% 164191ms 100% AbstractConvergenceTester::Converge 0 0% 0% 164191ms 100% CxxTest::RealTestDescription::run 0 0% 0% 164191ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 164191ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 164191ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 164191ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 1ms 0.00061% 0.00061% 163045ms 99.27% AbstractCardiacProblem::Solve 7ms 0.0043% 0.0049% 162451ms 98.91% AbstractDynamicLinearPdeSolver::Solve 1ms 0.00061% 0.0055% 108889ms 66.30% LinearSystem::Solve 1ms 0.00061% 0.0061% 108458ms 66.03% KSPSolve 8ms 0.0049% 0.011% 108457ms 66.03% KSPSolve_Private 13ms 0.0079% 0.019% 108143ms 65.84% KSPSolve_SYMMLQ 10ms 0.0061% 0.025% 73789ms 44.93% MatMult 355ms 0.22% 0.24% 73779ms 44.92% MatMult_SeqAIJ (partial-inline) 72731ms 44.28% 44.52% 73776ms 44.92% MatMult_SeqAIJ_Inode (inline) 219ms 0.13% 44.66% 36758ms 22.38% AbstractCardiacTissue::SolveCellSystems 6ms 0.0037% 44.66% 36350ms 22.13% PCApply 6ms 0.0037% 44.66% 36343ms 22.13% PCApply_BJacobi_Singleblock 4ms 0.0024% 44.67% 33517ms 20.41% KSPSolve_PREONLY (partial-inline) 2ms 0.0012% 44.67% 32190ms 19.60% PCApply_ICC 8ms 0.0049% 44.67% 32188ms 19.60% MatSolve 31729ms 19.32% 63.99% 32180ms 19.59% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 3ms 0.0018% 63.99% 31143ms 18.96% KSP_PCApply.lto_priv.18 538ms 0.33% 64.32% 29782ms 18.13% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 3906ms 2.38% 66.70% 25908ms 15.77% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 1061ms 0.65% 67.34% 18411ms 11.21% CardiacNewtonSolver::Solve 834ms 0.51% 67.85% 15804ms 9.62% BidomainSolver::SetupLinearSystem 6414ms 3.91% 71.76% 13805ms 8.41% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 0 0% 71.76% 7282ms 4.43% KSP_PCApply (partial-inline) 6997ms 4.26% 76.02% 7027ms 4.28% __ieee754_log_fma 6ms 0.0037% 76.02% 6468ms 3.94% KSPConvergedDefault 61ms 0.037% 76.06% 6102ms 3.72% AbstractCardiacTissue::UpdateCaches (inline) 1188ms 0.72% 76.78% 5777ms 3.52% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 3815ms 2.32% 79.10% 3815ms 2.32% __memcpy_avx512_unaligned_erms 0 0% 79.10% 3761ms 2.29% PetscMemcpy (inline) 4ms 0.0024% 79.11% 3514ms 2.14% MatNullSpaceRemove 16ms 0.0097% 79.12% 3340ms 2.03% VecCopy 2ms 0.0012% 79.12% 3323ms 2.02% VecCopy_Seq (partial-inline) 2330ms 1.42% 80.54% 3232ms 1.97% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 354ms 0.22% 80.75% 3109ms 1.89% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 80.75% 3070ms 1.87% boost::numeric::ublas::norm_inf (inline) 2977ms 1.81% 82.56% 3070ms 1.87% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 82.56% 3070ms 1.87% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 82.56% 3070ms 1.87% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 11ms 0.0067% 82.57% 3056ms 1.86% std::pow (inline) 7ms 0.0043% 82.58% 2997ms 1.82% VecAXPY 222ms 0.14% 82.71% 2996ms 1.82% __pow 1ms 0.00061% 82.71% 2990ms 1.82% VecAXPY_Seq 2980ms 1.81% 84.53% 2980ms 1.81% daxpy_ 2764ms 1.68% 86.21% 2764ms 1.68% [libchaste_heart.so] 307ms 0.19% 86.40% 2722ms 1.66% __ieee754_pow_fma 2278ms 1.39% 87.78% 2278ms 1.39% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 0 0% 87.78% 2238ms 1.36% VecMDot 7ms 0.0043% 87.79% 2238ms 1.36% VecMXDot_Private 2221ms 1.35% 89.14% 2226ms 1.36% VecMDot_Seq 2003ms 1.22% 90.36% 2003ms 1.22% ddot_ 3ms 0.0018% 90.36% 1889ms 1.15% AbstractFeVolumeIntegralAssembler::DoAssemble 1500ms 0.91% 91.27% 1769ms 1.08% exp_inline (inline) 3ms 0.0018% 91.28% 1684ms 1.03% VecDot 1ms 0.00061% 91.28% 1681ms 1.02% VecDot_Seq 4ms 0.0024% 91.28% 1680ms 1.02% VecXDot_Seq_Private.constprop.0 23ms 0.014% 91.29% 1615ms 0.98% AbstractFeVolumeIntegralAssembler::AssembleOnElement 0 0% 91.29% 1301ms 0.79% AbstractFeAssemblerInterface::AssembleMatrix (inline) 6ms 0.0037% 91.30% 1272ms 0.77% VecMAXPY 1263ms 0.77% 92.06% 1266ms 0.77% VecMAXPY_Seq 1247ms 0.76% 92.82% 1247ms 0.76% __memset_avx512_unaligned_erms 0 0% 92.82% 1238ms 0.75% PetscMemzero (inline) 448ms 0.27% 93.10% 1106ms 0.67% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 4ms 0.0024% 93.10% 1076ms 0.66% boost::numeric::ublas::matrix_assign (inline) 160ms 0.097% 93.20% 1066ms 0.65% boost::numeric::ublas::indexing_matrix_assign 0 0% 93.20% 994ms 0.61% AbstractTetrahedralMesh::ConstructRegularSlabMesh 0 0% 93.20% 994ms 0.61% CuboidMeshConstructor::Construct 1ms 0.00061% 93.20% 994ms 0.61% DistributedTetrahedralMesh::ConstructCuboid 2ms 0.0012% 93.20% 982ms 0.6% VecDuplicate 1ms 0.00061% 93.20% 968ms 0.59% KSP_RemoveNullSpace (inline) 4ms 0.0024% 93.20% 903ms 0.55% VecScale 7ms 0.0043% 93.21% 899ms 0.55% VecScale_Seq 2ms 0.0012% 93.21% 896ms 0.55% Element::Element 888ms 0.54% 93.75% 888ms 0.54% dscal_ 2ms 0.0012% 93.75% 884ms 0.54% AbstractTetrahedralElement::CalculateJacobian 2ms 0.0012% 93.75% 831ms 0.51% AbstractTetrahedralElement::AbstractTetrahedralElement 1ms 0.00061% 93.75% 828ms 0.5% boost::numeric::ublas::c_matrix::c_matrix (inline)