File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3698ms, 86.93% of 4254ms total Dropped 474 nodes (cum <= 21.27ms) flat flat% sum% cum cum% 0 0% 0% 4247ms 99.84% __libc_start_call_main 0 0% 0% 4247ms 99.84% __libc_start_main_impl 0 0% 0% 4247ms 99.84% _start 0 0% 0% 4244ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4244ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4244ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4244ms 99.76% main 0 0% 0% 4200ms 98.73% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4200ms 98.73% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4200ms 98.73% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 1ms 0.024% 0.024% 4192ms 98.54% AbstractCardiacProblem::Solve 4ms 0.094% 0.12% 4178ms 98.21% AbstractDynamicLinearPdeSolver::Solve 21ms 0.49% 0.61% 1917ms 45.06% AbstractCardiacTissue::SolveCellSystems 5ms 0.12% 0.73% 1705ms 40.08% LinearSystem::Solve 1ms 0.024% 0.75% 1626ms 38.22% KSPSolve 10ms 0.24% 0.99% 1625ms 38.20% KSPSolve_Private 0 0% 0.99% 1562ms 36.72% KSPSolve_CG 59ms 1.39% 2.37% 1310ms 30.79% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 284ms 6.68% 9.05% 1138ms 26.75% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 9ms 0.21% 9.26% 916ms 21.53% PCApply 0 0% 9.26% 898ms 21.11% PCApply_BJacobi_Singleblock 0 0% 9.26% 757ms 17.80% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 9.29% 734ms 17.25% KSP_PCApply.lto_priv.7 1ms 0.024% 9.31% 710ms 16.69% PCApply_ICC 4ms 0.094% 9.40% 709ms 16.67% MatSolve 692ms 16.27% 25.67% 697ms 16.38% MatSolve_SeqSBAIJ_1_NaturalOrdering 3ms 0.071% 25.74% 643ms 15.12% MatMult 15ms 0.35% 26.09% 632ms 14.86% MatMult_SeqAIJ (partial-inline) 606ms 14.25% 40.34% 631ms 14.83% MatMult_SeqAIJ_Inode (inline) 10ms 0.24% 40.57% 537ms 12.62% AbstractCardiacTissue::UpdateCaches (inline) 137ms 3.22% 43.79% 499ms 11.73% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 76ms 1.79% 45.58% 482ms 11.33% CardiacNewtonSolver::Solve 91ms 2.14% 47.72% 475ms 11.17% BidomainSolver::SetupLinearSystem 45ms 1.06% 48.78% 277ms 6.51% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 140ms 3.29% 52.07% 276ms 6.49% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 0 0% 52.07% 264ms 6.21% KSPConvergedDefault 0 0% 52.07% 257ms 6.04% KSP_PCApply (partial-inline) 24ms 0.56% 52.63% 237ms 5.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 223ms 5.24% 57.87% 223ms 5.24% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 0 0% 57.87% 205ms 4.82% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 28ms 0.66% 58.53% 205ms 4.82% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 1ms 0.024% 58.56% 161ms 3.78% std::pow (inline) 27ms 0.63% 59.19% 160ms 3.76% __pow 150ms 3.53% 62.72% 150ms 3.53% __ieee754_log_fma 66ms 1.55% 64.27% 145ms 3.41% __GI___exp 0 0% 64.27% 137ms 3.22% MatNullSpaceRemove 2ms 0.047% 64.32% 132ms 3.10% VecDuplicate 23ms 0.54% 64.86% 132ms 3.10% __ieee754_pow_fma 0 0% 64.86% 118ms 2.77% boost::numeric::ublas::norm_inf (inline) 69ms 1.62% 66.48% 118ms 2.77% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 66.48% 118ms 2.77% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 66.48% 118ms 2.77% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 25ms 0.59% 67.07% 110ms 2.59% MPI_Wtime 66ms 1.55% 68.62% 104ms 2.44% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 94ms 2.21% 70.83% 94ms 2.21% ddot_ 0 0% 70.83% 87ms 2.05% VecMDot 5ms 0.12% 70.94% 87ms 2.05% VecMXDot_Private 2ms 0.047% 70.99% 84ms 1.97% __GI___clock_gettime 1ms 0.024% 71.02% 83ms 1.95% VecDuplicate_MPI 82ms 1.93% 72.94% 82ms 1.93% [[vdso]] 9ms 0.21% 73.15% 75ms 1.76% PetscLogEventBeginDefault 1ms 0.024% 73.18% 74ms 1.74% VecTDot 27ms 0.63% 73.81% 73ms 1.72% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 73.81% 73ms 1.72% AbstractBidomainSolver::FinaliseLinearSystem 71ms 1.67% 75.48% 73ms 1.72% exp_inline (inline) 2ms 0.047% 75.53% 64ms 1.50% VecNorm 62ms 1.46% 76.99% 63ms 1.48% VecMDot_Seq 15ms 0.35% 77.34% 62ms 1.46% PetscMallocA 5ms 0.12% 77.46% 60ms 1.41% VecCreate 0 0% 77.46% 60ms 1.41% VecTDot_Seq 0 0% 77.46% 60ms 1.41% VecXDot_Seq_Private.constprop.0 57ms 1.34% 78.80% 57ms 1.34% [libchaste_heart.so] 6ms 0.14% 78.94% 56ms 1.32% PetscLogEventEndDefault 42ms 0.99% 79.92% 55ms 1.29% __ieee754_exp_fma 0 0% 79.92% 53ms 1.25% VecNorm_Seq 4ms 0.094% 80.02% 50ms 1.18% VecMAXPY 0 0% 80.02% 49ms 1.15% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 80.02% 49ms 1.15% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 80.02% 49ms 1.15% boost_numeric_ublas_abs (inline) 49ms 1.15% 81.17% 49ms 1.15% std::abs (inline) 1ms 0.024% 81.19% 47ms 1.10% PetscMallocAlign (partial-inline) 1ms 0.024% 81.22% 47ms 1.10% VecDuplicate_Seq 5ms 0.12% 81.34% 42ms 0.99% VecCreate_MPI_Private 0 0% 81.34% 39ms 0.92% CxxTest::RealWorldDescription::setUp 0 0% 81.34% 39ms 0.92% PetscInitialize 0 0% 81.34% 39ms 0.92% PetscSetup::setUpWorld 0 0% 81.34% 39ms 0.92% PetscSetupUtils::CommonSetup 0 0% 81.34% 39ms 0.92% PetscSetupUtils::InitialisePetsc 0 0% 81.34% 38ms 0.89% PMPI_Init_thread 0 0% 81.34% 38ms 0.89% ompi_mpi_init 36ms 0.85% 82.18% 36ms 0.85% DistributedVector::Stripe::operator[] (inline) 36ms 0.85% 83.03% 36ms 0.85% log_inline (inline) 1ms 0.024% 83.05% 34ms 0.8% VecDestroy 1ms 0.024% 83.07% 31ms 0.73% 31ms 0.73% 83.80% 31ms 0.73% DistributedVector::Iterator::operator!= 30ms 0.71% 84.51% 30ms 0.71% [libm.so.6] 29ms 0.68% 85.19% 29ms 0.68% VecMAXPY_Seq 4ms 0.094% 85.28% 28ms 0.66% VecCopy 0 0% 85.28% 28ms 0.66% VecNorm_MPI 0 0% 85.28% 28ms 0.66% VecNorm_MPI_Default.constprop.0 0 0% 85.28% 26ms 0.61% PetscMemzero (inline) 26ms 0.61% 85.90% 26ms 0.61% __memset_avx2_unaligned_erms 25ms 0.59% 86.48% 25ms 0.59% DistributedVector::End 2ms 0.047% 86.53% 25ms 0.59% PetscVecTools::Finalise 7ms 0.16% 86.69% 25ms 0.59% __GI___libc_malloc 1ms 0.024% 86.72% 25ms 0.59% __posix_memalign 3ms 0.071% 86.79% 24ms 0.56% PetscOptionsFindPair 3ms 0.071% 86.86% 23ms 0.54% VecAXPY 3ms 0.071% 86.93% 23ms 0.54% VecAssemblyBegin 0 0% 86.93% 23ms 0.54% VecSetType 0 0% 86.93% 23ms 0.54% orte_init 0 0% 86.93% 22ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble