File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3578ms, 85.50% of 4185ms total Dropped 455 nodes (cum <= 20.93ms) flat flat% sum% cum cum% 0 0% 0% 4176ms 99.78% __libc_start_call_main 0 0% 0% 4176ms 99.78% __libc_start_main_impl 0 0% 0% 4176ms 99.78% _start 0 0% 0% 4173ms 99.71% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4173ms 99.71% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4173ms 99.71% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4173ms 99.71% main 0 0% 0% 4136ms 98.83% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4136ms 98.83% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4136ms 98.83% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4128ms 98.64% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4113ms 98.28% AbstractDynamicLinearPdeSolver::Solve 8ms 0.19% 0.22% 2349ms 56.13% AbstractCardiacTissue::SolveCellSystems 2ms 0.048% 0.26% 1450ms 34.65% LinearSystem::Solve 0 0% 0.26% 1401ms 33.48% KSPSolve 6ms 0.14% 0.41% 1401ms 33.48% KSPSolve_Private 35ms 0.84% 1.24% 1376ms 32.88% AbstractCardiacCell::ComputeExceptVoltage 1ms 0.024% 1.27% 1346ms 32.16% KSPSolve_SYMMLQ 28ms 0.67% 1.94% 1181ms 28.22% AbstractOneStepIvpOdeSolver::InternalSolve 62ms 1.48% 3.42% 985ms 23.54% EulerIvpOdeSolver::CalculateNextYValue 274ms 6.55% 9.96% 907ms 21.67% CellLuoRudy1991FromCellML::EvaluateYDerivatives 2ms 0.048% 10.01% 812ms 19.40% PCApply 383ms 9.15% 19.16% 808ms 19.31% __GI___exp 0 0% 19.16% 807ms 19.28% PCApply_BJacobi_Singleblock 29ms 0.69% 19.86% 770ms 18.40% AbstractCardiacTissue::UpdateCaches (inline) 232ms 5.54% 25.40% 716ms 17.11% CellLuoRudy1991FromCellML::GetIIonic 0 0% 25.40% 692ms 16.54% KSPSolve_PREONLY (partial-inline) 2ms 0.048% 25.45% 650ms 15.53% MatSolve 0 0% 25.45% 650ms 15.53% PCApply_ICC 639ms 15.27% 40.72% 645ms 15.41% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 40.72% 567ms 13.55% KSP_PCApply.lto_priv.18 1ms 0.024% 40.74% 417ms 9.96% MatMult 3ms 0.072% 40.81% 412ms 9.84% MatMult_SeqAIJ 406ms 9.70% 50.51% 412ms 9.84% MatMult_SeqAIJ_Inode (inline) 379ms 9.06% 59.57% 411ms 9.82% __ieee754_exp_fma 0 0% 59.57% 320ms 7.65% KSPConvergedDefault 1ms 0.024% 59.59% 302ms 7.22% KSP_PCApply (partial-inline) 68ms 1.62% 61.22% 273ms 6.52% BidomainSolver::SetupLinearSystem 2ms 0.048% 61.27% 253ms 6.05% std::pow (inline) 24ms 0.57% 61.84% 251ms 6.00% __pow 34ms 0.81% 62.65% 227ms 5.42% __ieee754_pow_fma 72ms 1.72% 64.37% 168ms 4.01% CellLuoRudy1991FromCellML::VerifyStateVariables 115ms 2.75% 67.12% 115ms 2.75% log_inline (inline) 0 0% 67.12% 98ms 2.34% MatNullSpaceRemove 0 0% 67.12% 97ms 2.32% VecDuplicate 21ms 0.5% 67.62% 73ms 1.74% MPI_Wtime 70ms 1.67% 69.30% 71ms 1.70% exp_inline (inline) 68ms 1.62% 70.92% 68ms 1.62% ddot_ 0 0% 70.92% 67ms 1.60% VecMDot 2ms 0.048% 70.97% 67ms 1.60% VecMXDot_Private 31ms 0.74% 71.71% 60ms 1.43% TimeStepper::TimeStepper 13ms 0.31% 72.02% 56ms 1.34% PetscLogEventEndDefault 3ms 0.072% 72.09% 55ms 1.31% VecDuplicate_MPI 9ms 0.22% 72.31% 54ms 1.29% PetscLogEventBeginDefault 52ms 1.24% 73.55% 52ms 1.24% [[vdso]] 0 0% 73.55% 52ms 1.24% __GI___clock_gettime 6ms 0.14% 73.69% 51ms 1.22% VecCopy 0 0% 73.69% 50ms 1.19% VecNorm 1ms 0.024% 73.72% 47ms 1.12% VecDot 29ms 0.69% 74.41% 45ms 1.08% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 45ms 1.08% 75.48% 45ms 1.08% VecMDot_Seq 2ms 0.048% 75.53% 44ms 1.05% VecDestroy 0 0% 75.53% 43ms 1.03% VecDot_Seq 0 0% 75.53% 43ms 1.03% VecXDot_Seq_Private.constprop.0 15ms 0.36% 75.89% 43ms 1.03% std::__cxx11::basic_string::basic_string 31ms 0.74% 76.63% 42ms 1.00% AbstractOneStepIvpOdeSolver::Solve 42ms 1.00% 77.63% 42ms 1.00% TimeStepper::CalculateNextTime 1ms 0.024% 77.66% 42ms 1.00% VecDuplicate_Seq 6ms 0.14% 77.80% 41ms 0.98% AbstractCardiacCell::SetVoltage (partial-inline) 5ms 0.12% 77.92% 41ms 0.98% PetscMallocA 0 0% 77.92% 40ms 0.96% VecNorm_Seq 40ms 0.96% 78.88% 40ms 0.96% [libchaste_heart.so] 0 0% 78.88% 38ms 0.91% VecAXPY 37ms 0.88% 79.76% 37ms 0.88% __memcpy_avx_unaligned_erms 5ms 0.12% 79.88% 36ms 0.86% PetscMallocAlign (partial-inline) 36ms 0.86% 80.74% 36ms 0.86% std::isinf (inline) 15ms 0.36% 81.10% 36ms 0.86% top12 (inline) 32ms 0.76% 81.86% 35ms 0.84% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 2ms 0.048% 81.91% 35ms 0.84% VecCreate 10ms 0.24% 82.15% 34ms 0.81% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 82.15% 34ms 0.81% AbstractBidomainSolver::FinaliseLinearSystem 34ms 0.81% 82.96% 34ms 0.81% __ieee754_log_fma 0 0% 82.96% 33ms 0.79% CxxTest::RealWorldDescription::setUp 0 0% 82.96% 33ms 0.79% PetscInitialize 0 0% 82.96% 33ms 0.79% PetscSetup::setUpWorld 0 0% 82.96% 33ms 0.79% PetscSetupUtils::CommonSetup 0 0% 82.96% 33ms 0.79% PetscSetupUtils::InitialisePetsc 3ms 0.072% 83.03% 33ms 0.79% VecCreate_MPI_Private 0 0% 83.03% 32ms 0.76% PMPI_Init_thread 9ms 0.22% 83.25% 32ms 0.76% TimeStepper::AdvanceOneTimeStep 0 0% 83.25% 32ms 0.76% ompi_mpi_init 2ms 0.048% 83.30% 31ms 0.74% VecMAXPY 0 0% 83.30% 29ms 0.69% PetscMemcpy (inline) 0 0% 83.30% 29ms 0.69% VecNorm_MPI 0 0% 83.30% 29ms 0.69% VecNorm_MPI_Default.constprop.0 1ms 0.024% 83.32% 27ms 0.65% 26ms 0.62% 83.94% 27ms 0.65% AbstractParameterisedSystem::SetAnyVariable 7ms 0.17% 84.11% 26ms 0.62% __GI___libc_malloc 5ms 0.12% 84.23% 26ms 0.62% std::vector::_M_assign_aux (inline) 0 0% 84.23% 26ms 0.62% std::vector::assign (inline) 2ms 0.048% 84.28% 25ms 0.6% VecSetType 25ms 0.6% 84.87% 25ms 0.6% asuint64 (inline) 24ms 0.57% 85.45% 24ms 0.57% DistributedVector::Iterator::operator!= 0 0% 85.45% 23ms 0.55% VecAXPY_Seq 0 0% 85.45% 22ms 0.53% orte_init 0 0% 85.45% 21ms 0.5% AbstractFeVolumeIntegralAssembler::DoAssemble 0 0% 85.45% 21ms 0.5% PetscMemzero (inline) 0 0% 85.45% 21ms 0.5% VecCreate_Seq 2ms 0.048% 85.50% 21ms 0.5% std::char_traits::length (inline)