File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3808ms, 87.68% of 4343ms total Dropped 475 nodes (cum <= 21.71ms) flat flat% sum% cum cum% 0 0% 0% 4334ms 99.79% __libc_start_call_main 0 0% 0% 4334ms 99.79% __libc_start_main_impl 0 0% 0% 4334ms 99.79% _start 0 0% 0% 4330ms 99.70% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4330ms 99.70% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4330ms 99.70% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4330ms 99.70% main 0 0% 0% 4290ms 98.78% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4290ms 98.78% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4290ms 98.78% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 2ms 0.046% 0.046% 4282ms 98.60% AbstractCardiacProblem::Solve 3ms 0.069% 0.12% 4260ms 98.09% AbstractDynamicLinearPdeSolver::Solve 25ms 0.58% 0.69% 1976ms 45.50% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.71% 1927ms 44.37% LinearSystem::Solve 0 0% 0.71% 1887ms 43.45% KSPSolve 5ms 0.12% 0.83% 1887ms 43.45% KSPSolve_Private 2ms 0.046% 0.87% 1842ms 42.41% KSPSolve_CG 49ms 1.13% 2.00% 1360ms 31.31% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 264ms 6.08% 8.08% 1205ms 27.75% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 2ms 0.046% 8.13% 1142ms 26.30% PCApply 0 0% 8.13% 1134ms 26.11% PCApply_BJacobi_Singleblock 1ms 0.023% 8.15% 973ms 22.40% KSPSolve_PREONLY (partial-inline) 0 0% 8.15% 929ms 21.39% KSP_PCApply.lto_priv.7 1ms 0.023% 8.17% 898ms 20.68% MatSolve 0 0% 8.17% 898ms 20.68% PCApply_ICC 890ms 20.49% 28.67% 894ms 20.58% MatSolve_SeqSBAIJ_1_NaturalOrdering 16ms 0.37% 29.04% 552ms 12.71% AbstractCardiacTissue::UpdateCaches (inline) 73ms 1.68% 30.72% 527ms 12.13% CardiacNewtonSolver::Solve 2ms 0.046% 30.76% 527ms 12.13% MatMult 7ms 0.16% 30.92% 519ms 11.95% MatMult_SeqAIJ (partial-inline) 505ms 11.63% 42.55% 519ms 11.95% MatMult_SeqAIJ_Inode (inline) 135ms 3.11% 45.66% 509ms 11.72% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 0 0% 45.66% 329ms 7.58% KSP_PCApply (partial-inline) 1ms 0.023% 45.68% 308ms 7.09% KSPConvergedDefault 172ms 3.96% 49.64% 302ms 6.95% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 73ms 1.68% 51.32% 301ms 6.93% BidomainSolver::SetupLinearSystem 67ms 1.54% 52.87% 294ms 6.77% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 20ms 0.46% 53.33% 259ms 5.96% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 0 0% 53.33% 231ms 5.32% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 49ms 1.13% 54.46% 231ms 5.32% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 220ms 5.07% 59.52% 220ms 5.07% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 4ms 0.092% 59.61% 170ms 3.91% MatNullSpaceRemove 156ms 3.59% 63.21% 156ms 3.59% ddot_ 1ms 0.023% 63.23% 155ms 3.57% std::pow (inline) 24ms 0.55% 63.78% 154ms 3.55% __pow 148ms 3.41% 67.19% 149ms 3.43% __ieee754_log_fma 57ms 1.31% 68.50% 145ms 3.34% __GI___exp 0 0% 68.50% 139ms 3.20% boost::numeric::ublas::norm_inf (inline) 87ms 2.00% 70.50% 139ms 3.20% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 70.50% 139ms 3.20% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 70.50% 139ms 3.20% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 16ms 0.37% 70.87% 129ms 2.97% __ieee754_pow_fma 1ms 0.023% 70.90% 103ms 2.37% VecTDot 0 0% 70.90% 97ms 2.23% VecDuplicate 64ms 1.47% 72.37% 96ms 2.21% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 0 0% 72.37% 92ms 2.12% VecMDot 3ms 0.069% 72.44% 92ms 2.12% VecMXDot_Private 0 0% 72.44% 92ms 2.12% VecTDot_Seq 1ms 0.023% 72.46% 92ms 2.12% VecXDot_Seq_Private.constprop.0 1ms 0.023% 72.48% 82ms 1.89% VecNorm 81ms 1.87% 74.35% 82ms 1.89% exp_inline (inline) 21ms 0.48% 74.83% 81ms 1.87% MPI_Wtime 0 0% 74.83% 74ms 1.70% VecMAXPY 0 0% 74.83% 73ms 1.68% VecNorm_Seq 11ms 0.25% 75.09% 67ms 1.54% PetscLogEventEndDefault 65ms 1.50% 76.58% 67ms 1.54% VecMDot_Seq 1ms 0.023% 76.61% 60ms 1.38% __GI___clock_gettime 59ms 1.36% 77.96% 59ms 1.36% [[vdso]] 12ms 0.28% 78.24% 56ms 1.29% PetscLogEventBeginDefault 2ms 0.046% 78.29% 53ms 1.22% VecDestroy 0 0% 78.29% 51ms 1.17% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 78.29% 51ms 1.17% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 78.29% 51ms 1.17% boost_numeric_ublas_abs (inline) 51ms 1.17% 79.46% 51ms 1.17% std::abs (inline) 3ms 0.069% 79.53% 50ms 1.15% VecDuplicate_MPI 3ms 0.069% 79.60% 47ms 1.08% VecDuplicate_Seq 46ms 1.06% 80.66% 46ms 1.06% [libm.so.6] 15ms 0.35% 81.00% 45ms 1.04% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.00% 45ms 1.04% AbstractBidomainSolver::FinaliseLinearSystem 33ms 0.76% 81.76% 45ms 1.04% __ieee754_exp_fma 44ms 1.01% 82.78% 44ms 1.01% VecMAXPY_Seq 44ms 1.01% 83.79% 44ms 1.01% [libchaste_heart.so] 2ms 0.046% 83.84% 39ms 0.9% VecCreate 0 0% 83.84% 36ms 0.83% CxxTest::RealWorldDescription::setUp 0 0% 83.84% 36ms 0.83% PetscInitialize 0 0% 83.84% 36ms 0.83% PetscSetup::setUpWorld 0 0% 83.84% 36ms 0.83% PetscSetupUtils::CommonSetup 0 0% 83.84% 36ms 0.83% PetscSetupUtils::InitialisePetsc 0 0% 83.84% 35ms 0.81% PMPI_Init_thread 4ms 0.092% 83.93% 35ms 0.81% PetscMallocA 0 0% 83.93% 35ms 0.81% ompi_mpi_init 34ms 0.78% 84.71% 34ms 0.78% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CheckIndex0 (inline) 3ms 0.069% 84.78% 31ms 0.71% PetscMallocAlign 30ms 0.69% 85.47% 30ms 0.69% log_inline (inline) 0 0% 85.47% 28ms 0.64% 3ms 0.069% 85.54% 27ms 0.62% PetscHeaderDestroy_Private 10ms 0.23% 85.77% 26ms 0.6% AbstractCardiacCell::SetVoltage 2ms 0.046% 85.82% 26ms 0.6% VecCreate_MPI_Private 25ms 0.58% 86.39% 25ms 0.58% DistributedVector::Iterator::operator!= 3ms 0.069% 86.46% 25ms 0.58% PMPI_Comm_get_attr 24ms 0.55% 87.01% 24ms 0.55% DistributedVector::Stripe::operator[] (inline) 1ms 0.023% 87.04% 24ms 0.55% VecSetType 1ms 0.023% 87.06% 23ms 0.53% PetscHeaderCreate_Private 22ms 0.51% 87.57% 22ms 0.51% __memset_avx2_unaligned_erms 5ms 0.12% 87.68% 22ms 0.51% ompi_attr_get_c 0 0% 87.68% 22ms 0.51% orte_init