File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 119044ms, 91.57% of 129998ms total Dropped 1168 nodes (cum <= 649.99ms) flat flat% sum% cum cum% 0 0% 0% 129980ms 100% __libc_start_call_main 0 0% 0% 129980ms 100% __libc_start_main_impl 0 0% 0% 129980ms 100% _start 0 0% 0% 129977ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 129977ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 129977ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 129977ms 100% main 0 0% 0% 129938ms 100% AbstractConvergenceTester::Converge 0 0% 0% 129938ms 100% CxxTest::RealTestDescription::run 0 0% 0% 129938ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 129938ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 129938ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 129938ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 6ms 0.0046% 0.0046% 128761ms 99.05% AbstractCardiacProblem::Solve 3ms 0.0023% 0.0069% 127955ms 98.43% AbstractDynamicLinearPdeSolver::Solve 7ms 0.0054% 0.012% 70646ms 54.34% LinearSystem::Solve 1ms 0.00077% 0.013% 70147ms 53.96% KSPSolve 6ms 0.0046% 0.018% 70147ms 53.96% KSPSolve_Private 12ms 0.0092% 0.027% 69784ms 53.68% KSPSolve_SYMMLQ 501ms 0.39% 0.41% 47777ms 36.75% AbstractCardiacTissue::SolveCellSystems 4ms 0.0031% 0.42% 39828ms 30.64% PCApply 3ms 0.0023% 0.42% 39813ms 30.63% PCApply_BJacobi_Singleblock 2ms 0.0015% 0.42% 37481ms 28.83% KSPSolve_PREONLY (partial-inline) 1234ms 0.95% 1.37% 37136ms 28.57% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 1ms 0.00077% 1.37% 36426ms 28.02% PCApply_ICC 7ms 0.0054% 1.37% 36425ms 28.02% MatSolve 36057ms 27.74% 29.11% 36418ms 28.01% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 4ms 0.0031% 29.11% 34196ms 26.31% KSP_PCApply.lto_priv.18 7785ms 5.99% 35.10% 32516ms 25.01% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 12ms 0.0092% 35.11% 24657ms 18.97% MatMult 299ms 0.23% 35.34% 24645ms 18.96% MatMult_SeqAIJ (partial-inline) 24099ms 18.54% 53.88% 24643ms 18.96% MatMult_SeqAIJ_Inode (inline) 2324ms 1.79% 55.67% 16861ms 12.97% CardiacNewtonSolver::Solve 5484ms 4.22% 59.89% 10010ms 7.70% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 1429ms 1.10% 60.99% 9335ms 7.18% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 313ms 0.24% 61.23% 9187ms 7.07% AbstractCardiacTissue::UpdateCaches (inline) 1178ms 0.91% 62.13% 8287ms 6.37% BidomainSolver::SetupLinearSystem 1706ms 1.31% 63.44% 8257ms 6.35% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 7622ms 5.86% 69.31% 7622ms 5.86% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 1ms 0.00077% 69.31% 7500ms 5.77% KSP_PCApply (partial-inline) 6ms 0.0046% 69.31% 7022ms 5.40% KSPConvergedDefault 4238ms 3.26% 72.57% 4333ms 3.33% __ieee754_log_fma 0 0% 72.57% 4048ms 3.11% boost::numeric::ublas::norm_inf (inline) 2761ms 2.12% 74.70% 4048ms 3.11% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 74.70% 4048ms 3.11% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 74.70% 4048ms 3.11% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 3708ms 2.85% 77.55% 3708ms 2.85% ddot_ 7ms 0.0054% 77.56% 3233ms 2.49% MatNullSpaceRemove 2144ms 1.65% 79.20% 3207ms 2.47% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 30ms 0.023% 79.23% 3141ms 2.42% std::pow (inline) 7ms 0.0054% 79.23% 3093ms 2.38% VecDot 423ms 0.33% 79.56% 3091ms 2.38% __pow 0 0% 79.56% 3086ms 2.37% VecDot_Seq 4ms 0.0031% 79.56% 3086ms 2.37% VecXDot_Seq_Private.constprop.0 2668ms 2.05% 81.61% 2668ms 2.05% __memcpy_avx_unaligned_erms 0 0% 81.61% 2635ms 2.03% PetscMemcpy (inline) 350ms 0.27% 81.88% 2635ms 2.03% __ieee754_pow_fma 21ms 0.016% 81.90% 2294ms 1.76% VecCopy 2ms 0.0015% 81.90% 2273ms 1.75% VecCopy_Seq (partial-inline) 0 0% 81.90% 2013ms 1.55% VecMDot 14ms 0.011% 81.91% 2013ms 1.55% VecMXDot_Private 1ms 0.00077% 81.91% 2012ms 1.55% AbstractFeVolumeIntegralAssembler::DoAssemble 1991ms 1.53% 83.44% 1997ms 1.54% VecMDot_Seq 8ms 0.0062% 83.45% 1902ms 1.46% VecAXPY 8ms 0.0062% 83.46% 1894ms 1.46% VecAXPY_Seq 1875ms 1.44% 84.90% 1875ms 1.44% daxpy_ 37ms 0.028% 84.93% 1674ms 1.29% AbstractFeVolumeIntegralAssembler::AssembleOnElement 1555ms 1.20% 86.12% 1621ms 1.25% exp_inline (inline) 0 0% 86.12% 1388ms 1.07% AbstractFeAssemblerInterface::AssembleMatrix (inline) 0 0% 86.12% 1276ms 0.98% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 86.12% 1276ms 0.98% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 86.12% 1276ms 0.98% boost_numeric_ublas_abs (inline) 1276ms 0.98% 87.10% 1276ms 0.98% std::abs (inline) 10ms 0.0077% 87.11% 1213ms 0.93% VecMAXPY 1199ms 0.92% 88.03% 1203ms 0.93% VecMAXPY_Seq 1192ms 0.92% 88.95% 1192ms 0.92% [libchaste_heart.so] 11ms 0.0085% 88.96% 1129ms 0.87% boost::numeric::ublas::matrix_assign (inline) 248ms 0.19% 89.15% 1108ms 0.85% boost::numeric::ublas::indexing_matrix_assign 0 0% 89.15% 1013ms 0.78% CuboidMeshConstructor::Construct 0 0% 89.15% 1011ms 0.78% AbstractTetrahedralMesh::ConstructRegularSlabMesh 1ms 0.00077% 89.15% 1011ms 0.78% DistributedTetrahedralMesh::ConstructCuboid 683ms 0.53% 89.68% 1002ms 0.77% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 1ms 0.00077% 89.68% 903ms 0.69% AbstractBidomainSolver::FinaliseLinearSystem 3ms 0.0023% 89.68% 901ms 0.69% VecNorm 216ms 0.17% 89.85% 900ms 0.69% AbstractBidomainSolver::CheckCompatibilityCondition 1ms 0.00077% 89.85% 895ms 0.69% Element::Element 0 0% 89.85% 891ms 0.69% VecNorm_Seq 8ms 0.0062% 89.85% 880ms 0.68% BidomainAssembler::ComputeMatrixTerm 5ms 0.0038% 89.86% 875ms 0.67% AbstractTetrahedralElement::CalculateJacobian 8ms 0.0062% 89.86% 874ms 0.67% boost::numeric::ublas::c_matrix::c_matrix (inline) 1ms 0.00077% 89.86% 835ms 0.64% AbstractTetrahedralElement::AbstractTetrahedralElement 766ms 0.59% 90.45% 766ms 0.59% __memset_avx2_unaligned_erms 0 0% 90.45% 751ms 0.58% PetscMemzero (inline) 5ms 0.0038% 90.46% 738ms 0.57% VecScale 2ms 0.0015% 90.46% 734ms 0.56% BidomainProblem::WriteOneStep 5ms 0.0038% 90.46% 733ms 0.56% VecScale_Seq 725ms 0.56% 91.02% 725ms 0.56% dscal_ 719ms 0.55% 91.57% 719ms 0.55% DistributedVector::Iterator::operator!= 1ms 0.00077% 91.57% 700ms 0.54% VecDuplicate