File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3633ms, 86.98% of 4177ms total Dropped 474 nodes (cum <= 20.89ms) flat flat% sum% cum cum% 0 0% 0% 4170ms 99.83% __libc_start_call_main 0 0% 0% 4170ms 99.83% __libc_start_main_impl 0 0% 0% 4170ms 99.83% _start 0 0% 0% 4167ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4167ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4167ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4167ms 99.76% main 0 0% 0% 4129ms 98.85% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4129ms 98.85% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4129ms 98.85% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4122ms 98.68% AbstractCardiacProblem::Solve 2ms 0.048% 0.048% 4110ms 98.40% AbstractDynamicLinearPdeSolver::Solve 8ms 0.19% 0.24% 2314ms 55.40% AbstractCardiacTissue::SolveCellSystems 0 0% 0.24% 1485ms 35.55% LinearSystem::Solve 0 0% 0.24% 1444ms 34.57% KSPSolve 3ms 0.072% 0.31% 1444ms 34.57% KSPSolve_Private 0 0% 0.31% 1397ms 33.45% KSPSolve_SYMMLQ 36ms 0.86% 1.17% 1362ms 32.61% AbstractCardiacCell::ComputeExceptVoltage 20ms 0.48% 1.65% 1148ms 27.48% AbstractOneStepIvpOdeSolver::InternalSolve 76ms 1.82% 3.47% 978ms 23.41% EulerIvpOdeSolver::CalculateNextYValue 235ms 5.63% 9.10% 847ms 20.28% CellLuoRudy1991FromCellML::EvaluateYDerivatives 2ms 0.048% 9.15% 843ms 20.18% PCApply 1ms 0.024% 9.17% 835ms 19.99% PCApply_BJacobi_Singleblock 365ms 8.74% 17.91% 779ms 18.65% __GI___exp 24ms 0.57% 18.48% 735ms 17.60% AbstractCardiacTissue::UpdateCaches (inline) 242ms 5.79% 24.28% 686ms 16.42% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.024% 24.30% 678ms 16.23% KSPSolve_PREONLY (partial-inline) 3ms 0.072% 24.37% 643ms 15.39% MatSolve 0 0% 24.37% 643ms 15.39% PCApply_ICC 628ms 15.03% 39.41% 637ms 15.25% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 39.41% 619ms 14.82% KSP_PCApply.lto_priv.18 4ms 0.096% 39.50% 428ms 10.25% MatMult 1ms 0.024% 39.53% 422ms 10.10% MatMult_SeqAIJ 413ms 9.89% 49.41% 422ms 10.10% MatMult_SeqAIJ_Inode (inline) 355ms 8.50% 57.91% 383ms 9.17% __ieee754_exp_fma 1ms 0.024% 57.94% 299ms 7.16% KSPConvergedDefault 0 0% 57.94% 288ms 6.89% KSP_PCApply (partial-inline) 61ms 1.46% 59.40% 267ms 6.39% BidomainSolver::SetupLinearSystem 1ms 0.024% 59.42% 225ms 5.39% std::pow (inline) 18ms 0.43% 59.85% 224ms 5.36% __pow 22ms 0.53% 60.38% 206ms 4.93% __ieee754_pow_fma 70ms 1.68% 62.05% 159ms 3.81% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 62.08% 122ms 2.92% MatNullSpaceRemove 99ms 2.37% 64.45% 99ms 2.37% log_inline (inline) 1ms 0.024% 64.47% 85ms 2.03% VecDuplicate 25ms 0.6% 65.07% 84ms 2.01% MPI_Wtime 0 0% 65.07% 81ms 1.94% VecMDot 6ms 0.14% 65.21% 81ms 1.94% VecMXDot_Private 78ms 1.87% 67.08% 78ms 1.87% exp_inline (inline) 43ms 1.03% 68.11% 77ms 1.84% TimeStepper::TimeStepper 20ms 0.48% 68.59% 68ms 1.63% PetscLogEventEndDefault 8ms 0.19% 68.78% 65ms 1.56% VecCopy 16ms 0.38% 69.16% 60ms 1.44% PetscLogEventBeginDefault 59ms 1.41% 70.58% 59ms 1.41% [[vdso]] 0 0% 70.58% 59ms 1.41% __GI___clock_gettime 55ms 1.32% 71.89% 56ms 1.34% VecMDot_Seq 3ms 0.072% 71.97% 54ms 1.29% VecDestroy 50ms 1.20% 73.16% 50ms 1.20% ddot_ 40ms 0.96% 74.12% 49ms 1.17% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 26ms 0.62% 74.74% 48ms 1.15% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 48ms 1.15% 75.89% 48ms 1.15% non-virtual thunk to CellLuoRudy1991FromCellML::EvaluateYDerivatives(double, std::vector const&, std::vector&) 6ms 0.14% 76.04% 46ms 1.10% AbstractCardiacCell::SetVoltage (partial-inline) 2ms 0.048% 76.08% 46ms 1.10% VecDuplicate_MPI 2ms 0.048% 76.13% 44ms 1.05% VecAXPY 43ms 1.03% 77.16% 43ms 1.03% TimeStepper::CalculateNextTime 26ms 0.62% 77.78% 42ms 1.01% AbstractOneStepIvpOdeSolver::Solve 3ms 0.072% 77.85% 42ms 1.01% VecDot 41ms 0.98% 78.84% 41ms 0.98% __memcpy_avx_unaligned_erms 2ms 0.048% 78.88% 40ms 0.96% VecMAXPY 1ms 0.024% 78.91% 38ms 0.91% VecDuplicate_Seq 37ms 0.89% 79.79% 37ms 0.89% [libchaste_heart.so] 37ms 0.89% 80.68% 37ms 0.89% std::isinf (inline) 4ms 0.096% 80.78% 36ms 0.86% VecCreate 9ms 0.22% 80.99% 34ms 0.81% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 80.99% 34ms 0.81% AbstractBidomainSolver::FinaliseLinearSystem 16ms 0.38% 81.37% 34ms 0.81% std::__cxx11::basic_string::basic_string 0 0% 81.37% 33ms 0.79% CxxTest::RealWorldDescription::setUp 0 0% 81.37% 33ms 0.79% PMPI_Init_thread 0 0% 81.37% 33ms 0.79% PetscInitialize 0 0% 81.37% 33ms 0.79% PetscMemcpy (inline) 0 0% 81.37% 33ms 0.79% PetscSetup::setUpWorld 0 0% 81.37% 33ms 0.79% PetscSetupUtils::CommonSetup 0 0% 81.37% 33ms 0.79% PetscSetupUtils::InitialisePetsc 0 0% 81.37% 33ms 0.79% ompi_mpi_init 0 0% 81.37% 32ms 0.77% VecDot_Seq 0 0% 81.37% 32ms 0.77% VecXDot_Seq_Private.constprop.0 0 0% 81.37% 31ms 0.74% VecNorm 31ms 0.74% 82.12% 31ms 0.74% [libm.so.6] 14ms 0.34% 82.45% 31ms 0.74% top12 (inline) 2ms 0.048% 82.50% 30ms 0.72% PetscMallocA 28ms 0.67% 83.17% 29ms 0.69% AbstractParameterisedSystem::SetAnyVariable 2ms 0.048% 83.22% 28ms 0.67% PetscMallocAlign 28ms 0.67% 83.89% 28ms 0.67% __ieee754_log_fma 0 0% 83.89% 27ms 0.65% VecAXPY_Seq 2ms 0.048% 83.94% 26ms 0.62% 26ms 0.62% 84.56% 26ms 0.62% daxpy_ 24ms 0.57% 85.13% 25ms 0.6% VecMAXPY_Seq 0 0% 85.13% 25ms 0.6% VecNorm_Seq 0 0% 85.13% 23ms 0.55% VecCopy_Seq (partial-inline) 0 0% 85.13% 23ms 0.55% orte_init 3ms 0.072% 85.20% 22ms 0.53% VecCreate_MPI_Private 19ms 0.45% 85.66% 21ms 0.5% AbstractParameterisedSystem::GetAnyVariable 21ms 0.5% 86.16% 21ms 0.5% DistributedVector::Iterator::operator!= 8ms 0.19% 86.35% 21ms 0.5% TimeStepper::AdvanceOneTimeStep 5ms 0.12% 86.47% 21ms 0.5% __GI___libc_malloc 21ms 0.5% 86.98% 21ms 0.5% asuint64 (inline)