File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3681ms, 85.29% of 4316ms total Dropped 486 nodes (cum <= 21.58ms) flat flat% sum% cum cum% 0 0% 0% 4305ms 99.75% __libc_start_call_main 0 0% 0% 4305ms 99.75% __libc_start_main_impl 0 0% 0% 4305ms 99.75% _start 0 0% 0% 4301ms 99.65% main 0 0% 0% 4300ms 99.63% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4300ms 99.63% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4300ms 99.63% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4254ms 98.56% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4254ms 98.56% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4254ms 98.56% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 4245ms 98.35% AbstractCardiacProblem::Solve 0 0% 0% 4226ms 97.91% AbstractDynamicLinearPdeSolver::Solve 19ms 0.44% 0.44% 1979ms 45.85% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.46% 1898ms 43.98% LinearSystem::Solve 0 0% 0.46% 1832ms 42.45% KSPSolve 7ms 0.16% 0.63% 1832ms 42.45% KSPSolve_Private 2ms 0.046% 0.67% 1790ms 41.47% KSPSolve_CG 61ms 1.41% 2.09% 1324ms 30.68% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 268ms 6.21% 8.29% 1179ms 27.32% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 2ms 0.046% 8.34% 1091ms 25.28% PCApply 0 0% 8.34% 1078ms 24.98% PCApply_BJacobi_Singleblock 0 0% 8.34% 923ms 21.39% KSPSolve_PREONLY (partial-inline) 2ms 0.046% 8.39% 870ms 20.16% MatSolve 0 0% 8.39% 870ms 20.16% PCApply_ICC 0 0% 8.39% 866ms 20.06% KSP_PCApply.lto_priv.7 857ms 19.86% 28.24% 858ms 19.88% MatSolve_SeqSBAIJ_1_NaturalOrdering 15ms 0.35% 28.59% 584ms 13.53% AbstractCardiacTissue::UpdateCaches (inline) 2ms 0.046% 28.64% 581ms 13.46% MatMult 19ms 0.44% 29.08% 573ms 13.28% MatMult_SeqAIJ (partial-inline) 551ms 12.77% 41.84% 573ms 13.28% MatMult_SeqAIJ_Inode (inline) 116ms 2.69% 44.53% 536ms 12.42% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 75ms 1.74% 46.27% 533ms 12.35% CardiacNewtonSolver::Solve 1ms 0.023% 46.29% 335ms 7.76% KSPConvergedDefault 175ms 4.05% 50.35% 330ms 7.65% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 1ms 0.023% 50.37% 320ms 7.41% KSP_PCApply (partial-inline) 54ms 1.25% 51.62% 300ms 6.95% BidomainSolver::SetupLinearSystem 57ms 1.32% 52.94% 282ms 6.53% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 21ms 0.49% 53.43% 241ms 5.58% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 218ms 5.05% 58.48% 218ms 5.05% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 0 0% 58.48% 209ms 4.84% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 42ms 0.97% 59.45% 209ms 4.84% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 1ms 0.023% 59.48% 207ms 4.80% std::pow (inline) 30ms 0.7% 60.17% 204ms 4.73% __pow 177ms 4.10% 64.27% 179ms 4.15% __ieee754_log_fma 29ms 0.67% 64.94% 172ms 3.99% __ieee754_pow_fma 1ms 0.023% 64.97% 149ms 3.45% MatNullSpaceRemove 60ms 1.39% 66.36% 136ms 3.15% __GI___exp 126ms 2.92% 69.28% 126ms 2.92% ddot_ 0 0% 69.28% 123ms 2.85% boost::numeric::ublas::norm_inf (inline) 83ms 1.92% 71.20% 123ms 2.85% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 71.20% 123ms 2.85% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 71.20% 123ms 2.85% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 94ms 2.18% 73.38% 96ms 2.22% exp_inline (inline) 0 0% 73.38% 94ms 2.18% VecMDot 4ms 0.093% 73.47% 94ms 2.18% VecMXDot_Private 0 0% 73.47% 90ms 2.09% VecDuplicate 3ms 0.07% 73.54% 88ms 2.04% VecNorm 22ms 0.51% 74.05% 85ms 1.97% MPI_Wtime 0 0% 74.05% 83ms 1.92% VecTDot 48ms 1.11% 75.16% 82ms 1.90% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 0 0% 75.16% 74ms 1.71% VecNorm_Seq 0 0% 75.16% 70ms 1.62% VecTDot_Seq 0 0% 75.16% 70ms 1.62% VecXDot_Seq_Private.constprop.0 3ms 0.07% 75.23% 66ms 1.53% VecDestroy 12ms 0.28% 75.51% 63ms 1.46% PetscLogEventEndDefault 3ms 0.07% 75.58% 63ms 1.46% __GI___clock_gettime 10ms 0.23% 75.81% 61ms 1.41% PetscLogEventBeginDefault 58ms 1.34% 77.15% 60ms 1.39% VecMDot_Seq 60ms 1.39% 78.54% 60ms 1.39% [[vdso]] 2ms 0.046% 78.59% 58ms 1.34% KSP_RemoveNullSpace (inline) 2ms 0.046% 78.64% 54ms 1.25% VecMAXPY 4ms 0.093% 78.73% 48ms 1.11% VecDuplicate_MPI 46ms 1.07% 79.80% 46ms 1.07% [libchaste_heart.so] 34ms 0.79% 80.58% 46ms 1.07% __ieee754_exp_fma 43ms 1% 81.58% 43ms 1% log_inline (inline) 0 0% 81.58% 42ms 0.97% VecDuplicate_Seq 11ms 0.25% 81.84% 39ms 0.9% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.84% 39ms 0.9% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 81.84% 39ms 0.9% CxxTest::RealWorldDescription::setUp 0 0% 81.84% 39ms 0.9% PMPI_Init_thread 0 0% 81.84% 39ms 0.9% PetscInitialize 0 0% 81.84% 39ms 0.9% PetscSetup::setUpWorld 0 0% 81.84% 39ms 0.9% PetscSetupUtils::CommonSetup 0 0% 81.84% 39ms 0.9% PetscSetupUtils::InitialisePetsc 0 0% 81.84% 39ms 0.9% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 81.84% 39ms 0.9% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 81.84% 39ms 0.9% boost_numeric_ublas_abs (inline) 0 0% 81.84% 39ms 0.9% ompi_mpi_init 39ms 0.9% 82.74% 39ms 0.9% std::abs (inline) 2ms 0.046% 82.78% 36ms 0.83% 34ms 0.79% 83.57% 36ms 0.83% VecMAXPY_Seq 2ms 0.046% 83.62% 35ms 0.81% VecCopy 0 0% 83.62% 35ms 0.81% VecCreate 3ms 0.07% 83.69% 33ms 0.76% PetscMallocA 0 0% 83.69% 33ms 0.76% VecNorm_MPI 3ms 0.07% 83.76% 33ms 0.76% VecNorm_MPI_Default.constprop.0 32ms 0.74% 84.50% 32ms 0.74% [libm.so.6] 1ms 0.023% 84.52% 30ms 0.7% PetscMallocAlign 14ms 0.32% 84.85% 27ms 0.63% AbstractCardiacCell::SetVoltage 2ms 0.046% 84.89% 27ms 0.63% VecSetType 3ms 0.07% 84.96% 26ms 0.6% VecDestroy_MPI 5ms 0.12% 85.08% 25ms 0.58% __GI___libc_free 0 0% 85.08% 25ms 0.58% orte_init 4ms 0.093% 85.17% 24ms 0.56% PetscFreeAlign 0 0% 85.17% 22ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 5ms 0.12% 85.29% 22ms 0.51% VecCreate_MPI_Private