File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 2865ms, 86.37% of 3317ms total Dropped 429 nodes (cum <= 16.59ms) flat flat% sum% cum cum% 0 0% 0% 3310ms 99.79% __libc_start_call_main 0 0% 0% 3310ms 99.79% __libc_start_main_impl 0 0% 0% 3310ms 99.79% _start 0 0% 0% 3308ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3308ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3308ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3308ms 99.73% main 0 0% 0% 3266ms 98.46% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3266ms 98.46% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3266ms 98.46% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.03% 0.03% 3259ms 98.25% AbstractCardiacProblem::Solve 0 0% 0.03% 3249ms 97.95% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.03% 1628ms 49.08% LinearSystem::Solve 2ms 0.06% 0.09% 1582ms 47.69% KSPSolve 4ms 0.12% 0.21% 1582ms 47.69% KSPSolve_Private 5ms 0.15% 0.36% 1548ms 46.67% KSPSolve_SYMMLQ 12ms 0.36% 0.72% 1332ms 40.16% AbstractCardiacTissue::SolveCellSystems 2ms 0.06% 0.78% 1000ms 30.15% PCApply 1ms 0.03% 0.81% 990ms 29.85% PCApply_BJacobi_Singleblock 0 0% 0.81% 848ms 25.57% KSPSolve_PREONLY (partial-inline) 3ms 0.09% 0.9% 797ms 24.03% MatSolve 0 0% 0.9% 797ms 24.03% PCApply_ICC 785ms 23.67% 24.57% 790ms 23.82% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 25ms 0.75% 25.32% 769ms 23.18% AbstractCardiacCell::ComputeExceptVoltage 0 0% 25.32% 750ms 22.61% KSP_PCApply.lto_priv.18 9ms 0.27% 25.60% 641ms 19.32% AbstractOneStepIvpOdeSolver::InternalSolve 37ms 1.12% 26.71% 535ms 16.13% EulerIvpOdeSolver::CalculateNextYValue 145ms 4.37% 31.08% 492ms 14.83% CellLuoRudy1991FromCellML::EvaluateYDerivatives 16ms 0.48% 31.56% 468ms 14.11% AbstractCardiacTissue::UpdateCaches (inline) 206ms 6.21% 37.78% 444ms 13.39% __GI___exp 3ms 0.09% 37.87% 438ms 13.20% MatMult 11ms 0.33% 38.20% 430ms 12.96% MatMult_SeqAIJ (partial-inline) 411ms 12.39% 50.59% 430ms 12.96% MatMult_SeqAIJ_Inode (inline) 156ms 4.70% 55.29% 429ms 12.93% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.03% 55.32% 324ms 9.77% KSPConvergedDefault 0 0% 55.32% 319ms 9.62% KSP_PCApply (partial-inline) 38ms 1.15% 56.47% 235ms 7.08% BidomainSolver::SetupLinearSystem 191ms 5.76% 62.22% 235ms 7.08% __ieee754_exp_fma 0 0% 62.22% 135ms 4.07% MatNullSpaceRemove 2ms 0.06% 62.29% 132ms 3.98% std::pow (inline) 16ms 0.48% 62.77% 130ms 3.92% __pow 8ms 0.24% 63.01% 114ms 3.44% __ieee754_pow_fma 1ms 0.03% 63.04% 86ms 2.59% VecMDot 7ms 0.21% 63.25% 85ms 2.56% VecMXDot_Private 82ms 2.47% 65.72% 82ms 2.47% ddot_ 2ms 0.06% 65.78% 81ms 2.44% VecDuplicate 16ms 0.48% 66.26% 79ms 2.38% MPI_Wtime 37ms 1.12% 67.38% 66ms 1.99% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.03% 67.41% 63ms 1.90% __GI___clock_gettime 62ms 1.87% 69.28% 62ms 1.87% [[vdso]] 59ms 1.78% 71.06% 60ms 1.81% VecMDot_Seq 57ms 1.72% 72.78% 57ms 1.72% log_inline (inline) 1ms 0.03% 72.81% 56ms 1.69% VecDot 9ms 0.27% 73.08% 55ms 1.66% PetscLogEventBeginDefault 2ms 0.06% 73.14% 53ms 1.60% VecDuplicate_MPI 0 0% 73.14% 52ms 1.57% VecDot_Seq 1ms 0.03% 73.17% 52ms 1.57% VecXDot_Seq_Private.constprop.0 3ms 0.09% 73.26% 49ms 1.48% VecMAXPY 0 0% 73.26% 49ms 1.48% VecNorm 17ms 0.51% 73.77% 48ms 1.45% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 73.77% 48ms 1.45% AbstractBidomainSolver::FinaliseLinearSystem 7ms 0.21% 73.98% 48ms 1.45% PetscLogEventEndDefault 0 0% 73.98% 48ms 1.45% VecNorm_Seq 44ms 1.33% 75.31% 44ms 1.33% exp_inline (inline) 8ms 0.24% 75.55% 43ms 1.30% VecCopy 2ms 0.06% 75.61% 42ms 1.27% VecDestroy 8ms 0.24% 75.85% 40ms 1.21% PetscMallocA 0 0% 75.85% 37ms 1.12% CxxTest::RealWorldDescription::setUp 0 0% 75.85% 37ms 1.12% PetscInitialize 0 0% 75.85% 37ms 1.12% PetscSetup::setUpWorld 0 0% 75.85% 37ms 1.12% PetscSetupUtils::CommonSetup 0 0% 75.85% 37ms 1.12% PetscSetupUtils::InitialisePetsc 2ms 0.06% 75.91% 37ms 1.12% VecCreate 30ms 0.9% 76.82% 37ms 1.12% top12 (inline) 0 0% 76.82% 36ms 1.09% PMPI_Init_thread 0 0% 76.82% 36ms 1.09% ompi_mpi_init 35ms 1.06% 77.87% 35ms 1.06% __memcpy_avx512_unaligned_erms 0 0% 77.87% 34ms 1.03% 7ms 0.21% 78.08% 33ms 0.99% AbstractCardiacCell::SetVoltage (partial-inline) 4ms 0.12% 78.20% 32ms 0.96% PetscMallocAlign 31ms 0.93% 79.14% 32ms 0.96% VecMAXPY_Seq 29ms 0.87% 80.01% 29ms 0.87% TimeStepper::CalculateNextTime 11ms 0.33% 80.34% 29ms 0.87% TimeStepper::TimeStepper 29ms 0.87% 81.22% 29ms 0.87% [libchaste_heart.so] 1ms 0.03% 81.25% 28ms 0.84% VecCreate_MPI_Private 18ms 0.54% 81.79% 26ms 0.78% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 81.79% 26ms 0.78% VecDuplicate_Seq 0 0% 81.79% 26ms 0.78% VecNorm_MPI 0 0% 81.79% 26ms 0.78% VecNorm_MPI_Default.constprop.0 25ms 0.75% 82.54% 25ms 0.75% DistributedVector::Iterator::operator!= 13ms 0.39% 82.94% 25ms 0.75% TimeStepper::AdvanceOneTimeStep 0 0% 82.94% 25ms 0.75% orte_init 15ms 0.45% 83.39% 24ms 0.72% AbstractOneStepIvpOdeSolver::Solve 3ms 0.09% 83.48% 24ms 0.72% VecAXPY 22ms 0.66% 84.14% 23ms 0.69% __ieee754_log_fma 19ms 0.57% 84.72% 22ms 0.66% AbstractParameterisedSystem::SetAnyVariable 0 0% 84.72% 22ms 0.66% std::vector::_M_assign_aux (inline) 0 0% 84.72% 22ms 0.66% std::vector::assign (inline) 17ms 0.51% 85.23% 21ms 0.63% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 85.23% 21ms 0.63% PetscMemcpy (inline) 1ms 0.03% 85.26% 20ms 0.6% PetscHeaderCreate_Private 20ms 0.6% 85.86% 20ms 0.6% asuint64 (inline) 2ms 0.06% 85.92% 20ms 0.6% std::__copy_move::__copy_m (inline) 0 0% 85.92% 20ms 0.6% std::__copy_move_a (inline) 0 0% 85.92% 20ms 0.6% std::__copy_move_a1 (inline) 0 0% 85.92% 20ms 0.6% std::__copy_move_a2 (inline) 0 0% 85.92% 20ms 0.6% std::copy (inline) 2ms 0.06% 85.98% 19ms 0.57% PetscHeaderDestroy_Private 0 0% 85.98% 19ms 0.57% VecScale 7ms 0.21% 86.19% 19ms 0.57% __GI___libc_malloc 0 0% 86.19% 17ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 6ms 0.18% 86.37% 17ms 0.51% PetscOptionsFindPair 0 0% 86.37% 17ms 0.51% __GI__dl_catch_exception 0 0% 86.37% 17ms 0.51% _dl_catch_error 0 0% 86.37% 17ms 0.51% _dlerror_run 0 0% 86.37% 17ms 0.51% hwloc_topology_load