File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3513ms, 85.47% of 4110ms total Dropped 470 nodes (cum <= 20.55ms) flat flat% sum% cum cum% 0 0% 0% 4103ms 99.83% __libc_start_call_main 0 0% 0% 4103ms 99.83% __libc_start_main_impl 0 0% 0% 4103ms 99.83% _start 0 0% 0% 4100ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4100ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4100ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4100ms 99.76% main 0 0% 0% 4063ms 98.86% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4063ms 98.86% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4063ms 98.86% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4055ms 98.66% AbstractCardiacProblem::Solve 0 0% 0% 4050ms 98.54% AbstractDynamicLinearPdeSolver::Solve 0 0% 0% 2219ms 53.99% LinearSystem::Solve 0 0% 0% 2108ms 51.29% KSPSolve 9ms 0.22% 0.22% 2108ms 51.29% KSPSolve_Private 7ms 0.17% 0.39% 2024ms 49.25% KSPSolve_SYMMLQ 8ms 0.19% 0.58% 1429ms 34.77% AbstractCardiacTissue::SolveCellSystems 2ms 0.049% 0.63% 1332ms 32.41% PCApply 1ms 0.024% 0.66% 1320ms 32.12% PCApply_BJacobi_Singleblock 0 0% 0.66% 1104ms 26.86% KSPSolve_PREONLY (partial-inline) 0 0% 0.66% 1099ms 26.74% KSP_PCApply.lto_priv.18 1ms 0.024% 0.68% 1055ms 25.67% PCApply_ICC 6ms 0.15% 0.83% 1054ms 25.64% MatSolve 1032ms 25.11% 25.94% 1039ms 25.28% MatSolve_SeqSBAIJ_1_NaturalOrdering 22ms 0.54% 26.47% 838ms 20.39% AbstractCardiacCell::ComputeExceptVoltage 9ms 0.22% 26.69% 718ms 17.47% AbstractOneStepIvpOdeSolver::InternalSolve 44ms 1.07% 27.76% 611ms 14.87% EulerIvpOdeSolver::CalculateNextYValue 153ms 3.72% 31.48% 559ms 13.60% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.024% 31.51% 523ms 12.73% MatMult 227ms 5.52% 37.03% 519ms 12.63% __GI___exp 6ms 0.15% 37.18% 517ms 12.58% MatMult_SeqAIJ (partial-inline) 506ms 12.31% 49.49% 516ms 12.55% MatMult_SeqAIJ_Inode (inline) 11ms 0.27% 49.76% 448ms 10.90% AbstractCardiacTissue::UpdateCaches (inline) 149ms 3.63% 53.38% 425ms 10.34% CellLuoRudy1991FromCellML::GetIIonic 52ms 1.27% 54.65% 334ms 8.13% BidomainSolver::SetupLinearSystem 1ms 0.024% 54.67% 332ms 8.08% KSPConvergedDefault 0 0% 54.67% 323ms 7.86% KSP_PCApply (partial-inline) 263ms 6.40% 61.07% 278ms 6.76% __ieee754_exp_fma 1ms 0.024% 61.09% 163ms 3.97% VecDuplicate 1ms 0.024% 61.12% 162ms 3.94% MatNullSpaceRemove 21ms 0.51% 61.63% 135ms 3.28% MPI_Wtime 1ms 0.024% 61.65% 122ms 2.97% std::pow (inline) 14ms 0.34% 62.00% 121ms 2.94% VecCopy 9ms 0.22% 62.21% 121ms 2.94% __pow 1ms 0.024% 62.24% 114ms 2.77% __GI___clock_gettime 113ms 2.75% 64.99% 113ms 2.75% [[vdso]] 14ms 0.34% 65.33% 112ms 2.73% __ieee754_pow_fma 46ms 1.12% 66.45% 103ms 2.51% CellLuoRudy1991FromCellML::VerifyStateVariables 4ms 0.097% 66.55% 102ms 2.48% VecDuplicate_MPI 15ms 0.36% 66.91% 100ms 2.43% PetscLogEventBeginDefault 1ms 0.024% 66.93% 97ms 2.36% VecMDot 12ms 0.29% 67.23% 96ms 2.34% VecMXDot_Private 21ms 0.51% 67.74% 87ms 2.12% PetscLogEventEndDefault 76ms 1.85% 69.59% 76ms 1.85% ddot_ 3ms 0.073% 69.66% 74ms 1.80% VecNorm 7ms 0.17% 69.83% 73ms 1.78% VecCreate 4ms 0.097% 69.93% 68ms 1.65% VecDot 7ms 0.17% 70.10% 64ms 1.56% VecMAXPY 1ms 0.024% 70.12% 62ms 1.51% AbstractBidomainSolver::FinaliseLinearSystem 12ms 0.29% 70.41% 61ms 1.48% AbstractBidomainSolver::CheckCompatibilityCondition 1ms 0.024% 70.44% 61ms 1.48% VecNorm_Seq 13ms 0.32% 70.75% 60ms 1.46% PetscMallocA 3ms 0.073% 70.83% 60ms 1.46% VecDuplicate_Seq 3ms 0.073% 70.90% 59ms 1.44% VecDestroy 1ms 0.024% 70.92% 56ms 1.36% KSP_RemoveNullSpace (inline) 0 0% 70.92% 56ms 1.36% VecDot_Seq 55ms 1.34% 72.26% 56ms 1.36% VecMDot_Seq 2ms 0.049% 72.31% 56ms 1.36% VecXDot_Seq_Private.constprop.0 56ms 1.36% 73.67% 56ms 1.36% log_inline (inline) 2ms 0.049% 73.72% 51ms 1.24% VecCopy_Seq (partial-inline) 51ms 1.24% 74.96% 51ms 1.24% __memcpy_avx_unaligned_erms 0 0% 74.96% 49ms 1.19% PetscMemcpy (inline) 3ms 0.073% 75.04% 49ms 1.19% VecCreate_MPI_Private 0 0% 75.04% 48ms 1.17% VecNorm_MPI 1ms 0.024% 75.06% 48ms 1.17% VecNorm_MPI_Default.constprop.0 3ms 0.073% 75.13% 47ms 1.14% PetscMallocAlign (partial-inline) 23ms 0.56% 75.69% 46ms 1.12% TimeStepper::TimeStepper 41ms 1% 76.69% 41ms 1% DistributedVector::Iterator::operator!= 40ms 0.97% 77.66% 40ms 0.97% exp_inline (inline) 37ms 0.9% 78.56% 37ms 0.9% TimeStepper::CalculateNextTime 5ms 0.12% 78.69% 35ms 0.85% PetscHeaderCreate_Private 0 0% 78.69% 35ms 0.85% PetscMemzero (inline) 32ms 0.78% 79.46% 35ms 0.85% VecMAXPY_Seq 35ms 0.85% 80.32% 35ms 0.85% dasum_ 20ms 0.49% 80.80% 33ms 0.8% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 80.80% 33ms 0.8% CxxTest::RealWorldDescription::setUp 0 0% 80.80% 33ms 0.8% PMPI_Init_thread 0 0% 80.80% 33ms 0.8% PetscInitialize 0 0% 80.80% 33ms 0.8% PetscSetup::setUpWorld 0 0% 80.80% 33ms 0.8% PetscSetupUtils::CommonSetup 0 0% 80.80% 33ms 0.8% PetscSetupUtils::InitialisePetsc 0 0% 80.80% 33ms 0.8% ompi_mpi_init 4ms 0.097% 80.90% 32ms 0.78% VecSetType 32ms 0.78% 81.68% 32ms 0.78% __memset_avx2_unaligned_erms 3ms 0.073% 81.75% 31ms 0.75% PMPI_Comm_get_attr 2ms 0.049% 81.80% 31ms 0.75% VecAXPY 31ms 0.75% 82.55% 31ms 0.75% [libchaste_heart.so] 4ms 0.097% 82.65% 30ms 0.73% PetscHeaderDestroy_Private 2ms 0.049% 82.70% 28ms 0.68% VecScale 1ms 0.024% 82.73% 28ms 0.68% VecStashCreate_Private 7ms 0.17% 82.90% 28ms 0.68% ompi_attr_get_c 8ms 0.19% 83.09% 27ms 0.66% PetscOptionsFindPair 12ms 0.29% 83.38% 27ms 0.66% std::__cxx11::basic_string::basic_string 22ms 0.54% 83.92% 25ms 0.61% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 9ms 0.22% 84.14% 25ms 0.61% TimeStepper::AdvanceOneTimeStep 1ms 0.024% 84.16% 25ms 0.61% VecSet 3ms 0.073% 84.23% 25ms 0.61% __posix_memalign 0 0% 84.23% 24ms 0.58% 5ms 0.12% 84.36% 24ms 0.58% AbstractCardiacCell::SetVoltage (partial-inline) 5ms 0.12% 84.48% 24ms 0.58% __GI___libc_malloc 24ms 0.58% 85.06% 24ms 0.58% __ieee754_log_fma 17ms 0.41% 85.47% 23ms 0.56% AbstractOneStepIvpOdeSolver::Solve 0 0% 85.47% 22ms 0.54% orte_init