File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3573ms, 87.49% of 4084ms total Dropped 463 nodes (cum <= 20.42ms) flat flat% sum% cum cum% 0 0% 0% 4076ms 99.80% __libc_start_call_main 0 0% 0% 4076ms 99.80% __libc_start_main_impl 0 0% 0% 4076ms 99.80% _start 0 0% 0% 4073ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4073ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4073ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4073ms 99.73% main 0 0% 0% 4032ms 98.73% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4032ms 98.73% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4032ms 98.73% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 1ms 0.024% 0.024% 4024ms 98.53% AbstractCardiacProblem::Solve 1ms 0.024% 0.049% 4008ms 98.14% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.049% 2062ms 50.49% LinearSystem::Solve 0 0% 0.049% 2022ms 49.51% KSPSolve 4ms 0.098% 0.15% 2022ms 49.51% KSPSolve_Private 3ms 0.073% 0.22% 1973ms 48.31% KSPSolve_CG 10ms 0.24% 0.47% 1628ms 39.86% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.49% 1278ms 31.29% PCApply 1ms 0.024% 0.51% 1272ms 31.15% PCApply_BJacobi_Singleblock 1ms 0.024% 0.54% 1086ms 26.59% KSPSolve_PREONLY (partial-inline) 63ms 1.54% 2.08% 1084ms 26.54% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 1ms 0.024% 2.11% 1025ms 25.10% PCApply_ICC 4ms 0.098% 2.20% 1024ms 25.07% MatSolve 1ms 0.024% 2.23% 1020ms 24.98% KSP_PCApply.lto_priv.7 1005ms 24.61% 26.84% 1014ms 24.83% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 197ms 4.82% 31.66% 940ms 23.02% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 7ms 0.17% 31.83% 545ms 13.34% MatMult 1ms 0.024% 31.86% 529ms 12.95% MatMult_SeqAIJ 521ms 12.76% 44.61% 529ms 12.95% MatMult_SeqAIJ_Inode (inline) 14ms 0.34% 44.96% 508ms 12.44% AbstractCardiacTissue::UpdateCaches (inline) 147ms 3.60% 48.56% 483ms 11.83% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 57ms 1.40% 49.95% 444ms 10.87% CardiacNewtonSolver::Solve 3ms 0.073% 50.02% 369ms 9.04% KSPConvergedDefault 0 0% 50.02% 359ms 8.79% KSP_PCApply (partial-inline) 74ms 1.81% 51.84% 272ms 6.66% BidomainSolver::SetupLinearSystem 141ms 3.45% 55.29% 268ms 6.56% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 25ms 0.61% 55.90% 227ms 5.56% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 36ms 0.88% 56.78% 203ms 4.97% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 56.78% 200ms 4.90% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 43ms 1.05% 57.84% 200ms 4.90% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 0 0% 57.84% 172ms 4.21% MatNullSpaceRemove 159ms 3.89% 61.73% 159ms 3.89% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 2ms 0.049% 61.78% 151ms 3.70% std::pow (inline) 14ms 0.34% 62.12% 147ms 3.60% __pow 134ms 3.28% 65.40% 135ms 3.31% __ieee754_log_fma 18ms 0.44% 65.84% 132ms 3.23% __ieee754_pow_fma 66ms 1.62% 67.46% 131ms 3.21% __GI___exp 1ms 0.024% 67.48% 117ms 2.86% VecDuplicate 1ms 0.024% 67.51% 117ms 2.86% VecMDot 10ms 0.24% 67.75% 116ms 2.84% VecMXDot_Private 0 0% 67.75% 110ms 2.69% boost::numeric::ublas::norm_inf (inline) 74ms 1.81% 69.56% 110ms 2.69% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 69.56% 110ms 2.69% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 69.56% 110ms 2.69% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 109ms 2.67% 72.23% 109ms 2.67% ddot_ 0 0% 72.23% 80ms 1.96% VecTDot 46ms 1.13% 73.36% 78ms 1.91% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 74ms 1.81% 75.17% 77ms 1.89% VecMDot_Seq 74ms 1.81% 76.98% 76ms 1.86% exp_inline (inline) 25ms 0.61% 77.60% 73ms 1.79% MPI_Wtime 0 0% 77.60% 67ms 1.64% VecTDot_Seq 0 0% 77.60% 67ms 1.64% VecXDot_Seq_Private.constprop.0 58ms 1.42% 79.02% 62ms 1.52% __ieee754_exp_fma 1ms 0.024% 79.04% 59ms 1.44% VecDuplicate_Seq 1ms 0.024% 79.06% 58ms 1.42% VecNorm 4ms 0.098% 79.16% 57ms 1.40% VecDuplicate_MPI 12ms 0.29% 79.46% 56ms 1.37% PetscLogEventEndDefault 3ms 0.073% 79.53% 55ms 1.35% VecMAXPY 0 0% 79.53% 53ms 1.30% VecDestroy 0 0% 79.53% 52ms 1.27% VecNorm_Seq 7ms 0.17% 79.70% 50ms 1.22% PetscLogEventBeginDefault 8ms 0.2% 79.90% 48ms 1.18% PetscMallocA 48ms 1.18% 81.07% 48ms 1.18% [[vdso]] 0 0% 81.07% 48ms 1.18% __GI___clock_gettime 2ms 0.049% 81.12% 40ms 0.98% PetscMallocAlign (partial-inline) 6ms 0.15% 81.27% 40ms 0.98% VecCreate 39ms 0.95% 82.22% 39ms 0.95% VecMAXPY_Seq 12ms 0.29% 82.52% 37ms 0.91% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 82.52% 37ms 0.91% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 82.52% 36ms 0.88% CxxTest::RealWorldDescription::setUp 0 0% 82.52% 36ms 0.88% PetscInitialize 0 0% 82.52% 36ms 0.88% PetscSetup::setUpWorld 0 0% 82.52% 36ms 0.88% PetscSetupUtils::CommonSetup 0 0% 82.52% 36ms 0.88% PetscSetupUtils::InitialisePetsc 0 0% 82.52% 36ms 0.88% VecCreate_MPI_Private 0 0% 82.52% 35ms 0.86% PMPI_Init_thread 0 0% 82.52% 35ms 0.86% ompi_mpi_init 0 0% 82.52% 33ms 0.81% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 82.52% 33ms 0.81% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 82.52% 33ms 0.81% boost_numeric_ublas_abs (inline) 33ms 0.81% 83.33% 33ms 0.81% log_inline (inline) 33ms 0.81% 84.13% 33ms 0.81% std::abs (inline) 0 0% 84.13% 32ms 0.78% VecSetType 31ms 0.76% 84.89% 31ms 0.76% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CheckIndex0 (inline) 2ms 0.049% 84.94% 30ms 0.73% PetscHeaderDestroy_Private 30ms 0.73% 85.68% 30ms 0.73% __memset_avx2_unaligned_erms 0 0% 85.68% 29ms 0.71% PetscMemzero (inline) 0 0% 85.68% 27ms 0.66% PetscMemcpy (inline) 1ms 0.024% 85.70% 26ms 0.64% 3ms 0.073% 85.77% 25ms 0.61% VecCopy 2ms 0.049% 85.82% 25ms 0.61% VecCreate_Seq 0 0% 85.82% 25ms 0.61% orte_init 4ms 0.098% 85.92% 24ms 0.59% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 0 0% 85.92% 24ms 0.59% VecNorm_MPI 0 0% 85.92% 24ms 0.59% VecNorm_MPI_Default.constprop.0 1ms 0.024% 85.95% 24ms 0.59% VecStashCreate_Private 24ms 0.59% 86.53% 24ms 0.59% __memcpy_avx_unaligned_erms 3ms 0.073% 86.61% 23ms 0.56% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 23ms 0.56% 87.17% 23ms 0.56% [libchaste_heart.so] 5ms 0.12% 87.29% 23ms 0.56% __GI___libc_malloc 6ms 0.15% 87.44% 21ms 0.51% PetscOptionsFindPair 2ms 0.049% 87.49% 21ms 0.51% VecAXPY