File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 110760ms, 91.69% of 120803ms total Dropped 1162 nodes (cum <= 604.01ms) flat flat% sum% cum cum% 0 0% 0% 120786ms 100% __libc_start_call_main 0 0% 0% 120786ms 100% __libc_start_main_impl 0 0% 0% 120786ms 100% _start 0 0% 0% 120783ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 120783ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 120783ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 120783ms 100% main 1ms 0.00083% 0.00083% 120745ms 100% AbstractConvergenceTester::Converge 0 0% 0.00083% 120745ms 100% CxxTest::RealTestDescription::run 0 0% 0.00083% 120745ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0.00083% 120745ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0.00083% 120745ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0.00083% 120745ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 1ms 0.00083% 0.0017% 119478ms 98.90% AbstractCardiacProblem::Solve 8ms 0.0066% 0.0083% 118604ms 98.18% AbstractDynamicLinearPdeSolver::Solve 5ms 0.0041% 0.012% 67015ms 55.47% LinearSystem::Solve 0 0% 0.012% 66517ms 55.06% KSPSolve 16ms 0.013% 0.026% 66517ms 55.06% KSPSolve_Private 13ms 0.011% 0.036% 66076ms 54.70% KSPSolve_SYMMLQ 217ms 0.18% 0.22% 42698ms 35.35% AbstractCardiacTissue::SolveCellSystems 8ms 0.0066% 0.22% 37150ms 30.75% PCApply 7ms 0.0058% 0.23% 37135ms 30.74% PCApply_BJacobi_Singleblock 0 0% 0.23% 34362ms 28.44% KSPSolve_PREONLY (partial-inline) 2ms 0.0017% 0.23% 33306ms 27.57% PCApply_ICC 3ms 0.0025% 0.23% 33304ms 27.57% MatSolve 32746ms 27.11% 27.34% 33301ms 27.57% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1401ms 1.16% 28.50% 32848ms 27.19% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 4ms 0.0033% 28.50% 32038ms 26.52% KSP_PCApply.lto_priv.18 7051ms 5.84% 34.34% 28349ms 23.47% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 13ms 0.011% 34.35% 22651ms 18.75% MatMult 19ms 0.016% 34.37% 22638ms 18.74% MatMult_SeqAIJ 22104ms 18.30% 52.66% 22636ms 18.74% MatMult_SeqAIJ_Inode (inline) 1872ms 1.55% 54.21% 14527ms 12.03% CardiacNewtonSolver::Solve 336ms 0.28% 54.49% 9022ms 7.47% AbstractCardiacTissue::UpdateCaches (inline) 4319ms 3.58% 58.07% 8478ms 7.02% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 1959ms 1.62% 59.69% 8472ms 7.01% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 1139ms 0.94% 60.63% 7884ms 6.53% BidomainSolver::SetupLinearSystem 1112ms 0.92% 61.55% 7275ms 6.02% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 2ms 0.0017% 61.55% 7022ms 5.81% KSP_PCApply (partial-inline) 2ms 0.0017% 61.55% 6511ms 5.39% KSPConvergedDefault 5888ms 4.87% 66.43% 5888ms 4.87% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 3882ms 3.21% 69.64% 3919ms 3.24% __ieee754_log_fma 0 0% 69.64% 3783ms 3.13% boost::numeric::ublas::norm_inf (inline) 2564ms 2.12% 71.76% 3783ms 3.13% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 71.76% 3783ms 3.13% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 71.76% 3783ms 3.13% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 3386ms 2.80% 74.57% 3386ms 2.80% __memcpy_avx_unaligned_erms 0 0% 74.57% 3364ms 2.78% PetscMemcpy (inline) 7ms 0.0058% 74.57% 3308ms 2.74% MatNullSpaceRemove 18ms 0.015% 74.59% 3213ms 2.66% std::pow (inline) 410ms 0.34% 74.93% 3186ms 2.64% __pow 1778ms 1.47% 76.40% 2894ms 2.40% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 2877ms 2.38% 78.78% 2877ms 2.38% ddot_ 29ms 0.024% 78.81% 2855ms 2.36% VecCopy 0 0% 78.81% 2824ms 2.34% VecCopy_Seq (partial-inline) 372ms 0.31% 79.11% 2766ms 2.29% __ieee754_pow_fma 15ms 0.012% 79.13% 2747ms 2.27% VecAXPY 4ms 0.0033% 79.13% 2732ms 2.26% VecAXPY_Seq 2716ms 2.25% 81.38% 2716ms 2.25% daxpy_ 5ms 0.0041% 81.38% 2325ms 1.92% VecDot 0 0% 81.38% 2320ms 1.92% VecDot_Seq 0 0% 81.38% 2320ms 1.92% VecXDot_Seq_Private.constprop.0 1ms 0.00083% 81.38% 2080ms 1.72% AbstractFeVolumeIntegralAssembler::DoAssemble 2ms 0.0017% 81.38% 1829ms 1.51% VecMDot 14ms 0.012% 81.40% 1827ms 1.51% VecMXDot_Private 1794ms 1.49% 82.88% 1809ms 1.50% VecMDot_Seq 25ms 0.021% 82.90% 1751ms 1.45% AbstractFeVolumeIntegralAssembler::AssembleOnElement 1620ms 1.34% 84.24% 1692ms 1.40% exp_inline (inline) 1489ms 1.23% 85.47% 1489ms 1.23% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CheckIndex0 (inline) 10ms 0.0083% 85.48% 1472ms 1.22% VecMAXPY 1455ms 1.20% 86.69% 1462ms 1.21% VecMAXPY_Seq 0 0% 86.69% 1430ms 1.18% AbstractFeAssemblerInterface::AssembleMatrix (inline) 1258ms 1.04% 87.73% 1258ms 1.04% __memset_avx2_unaligned_erms 0 0% 87.73% 1248ms 1.03% PetscMemzero (inline) 5ms 0.0041% 87.73% 1163ms 0.96% boost::numeric::ublas::matrix_assign (inline) 235ms 0.19% 87.93% 1149ms 0.95% boost::numeric::ublas::indexing_matrix_assign 0 0% 87.93% 1119ms 0.93% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 87.93% 1119ms 0.93% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 87.93% 1119ms 0.93% boost_numeric_ublas_abs (inline) 1119ms 0.93% 88.85% 1119ms 0.93% std::abs (inline) 0 0% 88.85% 1115ms 0.92% AbstractTetrahedralMesh::ConstructRegularSlabMesh 0 0% 88.85% 1115ms 0.92% CuboidMeshConstructor::Construct 1ms 0.00083% 88.85% 1115ms 0.92% DistributedTetrahedralMesh::ConstructCuboid 1ms 0.00083% 88.86% 1065ms 0.88% VecDuplicate 789ms 0.65% 89.51% 1034ms 0.86% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 5ms 0.0041% 89.51% 1033ms 0.86% KSP_RemoveNullSpace (inline) 1ms 0.00083% 89.51% 996ms 0.82% Element::Element 7ms 0.0058% 89.52% 983ms 0.81% AbstractTetrahedralElement::CalculateJacobian 1ms 0.00083% 89.52% 937ms 0.78% AbstractTetrahedralElement::AbstractTetrahedralElement 8ms 0.0066% 89.53% 914ms 0.76% BidomainAssembler::ComputeMatrixTerm 12ms 0.0099% 89.54% 896ms 0.74% PetscMallocA 6ms 0.005% 89.54% 884ms 0.73% PetscMallocAlign (partial-inline) 8ms 0.0066% 89.55% 863ms 0.71% boost::numeric::ublas::c_matrix::c_matrix (inline) 846ms 0.7% 90.25% 846ms 0.7% [libchaste_heart.so] 7ms 0.0058% 90.25% 837ms 0.69% VecScale 6ms 0.005% 90.26% 830ms 0.69% VecScale_Seq 1ms 0.00083% 90.26% 827ms 0.68% VecNorm 821ms 0.68% 90.94% 821ms 0.68% dscal_ 1ms 0.00083% 90.94% 817ms 0.68% BidomainProblem::WriteOneStep 3ms 0.0025% 90.94% 816ms 0.68% VecNorm_Seq 3ms 0.0025% 90.95% 700ms 0.58% AbstractBidomainSolver::FinaliseLinearSystem 231ms 0.19% 91.14% 695ms 0.58% AbstractBidomainSolver::CheckCompatibilityCondition 6ms 0.005% 91.14% 686ms 0.57% VecDuplicate_Seq 656ms 0.54% 91.68% 656ms 0.54% log_inline (inline) 0 0% 91.68% 650ms 0.54% AbstractFeAssemblerInterface::Assemble (inline) 0 0% 91.68% 624ms 0.52% boost::numeric::ublas::matrix_slice::operator= (inline) 2ms 0.0017% 91.69% 607ms 0.5% VecSetType