File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 125108ms, 91.34% of 136968ms total Dropped 1205 nodes (cum <= 684.84ms) flat flat% sum% cum cum% 0 0% 0% 136953ms 100% __libc_start_call_main 0 0% 0% 136953ms 100% __libc_start_main_impl 0 0% 0% 136953ms 100% _start 0 0% 0% 136950ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 136950ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 136950ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 136950ms 100% main 0 0% 0% 136906ms 100% AbstractConvergenceTester::Converge 0 0% 0% 136906ms 100% CxxTest::RealTestDescription::run 0 0% 0% 136906ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 136906ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 136906ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 136906ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 4ms 0.0029% 0.0029% 135647ms 99.04% AbstractCardiacProblem::Solve 6ms 0.0044% 0.0073% 134667ms 98.32% AbstractDynamicLinearPdeSolver::Solve 6ms 0.0044% 0.012% 75921ms 55.43% LinearSystem::Solve 4ms 0.0029% 0.015% 75391ms 55.04% KSPSolve 21ms 0.015% 0.03% 75387ms 55.04% KSPSolve_Private 14ms 0.01% 0.04% 75043ms 54.79% KSPSolve_SYMMLQ 552ms 0.4% 0.44% 48895ms 35.70% AbstractCardiacTissue::SolveCellSystems 4ms 0.0029% 0.45% 41004ms 29.94% PCApply 7ms 0.0051% 0.45% 40975ms 29.92% PCApply_BJacobi_Singleblock 4ms 0.0029% 0.45% 38180ms 27.88% KSPSolve_PREONLY (partial-inline) 972ms 0.71% 1.16% 38138ms 27.84% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 4ms 0.0029% 1.17% 37108ms 27.09% PCApply_ICC 11ms 0.008% 1.17% 37104ms 27.09% MatSolve 36678ms 26.78% 27.95% 37093ms 27.08% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 2ms 0.0015% 27.95% 35453ms 25.88% KSP_PCApply.lto_priv.18 8048ms 5.88% 33.83% 33831ms 24.70% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 12ms 0.0088% 33.84% 26408ms 19.28% MatMult 251ms 0.18% 34.02% 26396ms 19.27% MatMult_SeqAIJ (partial-inline) 25860ms 18.88% 52.90% 26392ms 19.27% MatMult_SeqAIJ_Inode (inline) 2160ms 1.58% 54.48% 17047ms 12.45% CardiacNewtonSolver::Solve 1578ms 1.15% 55.63% 10378ms 7.58% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 5876ms 4.29% 59.92% 10302ms 7.52% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 210ms 0.15% 60.08% 9094ms 6.64% AbstractCardiacTissue::UpdateCaches (inline) 1671ms 1.22% 61.30% 8534ms 6.23% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 8496ms 6.20% 67.50% 8496ms 6.20% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 1195ms 0.87% 68.37% 8467ms 6.18% BidomainSolver::SetupLinearSystem 2ms 0.0015% 68.37% 7638ms 5.58% KSP_PCApply (partial-inline) 12ms 0.0088% 68.38% 7280ms 5.32% KSPConvergedDefault 4098ms 2.99% 71.37% 4206ms 3.07% __ieee754_log_fma 0 0% 71.37% 4093ms 2.99% boost::numeric::ublas::norm_inf (inline) 2827ms 2.06% 73.44% 4093ms 2.99% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 73.44% 4093ms 2.99% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 73.44% 4093ms 2.99% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 3686ms 2.69% 76.13% 3686ms 2.69% __memcpy_avx_unaligned_erms 0 0% 76.13% 3636ms 2.65% PetscMemcpy (inline) 4ms 0.0029% 76.13% 3562ms 2.60% MatNullSpaceRemove 3546ms 2.59% 78.72% 3546ms 2.59% ddot_ 26ms 0.019% 78.74% 3295ms 2.41% std::pow (inline) 411ms 0.3% 79.04% 3253ms 2.38% __pow 21ms 0.015% 79.05% 3248ms 2.37% VecCopy 2ms 0.0015% 79.06% 3226ms 2.36% VecCopy_Seq (partial-inline) 2058ms 1.50% 80.56% 3148ms 2.30% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 24ms 0.018% 80.58% 3105ms 2.27% VecAXPY 5ms 0.0037% 80.58% 3081ms 2.25% VecAXPY_Seq 3059ms 2.23% 82.81% 3059ms 2.23% daxpy_ 11ms 0.008% 82.82% 2888ms 2.11% VecDot 1ms 0.00073% 82.82% 2877ms 2.10% VecDot_Seq 4ms 0.0029% 82.82% 2876ms 2.10% VecXDot_Seq_Private.constprop.0 413ms 0.3% 83.13% 2804ms 2.05% __ieee754_pow_fma 3ms 0.0022% 83.13% 2207ms 1.61% VecMDot 13ms 0.0095% 83.14% 2204ms 1.61% VecMXDot_Private 2176ms 1.59% 84.73% 2182ms 1.59% VecMDot_Seq 0 0% 84.73% 2023ms 1.48% AbstractFeVolumeIntegralAssembler::DoAssemble 28ms 0.02% 84.75% 1682ms 1.23% AbstractFeVolumeIntegralAssembler::AssembleOnElement 1497ms 1.09% 85.84% 1544ms 1.13% exp_inline (inline) 0 0% 85.84% 1399ms 1.02% AbstractFeAssemblerInterface::AssembleMatrix (inline) 8ms 0.0058% 85.85% 1351ms 0.99% VecMAXPY 1336ms 0.98% 86.82% 1343ms 0.98% VecMAXPY_Seq 0 0% 86.82% 1259ms 0.92% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 86.82% 1259ms 0.92% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 86.82% 1259ms 0.92% boost_numeric_ublas_abs (inline) 1259ms 0.92% 87.74% 1259ms 0.92% std::abs (inline) 9ms 0.0066% 87.75% 1099ms 0.8% boost::numeric::ublas::matrix_assign (inline) 233ms 0.17% 87.92% 1086ms 0.79% boost::numeric::ublas::indexing_matrix_assign 0 0% 87.92% 1066ms 0.78% CuboidMeshConstructor::Construct 0 0% 87.92% 1065ms 0.78% AbstractTetrahedralMesh::ConstructRegularSlabMesh 2ms 0.0015% 87.92% 1065ms 0.78% DistributedTetrahedralMesh::ConstructCuboid 695ms 0.51% 88.43% 1055ms 0.77% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 991ms 0.72% 89.15% 991ms 0.72% __memset_avx2_unaligned_erms 0 0% 89.15% 982ms 0.72% PetscMemzero (inline) 966ms 0.71% 89.85% 966ms 0.71% [libchaste_heart.so] 1ms 0.00073% 89.86% 960ms 0.7% Element::Element 3ms 0.0022% 89.86% 960ms 0.7% VecNorm 10ms 0.0073% 89.86% 948ms 0.69% VecScale 0 0% 89.86% 942ms 0.69% VecNorm_Seq 3ms 0.0022% 89.87% 938ms 0.68% VecScale_Seq 934ms 0.68% 90.55% 934ms 0.68% dscal_ 7ms 0.0051% 90.55% 913ms 0.67% AbstractTetrahedralElement::CalculateJacobian 2ms 0.0015% 90.56% 903ms 0.66% BidomainProblem::WriteOneStep 6ms 0.0044% 90.56% 901ms 0.66% VecDuplicate 0 0% 90.56% 897ms 0.65% AbstractBidomainSolver::FinaliseLinearSystem 254ms 0.19% 90.75% 893ms 0.65% AbstractBidomainSolver::CheckCompatibilityCondition 2ms 0.0015% 90.75% 871ms 0.64% BidomainAssembler::ComputeMatrixTerm 2ms 0.0015% 90.75% 863ms 0.63% AbstractTetrahedralElement::AbstractTetrahedralElement 7ms 0.0051% 90.75% 850ms 0.62% boost::numeric::ublas::c_matrix::c_matrix (inline) 805ms 0.59% 91.34% 805ms 0.59% log_inline (inline)