File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 177885ms, 94.21% of 188808ms total Dropped 1143 nodes (cum <= 944.04ms) flat flat% sum% cum cum% 0 0% 0% 188790ms 100% __libc_start_call_main 0 0% 0% 188790ms 100% __libc_start_main_impl 0 0% 0% 188790ms 100% _start 0 0% 0% 188788ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 188788ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 188788ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 188788ms 100% main 0 0% 0% 188756ms 100% AbstractConvergenceTester::Converge 0 0% 0% 188756ms 100% CxxTest::RealTestDescription::run 0 0% 0% 188756ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 188756ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 188756ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 188756ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 5ms 0.0026% 0.0026% 187543ms 99.33% AbstractCardiacProblem::Solve 14ms 0.0074% 0.01% 186687ms 98.88% AbstractDynamicLinearPdeSolver::Solve 12ms 0.0064% 0.016% 130146ms 68.93% LinearSystem::Solve 1ms 0.00053% 0.017% 129424ms 68.55% KSPSolve 15ms 0.0079% 0.025% 129423ms 68.55% KSPSolve_Private 20ms 0.011% 0.035% 128901ms 68.27% KSPSolve_SYMMLQ 19ms 0.01% 0.046% 76881ms 40.72% MatMult 337ms 0.18% 0.22% 76862ms 40.71% MatMult_SeqAIJ (partial-inline) 67856ms 35.94% 36.16% 76862ms 40.71% MatMult_SeqAIJ_Inode (inline) 7ms 0.0037% 36.17% 48008ms 25.43% PCApply 6ms 0.0032% 36.17% 47988ms 25.42% PCApply_BJacobi_Singleblock 5ms 0.0026% 36.17% 44018ms 23.31% KSPSolve_PREONLY (partial-inline) 8ms 0.0042% 36.18% 42259ms 22.38% PCApply_ICC 6ms 0.0032% 36.18% 42251ms 22.38% MatSolve 41530ms 22.00% 58.18% 42245ms 22.37% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1ms 0.00053% 58.18% 41685ms 22.08% KSP_PCApply.lto_priv.18 210ms 0.11% 58.29% 40163ms 21.27% AbstractCardiacTissue::SolveCellSystems 631ms 0.33% 58.62% 30696ms 16.26% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 5682ms 3.01% 61.63% 26597ms 14.09% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 911ms 0.48% 62.11% 15441ms 8.18% BidomainSolver::SetupLinearSystem 1085ms 0.57% 62.69% 14796ms 7.84% CardiacNewtonSolver::Solve 5584ms 2.96% 65.65% 10154ms 5.38% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 1ms 0.00053% 65.65% 8932ms 4.73% KSP_PCApply (partial-inline) 8661ms 4.59% 70.23% 8661ms 4.59% _mm_prefetch (inline) 88ms 0.047% 70.28% 8507ms 4.51% AbstractCardiacTissue::UpdateCaches (inline) 1606ms 0.85% 71.13% 8166ms 4.33% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 9ms 0.0048% 71.14% 7975ms 4.22% KSPConvergedDefault 1838ms 0.97% 72.11% 7611ms 4.03% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 5413ms 2.87% 74.98% 5413ms 2.87% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 5363ms 2.84% 77.82% 5363ms 2.84% __memcpy_evex_unaligned_erms 0 0% 77.82% 5318ms 2.82% PetscMemcpy (inline) 15ms 0.0079% 77.82% 5088ms 2.69% VecAXPY 3ms 0.0016% 77.83% 5073ms 2.69% VecAXPY_Seq 5050ms 2.67% 80.50% 5050ms 2.67% daxpy_ 19ms 0.01% 80.51% 4640ms 2.46% VecCopy 3ms 0.0016% 80.51% 4619ms 2.45% VecCopy_Seq (partial-inline) 12ms 0.0064% 80.52% 4561ms 2.42% MatNullSpaceRemove 4071ms 2.16% 82.67% 4075ms 2.16% __ieee754_log_fma 3472ms 1.84% 84.51% 3472ms 1.84% ddot_ 2132ms 1.13% 85.64% 3308ms 1.75% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 0 0% 85.64% 3178ms 1.68% boost::numeric::ublas::norm_inf (inline) 2687ms 1.42% 87.07% 3178ms 1.68% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 87.07% 3178ms 1.68% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 87.07% 3178ms 1.68% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 5ms 0.0026% 87.07% 2992ms 1.58% VecMDot 11ms 0.0058% 87.07% 2987ms 1.58% VecMXDot_Private 2955ms 1.57% 88.64% 2967ms 1.57% VecMDot_Seq 71ms 0.038% 88.68% 2922ms 1.55% std::pow (inline) 3ms 0.0016% 88.68% 2878ms 1.52% VecDot 1ms 0.00053% 88.68% 2875ms 1.52% VecDot_Seq 7ms 0.0037% 88.68% 2874ms 1.52% VecXDot_Seq_Private.constprop.0 311ms 0.16% 88.85% 2800ms 1.48% __pow 2735ms 1.45% 90.30% 2735ms 1.45% [libchaste_heart.so] 293ms 0.16% 90.45% 2442ms 1.29% __ieee754_pow_fma 2128ms 1.13% 91.58% 2128ms 1.13% __memset_evex_unaligned_erms 0 0% 91.58% 2116ms 1.12% PetscMemzero (inline) 0 0% 91.58% 2071ms 1.10% AbstractFeVolumeIntegralAssembler::DoAssemble 22ms 0.012% 91.59% 1776ms 0.94% AbstractFeVolumeIntegralAssembler::AssembleOnElement 2ms 0.0011% 91.59% 1665ms 0.88% VecDuplicate 6ms 0.0032% 91.59% 1557ms 0.82% VecMAXPY 1543ms 0.82% 92.41% 1551ms 0.82% VecMAXPY_Seq 15ms 0.0079% 92.42% 1448ms 0.77% PetscMallocA 5ms 0.0026% 92.42% 1433ms 0.76% PetscMallocAlign (partial-inline) 1384ms 0.73% 93.16% 1408ms 0.75% exp_inline (inline) 0 0% 93.16% 1397ms 0.74% AbstractFeAssemblerInterface::AssembleMatrix (inline) 13ms 0.0069% 93.16% 1362ms 0.72% VecScale 2ms 0.0011% 93.16% 1349ms 0.71% VecScale_Seq 1345ms 0.71% 93.88% 1345ms 0.71% dscal_ 1ms 0.00053% 93.88% 1092ms 0.58% boost::numeric::ublas::matrix_assign (inline) 199ms 0.11% 93.98% 1090ms 0.58% boost::numeric::ublas::indexing_matrix_assign 418ms 0.22% 94.20% 1089ms 0.58% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 8ms 0.0042% 94.21% 1080ms 0.57% VecDuplicate_Seq 0 0% 94.21% 1055ms 0.56% CuboidMeshConstructor::Construct 0 0% 94.21% 1054ms 0.56% AbstractTetrahedralMesh::ConstructRegularSlabMesh 4ms 0.0021% 94.21% 1054ms 0.56% DistributedTetrahedralMesh::ConstructCuboid 7ms 0.0037% 94.21% 960ms 0.51% VecSetType 3ms 0.0016% 94.21% 956ms 0.51% VecNorm