File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3515ms, 87.03% of 4039ms total Dropped 476 nodes (cum <= 20.20ms) flat flat% sum% cum cum% 0 0% 0% 4031ms 99.80% __libc_start_call_main 0 0% 0% 4031ms 99.80% __libc_start_main_impl 0 0% 0% 4031ms 99.80% _start 0 0% 0% 4028ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4028ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4028ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4028ms 99.73% main 0 0% 0% 3991ms 98.81% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3991ms 98.81% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3991ms 98.81% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 3983ms 98.61% AbstractCardiacProblem::Solve 1ms 0.025% 0.025% 3974ms 98.39% AbstractDynamicLinearPdeSolver::Solve 2ms 0.05% 0.074% 1985ms 49.15% LinearSystem::Solve 0 0% 0.074% 1946ms 48.18% KSPSolve 5ms 0.12% 0.2% 1946ms 48.18% KSPSolve_Private 6ms 0.15% 0.35% 1897ms 46.97% KSPSolve_CG 11ms 0.27% 0.62% 1648ms 40.80% AbstractCardiacTissue::SolveCellSystems 3ms 0.074% 0.69% 1252ms 31.00% PCApply 2ms 0.05% 0.74% 1238ms 30.65% PCApply_BJacobi_Singleblock 59ms 1.46% 2.20% 1105ms 27.36% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 0 0% 2.20% 1051ms 26.02% KSPSolve_PREONLY (partial-inline) 0 0% 2.20% 1002ms 24.81% KSP_PCApply.lto_priv.7 2ms 0.05% 2.25% 996ms 24.66% PCApply_ICC 4ms 0.099% 2.35% 994ms 24.61% MatSolve 968ms 23.97% 26.32% 977ms 24.19% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 214ms 5.30% 31.62% 974ms 24.11% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 2ms 0.05% 31.67% 524ms 12.97% MatMult 2ms 0.05% 31.72% 520ms 12.87% MatMult_SeqAIJ 515ms 12.75% 44.47% 520ms 12.87% MatMult_SeqAIJ_Inode (inline) 21ms 0.52% 44.99% 500ms 12.38% AbstractCardiacTissue::UpdateCaches (inline) 116ms 2.87% 47.86% 457ms 11.31% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 60ms 1.49% 49.34% 435ms 10.77% CardiacNewtonSolver::Solve 0 0% 49.34% 342ms 8.47% KSP_PCApply (partial-inline) 0 0% 49.34% 340ms 8.42% KSPConvergedDefault 59ms 1.46% 50.80% 295ms 7.30% BidomainSolver::SetupLinearSystem 128ms 3.17% 53.97% 263ms 6.51% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 23ms 0.57% 54.54% 227ms 5.62% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 36ms 0.89% 55.43% 209ms 5.17% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 55.43% 202ms 5.00% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 43ms 1.06% 56.50% 202ms 5.00% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 166ms 4.11% 60.61% 166ms 4.11% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 1ms 0.025% 60.63% 153ms 3.79% std::pow (inline) 26ms 0.64% 61.28% 151ms 3.74% __pow 2ms 0.05% 61.33% 143ms 3.54% MatNullSpaceRemove 59ms 1.46% 62.79% 135ms 3.34% __GI___exp 134ms 3.32% 66.11% 135ms 3.34% __ieee754_log_fma 128ms 3.17% 69.27% 128ms 3.17% ddot_ 15ms 0.37% 69.65% 125ms 3.09% __ieee754_pow_fma 0 0% 69.65% 104ms 2.57% boost::numeric::ublas::norm_inf (inline) 71ms 1.76% 71.40% 104ms 2.57% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 71.40% 104ms 2.57% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 71.40% 104ms 2.57% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 1ms 0.025% 71.43% 99ms 2.45% VecDuplicate 2ms 0.05% 71.48% 85ms 2.10% VecTDot 0 0% 71.48% 83ms 2.05% VecMDot 5ms 0.12% 71.60% 83ms 2.05% VecMXDot_Private 20ms 0.5% 72.10% 82ms 2.03% MPI_Wtime 1ms 0.025% 72.12% 82ms 2.03% VecNorm 0 0% 72.12% 73ms 1.81% VecTDot_Seq 1ms 0.025% 72.15% 73ms 1.81% VecXDot_Seq_Private.constprop.0 67ms 1.66% 73.81% 73ms 1.81% __ieee754_exp_fma 73ms 1.81% 75.61% 73ms 1.81% exp_inline (inline) 16ms 0.4% 76.01% 71ms 1.76% PetscLogEventEndDefault 36ms 0.89% 76.90% 69ms 1.71% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 0 0% 76.90% 67ms 1.66% VecNorm_Seq 62ms 1.54% 78.44% 62ms 1.54% [[vdso]] 0 0% 78.44% 62ms 1.54% __GI___clock_gettime 3ms 0.074% 78.51% 58ms 1.44% VecMAXPY 4ms 0.099% 78.61% 57ms 1.41% VecDestroy 1ms 0.025% 78.63% 55ms 1.36% VecDuplicate_Seq 54ms 1.34% 79.97% 55ms 1.36% VecMDot_Seq 0 0% 79.97% 51ms 1.26% KSP_RemoveNullSpace (inline) 48ms 1.19% 81.16% 48ms 1.19% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CheckIndex0 (inline) 45ms 1.11% 82.27% 45ms 1.11% [libchaste_heart.so] 8ms 0.2% 82.47% 44ms 1.09% PetscMallocA 9ms 0.22% 82.69% 43ms 1.06% PetscLogEventBeginDefault 2ms 0.05% 82.74% 43ms 1.06% VecDuplicate_MPI 36ms 0.89% 83.63% 39ms 0.97% VecMAXPY_Seq 1ms 0.025% 83.66% 38ms 0.94% AbstractBidomainSolver::FinaliseLinearSystem 9ms 0.22% 83.88% 37ms 0.92% AbstractBidomainSolver::CheckCompatibilityCondition 1ms 0.025% 83.91% 36ms 0.89% PetscMallocAlign 2ms 0.05% 83.96% 36ms 0.89% VecCreate 36ms 0.89% 84.85% 36ms 0.89% log_inline (inline) 0 0% 84.85% 33ms 0.82% CxxTest::RealWorldDescription::setUp 0 0% 84.85% 33ms 0.82% PMPI_Init_thread 0 0% 84.85% 33ms 0.82% PetscInitialize 0 0% 84.85% 33ms 0.82% PetscSetup::setUpWorld 0 0% 84.85% 33ms 0.82% PetscSetupUtils::CommonSetup 0 0% 84.85% 33ms 0.82% PetscSetupUtils::InitialisePetsc 0 0% 84.85% 33ms 0.82% ompi_mpi_init 0 0% 84.85% 31ms 0.77% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 84.85% 31ms 0.77% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 84.85% 31ms 0.77% boost_numeric_ublas_abs (inline) 31ms 0.77% 85.62% 31ms 0.77% std::abs (inline) 4ms 0.099% 85.71% 29ms 0.72% VecCreate_MPI_Private 0 0% 85.71% 29ms 0.72% VecSetType 0 0% 85.71% 27ms 0.67% 0 0% 85.71% 27ms 0.67% PetscMemcpy (inline) 0 0% 85.71% 27ms 0.67% VecNorm_MPI 0 0% 85.71% 27ms 0.67% VecNorm_MPI_Default.constprop.0 2ms 0.05% 85.76% 26ms 0.64% VecCopy 1ms 0.025% 85.79% 25ms 0.62% PetscHeaderDestroy_Private 1ms 0.025% 85.81% 24ms 0.59% VecCreate_Seq 4ms 0.099% 85.91% 23ms 0.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 0 0% 85.91% 23ms 0.57% orte_init 3ms 0.074% 85.99% 22ms 0.54% __GI___libc_malloc 0 0% 85.99% 21ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble 21ms 0.52% 86.51% 21ms 0.52% DistributedVector::Iterator::operator!= 21ms 0.52% 87.03% 21ms 0.52% __memset_avx2_unaligned_erms