File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3573ms, 87.81% of 4069ms total Dropped 440 nodes (cum <= 20.34ms) flat flat% sum% cum cum% 0 0% 0% 4061ms 99.80% __libc_start_call_main 0 0% 0% 4061ms 99.80% __libc_start_main_impl 0 0% 0% 4061ms 99.80% _start 0 0% 0% 4058ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4058ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4058ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4058ms 99.73% main 0 0% 0% 4021ms 98.82% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4021ms 98.82% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4021ms 98.82% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 4013ms 98.62% AbstractCardiacProblem::Solve 1ms 0.025% 0.025% 3999ms 98.28% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.025% 2037ms 50.06% LinearSystem::Solve 0 0% 0.025% 1993ms 48.98% KSPSolve 5ms 0.12% 0.15% 1993ms 48.98% KSPSolve_Private 2ms 0.049% 0.2% 1948ms 47.87% KSPSolve_CG 17ms 0.42% 0.61% 1673ms 41.12% AbstractCardiacTissue::SolveCellSystems 5ms 0.12% 0.74% 1287ms 31.63% PCApply 1ms 0.025% 0.76% 1274ms 31.31% PCApply_BJacobi_Singleblock 43ms 1.06% 1.82% 1104ms 27.13% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 1ms 0.025% 1.84% 1059ms 26.03% KSPSolve_PREONLY (partial-inline) 0 0% 1.84% 1018ms 25.02% KSP_PCApply.lto_priv.7 6ms 0.15% 1.99% 994ms 24.43% MatSolve 0 0% 1.99% 994ms 24.43% PCApply_ICC 195ms 4.79% 6.78% 988ms 24.28% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 975ms 23.96% 30.74% 981ms 24.11% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 21ms 0.52% 31.26% 512ms 12.58% AbstractCardiacTissue::UpdateCaches (inline) 4ms 0.098% 31.36% 512ms 12.58% MatMult 11ms 0.27% 31.63% 500ms 12.29% MatMult_SeqAIJ 485ms 11.92% 43.55% 493ms 12.12% MatMult_SeqAIJ_Inode (inline) 49ms 1.20% 44.75% 473ms 11.62% CardiacNewtonSolver::Solve 131ms 3.22% 47.97% 470ms 11.55% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 5ms 0.12% 48.10% 374ms 9.19% KSPConvergedDefault 0 0% 48.10% 362ms 8.90% KSP_PCApply (partial-inline) 150ms 3.69% 51.78% 294ms 7.23% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 49ms 1.20% 52.99% 254ms 6.24% BidomainSolver::SetupLinearSystem 20ms 0.49% 53.48% 216ms 5.31% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 43ms 1.06% 54.53% 206ms 5.06% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 54.53% 194ms 4.77% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 45ms 1.11% 55.64% 194ms 4.77% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 2ms 0.049% 55.69% 163ms 4.01% MatNullSpaceRemove 160ms 3.93% 59.62% 162ms 3.98% __ieee754_log_fma 2ms 0.049% 59.67% 162ms 3.98% std::pow (inline) 16ms 0.39% 60.06% 160ms 3.93% __pow 158ms 3.88% 63.95% 158ms 3.88% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 17ms 0.42% 64.36% 143ms 3.51% __ieee754_pow_fma 127ms 3.12% 67.49% 127ms 3.12% ddot_ 0 0% 67.49% 125ms 3.07% VecDuplicate 68ms 1.67% 69.16% 125ms 3.07% __GI___exp 0 0% 69.16% 115ms 2.83% boost::numeric::ublas::norm_inf (inline) 84ms 2.06% 71.22% 115ms 2.83% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 71.22% 115ms 2.83% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 71.22% 115ms 2.83% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 93ms 2.29% 73.51% 99ms 2.43% exp_inline (inline) 0 0% 73.51% 94ms 2.31% VecMDot 6ms 0.15% 73.65% 94ms 2.31% VecMXDot_Private 0 0% 73.65% 87ms 2.14% VecNorm 2ms 0.049% 73.70% 82ms 2.02% VecTDot 0 0% 73.70% 77ms 1.89% VecNorm_Seq 19ms 0.47% 74.17% 75ms 1.84% MPI_Wtime 1ms 0.025% 74.20% 71ms 1.74% VecDuplicate_Seq 70ms 1.72% 75.92% 70ms 1.72% VecMDot_Seq 44ms 1.08% 77.00% 68ms 1.67% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 6ms 0.15% 77.14% 67ms 1.65% VecMAXPY 0 0% 77.14% 66ms 1.62% VecTDot_Seq 0 0% 77.14% 66ms 1.62% VecXDot_Seq_Private.constprop.0 4ms 0.098% 77.24% 62ms 1.52% PetscMallocA 5ms 0.12% 77.37% 58ms 1.43% PetscMallocAlign (partial-inline) 2ms 0.049% 77.41% 56ms 1.38% KSP_RemoveNullSpace (inline) 7ms 0.17% 77.59% 56ms 1.38% PetscLogEventEndDefault 5ms 0.12% 77.71% 55ms 1.35% VecDestroy 1ms 0.025% 77.73% 55ms 1.35% __GI___clock_gettime 1ms 0.025% 77.76% 54ms 1.33% VecDuplicate_MPI 54ms 1.33% 79.09% 54ms 1.33% [[vdso]] 53ms 1.30% 80.39% 54ms 1.33% __ieee754_exp_fma 7ms 0.17% 80.56% 51ms 1.25% PetscLogEventBeginDefault 2ms 0.049% 80.61% 48ms 1.18% VecCreate 46ms 1.13% 81.74% 46ms 1.13% VecMAXPY_Seq 43ms 1.06% 82.80% 43ms 1.06% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CheckIndex0 (inline) 5ms 0.12% 82.92% 41ms 1.01% VecSetType (partial-inline) 35ms 0.86% 83.78% 35ms 0.86% [libchaste_heart.so] 6ms 0.15% 83.93% 35ms 0.86% __posix_memalign 0 0% 83.93% 33ms 0.81% CxxTest::RealWorldDescription::setUp 0 0% 83.93% 33ms 0.81% PMPI_Init_thread 0 0% 83.93% 33ms 0.81% PetscInitialize 0 0% 83.93% 33ms 0.81% PetscMemzero (inline) 0 0% 83.93% 33ms 0.81% PetscSetup::setUpWorld 0 0% 83.93% 33ms 0.81% PetscSetupUtils::CommonSetup 0 0% 83.93% 33ms 0.81% PetscSetupUtils::InitialisePetsc 0 0% 83.93% 33ms 0.81% ompi_mpi_init 1ms 0.025% 83.95% 31ms 0.76% VecCreate_MPI_Private 0 0% 83.95% 31ms 0.76% VecNorm_MPI 0 0% 83.95% 31ms 0.76% VecNorm_MPI_Default.constprop.0 8ms 0.2% 84.15% 31ms 0.76% __GI___libc_malloc 11ms 0.27% 84.42% 30ms 0.74% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 84.42% 30ms 0.74% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 84.42% 30ms 0.74% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 84.42% 30ms 0.74% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 84.42% 30ms 0.74% boost_numeric_ublas_abs (inline) 30ms 0.74% 85.16% 30ms 0.74% std::abs (inline) 0 0% 85.16% 28ms 0.69% PetscMemcpy (inline) 0 0% 85.16% 28ms 0.69% VecCopy 28ms 0.69% 85.84% 28ms 0.69% __memset_avx2_unaligned_erms 2ms 0.049% 85.89% 27ms 0.66% VecCreate_Seq 0 0% 85.89% 26ms 0.64% 4ms 0.098% 85.99% 26ms 0.64% PetscHeaderDestroy_Private 25ms 0.61% 86.61% 25ms 0.61% log_inline (inline) 7ms 0.17% 86.78% 23ms 0.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 5ms 0.12% 86.90% 23ms 0.57% VecSet 23ms 0.57% 87.47% 23ms 0.57% __memcpy_avx_unaligned_erms 11ms 0.27% 87.74% 22ms 0.54% AbstractCardiacCell::SetVoltage 0 0% 87.74% 22ms 0.54% orte_init 0 0% 87.74% 21ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble 3ms 0.074% 87.81% 21ms 0.52% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline)