File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3656ms, 87.11% of 4197ms total Dropped 444 nodes (cum <= 20.98ms) flat flat% sum% cum cum% 0 0% 0% 4190ms 99.83% __libc_start_call_main 0 0% 0% 4190ms 99.83% __libc_start_main_impl 0 0% 0% 4190ms 99.83% _start 0 0% 0% 4187ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4187ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4187ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4187ms 99.76% main 0 0% 0% 4151ms 98.90% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4151ms 98.90% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4151ms 98.90% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4144ms 98.74% AbstractCardiacProblem::Solve 4ms 0.095% 0.095% 4130ms 98.40% AbstractDynamicLinearPdeSolver::Solve 15ms 0.36% 0.45% 2235ms 53.25% AbstractCardiacTissue::SolveCellSystems 0 0% 0.45% 1556ms 37.07% LinearSystem::Solve 0 0% 0.45% 1506ms 35.88% KSPSolve 5ms 0.12% 0.57% 1506ms 35.88% KSPSolve_Private 1ms 0.024% 0.6% 1460ms 34.79% KSPSolve_SYMMLQ 32ms 0.76% 1.36% 1294ms 30.83% AbstractCardiacCell::ComputeExceptVoltage 25ms 0.6% 1.95% 1077ms 25.66% AbstractOneStepIvpOdeSolver::InternalSolve 64ms 1.52% 3.48% 916ms 21.83% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.024% 3.50% 862ms 20.54% PCApply 1ms 0.024% 3.53% 852ms 20.30% PCApply_BJacobi_Singleblock 242ms 5.77% 9.29% 837ms 19.94% CellLuoRudy1991FromCellML::EvaluateYDerivatives 349ms 8.32% 17.61% 780ms 18.58% __GI___exp 28ms 0.67% 18.27% 721ms 17.18% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 18.27% 708ms 16.87% KSPSolve_PREONLY (partial-inline) 241ms 5.74% 24.02% 666ms 15.87% CellLuoRudy1991FromCellML::GetIIonic 3ms 0.071% 24.09% 662ms 15.77% MatSolve 0 0% 24.09% 662ms 15.77% PCApply_ICC 648ms 15.44% 39.53% 652ms 15.53% MatSolve_SeqSBAIJ_1_NaturalOrdering 1ms 0.024% 39.55% 635ms 15.13% KSP_PCApply.lto_priv.18 2ms 0.048% 39.60% 463ms 11.03% MatMult 2ms 0.048% 39.65% 453ms 10.79% MatMult_SeqAIJ 447ms 10.65% 50.30% 453ms 10.79% MatMult_SeqAIJ_Inode (inline) 382ms 9.10% 59.40% 412ms 9.82% __ieee754_exp_fma 0 0% 59.40% 315ms 7.51% KSPConvergedDefault 0 0% 59.40% 294ms 7.01% KSP_PCApply (partial-inline) 57ms 1.36% 60.76% 287ms 6.84% BidomainSolver::SetupLinearSystem 3ms 0.071% 60.83% 190ms 4.53% std::pow (inline) 13ms 0.31% 61.14% 187ms 4.46% __pow 17ms 0.41% 61.54% 174ms 4.15% __ieee754_pow_fma 70ms 1.67% 63.21% 163ms 3.88% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 63.21% 116ms 2.76% MatNullSpaceRemove 0 0% 63.21% 110ms 2.62% VecDuplicate 23ms 0.55% 63.76% 98ms 2.34% MPI_Wtime 82ms 1.95% 65.71% 82ms 1.95% log_inline (inline) 14ms 0.33% 66.05% 78ms 1.86% PetscLogEventBeginDefault 75ms 1.79% 67.83% 75ms 1.79% [[vdso]] 0 0% 67.83% 75ms 1.79% __GI___clock_gettime 19ms 0.45% 68.29% 70ms 1.67% PetscLogEventEndDefault 43ms 1.02% 69.31% 69ms 1.64% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 65ms 1.55% 70.86% 68ms 1.62% exp_inline (inline) 0 0% 70.86% 67ms 1.60% VecMDot 2ms 0.048% 70.91% 67ms 1.60% VecMXDot_Private 65ms 1.55% 72.46% 65ms 1.55% ddot_ 6ms 0.14% 72.60% 60ms 1.43% VecDuplicate_MPI (partial-inline) 3ms 0.071% 72.67% 60ms 1.43% VecNorm 8ms 0.19% 72.86% 58ms 1.38% VecCopy 42ms 1.00% 73.86% 57ms 1.36% TimeStepper::TimeStepper 5ms 0.12% 73.98% 50ms 1.19% VecAXPY 4ms 0.095% 74.08% 50ms 1.19% VecDestroy 1ms 0.024% 74.10% 50ms 1.19% VecDuplicate_Seq 3ms 0.071% 74.17% 49ms 1.17% VecMAXPY 1ms 0.024% 74.20% 48ms 1.14% PetscTimeSubtract (inline) 48ms 1.14% 75.34% 48ms 1.14% std::isinf (inline) 0 0% 75.34% 46ms 1.10% VecNorm_Seq 6ms 0.14% 75.48% 45ms 1.07% PetscMallocA 24ms 0.57% 76.05% 44ms 1.05% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 41ms 0.98% 77.03% 44ms 1.05% VecMDot_Seq 0 0% 77.03% 43ms 1.02% VecDot 0 0% 77.03% 42ms 1.00% AbstractBidomainSolver::FinaliseLinearSystem 17ms 0.41% 77.44% 40ms 0.95% AbstractBidomainSolver::CheckCompatibilityCondition 4ms 0.095% 77.53% 39ms 0.93% PetscMallocAlign (partial-inline) 19ms 0.45% 77.98% 39ms 0.93% top12 (inline) 6ms 0.14% 78.13% 36ms 0.86% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 78.13% 36ms 0.86% VecCreate 3ms 0.071% 78.20% 36ms 0.86% VecCreate_MPI_Private 0 0% 78.20% 36ms 0.86% VecDot_Seq 0 0% 78.20% 36ms 0.86% VecXDot_Seq_Private.constprop.0 0 0% 78.20% 35ms 0.83% PetscMemcpy (inline) 17ms 0.41% 78.60% 34ms 0.81% AbstractOneStepIvpOdeSolver::Solve 33ms 0.79% 79.39% 33ms 0.79% [libchaste_heart.so] 33ms 0.79% 80.18% 33ms 0.79% __ieee754_log_fma 0 0% 80.18% 32ms 0.76% CxxTest::RealWorldDescription::setUp 0 0% 80.18% 32ms 0.76% PetscInitialize 0 0% 80.18% 32ms 0.76% PetscSetup::setUpWorld 0 0% 80.18% 32ms 0.76% PetscSetupUtils::CommonSetup 0 0% 80.18% 32ms 0.76% PetscSetupUtils::InitialisePetsc 0 0% 80.18% 31ms 0.74% PMPI_Init_thread 0 0% 80.18% 31ms 0.74% ompi_mpi_init 8ms 0.19% 80.37% 31ms 0.74% std::__cxx11::basic_string::basic_string 2ms 0.048% 80.41% 30ms 0.71% VecAXPY_Seq 1ms 0.024% 80.44% 30ms 0.71% VecNorm_MPI 17ms 0.41% 80.84% 29ms 0.69% TimeStepper::AdvanceOneTimeStep 0 0% 80.84% 29ms 0.69% VecNorm_MPI_Default.constprop.0 27ms 0.64% 81.49% 28ms 0.67% VecMAXPY_Seq 1ms 0.024% 81.51% 28ms 0.67% VecSetType 21ms 0.5% 82.01% 27ms 0.64% AbstractParameterisedSystem::GetAnyVariable 25ms 0.6% 82.61% 27ms 0.64% AbstractParameterisedSystem::SetAnyVariable 27ms 0.64% 83.25% 27ms 0.64% __memcpy_avx_unaligned_erms 0 0% 83.25% 26ms 0.62% 26ms 0.62% 83.87% 26ms 0.62% AbstractParameterisedSystem::rGetStateVariables 1ms 0.024% 83.89% 26ms 0.62% PetscHeaderDestroy_Private 0 0% 83.89% 26ms 0.62% PetscMemzero (inline) 26ms 0.62% 84.51% 26ms 0.62% __memset_avx2_unaligned_erms 25ms 0.6% 85.11% 25ms 0.6% DistributedVector::Iterator::operator!= 10ms 0.24% 85.35% 24ms 0.57% AbstractCardiacCell::GetVoltage (partial-inline) 24ms 0.57% 85.92% 24ms 0.57% TimeStepper::CalculateNextTime 24ms 0.57% 86.49% 24ms 0.57% daxpy_ 1ms 0.024% 86.51% 22ms 0.52% VecCopy_Seq (partial-inline) 4ms 0.095% 86.61% 22ms 0.52% __GI___libc_malloc 0 0% 86.61% 22ms 0.52% orte_init 0 0% 86.61% 21ms 0.5% VecCreate_Seq 21ms 0.5% 87.11% 21ms 0.5% asuint64 (inline)