File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 184702ms, 94.77% of 194886ms total Dropped 1168 nodes (cum <= 974.43ms) flat flat% sum% cum cum% 0 0% 0% 194859ms 100% __libc_start_call_main 0 0% 0% 194859ms 100% __libc_start_main_impl 0 0% 0% 194859ms 100% _start 0 0% 0% 194857ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 194857ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 194857ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 194857ms 100% main 0 0% 0% 194826ms 100% AbstractConvergenceTester::Converge 0 0% 0% 194826ms 100% CxxTest::RealTestDescription::run 0 0% 0% 194826ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 194826ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 194826ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 194826ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 5ms 0.0026% 0.0026% 193607ms 99.34% AbstractCardiacProblem::Solve 7ms 0.0036% 0.0062% 192729ms 98.89% AbstractDynamicLinearPdeSolver::Solve 10ms 0.0051% 0.011% 137734ms 70.67% LinearSystem::Solve 6ms 0.0031% 0.014% 136930ms 70.26% KSPSolve 18ms 0.0092% 0.024% 136925ms 70.26% KSPSolve_Private 26ms 0.013% 0.037% 136399ms 69.99% KSPSolve_SYMMLQ 21ms 0.011% 0.048% 77492ms 39.76% MatMult 350ms 0.18% 0.23% 77471ms 39.75% MatMult_SeqAIJ (partial-inline) 68291ms 35.04% 35.27% 77468ms 39.75% MatMult_SeqAIJ_Inode (inline) 9ms 0.0046% 35.27% 52405ms 26.89% PCApply 9ms 0.0046% 35.28% 52373ms 26.87% PCApply_BJacobi_Singleblock 2ms 0.001% 35.28% 47896ms 24.58% KSPSolve_PREONLY (partial-inline) 7ms 0.0036% 35.28% 45983ms 23.59% PCApply_ICC 6ms 0.0031% 35.29% 45976ms 23.59% MatSolve 45284ms 23.24% 58.52% 45970ms 23.59% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 4ms 0.0021% 58.52% 45395ms 23.29% KSP_PCApply.lto_priv.18 208ms 0.11% 58.63% 39704ms 20.37% AbstractCardiacTissue::SolveCellSystems 653ms 0.34% 58.97% 30510ms 15.66% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 5703ms 2.93% 61.89% 26330ms 13.51% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 1169ms 0.6% 62.49% 14875ms 7.63% CardiacNewtonSolver::Solve 919ms 0.47% 62.96% 14378ms 7.38% BidomainSolver::SetupLinearSystem 5621ms 2.88% 65.85% 10121ms 5.19% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 1ms 0.00051% 65.85% 9785ms 5.02% KSP_PCApply (partial-inline) 8821ms 4.53% 70.37% 8821ms 4.53% _mm_prefetch (inline) 12ms 0.0062% 70.38% 8730ms 4.48% KSPConvergedDefault 89ms 0.046% 70.43% 8246ms 4.23% AbstractCardiacTissue::UpdateCaches (inline) 1571ms 0.81% 71.23% 7873ms 4.04% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 1039ms 0.53% 71.77% 6924ms 3.55% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 10ms 0.0051% 71.77% 5811ms 2.98% VecAXPY 2ms 0.001% 71.77% 5801ms 2.98% VecAXPY_Seq 5788ms 2.97% 74.74% 5788ms 2.97% daxpy_ 5755ms 2.95% 77.69% 5755ms 2.95% __memcpy_evex_unaligned_erms 0 0% 77.69% 5708ms 2.93% PetscMemcpy (inline) 5514ms 2.83% 80.52% 5514ms 2.83% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 25ms 0.013% 80.54% 5073ms 2.60% VecCopy 2ms 0.001% 80.54% 5044ms 2.59% VecCopy_Seq (partial-inline) 11ms 0.0056% 80.54% 4938ms 2.53% MatNullSpaceRemove 4028ms 2.07% 82.61% 4034ms 2.07% __ieee754_log_fma 3735ms 1.92% 84.53% 3735ms 1.92% ddot_ 2125ms 1.09% 85.62% 3352ms 1.72% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 4ms 0.0021% 85.62% 3331ms 1.71% VecMDot 27ms 0.014% 85.63% 3327ms 1.71% VecMXDot_Private 82ms 0.042% 85.68% 3303ms 1.69% std::pow (inline) 3280ms 1.68% 87.36% 3294ms 1.69% VecMDot_Seq 312ms 0.16% 87.52% 3183ms 1.63% __pow 0 0% 87.52% 3163ms 1.62% boost::numeric::ublas::norm_inf (inline) 2666ms 1.37% 88.89% 3163ms 1.62% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 88.89% 3163ms 1.62% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 88.89% 3163ms 1.62% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 9ms 0.0046% 88.89% 3070ms 1.58% VecDot 0 0% 88.89% 3061ms 1.57% VecDot_Seq 3ms 0.0015% 88.89% 3061ms 1.57% VecXDot_Seq_Private.constprop.0 312ms 0.16% 89.05% 2836ms 1.46% __ieee754_pow_fma 2704ms 1.39% 90.44% 2704ms 1.39% [libchaste_heart.so] 2300ms 1.18% 91.62% 2300ms 1.18% __memset_evex_unaligned_erms 0 0% 91.62% 2288ms 1.17% PetscMemzero (inline) 3ms 0.0015% 91.62% 2072ms 1.06% AbstractFeVolumeIntegralAssembler::DoAssemble 2ms 0.001% 91.62% 1872ms 0.96% VecDuplicate 25ms 0.013% 91.64% 1745ms 0.9% AbstractFeVolumeIntegralAssembler::AssembleOnElement 26ms 0.013% 91.65% 1633ms 0.84% PetscMallocA 10ms 0.0051% 91.65% 1607ms 0.82% PetscMallocAlign (partial-inline) 10ms 0.0051% 91.66% 1596ms 0.82% VecMAXPY 1579ms 0.81% 92.47% 1586ms 0.81% VecMAXPY_Seq 1414ms 0.73% 93.19% 1446ms 0.74% exp_inline (inline) 0 0% 93.19% 1399ms 0.72% AbstractFeAssemblerInterface::AssembleMatrix (inline) 13ms 0.0067% 93.20% 1390ms 0.71% VecScale 1ms 0.00051% 93.20% 1377ms 0.71% VecScale_Seq 1373ms 0.7% 93.91% 1373ms 0.7% dscal_ 7ms 0.0036% 93.91% 1220ms 0.63% VecDuplicate_Seq 6ms 0.0031% 93.91% 1110ms 0.57% boost::numeric::ublas::matrix_assign (inline) 203ms 0.1% 94.02% 1101ms 0.56% boost::numeric::ublas::indexing_matrix_assign 420ms 0.22% 94.23% 1092ms 0.56% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 2ms 0.001% 94.23% 1091ms 0.56% VecSetType 9ms 0.0046% 94.24% 1066ms 0.55% VecCreate_Seq 0 0% 94.24% 1049ms 0.54% CuboidMeshConstructor::Construct 0 0% 94.24% 1048ms 0.54% AbstractTetrahedralMesh::ConstructRegularSlabMesh 3ms 0.0015% 94.24% 1048ms 0.54% DistributedTetrahedralMesh::ConstructCuboid 1034ms 0.53% 94.77% 1034ms 0.53% log_inline (inline) 4ms 0.0021% 94.77% 1025ms 0.53% VecNorm 3ms 0.0015% 94.77% 1008ms 0.52% VecNorm_Seq