File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 155761ms, 93.37% of 166822ms total Dropped 1108 nodes (cum <= 834.11ms) flat flat% sum% cum cum% 0 0% 0% 166803ms 100% __libc_start_call_main 0 0% 0% 166803ms 100% __libc_start_main_impl 0 0% 0% 166803ms 100% _start 0 0% 0% 166800ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 166800ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 166800ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 166800ms 100% main 0 0% 0% 166764ms 100% AbstractConvergenceTester::Converge 0 0% 0% 166764ms 100% CxxTest::RealTestDescription::run 0 0% 0% 166764ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 166764ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 166764ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 166764ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 2ms 0.0012% 0.0012% 165553ms 99.24% AbstractCardiacProblem::Solve 4ms 0.0024% 0.0036% 164798ms 98.79% AbstractDynamicLinearPdeSolver::Solve 6ms 0.0036% 0.0072% 115143ms 69.02% LinearSystem::Solve 1ms 0.0006% 0.0078% 114595ms 68.69% KSPSolve 7ms 0.0042% 0.012% 114594ms 68.69% KSPSolve_Private 11ms 0.0066% 0.019% 114171ms 68.44% KSPSolve_SYMMLQ 7ms 0.0042% 0.023% 75131ms 45.04% MatMult 2539ms 1.52% 1.54% 75124ms 45.03% MatMult_SeqAIJ (partial-inline) 72038ms 43.18% 44.73% 72893ms 43.70% MatMult_SeqAIJ_Inode (inline) 2ms 0.0012% 44.73% 38700ms 23.20% PCApply 2ms 0.0012% 44.73% 38691ms 23.19% PCApply_BJacobi_Singleblock 5ms 0.003% 44.73% 35754ms 21.43% KSPSolve_PREONLY (partial-inline) 1ms 0.0006% 44.73% 34343ms 20.59% PCApply_ICC 6ms 0.0036% 44.74% 34342ms 20.59% MatSolve 33849ms 20.29% 65.03% 34336ms 20.58% MatSolve_SeqSBAIJ_1_NaturalOrdering 231ms 0.14% 65.17% 33728ms 20.22% AbstractCardiacTissue::SolveCellSystems 3ms 0.0018% 65.17% 33330ms 19.98% KSP_PCApply.lto_priv.18 552ms 0.33% 65.50% 26718ms 16.02% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 3868ms 2.32% 67.82% 22587ms 13.54% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 1265ms 0.76% 68.58% 15212ms 9.12% CardiacNewtonSolver::Solve 926ms 0.56% 69.13% 14845ms 8.90% BidomainSolver::SetupLinearSystem 5641ms 3.38% 72.51% 10108ms 6.06% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 0 0% 72.51% 7633ms 4.58% KSP_PCApply (partial-inline) 7ms 0.0042% 72.52% 6829ms 4.09% KSPConvergedDefault 53ms 0.032% 72.55% 6087ms 3.65% AbstractCardiacTissue::UpdateCaches (inline) 1366ms 0.82% 73.37% 5717ms 3.43% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 4133ms 2.48% 75.84% 4133ms 2.48% __memcpy_avx512_unaligned_erms 0 0% 75.84% 4080ms 2.45% PetscMemcpy (inline) 4050ms 2.43% 78.27% 4057ms 2.43% __ieee754_log_fma 12ms 0.0072% 78.28% 3814ms 2.29% MatNullSpaceRemove 19ms 0.011% 78.29% 3632ms 2.18% VecCopy 3ms 0.0018% 78.29% 3612ms 2.17% VecCopy_Seq (partial-inline) 2571ms 1.54% 79.83% 3499ms 2.10% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 7ms 0.0042% 79.84% 3484ms 2.09% VecAXPY 2ms 0.0012% 79.84% 3477ms 2.08% VecAXPY_Seq 3464ms 2.08% 81.92% 3464ms 2.08% daxpy_ 0 0% 81.92% 3322ms 1.99% boost::numeric::ublas::norm_inf (inline) 2831ms 1.70% 83.61% 3322ms 1.99% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 83.61% 3322ms 1.99% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 83.61% 3322ms 1.99% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 340ms 0.2% 83.82% 2884ms 1.73% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 18ms 0.011% 83.83% 2793ms 1.67% std::pow (inline) 2771ms 1.66% 85.49% 2771ms 1.66% [libchaste_heart.so] 224ms 0.13% 85.62% 2735ms 1.64% __pow 284ms 0.17% 85.79% 2463ms 1.48% __ieee754_pow_fma 1ms 0.0006% 85.79% 2325ms 1.39% VecMDot 15ms 0.009% 85.80% 2324ms 1.39% VecMXDot_Private 2302ms 1.38% 87.18% 2305ms 1.38% VecMDot_Seq 2144ms 1.29% 88.47% 2144ms 1.29% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 2141ms 1.28% 89.75% 2141ms 1.28% ddot_ 0 0% 89.75% 2005ms 1.20% AbstractFeVolumeIntegralAssembler::DoAssemble 1534ms 0.92% 90.67% 1774ms 1.06% exp_inline (inline) 1ms 0.0006% 90.67% 1755ms 1.05% VecDot 1ms 0.0006% 90.67% 1754ms 1.05% VecDot_Seq 4ms 0.0024% 90.67% 1753ms 1.05% VecXDot_Seq_Private.constprop.0 20ms 0.012% 90.69% 1646ms 0.99% AbstractFeVolumeIntegralAssembler::AssembleOnElement 12ms 0.0072% 90.69% 1477ms 0.89% VecMAXPY 1461ms 0.88% 91.57% 1465ms 0.88% VecMAXPY_Seq 1464ms 0.88% 92.45% 1464ms 0.88% __memset_avx512_unaligned_erms 0 0% 92.45% 1453ms 0.87% PetscMemzero (inline) 0 0% 92.45% 1384ms 0.83% AbstractFeAssemblerInterface::AssembleMatrix (inline) 1ms 0.0006% 92.45% 1184ms 0.71% VecDuplicate 457ms 0.27% 92.72% 1156ms 0.69% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 1ms 0.0006% 92.72% 1121ms 0.67% KSP_RemoveNullSpace (inline) 5ms 0.003% 92.72% 1068ms 0.64% boost::numeric::ublas::matrix_assign (inline) 122ms 0.073% 92.80% 1061ms 0.64% boost::numeric::ublas::indexing_matrix_assign 0 0% 92.80% 1050ms 0.63% CuboidMeshConstructor::Construct 0 0% 92.80% 1049ms 0.63% AbstractTetrahedralMesh::ConstructRegularSlabMesh 2ms 0.0012% 92.80% 1049ms 0.63% DistributedTetrahedralMesh::ConstructCuboid 11ms 0.0066% 92.81% 1035ms 0.62% PetscMallocA 5ms 0.003% 92.81% 1024ms 0.61% PetscMallocAlign (partial-inline) 1ms 0.0006% 92.81% 945ms 0.57% Element::Element 11ms 0.0066% 92.82% 932ms 0.56% VecScale 4ms 0.0024% 92.82% 921ms 0.55% VecScale_Seq 3ms 0.0018% 92.82% 916ms 0.55% AbstractTetrahedralElement::CalculateJacobian 913ms 0.55% 93.37% 913ms 0.55% dscal_ 1ms 0.0006% 93.37% 869ms 0.52% AbstractTetrahedralElement::AbstractTetrahedralElement 3ms 0.0018% 93.37% 850ms 0.51% BidomainAssembler::ComputeMatrixTerm