File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3652ms, 87.06% of 4195ms total Dropped 463 nodes (cum <= 20.98ms) flat flat% sum% cum cum% 0 0% 0% 4187ms 99.81% __libc_start_call_main 0 0% 0% 4187ms 99.81% __libc_start_main_impl 0 0% 0% 4187ms 99.81% _start 0 0% 0% 4184ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4184ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4184ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4184ms 99.74% main 0 0% 0% 4149ms 98.90% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4149ms 98.90% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4149ms 98.90% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.024% 0.024% 4142ms 98.74% AbstractCardiacProblem::Solve 1ms 0.024% 0.048% 4124ms 98.31% AbstractDynamicLinearPdeSolver::Solve 13ms 0.31% 0.36% 2389ms 56.95% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.38% 1462ms 34.85% LinearSystem::Solve 0 0% 0.38% 1413ms 33.68% KSPSolve 7ms 0.17% 0.55% 1413ms 33.68% KSPSolve_Private 31ms 0.74% 1.29% 1373ms 32.73% AbstractCardiacCell::ComputeExceptVoltage 1ms 0.024% 1.31% 1369ms 32.63% KSPSolve_SYMMLQ 43ms 1.03% 2.34% 1182ms 28.18% AbstractOneStepIvpOdeSolver::InternalSolve 63ms 1.50% 3.84% 951ms 22.67% EulerIvpOdeSolver::CalculateNextYValue 259ms 6.17% 10.01% 882ms 21.03% CellLuoRudy1991FromCellML::EvaluateYDerivatives 4ms 0.095% 10.11% 833ms 19.86% PCApply 1ms 0.024% 10.13% 823ms 19.62% PCApply_BJacobi_Singleblock 338ms 8.06% 18.19% 803ms 19.14% __GI___exp 30ms 0.72% 18.90% 792ms 18.88% AbstractCardiacTissue::UpdateCaches (inline) 255ms 6.08% 24.98% 735ms 17.52% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.98% 699ms 16.66% KSPSolve_PREONLY (partial-inline) 3ms 0.072% 25.05% 651ms 15.52% MatSolve 0 0% 25.05% 651ms 15.52% PCApply_ICC 639ms 15.23% 40.29% 645ms 15.38% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 40.29% 599ms 14.28% KSP_PCApply.lto_priv.18 413ms 9.85% 50.13% 447ms 10.66% __ieee754_exp_fma 5ms 0.12% 50.25% 398ms 9.49% MatMult 2ms 0.048% 50.30% 390ms 9.30% MatMult_SeqAIJ 384ms 9.15% 59.45% 390ms 9.30% MatMult_SeqAIJ_Inode (inline) 2ms 0.048% 59.50% 317ms 7.56% KSPConvergedDefault 0 0% 59.50% 300ms 7.15% KSP_PCApply (partial-inline) 3ms 0.072% 59.57% 251ms 5.98% std::pow (inline) 26ms 0.62% 60.19% 248ms 5.91% __pow 43ms 1.03% 61.22% 229ms 5.46% BidomainSolver::SetupLinearSystem 37ms 0.88% 62.10% 222ms 5.29% __ieee754_pow_fma 72ms 1.72% 63.81% 168ms 4.00% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 63.84% 117ms 2.79% MatNullSpaceRemove 100ms 2.38% 66.22% 100ms 2.38% log_inline (inline) 84ms 2.00% 68.22% 85ms 2.03% exp_inline (inline) 44ms 1.05% 69.27% 84ms 2.00% TimeStepper::TimeStepper 18ms 0.43% 69.70% 79ms 1.88% MPI_Wtime 1ms 0.024% 69.73% 79ms 1.88% VecDuplicate 0 0% 69.73% 76ms 1.81% VecMDot 1ms 0.024% 69.75% 76ms 1.81% VecMXDot_Private 18ms 0.43% 70.18% 68ms 1.62% PetscLogEventEndDefault 4ms 0.095% 70.27% 64ms 1.53% VecCopy 63ms 1.50% 71.78% 63ms 1.50% ddot_ 1ms 0.024% 71.80% 61ms 1.45% __GI___clock_gettime 60ms 1.43% 73.23% 60ms 1.43% [[vdso]] 44ms 1.05% 74.28% 55ms 1.31% AbstractOneStepIvpOdeSolver::Solve 52ms 1.24% 75.52% 52ms 1.24% TimeStepper::CalculateNextTime 46ms 1.10% 76.62% 49ms 1.17% VecMDot_Seq 8ms 0.19% 76.81% 47ms 1.12% AbstractCardiacCell::SetVoltage (partial-inline) 4ms 0.095% 76.90% 45ms 1.07% VecDuplicate_MPI 45ms 1.07% 77.97% 45ms 1.07% __memcpy_avx_unaligned_erms 7ms 0.17% 78.14% 44ms 1.05% PetscLogEventBeginDefault 4ms 0.095% 78.24% 44ms 1.05% VecAXPY 2ms 0.048% 78.28% 44ms 1.05% VecDot 44ms 1.05% 79.33% 44ms 1.05% std::isinf (inline) 3ms 0.072% 79.40% 43ms 1.03% VecDestroy 0 0% 79.40% 43ms 1.03% VecNorm 0 0% 79.40% 41ms 0.98% PetscMemcpy (inline) 0 0% 79.40% 41ms 0.98% VecDot_Seq 0 0% 79.40% 41ms 0.98% VecXDot_Seq_Private.constprop.0 24ms 0.57% 79.98% 40ms 0.95% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 80.00% 40ms 0.95% VecMAXPY 14ms 0.33% 80.33% 38ms 0.91% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 80.33% 38ms 0.91% AbstractBidomainSolver::FinaliseLinearSystem 6ms 0.14% 80.48% 38ms 0.91% PetscMallocA 21ms 0.5% 80.98% 38ms 0.91% TimeStepper::AdvanceOneTimeStep 37ms 0.88% 81.86% 37ms 0.88% [libchaste_heart.so] 12ms 0.29% 82.15% 37ms 0.88% std::__cxx11::basic_string::basic_string 1ms 0.024% 82.17% 36ms 0.86% VecNorm_Seq 33ms 0.79% 82.96% 35ms 0.83% AbstractParameterisedSystem::SetAnyVariable 2ms 0.048% 83.00% 34ms 0.81% VecCreate 0 0% 83.00% 33ms 0.79% VecCopy_Seq (partial-inline) 0 0% 83.00% 33ms 0.79% VecDuplicate_Seq 1ms 0.024% 83.03% 32ms 0.76% PetscMallocAlign 31ms 0.74% 83.77% 32ms 0.76% __ieee754_log_fma 12ms 0.29% 84.05% 31ms 0.74% top12 (inline) 0 0% 84.05% 30ms 0.72% CxxTest::RealWorldDescription::setUp 0 0% 84.05% 30ms 0.72% PMPI_Init_thread 0 0% 84.05% 30ms 0.72% PetscInitialize 0 0% 84.05% 30ms 0.72% PetscSetup::setUpWorld 0 0% 84.05% 30ms 0.72% PetscSetupUtils::CommonSetup 0 0% 84.05% 30ms 0.72% PetscSetupUtils::InitialisePetsc 0 0% 84.05% 30ms 0.72% ompi_mpi_init 3ms 0.072% 84.12% 27ms 0.64% VecAXPY_Seq 0 0% 84.12% 25ms 0.6% 2ms 0.048% 84.17% 24ms 0.57% VecCreate_MPI_Private 23ms 0.55% 84.72% 24ms 0.57% VecMAXPY_Seq 24ms 0.57% 85.29% 24ms 0.57% asuint64 (inline) 23ms 0.55% 85.84% 23ms 0.55% DistributedVector::Iterator::operator!= 0 0% 85.84% 23ms 0.55% VecNorm_MPI 0 0% 85.84% 23ms 0.55% VecNorm_MPI_Default.constprop.0 23ms 0.55% 86.39% 23ms 0.55% daxpy_ 11ms 0.26% 86.65% 22ms 0.52% AbstractCardiacCell::GetVoltage (partial-inline) 17ms 0.41% 87.06% 21ms 0.5% AbstractParameterisedSystem::GetAnyVariable 0 0% 87.06% 21ms 0.5% orte_init