File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3502ms, 86.83% of 4033ms total Dropped 469 nodes (cum <= 20.16ms) flat flat% sum% cum cum% 0 0% 0% 4026ms 99.83% __libc_start_call_main 0 0% 0% 4026ms 99.83% __libc_start_main_impl 0 0% 0% 4026ms 99.83% _start 0 0% 0% 4024ms 99.78% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4024ms 99.78% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4024ms 99.78% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4024ms 99.78% main 0 0% 0% 3989ms 98.91% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3989ms 98.91% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3989ms 98.91% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 1ms 0.025% 0.025% 3981ms 98.71% AbstractCardiacProblem::Solve 1ms 0.025% 0.05% 3963ms 98.26% AbstractDynamicLinearPdeSolver::Solve 1ms 0.025% 0.074% 2026ms 50.24% LinearSystem::Solve 0 0% 0.074% 1969ms 48.82% KSPSolve 7ms 0.17% 0.25% 1969ms 48.82% KSPSolve_Private 2ms 0.05% 0.3% 1920ms 47.61% KSPSolve_CG 9ms 0.22% 0.52% 1651ms 40.94% AbstractCardiacTissue::SolveCellSystems 2ms 0.05% 0.57% 1201ms 29.78% PCApply 1ms 0.025% 0.6% 1193ms 29.58% PCApply_BJacobi_Singleblock 63ms 1.56% 2.16% 1104ms 27.37% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 1ms 0.025% 2.18% 998ms 24.75% KSPSolve_PREONLY (partial-inline) 208ms 5.16% 7.34% 957ms 23.73% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 0 0% 7.34% 949ms 23.53% KSP_PCApply.lto_priv.7 6ms 0.15% 7.49% 946ms 23.46% MatSolve 0 0% 7.49% 946ms 23.46% PCApply_ICC 933ms 23.13% 30.62% 935ms 23.18% MatSolve_SeqSBAIJ_1_NaturalOrdering 5ms 0.12% 30.75% 568ms 14.08% MatMult 2ms 0.05% 30.80% 558ms 13.84% MatMult_SeqAIJ 555ms 13.76% 44.56% 558ms 13.84% MatMult_SeqAIJ_Inode (inline) 17ms 0.42% 44.98% 504ms 12.50% AbstractCardiacTissue::UpdateCaches (inline) 148ms 3.67% 48.65% 474ms 11.75% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 49ms 1.21% 49.86% 434ms 10.76% CardiacNewtonSolver::Solve 2ms 0.05% 49.91% 352ms 8.73% KSPConvergedDefault 0 0% 49.91% 339ms 8.41% KSP_PCApply (partial-inline) 131ms 3.25% 53.16% 251ms 6.22% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 51ms 1.26% 54.43% 250ms 6.20% BidomainSolver::SetupLinearSystem 23ms 0.57% 55.00% 217ms 5.38% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 27ms 0.67% 55.67% 212ms 5.26% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 55.67% 193ms 4.79% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 33ms 0.82% 56.48% 193ms 4.79% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 176ms 4.36% 60.85% 176ms 4.36% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 0 0% 60.85% 157ms 3.89% std::pow (inline) 17ms 0.42% 61.27% 156ms 3.87% __pow 14ms 0.35% 61.62% 139ms 3.45% __ieee754_pow_fma 133ms 3.30% 64.91% 133ms 3.30% __ieee754_log_fma 0 0% 64.91% 132ms 3.27% MatNullSpaceRemove 0 0% 64.91% 130ms 3.22% VecDuplicate 130ms 3.22% 68.14% 130ms 3.22% ddot_ 63ms 1.56% 69.70% 129ms 3.20% __GI___exp 0 0% 69.70% 122ms 3.03% boost::numeric::ublas::norm_inf (inline) 83ms 2.06% 71.76% 122ms 3.03% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 71.76% 122ms 3.03% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 71.76% 122ms 3.03% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 86ms 2.13% 73.89% 89ms 2.21% exp_inline (inline) 1ms 0.025% 73.92% 88ms 2.18% VecTDot 38ms 0.94% 74.86% 79ms 1.96% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 0 0% 74.86% 79ms 1.96% VecMDot 5ms 0.12% 74.98% 79ms 1.96% VecMXDot_Private 0 0% 74.98% 78ms 1.93% VecTDot_Seq 0 0% 74.98% 78ms 1.93% VecXDot_Seq_Private.constprop.0 1ms 0.025% 75.01% 73ms 1.81% VecNorm 14ms 0.35% 75.35% 70ms 1.74% MPI_Wtime 0 0% 75.35% 67ms 1.66% VecDestroy 2ms 0.05% 75.40% 66ms 1.64% VecDuplicate_Seq 1ms 0.025% 75.43% 66ms 1.64% VecNorm_Seq 1ms 0.025% 75.45% 64ms 1.59% VecDuplicate_MPI 59ms 1.46% 76.92% 64ms 1.59% __ieee754_exp_fma 14ms 0.35% 77.26% 60ms 1.49% PetscMallocA 12ms 0.3% 77.56% 58ms 1.44% PetscLogEventBeginDefault 1ms 0.025% 77.58% 56ms 1.39% __GI___clock_gettime 55ms 1.36% 78.95% 55ms 1.36% [[vdso]] 51ms 1.26% 80.21% 54ms 1.34% VecMDot_Seq 3ms 0.074% 80.29% 53ms 1.31% VecCreate 6ms 0.15% 80.44% 53ms 1.31% VecMAXPY 12ms 0.3% 80.73% 47ms 1.17% PetscLogEventEndDefault 6ms 0.15% 80.88% 46ms 1.14% PetscMallocAlign (partial-inline) 1ms 0.025% 80.91% 42ms 1.04% VecCreate_MPI_Private 1ms 0.025% 80.93% 38ms 0.94% VecCopy 0 0% 80.93% 36ms 0.89% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 80.93% 36ms 0.89% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 80.93% 36ms 0.89% boost_numeric_ublas_abs (inline) 36ms 0.89% 81.82% 36ms 0.89% std::abs (inline) 34ms 0.84% 82.67% 34ms 0.84% log_inline (inline) 32ms 0.79% 83.46% 32ms 0.79% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CheckIndex0 (inline) 11ms 0.27% 83.73% 31ms 0.77% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 83.73% 31ms 0.77% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 83.73% 31ms 0.77% CxxTest::RealWorldDescription::setUp 0 0% 83.73% 31ms 0.77% PMPI_Init_thread 0 0% 83.73% 31ms 0.77% PetscInitialize 0 0% 83.73% 31ms 0.77% PetscSetup::setUpWorld 0 0% 83.73% 31ms 0.77% PetscSetupUtils::CommonSetup 0 0% 83.73% 31ms 0.77% PetscSetupUtils::InitialisePetsc 3ms 0.074% 83.81% 31ms 0.77% VecSetType 0 0% 83.81% 31ms 0.77% ompi_mpi_init 0 0% 83.81% 29ms 0.72% PetscMemzero (inline) 6ms 0.15% 83.96% 28ms 0.69% PetscHeaderDestroy_Private 27ms 0.67% 84.63% 27ms 0.67% __memset_avx2_unaligned_erms 2ms 0.05% 84.68% 26ms 0.64% VecStashCreate_Private 0 0% 84.68% 25ms 0.62% 1ms 0.025% 84.70% 25ms 0.62% PetscHeaderCreate_Private 6ms 0.15% 84.85% 24ms 0.6% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 0 0% 84.85% 24ms 0.6% PetscMemcpy (inline) 6ms 0.15% 85.00% 24ms 0.6% PetscOptionsFindPair 0 0% 85.00% 24ms 0.6% VecNorm_MPI 0 0% 85.00% 24ms 0.6% VecNorm_MPI_Default.constprop.0 24ms 0.6% 85.59% 24ms 0.6% [libchaste_heart.so] 4ms 0.099% 85.69% 23ms 0.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 22ms 0.55% 86.24% 23ms 0.57% VecMAXPY_Seq 3ms 0.074% 86.31% 23ms 0.57% __posix_memalign 4ms 0.099% 86.41% 22ms 0.55% PMPI_Comm_get_attr 5ms 0.12% 86.54% 22ms 0.55% PetscFreeAlign 0 0% 86.54% 22ms 0.55% orte_init 1ms 0.025% 86.56% 21ms 0.52% VecAYPX 1ms 0.025% 86.59% 21ms 0.52% VecDestroy_MPI 10ms 0.25% 86.83% 21ms 0.52% __GI___libc_free