File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3621ms, 87.82% of 4123ms total Dropped 483 nodes (cum <= 20.61ms) flat flat% sum% cum cum% 0 0% 0% 4115ms 99.81% __libc_start_call_main 0 0% 0% 4115ms 99.81% __libc_start_main_impl 0 0% 0% 4115ms 99.81% _start 0 0% 0% 4112ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4112ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4112ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4112ms 99.73% main 0 0% 0% 4071ms 98.74% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4071ms 98.74% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4071ms 98.74% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 1ms 0.024% 0.024% 4064ms 98.57% AbstractCardiacProblem::Solve 0 0% 0.024% 4052ms 98.28% AbstractDynamicLinearPdeSolver::Solve 1ms 0.024% 0.049% 2097ms 50.86% LinearSystem::Solve 0 0% 0.049% 2049ms 49.70% KSPSolve 5ms 0.12% 0.17% 2049ms 49.70% KSPSolve_Private 0 0% 0.17% 2000ms 48.51% KSPSolve_CG 7ms 0.17% 0.34% 1651ms 40.04% AbstractCardiacTissue::SolveCellSystems 4ms 0.097% 0.44% 1320ms 32.02% PCApply 0 0% 0.44% 1311ms 31.80% PCApply_BJacobi_Singleblock 66ms 1.60% 2.04% 1124ms 27.26% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 1ms 0.024% 2.06% 1107ms 26.85% KSPSolve_PREONLY (partial-inline) 0 0% 2.06% 1047ms 25.39% KSP_PCApply.lto_priv.7 3ms 0.073% 2.13% 1046ms 25.37% MatSolve 0 0% 2.13% 1046ms 25.37% PCApply_ICC 1031ms 25.01% 27.14% 1038ms 25.18% MatSolve_SeqSBAIJ_1_NaturalOrdering 194ms 4.71% 31.85% 989ms 23.99% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 4ms 0.097% 31.94% 541ms 13.12% MatMult 1ms 0.024% 31.97% 526ms 12.76% MatMult_SeqAIJ 516ms 12.52% 44.48% 526ms 12.76% MatMult_SeqAIJ_Inode (inline) 17ms 0.41% 44.89% 480ms 11.64% AbstractCardiacTissue::UpdateCaches (inline) 53ms 1.29% 46.18% 454ms 11.01% CardiacNewtonSolver::Solve 121ms 2.93% 49.11% 448ms 10.87% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 1ms 0.024% 49.14% 370ms 8.97% KSPConvergedDefault 0 0% 49.14% 351ms 8.51% KSP_PCApply (partial-inline) 59ms 1.43% 50.57% 269ms 6.52% BidomainSolver::SetupLinearSystem 138ms 3.35% 53.92% 241ms 5.85% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 21ms 0.51% 54.43% 226ms 5.48% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 21ms 0.51% 54.94% 224ms 5.43% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 0 0% 54.94% 203ms 4.92% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 44ms 1.07% 56.00% 203ms 4.92% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 196ms 4.75% 60.76% 196ms 4.75% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 1ms 0.024% 60.78% 147ms 3.57% MatNullSpaceRemove 0 0% 60.78% 147ms 3.57% boost::numeric::ublas::norm_inf (inline) 102ms 2.47% 63.25% 147ms 3.57% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 63.25% 147ms 3.57% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 63.25% 147ms 3.57% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 1ms 0.024% 63.28% 134ms 3.25% std::pow (inline) 12ms 0.29% 63.57% 133ms 3.23% __pow 69ms 1.67% 65.24% 129ms 3.13% __GI___exp 128ms 3.10% 68.35% 128ms 3.10% ddot_ 123ms 2.98% 71.33% 125ms 3.03% __ieee754_log_fma 0 0% 71.33% 122ms 2.96% VecDuplicate 17ms 0.41% 71.74% 121ms 2.93% __ieee754_pow_fma 1ms 0.024% 71.77% 96ms 2.33% VecMDot 24ms 0.58% 72.35% 95ms 2.30% MPI_Wtime 4ms 0.097% 72.45% 95ms 2.30% VecMXDot_Private 1ms 0.024% 72.47% 86ms 2.09% VecNorm 1ms 0.024% 72.50% 84ms 2.04% VecTDot 0 0% 72.50% 80ms 1.94% VecTDot_Seq 0 0% 72.50% 80ms 1.94% VecXDot_Seq_Private.constprop.0 1ms 0.024% 72.52% 77ms 1.87% VecDuplicate_Seq 2ms 0.049% 72.57% 71ms 1.72% __GI___clock_gettime 70ms 1.70% 74.27% 71ms 1.72% exp_inline (inline) 3ms 0.073% 74.34% 70ms 1.70% VecNorm_Seq 69ms 1.67% 76.01% 69ms 1.67% [[vdso]] 68ms 1.65% 77.66% 68ms 1.65% VecMDot_Seq 39ms 0.95% 78.61% 67ms 1.63% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 9ms 0.22% 78.83% 62ms 1.50% PetscLogEventEndDefault 3ms 0.073% 78.90% 62ms 1.50% VecDestroy 56ms 1.36% 80.26% 59ms 1.43% __ieee754_exp_fma 7ms 0.17% 80.43% 56ms 1.36% PetscMallocA 9ms 0.22% 80.65% 55ms 1.33% PetscLogEventBeginDefault 4ms 0.097% 80.74% 53ms 1.29% VecCreate 2ms 0.049% 80.79% 50ms 1.21% VecMAXPY 1ms 0.024% 80.81% 49ms 1.19% PetscMallocAlign (partial-inline) 0 0% 80.81% 45ms 1.09% VecDuplicate_MPI 42ms 1.02% 81.83% 42ms 1.02% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CheckIndex0 (inline) 0 0% 81.83% 42ms 1.02% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 81.83% 42ms 1.02% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 81.83% 42ms 1.02% boost_numeric_ublas_abs (inline) 42ms 1.02% 82.85% 42ms 1.02% std::abs (inline) 0 0% 82.85% 37ms 0.9% VecNorm_MPI 3ms 0.073% 82.93% 37ms 0.9% VecNorm_MPI_Default.constprop.0 0 0% 82.93% 36ms 0.87% CxxTest::RealWorldDescription::setUp 0 0% 82.93% 36ms 0.87% PetscInitialize 0 0% 82.93% 36ms 0.87% PetscSetup::setUpWorld 0 0% 82.93% 36ms 0.87% PetscSetupUtils::CommonSetup 0 0% 82.93% 36ms 0.87% PetscSetupUtils::InitialisePetsc 5ms 0.12% 83.05% 36ms 0.87% VecSetType 0 0% 83.05% 35ms 0.85% PMPI_Init_thread 1ms 0.024% 83.07% 35ms 0.85% ompi_mpi_init 32ms 0.78% 83.85% 33ms 0.8% VecMAXPY_Seq 32ms 0.78% 84.62% 32ms 0.78% log_inline (inline) 0 0% 84.62% 31ms 0.75% PetscMemzero (inline) 5ms 0.12% 84.74% 31ms 0.75% VecCopy 9ms 0.22% 84.96% 30ms 0.73% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 84.96% 30ms 0.73% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 84.96% 29ms 0.7% VecCreate_MPI_Private 29ms 0.7% 85.67% 29ms 0.7% [libchaste_heart.so] 29ms 0.7% 86.37% 29ms 0.7% __memset_avx2_unaligned_erms 0 0% 86.37% 28ms 0.68% 3ms 0.073% 86.44% 27ms 0.65% __posix_memalign 26ms 0.63% 87.07% 26ms 0.63% DistributedVector::Iterator::operator!= 6ms 0.15% 87.22% 26ms 0.63% PetscFreeAlign 4ms 0.097% 87.32% 26ms 0.63% PetscHeaderDestroy_Private 1ms 0.024% 87.34% 25ms 0.61% VecCreate_Seq 0 0% 87.34% 25ms 0.61% orte_init 7ms 0.17% 87.51% 24ms 0.58% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 4ms 0.097% 87.61% 24ms 0.58% __GI___libc_free 6ms 0.15% 87.75% 24ms 0.58% __GI___libc_malloc 1ms 0.024% 87.78% 23ms 0.56% VecAXPY 1ms 0.024% 87.80% 22ms 0.53% KSP_RemoveNullSpace (inline) 0 0% 87.80% 21ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 0 0% 87.80% 21ms 0.51% PetscHeaderCreate_Private 1ms 0.024% 87.82% 21ms 0.51% VecAYPX