File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3530ms, 87.03% of 4056ms total Dropped 467 nodes (cum <= 20.28ms) flat flat% sum% cum cum% 0 0% 0% 4049ms 99.83% __libc_start_call_main 0 0% 0% 4049ms 99.83% __libc_start_main_impl 0 0% 0% 4049ms 99.83% _start 0 0% 0% 4046ms 99.75% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4046ms 99.75% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4046ms 99.75% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4046ms 99.75% main 0 0% 0% 4012ms 98.92% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4012ms 98.92% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4012ms 98.92% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 1ms 0.025% 0.025% 4004ms 98.72% AbstractCardiacProblem::Solve 2ms 0.049% 0.074% 3992ms 98.42% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.074% 2000ms 49.31% LinearSystem::Solve 0 0% 0.074% 1964ms 48.42% KSPSolve 9ms 0.22% 0.3% 1964ms 48.42% KSPSolve_Private 2ms 0.049% 0.35% 1917ms 47.26% KSPSolve_CG 31ms 0.76% 1.11% 1689ms 41.64% AbstractCardiacTissue::SolveCellSystems 5ms 0.12% 1.23% 1215ms 29.96% PCApply 1ms 0.025% 1.26% 1200ms 29.59% PCApply_BJacobi_Singleblock 63ms 1.55% 2.81% 1091ms 26.90% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 0 0% 2.81% 1019ms 25.12% KSPSolve_PREONLY (partial-inline) 213ms 5.25% 8.06% 957ms 23.59% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 1ms 0.025% 8.09% 950ms 23.42% KSP_PCApply.lto_priv.7 4ms 0.099% 8.19% 948ms 23.37% MatSolve 0 0% 8.19% 948ms 23.37% PCApply_ICC 923ms 22.76% 30.94% 930ms 22.93% MatSolve_SeqSBAIJ_1_NaturalOrdering 37ms 0.91% 31.85% 534ms 13.17% AbstractCardiacTissue::UpdateCaches (inline) 2ms 0.049% 31.90% 528ms 13.02% MatMult 5ms 0.12% 32.03% 519ms 12.80% MatMult_SeqAIJ (partial-inline) 510ms 12.57% 44.60% 519ms 12.80% MatMult_SeqAIJ_Inode (inline) 154ms 3.80% 48.40% 478ms 11.79% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 60ms 1.48% 49.88% 427ms 10.53% CardiacNewtonSolver::Solve 3ms 0.074% 49.95% 376ms 9.27% KSPConvergedDefault 0 0% 49.95% 363ms 8.95% KSP_PCApply (partial-inline) 51ms 1.26% 51.21% 255ms 6.29% BidomainSolver::SetupLinearSystem 130ms 3.21% 54.41% 255ms 6.29% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 20ms 0.49% 54.91% 218ms 5.37% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 33ms 0.81% 55.72% 204ms 5.03% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 55.72% 196ms 4.83% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 43ms 1.06% 56.78% 196ms 4.83% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 1ms 0.025% 56.80% 172ms 4.24% std::pow (inline) 21ms 0.52% 57.32% 171ms 4.22% __pow 165ms 4.07% 61.39% 165ms 4.07% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 1ms 0.025% 61.42% 165ms 4.07% MatNullSpaceRemove 22ms 0.54% 61.96% 149ms 3.67% __ieee754_pow_fma 63ms 1.55% 63.51% 131ms 3.23% __GI___exp 128ms 3.16% 66.67% 128ms 3.16% __ieee754_log_fma 128ms 3.16% 69.82% 128ms 3.16% ddot_ 0 0% 69.82% 114ms 2.81% VecDuplicate 1ms 0.025% 69.85% 103ms 2.54% VecMDot 5ms 0.12% 69.97% 102ms 2.51% VecMXDot_Private 0 0% 69.97% 102ms 2.51% boost::numeric::ublas::norm_inf (inline) 64ms 1.58% 71.55% 102ms 2.51% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 71.55% 102ms 2.51% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 71.55% 102ms 2.51% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 26ms 0.64% 72.19% 95ms 2.34% MPI_Wtime 0 0% 72.19% 95ms 2.34% VecTDot 81ms 2.00% 74.19% 85ms 2.10% exp_inline (inline) 0 0% 74.19% 81ms 2.00% VecTDot_Seq 0 0% 74.19% 81ms 2.00% VecXDot_Seq_Private.constprop.0 16ms 0.39% 74.58% 73ms 1.80% PetscLogEventEndDefault 1ms 0.025% 74.61% 73ms 1.80% VecNorm 63ms 1.55% 76.16% 71ms 1.75% VecMDot_Seq 18ms 0.44% 76.60% 70ms 1.73% PetscLogEventBeginDefault 68ms 1.68% 78.28% 68ms 1.68% [[vdso]] 0 0% 78.28% 68ms 1.68% __GI___clock_gettime 42ms 1.04% 79.31% 67ms 1.65% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 65ms 1.60% 80.92% 67ms 1.65% __ieee754_exp_fma 3ms 0.074% 80.99% 61ms 1.50% VecMAXPY 0 0% 80.99% 58ms 1.43% VecDuplicate_Seq 1ms 0.025% 81.02% 58ms 1.43% VecNorm_Seq 1ms 0.025% 81.04% 56ms 1.38% VecDuplicate_MPI 2ms 0.049% 81.09% 52ms 1.28% VecCreate 3ms 0.074% 81.16% 52ms 1.28% VecDestroy 5ms 0.12% 81.29% 47ms 1.16% PetscMallocA 2ms 0.049% 81.34% 43ms 1.06% PetscTimeSubtract (inline) 2ms 0.049% 81.39% 42ms 1.04% PetscMallocAlign (partial-inline) 13ms 0.32% 81.71% 38ms 0.94% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.71% 38ms 0.94% AbstractBidomainSolver::FinaliseLinearSystem 37ms 0.91% 82.62% 37ms 0.91% log_inline (inline) 0 0% 82.62% 36ms 0.89% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 82.62% 36ms 0.89% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 82.62% 36ms 0.89% boost_numeric_ublas_abs (inline) 36ms 0.89% 83.51% 36ms 0.89% std::abs (inline) 0 0% 83.51% 33ms 0.81% PetscMemzero (inline) 31ms 0.76% 84.27% 33ms 0.81% VecMAXPY_Seq 5ms 0.12% 84.39% 33ms 0.81% VecSetType 32ms 0.79% 85.18% 32ms 0.79% [libchaste_heart.so] 0 0% 85.18% 31ms 0.76% CxxTest::RealWorldDescription::setUp 0 0% 85.18% 31ms 0.76% PetscInitialize 0 0% 85.18% 31ms 0.76% PetscSetup::setUpWorld 0 0% 85.18% 31ms 0.76% PetscSetupUtils::CommonSetup 0 0% 85.18% 31ms 0.76% PetscSetupUtils::InitialisePetsc 0 0% 85.18% 30ms 0.74% PMPI_Init_thread 0 0% 85.18% 30ms 0.74% ompi_mpi_init 29ms 0.71% 85.90% 29ms 0.71% __memset_avx2_unaligned_erms 3ms 0.074% 85.97% 27ms 0.67% VecCopy 2ms 0.049% 86.02% 26ms 0.64% VecCreate_MPI_Private 1ms 0.025% 86.05% 24ms 0.59% 24ms 0.59% 86.64% 24ms 0.59% DistributedVector::Iterator::operator!= 2ms 0.049% 86.69% 24ms 0.59% VecAYPX 3ms 0.074% 86.76% 23ms 0.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 4ms 0.099% 86.86% 23ms 0.57% PetscHeaderDestroy_Private 0 0% 86.86% 23ms 0.57% VecNorm_MPI 0 0% 86.86% 23ms 0.57% VecNorm_MPI_Default.constprop.0 5ms 0.12% 86.98% 22ms 0.54% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 2ms 0.049% 87.03% 22ms 0.54% PetscHeaderCreate_Private 0 0% 87.03% 21ms 0.52% VecCreate_Seq 0 0% 87.03% 21ms 0.52% orte_init