File: TestConvergenceEfficiency Type: cpu Showing nodes accounting for 136306ms, 93.67% of 145523ms total Dropped 1050 nodes (cum <= 727.62ms) flat flat% sum% cum cum% 0 0% 0% 145503ms 100% __libc_start_call_main 0 0% 0% 145503ms 100% __libc_start_main_impl 0 0% 0% 145503ms 100% _start 0 0% 0% 145501ms 100% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 145501ms 100% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 145501ms 100% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 145501ms 100% main 0 0% 0% 145470ms 100% AbstractConvergenceTester::Converge 0 0% 0% 145470ms 100% CxxTest::RealTestDescription::run 0 0% 0% 145470ms 100% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 145470ms 100% CxxTest::TestRunner::runTest (inline) 0 0% 0% 145470ms 100% TestConvergenceEfficiency::Test3DSpace10Efficiency (inline) 0 0% 0% 145470ms 100% TestDescription_TestConvergenceEfficiency_Test3DSpace10Efficiency::runTest (inline) 5ms 0.0034% 0.0034% 144469ms 99.28% AbstractCardiacProblem::Solve 4ms 0.0027% 0.0062% 144030ms 98.97% AbstractDynamicLinearPdeSolver::Solve 3ms 0.0021% 0.0082% 96955ms 66.63% LinearSystem::Solve 0 0% 0.0082% 96560ms 66.35% KSPSolve 3ms 0.0021% 0.01% 96560ms 66.35% KSPSolve_Private 10ms 0.0069% 0.017% 96278ms 66.16% KSPSolve_SYMMLQ 3ms 0.0021% 0.019% 67505ms 46.39% MatMult 999ms 0.69% 0.71% 67502ms 46.39% MatMult_SeqAIJ (partial-inline) 66227ms 45.51% 46.22% 67501ms 46.39% MatMult_SeqAIJ_Inode (inline) 203ms 0.14% 46.35% 32066ms 22.04% AbstractCardiacTissue::SolveCellSystems 5ms 0.0034% 46.36% 30823ms 21.18% PCApply 5ms 0.0034% 46.36% 30810ms 21.17% PCApply_BJacobi_Singleblock 1ms 0.00069% 46.36% 28353ms 19.48% KSPSolve_PREONLY (partial-inline) 2ms 0.0014% 46.36% 27155ms 18.66% PCApply_ICC 5ms 0.0034% 46.37% 27153ms 18.66% MatSolve 26756ms 18.39% 64.75% 27148ms 18.66% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 5ms 0.0034% 64.76% 26395ms 18.14% KSP_PCApply.lto_priv.18 466ms 0.32% 65.08% 26080ms 17.92% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 3439ms 2.36% 67.44% 22722ms 15.61% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 929ms 0.64% 68.08% 16148ms 11.10% CardiacNewtonSolver::Solve 789ms 0.54% 68.62% 14198ms 9.76% BidomainSolver::SetupLinearSystem 5643ms 3.88% 72.50% 12189ms 8.38% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 0 0% 72.50% 6299ms 4.33% KSP_PCApply (partial-inline) 6174ms 4.24% 76.74% 6215ms 4.27% __ieee754_log_fma 3ms 0.0021% 76.74% 5634ms 3.87% KSPConvergedDefault 40ms 0.027% 76.77% 5230ms 3.59% AbstractCardiacTissue::UpdateCaches (inline) 1101ms 0.76% 77.53% 4929ms 3.39% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 3116ms 2.14% 79.67% 3116ms 2.14% __memcpy_avx512_unaligned_erms 1ms 0.00069% 79.67% 3107ms 2.14% MatNullSpaceRemove 0 0% 79.67% 3087ms 2.12% PetscMemcpy (inline) 13ms 0.0089% 79.68% 2873ms 1.97% VecAXPY 2ms 0.0014% 79.68% 2860ms 1.97% VecAXPY_Seq 2849ms 1.96% 81.64% 2849ms 1.96% daxpy_ 2034ms 1.40% 83.03% 2816ms 1.94% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 16ms 0.011% 83.05% 2715ms 1.87% VecCopy 2ms 0.0014% 83.05% 2699ms 1.85% VecCopy_Seq (partial-inline) 333ms 0.23% 83.28% 2634ms 1.81% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 83.28% 2617ms 1.80% boost::numeric::ublas::norm_inf (inline) 2548ms 1.75% 85.03% 2617ms 1.80% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 85.03% 2617ms 1.80% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 85.03% 2617ms 1.80% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 8ms 0.0055% 85.03% 2584ms 1.78% std::pow (inline) 148ms 0.1% 85.13% 2534ms 1.74% __pow 288ms 0.2% 85.33% 2355ms 1.62% __ieee754_pow_fma 2330ms 1.60% 86.93% 2330ms 1.60% [libchaste_heart.so] 0 0% 86.93% 1923ms 1.32% VecMDot 12ms 0.0082% 86.94% 1923ms 1.32% VecMXDot_Private 1901ms 1.31% 88.25% 1907ms 1.31% VecMDot_Seq 1834ms 1.26% 89.51% 1834ms 1.26% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 1777ms 1.22% 90.73% 1777ms 1.22% ddot_ 1ms 0.00069% 90.73% 1659ms 1.14% AbstractFeVolumeIntegralAssembler::DoAssemble 1267ms 0.87% 91.60% 1466ms 1.01% exp_inline (inline) 2ms 0.0014% 91.60% 1448ms 1% VecDot 0 0% 91.60% 1446ms 0.99% VecDot_Seq 0 0% 91.60% 1446ms 0.99% VecXDot_Seq_Private.constprop.0 21ms 0.014% 91.62% 1398ms 0.96% AbstractFeVolumeIntegralAssembler::AssembleOnElement 1219ms 0.84% 92.45% 1219ms 0.84% __memset_avx512_unaligned_erms 0 0% 92.45% 1211ms 0.83% PetscMemzero (inline) 6ms 0.0041% 92.46% 1183ms 0.81% VecMAXPY 1173ms 0.81% 93.26% 1177ms 0.81% VecMAXPY_Seq 0 0% 93.26% 1143ms 0.79% AbstractFeAssemblerInterface::AssembleMatrix (inline) 449ms 0.31% 93.57% 1058ms 0.73% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 1ms 0.00069% 93.57% 956ms 0.66% VecDuplicate 1ms 0.00069% 93.57% 913ms 0.63% KSP_RemoveNullSpace (inline) 6ms 0.0041% 93.58% 883ms 0.61% boost::numeric::ublas::matrix_assign (inline) 109ms 0.075% 93.65% 872ms 0.6% boost::numeric::ublas::indexing_matrix_assign 0 0% 93.65% 868ms 0.6% CuboidMeshConstructor::Construct 0 0% 93.65% 867ms 0.6% AbstractTetrahedralMesh::ConstructRegularSlabMesh 0 0% 93.65% 867ms 0.6% DistributedTetrahedralMesh::ConstructCuboid 7ms 0.0048% 93.66% 825ms 0.57% PetscMallocA 9ms 0.0062% 93.66% 818ms 0.56% PetscMallocAlign (partial-inline) 1ms 0.00069% 93.66% 780ms 0.54% Element::Element 2ms 0.0014% 93.67% 754ms 0.52% AbstractTetrahedralElement::CalculateJacobian