File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3311ms, 89.05% of 3718ms total Dropped 452 nodes (cum <= 18.59ms) flat flat% sum% cum cum% 0 0% 0% 3711ms 99.81% __libc_start_call_main 0 0% 0% 3711ms 99.81% __libc_start_main_impl 0 0% 0% 3711ms 99.81% _start 0 0% 0% 3709ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3709ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3709ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3709ms 99.76% main 0 0% 0% 3675ms 98.84% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3675ms 98.84% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3675ms 98.84% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 3668ms 98.66% AbstractCardiacProblem::Solve 0 0% 0% 3662ms 98.49% AbstractDynamicLinearPdeSolver::Solve 5ms 0.13% 0.13% 1922ms 51.69% AbstractCardiacTissue::SolveCellSystems 0 0% 0.13% 1352ms 36.36% LinearSystem::Solve 0 0% 0.13% 1321ms 35.53% KSPSolve 4ms 0.11% 0.24% 1321ms 35.53% KSPSolve_Private 1ms 0.027% 0.27% 1288ms 34.64% KSPSolve_SYMMLQ 11ms 0.3% 0.56% 1087ms 29.24% AbstractCardiacCell::ComputeExceptVoltage 14ms 0.38% 0.94% 968ms 26.04% AbstractOneStepIvpOdeSolver::InternalSolve 91ms 2.45% 3.39% 832ms 22.38% EulerIvpOdeSolver::CalculateNextYValue 271ms 7.29% 10.68% 737ms 19.82% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.027% 10.70% 736ms 19.80% PCApply 0 0% 10.70% 733ms 19.71% PCApply_BJacobi_Singleblock 8ms 0.22% 10.92% 683ms 18.37% AbstractCardiacTissue::UpdateCaches (inline) 291ms 7.83% 18.75% 654ms 17.59% CellLuoRudy1991FromCellML::GetIIonic 0 0% 18.75% 626ms 16.84% KSPSolve_PREONLY (partial-inline) 0 0% 18.75% 594ms 15.98% MatMult 100ms 2.69% 21.44% 589ms 15.84% MatMult_SeqAIJ (partial-inline) 3ms 0.081% 21.52% 589ms 15.84% MatSolve 0 0% 21.52% 589ms 15.84% PCApply_ICC 578ms 15.55% 37.06% 583ms 15.68% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 37.06% 559ms 15.03% KSP_PCApply.lto_priv.18 182ms 4.90% 41.96% 542ms 14.58% __GI___exp 487ms 13.10% 55.06% 495ms 13.31% MatMult_SeqAIJ_Inode (inline) 28ms 0.75% 55.81% 353ms 9.49% BidomainSolver::SetupLinearSystem 316ms 8.50% 64.31% 321ms 8.63% __ieee754_exp_fma 0 0% 64.31% 250ms 6.72% KSPConvergedDefault 0 0% 64.31% 239ms 6.43% KSP_PCApply (partial-inline) 3ms 0.081% 64.39% 198ms 5.33% std::pow (inline) 6ms 0.16% 64.55% 195ms 5.24% __pow 9ms 0.24% 64.79% 186ms 5.00% __ieee754_pow_fma 59ms 1.59% 66.38% 120ms 3.23% CellLuoRudy1991FromCellML::VerifyStateVariables 118ms 3.17% 69.55% 118ms 3.17% [libchaste_heart.so] 2ms 0.054% 69.61% 109ms 2.93% MatNullSpaceRemove 84ms 2.26% 71.87% 100ms 2.69% exp_inline (inline) 77ms 2.07% 73.94% 77ms 2.07% log_inline (inline) 0 0% 73.94% 66ms 1.78% VecDuplicate 1ms 0.027% 73.96% 64ms 1.72% VecMDot 6ms 0.16% 74.13% 63ms 1.69% VecMXDot_Private 59ms 1.59% 75.71% 59ms 1.59% TimeStepper::CalculateNextTime 14ms 0.38% 76.09% 57ms 1.53% MPI_Wtime 53ms 1.43% 77.51% 53ms 1.43% ddot_ 15ms 0.4% 77.92% 50ms 1.34% TimeStepper::TimeStepper 8ms 0.22% 78.13% 48ms 1.29% PetscLogEventEndDefault 44ms 1.18% 79.32% 44ms 1.18% [libm.so.6] 17ms 0.46% 79.77% 44ms 1.18% std::__cxx11::basic_string::basic_string 5ms 0.13% 79.91% 43ms 1.16% VecMAXPY 40ms 1.08% 80.98% 43ms 1.16% VecMDot_Seq 43ms 1.16% 82.14% 43ms 1.16% [[vdso]] 0 0% 82.14% 43ms 1.16% __GI___clock_gettime 6ms 0.16% 82.30% 42ms 1.13% PetscLogEventBeginDefault 12ms 0.32% 82.63% 42ms 1.13% TimeStepper::AdvanceOneTimeStep 1ms 0.027% 82.65% 40ms 1.08% VecDestroy 4ms 0.11% 82.76% 39ms 1.05% VecCopy 0 0% 82.76% 38ms 1.02% VecDot 0 0% 82.76% 36ms 0.97% VecDot_Seq 0 0% 82.76% 36ms 0.97% VecXDot_Seq_Private.constprop.0 7ms 0.19% 82.95% 35ms 0.94% VecAXPY 1ms 0.027% 82.97% 35ms 0.94% VecDuplicate_MPI 13ms 0.35% 83.32% 34ms 0.91% AbstractCardiacCell::SetVoltage (partial-inline) 2ms 0.054% 83.38% 33ms 0.89% PetscMallocA 22ms 0.59% 83.97% 32ms 0.86% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 83.97% 32ms 0.86% VecCreate 4ms 0.11% 84.08% 31ms 0.83% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 84.08% 31ms 0.83% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 84.08% 31ms 0.83% PetscMallocAlign 0 0% 84.08% 31ms 0.83% VecDuplicate_Seq 31ms 0.83% 84.91% 31ms 0.83% __ieee754_log_fma 0 0% 84.91% 30ms 0.81% CxxTest::RealWorldDescription::setUp 0 0% 84.91% 30ms 0.81% PMPI_Init_thread 0 0% 84.91% 30ms 0.81% PetscInitialize 0 0% 84.91% 30ms 0.81% PetscSetup::setUpWorld 0 0% 84.91% 30ms 0.81% PetscSetupUtils::CommonSetup 0 0% 84.91% 30ms 0.81% PetscSetupUtils::InitialisePetsc 27ms 0.73% 85.64% 30ms 0.81% VecMAXPY_Seq 0 0% 85.64% 30ms 0.81% ompi_mpi_init 2ms 0.054% 85.69% 29ms 0.78% VecNorm 14ms 0.38% 86.07% 29ms 0.78% __GI___libc_malloc 19ms 0.51% 86.58% 28ms 0.75% AbstractOneStepIvpOdeSolver::Solve 3ms 0.081% 86.66% 28ms 0.75% __posix_memalign 1ms 0.027% 86.69% 27ms 0.73% PetscTimeSubtract (inline) 27ms 0.73% 87.41% 27ms 0.73% __memcpy_avx512_unaligned_erms 26ms 0.7% 88.11% 26ms 0.7% [libchaste_ode.so] 1ms 0.027% 88.14% 25ms 0.67% 0 0% 88.14% 24ms 0.65% PetscMemcpy (inline) 0 0% 88.14% 22ms 0.59% VecNorm_Seq 2ms 0.054% 88.19% 22ms 0.59% std::char_traits::length (inline) 9ms 0.24% 88.43% 21ms 0.56% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 21ms 0.56% 89.00% 21ms 0.56% asuint64 (inline) 2ms 0.054% 89.05% 20ms 0.54% __GI___libc_free 0 0% 89.05% 20ms 0.54% orte_init