File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3562ms, 86.14% of 4135ms total Dropped 463 nodes (cum <= 20.68ms) flat flat% sum% cum cum% 0 0% 0% 4127ms 99.81% __libc_start_call_main 0 0% 0% 4127ms 99.81% __libc_start_main_impl 0 0% 0% 4127ms 99.81% _start 0 0% 0% 4124ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4124ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4124ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4124ms 99.73% main 0 0% 0% 4086ms 98.81% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4086ms 98.81% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4086ms 98.81% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4078ms 98.62% AbstractCardiacProblem::Solve 0 0% 0% 4073ms 98.50% AbstractDynamicLinearPdeSolver::Solve 11ms 0.27% 0.27% 1836ms 44.40% AbstractCardiacTissue::SolveCellSystems 0 0% 0.27% 1723ms 41.67% LinearSystem::Solve 0 0% 0.27% 1636ms 39.56% KSPSolve 3ms 0.073% 0.34% 1636ms 39.56% KSPSolve_Private 3ms 0.073% 0.41% 1561ms 37.75% KSPSolve_SYMMLQ 30ms 0.73% 1.14% 998ms 24.14% AbstractCardiacCell::ComputeExceptVoltage 1ms 0.024% 1.16% 984ms 23.80% PCApply 1ms 0.024% 1.19% 965ms 23.34% PCApply_BJacobi_Singleblock 16ms 0.39% 1.57% 863ms 20.87% AbstractOneStepIvpOdeSolver::InternalSolve 0 0% 1.57% 846ms 20.46% KSP_PCApply.lto_priv.18 0 0% 1.57% 799ms 19.32% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 1.60% 767ms 18.55% PCApply_ICC 4ms 0.097% 1.69% 766ms 18.52% MatSolve 749ms 18.11% 19.81% 756ms 18.28% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 39ms 0.94% 20.75% 724ms 17.51% EulerIvpOdeSolver::CalculateNextYValue 201ms 4.86% 25.61% 684ms 16.54% CellLuoRudy1991FromCellML::EvaluateYDerivatives 305ms 7.38% 32.99% 649ms 15.70% __GI___exp 21ms 0.51% 33.49% 637ms 15.41% AbstractCardiacTissue::UpdateCaches (inline) 6ms 0.15% 33.64% 627ms 15.16% MatMult 6ms 0.15% 33.78% 608ms 14.70% MatMult_SeqAIJ (partial-inline) 597ms 14.44% 48.22% 607ms 14.68% MatMult_SeqAIJ_Inode (inline) 207ms 5.01% 53.23% 596ms 14.41% CellLuoRudy1991FromCellML::GetIIonic 87ms 2.10% 55.33% 437ms 10.57% BidomainSolver::SetupLinearSystem 311ms 7.52% 62.85% 330ms 7.98% __ieee754_exp_fma 0 0% 62.85% 190ms 4.59% KSP_PCApply (partial-inline) 1ms 0.024% 62.88% 187ms 4.52% KSPConvergedDefault 15ms 0.36% 63.24% 173ms 4.18% __pow 0 0% 63.24% 173ms 4.18% std::pow (inline) 15ms 0.36% 63.60% 158ms 3.82% __ieee754_pow_fma 73ms 1.77% 65.37% 155ms 3.75% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 65.39% 144ms 3.48% VecDuplicate 5ms 0.12% 65.51% 113ms 2.73% MatNullSpaceRemove 22ms 0.53% 66.05% 95ms 2.30% MPI_Wtime 9ms 0.22% 66.26% 88ms 2.13% VecDuplicate_MPI (partial-inline) 21ms 0.51% 66.77% 77ms 1.86% PetscLogEventEndDefault 76ms 1.84% 68.61% 76ms 1.84% log_inline (inline) 10ms 0.24% 68.85% 73ms 1.77% VecCopy 73ms 1.77% 70.62% 73ms 1.77% [[vdso]] 0 0% 70.62% 73ms 1.77% __GI___clock_gettime 2ms 0.048% 70.67% 72ms 1.74% AbstractBidomainSolver::FinaliseLinearSystem 27ms 0.65% 71.32% 70ms 1.69% AbstractBidomainSolver::CheckCompatibilityCondition 8ms 0.19% 71.51% 69ms 1.67% PetscLogEventBeginDefault 0 0% 71.51% 60ms 1.45% VecMDot 5ms 0.12% 71.63% 60ms 1.45% VecMXDot_Private 5ms 0.12% 71.75% 58ms 1.40% VecCreate 58ms 1.40% 73.16% 58ms 1.40% exp_inline (inline) 2ms 0.048% 73.20% 55ms 1.33% VecDuplicate_Seq 6ms 0.15% 73.35% 50ms 1.21% PetscMallocA 18ms 0.44% 73.78% 48ms 1.16% TimeStepper::TimeStepper 5ms 0.12% 73.91% 48ms 1.16% VecMAXPY 48ms 1.16% 75.07% 48ms 1.16% __memcpy_avx_unaligned_erms 3ms 0.073% 75.14% 44ms 1.06% PetscMallocAlign (partial-inline) 44ms 1.06% 76.20% 44ms 1.06% std::isinf (inline) 0 0% 76.20% 43ms 1.04% PetscMemcpy (inline) 38ms 0.92% 77.12% 40ms 0.97% VecMDot_Seq 0 0% 77.12% 39ms 0.94% VecNorm 38ms 0.92% 78.04% 38ms 0.92% TimeStepper::CalculateNextTime 38ms 0.92% 78.96% 38ms 0.92% [libchaste_heart.so] 2ms 0.048% 79.01% 37ms 0.89% VecCreate_MPI_Private 35ms 0.85% 79.85% 35ms 0.85% ddot_ 0 0% 79.85% 34ms 0.82% CxxTest::RealWorldDescription::setUp 34ms 0.82% 80.68% 34ms 0.82% DistributedVector::Iterator::operator!= 0 0% 80.68% 34ms 0.82% PMPI_Init_thread 0 0% 80.68% 34ms 0.82% PetscInitialize 0 0% 80.68% 34ms 0.82% PetscSetup::setUpWorld 0 0% 80.68% 34ms 0.82% PetscSetupUtils::CommonSetup 0 0% 80.68% 34ms 0.82% PetscSetupUtils::InitialisePetsc 1ms 0.024% 80.70% 34ms 0.82% VecDot 0 0% 80.70% 34ms 0.82% ompi_mpi_init 26ms 0.63% 81.33% 32ms 0.77% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.024% 81.35% 32ms 0.77% VecCopy_Seq (partial-inline) 4ms 0.097% 81.45% 31ms 0.75% PetscHeaderCreate_Private 1ms 0.024% 81.48% 30ms 0.73% 0 0% 81.48% 30ms 0.73% VecNorm_Seq 0 0% 81.48% 28ms 0.68% PetscMemzero (inline) 28ms 0.68% 82.15% 28ms 0.68% VecMAXPY_Seq 16ms 0.39% 82.54% 27ms 0.65% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 82.54% 27ms 0.65% VecDestroy 0 0% 82.54% 27ms 0.65% VecNorm_MPI 0 0% 82.54% 27ms 0.65% VecNorm_MPI_Default.constprop.0 0 0% 82.54% 27ms 0.65% VecSetType 27ms 0.65% 83.19% 27ms 0.65% __memset_avx2_unaligned_erms 20ms 0.48% 83.68% 26ms 0.63% AbstractOneStepIvpOdeSolver::Solve 26ms 0.63% 84.30% 26ms 0.63% DistributedVector::Stripe::operator[] (inline) 15ms 0.36% 84.67% 26ms 0.63% top12 (inline) 0 0% 84.67% 25ms 0.6% VecDot_Seq 0 0% 84.67% 25ms 0.6% VecXDot_Seq_Private.constprop.0 8ms 0.19% 84.86% 25ms 0.6% __GI___libc_malloc 24ms 0.58% 85.44% 25ms 0.6% __ieee754_log_fma 4ms 0.097% 85.54% 24ms 0.58% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.024% 85.56% 23ms 0.56% VecSet 0 0% 85.56% 23ms 0.56% orte_init 2ms 0.048% 85.61% 22ms 0.53% PMPI_Comm_get_attr 9ms 0.22% 85.83% 22ms 0.53% TimeStepper::AdvanceOneTimeStep 0 0% 85.83% 22ms 0.53% VecAXPY 2ms 0.048% 85.88% 22ms 0.53% __posix_memalign 5ms 0.12% 86.00% 22ms 0.53% std::__cxx11::basic_string::basic_string 6ms 0.15% 86.14% 21ms 0.51% PetscOptionsFindPair 0 0% 86.14% 21ms 0.51% VecCreate_Seq