File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3416ms, 87.95% of 3884ms total Dropped 483 nodes (cum <= 19.42ms) flat flat% sum% cum cum% 0 0% 0% 3876ms 99.79% __libc_start_call_main 0 0% 0% 3876ms 99.79% __libc_start_main_impl 0 0% 0% 3876ms 99.79% _start 0 0% 0% 3873ms 99.72% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3873ms 99.72% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3873ms 99.72% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3873ms 99.72% main 0 0% 0% 3837ms 98.79% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3837ms 98.79% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3837ms 98.79% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 3830ms 98.61% AbstractCardiacProblem::Solve 1ms 0.026% 0.026% 3820ms 98.35% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.026% 1880ms 48.40% LinearSystem::Solve 0 0% 0.026% 1847ms 47.55% KSPSolve 6ms 0.15% 0.18% 1847ms 47.55% KSPSolve_Private 0 0% 0.18% 1804ms 46.45% KSPSolve_CG 12ms 0.31% 0.49% 1485ms 38.23% AbstractCardiacTissue::SolveCellSystems 2ms 0.051% 0.54% 1049ms 27.01% PCApply 0 0% 0.54% 1038ms 26.73% PCApply_BJacobi_Singleblock 29ms 0.75% 1.29% 971ms 25.00% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 0 0% 1.29% 900ms 23.17% KSPSolve_PREONLY (partial-inline) 164ms 4.22% 5.51% 863ms 22.22% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 0 0% 5.51% 842ms 21.68% KSP_PCApply.lto_priv.7 (partial-inline) 3ms 0.077% 5.59% 842ms 21.68% MatSolve 0 0% 5.59% 842ms 21.68% PCApply_ICC 826ms 21.27% 26.85% 832ms 21.42% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 5ms 0.13% 26.98% 803ms 20.67% MatMult 6ms 0.15% 27.14% 790ms 20.34% MatMult_SeqAIJ (partial-inline) 782ms 20.13% 47.27% 790ms 20.34% MatMult_SeqAIJ_Inode (inline) 2ms 0.051% 47.32% 475ms 12.23% AbstractCardiacTissue::UpdateCaches (inline) 204ms 5.25% 52.57% 450ms 11.59% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 39ms 1.00% 53.58% 416ms 10.71% BidomainSolver::SetupLinearSystem 34ms 0.88% 54.45% 382ms 9.84% CardiacNewtonSolver::Solve 0 0% 54.45% 318ms 8.19% KSP_PCApply (partial-inline) 0 0% 54.45% 284ms 7.31% KSPConvergedDefault 161ms 4.15% 58.60% 270ms 6.95% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 12ms 0.31% 58.91% 264ms 6.80% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 0 0% 58.91% 239ms 6.15% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 45ms 1.16% 60.07% 239ms 6.15% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 75ms 1.93% 62.00% 158ms 4.07% __GI___exp 1ms 0.026% 62.02% 147ms 3.78% MatNullSpaceRemove 0 0% 62.02% 146ms 3.76% std::pow (inline) 11ms 0.28% 62.31% 143ms 3.68% __pow 19ms 0.49% 62.80% 131ms 3.37% __ieee754_pow_fma 122ms 3.14% 65.94% 124ms 3.19% __ieee754_log_fma 116ms 2.99% 68.92% 116ms 2.99% [libchaste_heart.so] 14ms 0.36% 69.28% 89ms 2.29% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 69.28% 88ms 2.27% VecMDot 8ms 0.21% 69.49% 88ms 2.27% VecMXDot_Private 80ms 2.06% 71.55% 88ms 2.27% exp_inline (inline) 20ms 0.51% 72.06% 85ms 2.19% MPI_Wtime 83ms 2.14% 74.20% 83ms 2.14% ddot_ 0 0% 74.20% 77ms 1.98% VecDuplicate 52ms 1.34% 75.54% 76ms 1.96% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 1ms 0.026% 75.57% 69ms 1.78% VecTDot 68ms 1.75% 77.32% 69ms 1.78% __ieee754_exp_fma 0 0% 77.32% 66ms 1.70% boost::numeric::ublas::norm_inf (inline) 60ms 1.54% 78.86% 66ms 1.70% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 78.86% 66ms 1.70% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 78.86% 66ms 1.70% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 1ms 0.026% 78.89% 63ms 1.62% VecNorm 63ms 1.62% 80.51% 63ms 1.62% [[vdso]] 0 0% 80.51% 63ms 1.62% __GI___clock_gettime 11ms 0.28% 80.79% 60ms 1.54% PetscLogEventEndDefault 58ms 1.49% 82.29% 58ms 1.49% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 6ms 0.15% 82.44% 58ms 1.49% VecMAXPY 55ms 1.42% 83.86% 57ms 1.47% VecMDot_Seq 10ms 0.26% 84.11% 56ms 1.44% PetscLogEventBeginDefault 0 0% 84.11% 53ms 1.36% VecTDot_Seq 2ms 0.051% 84.17% 53ms 1.36% VecXDot_Seq_Private.constprop.0 1ms 0.026% 84.19% 43ms 1.11% VecNorm_Seq 2ms 0.051% 84.24% 42ms 1.08% VecDuplicate_MPI 3ms 0.077% 84.32% 37ms 0.95% VecDestroy 36ms 0.93% 85.25% 37ms 0.95% VecMAXPY_Seq 2ms 0.051% 85.30% 35ms 0.9% VecDuplicate_Seq 4ms 0.1% 85.40% 34ms 0.88% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 85.40% 34ms 0.88% AbstractBidomainSolver::FinaliseLinearSystem 5ms 0.13% 85.53% 34ms 0.88% PetscMallocA 0 0% 85.53% 32ms 0.82% CxxTest::RealWorldDescription::setUp 0 0% 85.53% 32ms 0.82% PetscInitialize 0 0% 85.53% 32ms 0.82% PetscSetup::setUpWorld 0 0% 85.53% 32ms 0.82% PetscSetupUtils::CommonSetup 0 0% 85.53% 32ms 0.82% PetscSetupUtils::InitialisePetsc 0 0% 85.53% 31ms 0.8% PMPI_Init_thread 0 0% 85.53% 31ms 0.8% ompi_mpi_init 0 0% 85.53% 29ms 0.75% PetscMallocAlign 0 0% 85.53% 26ms 0.67% VecCreate 2ms 0.051% 85.58% 25ms 0.64% 24ms 0.62% 86.20% 24ms 0.62% [libm.so.6] 2ms 0.051% 86.25% 23ms 0.59% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 2ms 0.051% 86.30% 23ms 0.59% VecAYPX 3ms 0.077% 86.38% 23ms 0.59% VecCreate_MPI_Private 9ms 0.23% 86.61% 23ms 0.59% __GI___libc_malloc 23ms 0.59% 87.20% 23ms 0.59% log_inline (inline) 2ms 0.051% 87.26% 22ms 0.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 2ms 0.051% 87.31% 22ms 0.57% __posix_memalign 0 0% 87.31% 22ms 0.57% orte_init 1ms 0.026% 87.33% 21ms 0.54% PetscHeaderDestroy_Private 21ms 0.54% 87.87% 21ms 0.54% ReplicatableVector::operator[] 3ms 0.077% 87.95% 21ms 0.54% VecCopy 0 0% 87.95% 21ms 0.54% VecSetType 0 0% 87.95% 20ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 0 0% 87.95% 20ms 0.51% PetscMemcpy (inline)