File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3174ms, 87.01% of 3648ms total Dropped 465 nodes (cum <= 18.24ms) flat flat% sum% cum cum% 0 0% 0% 3639ms 99.75% __libc_start_call_main 0 0% 0% 3639ms 99.75% __libc_start_main_impl 0 0% 0% 3639ms 99.75% _start 0 0% 0% 3636ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3636ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3636ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3636ms 99.67% main 0 0% 0% 3598ms 98.63% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3598ms 98.63% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3598ms 98.63% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.027% 0.027% 3592ms 98.46% AbstractCardiacProblem::Solve 2ms 0.055% 0.082% 3585ms 98.27% AbstractDynamicLinearPdeSolver::Solve 20ms 0.55% 0.63% 1946ms 53.34% AbstractCardiacTissue::SolveCellSystems 0 0% 0.63% 1333ms 36.54% LinearSystem::Solve 1ms 0.027% 0.66% 1302ms 35.69% KSPSolve 2ms 0.055% 0.71% 1301ms 35.66% KSPSolve_Private 1ms 0.027% 0.74% 1259ms 34.51% KSPSolve_SYMMLQ 29ms 0.79% 1.54% 1075ms 29.47% AbstractCardiacCell::ComputeExceptVoltage 21ms 0.58% 2.11% 923ms 25.30% AbstractOneStepIvpOdeSolver::InternalSolve 3ms 0.082% 2.19% 808ms 22.15% PCApply 0 0% 2.19% 799ms 21.90% PCApply_BJacobi_Singleblock 41ms 1.12% 3.32% 779ms 21.35% EulerIvpOdeSolver::CalculateNextYValue 290ms 7.95% 11.27% 760ms 20.83% __GI___exp 21ms 0.58% 11.84% 736ms 20.18% AbstractCardiacTissue::UpdateCaches (inline) 193ms 5.29% 17.13% 730ms 20.01% CellLuoRudy1991FromCellML::EvaluateYDerivatives 229ms 6.28% 23.41% 697ms 19.11% CellLuoRudy1991FromCellML::GetIIonic 0 0% 23.41% 690ms 18.91% KSPSolve_PREONLY (partial-inline) 1ms 0.027% 23.44% 652ms 17.87% MatSolve 0 0% 23.44% 652ms 17.87% PCApply_ICC 635ms 17.41% 40.84% 647ms 17.74% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 40.84% 597ms 16.37% KSP_PCApply.lto_priv.18 310ms 8.50% 49.34% 386ms 10.58% __ieee754_exp_fma 0 0% 49.34% 369ms 10.12% MatMult 7ms 0.19% 49.53% 362ms 9.92% MatMult_SeqAIJ (partial-inline) 343ms 9.40% 58.94% 362ms 9.92% MatMult_SeqAIJ_Inode (inline) 1ms 0.027% 58.96% 283ms 7.76% KSPConvergedDefault 0 0% 58.96% 274ms 7.51% KSP_PCApply (partial-inline) 49ms 1.34% 60.31% 255ms 6.99% BidomainSolver::SetupLinearSystem 18ms 0.49% 60.80% 175ms 4.80% __pow 0 0% 60.80% 175ms 4.80% std::pow (inline) 12ms 0.33% 61.13% 157ms 4.30% __ieee754_pow_fma 1ms 0.027% 61.16% 113ms 3.10% MatNullSpaceRemove 84ms 2.30% 63.46% 84ms 2.30% [libm.so.6] 79ms 2.17% 65.62% 79ms 2.17% log_inline (inline) 38ms 1.04% 66.67% 73ms 2.00% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 66.67% 73ms 2.00% VecDuplicate 73ms 2.00% 68.67% 73ms 2.00% ddot_ 40ms 1.10% 69.76% 73ms 2.00% top12 (inline) 14ms 0.38% 70.15% 69ms 1.89% MPI_Wtime 0 0% 70.15% 69ms 1.89% VecMDot 2ms 0.055% 70.20% 69ms 1.89% VecMXDot_Private 56ms 1.54% 71.74% 58ms 1.59% exp_inline (inline) 15ms 0.41% 72.15% 57ms 1.56% PetscLogEventEndDefault 55ms 1.51% 73.66% 55ms 1.51% [[vdso]] 0 0% 73.66% 55ms 1.51% __GI___clock_gettime 8ms 0.22% 73.88% 50ms 1.37% PetscLogEventBeginDefault 23ms 0.63% 74.51% 47ms 1.29% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.027% 74.53% 47ms 1.29% VecDot 46ms 1.26% 75.79% 46ms 1.26% __memcpy_avx512_unaligned_erms 46ms 1.26% 77.06% 46ms 1.26% asuint64 (inline) 16ms 0.44% 77.49% 45ms 1.23% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 77.49% 45ms 1.23% AbstractBidomainSolver::FinaliseLinearSystem 14ms 0.38% 77.88% 45ms 1.23% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.027% 77.91% 45ms 1.23% VecNorm 0 0% 77.91% 44ms 1.21% VecDot_Seq 44ms 1.21% 79.11% 44ms 1.21% VecMDot_Seq 0 0% 79.11% 44ms 1.21% VecXDot_Seq_Private.constprop.0 3ms 0.082% 79.19% 43ms 1.18% VecMAXPY 43ms 1.18% 80.37% 43ms 1.18% __ieee754_log_fma 1ms 0.027% 80.40% 40ms 1.10% VecCopy 2ms 0.055% 80.46% 39ms 1.07% VecDuplicate_MPI 0 0% 80.46% 38ms 1.04% VecNorm_Seq 0 0% 80.46% 37ms 1.01% KSP_RemoveNullSpace (inline) 15ms 0.41% 80.87% 36ms 0.99% TimeStepper::TimeStepper 35ms 0.96% 81.83% 35ms 0.96% [libchaste_heart.so] 0 0% 81.83% 34ms 0.93% CxxTest::RealWorldDescription::setUp 0 0% 81.83% 34ms 0.93% PetscSetup::setUpWorld 0 0% 81.83% 34ms 0.93% PetscSetupUtils::CommonSetup 3ms 0.082% 81.91% 34ms 0.93% VecDuplicate_Seq 0 0% 81.91% 33ms 0.9% PMPI_Init_thread 0 0% 81.91% 33ms 0.9% PetscInitialize 0 0% 81.91% 33ms 0.9% PetscSetupUtils::InitialisePetsc 0 0% 81.91% 33ms 0.9% ompi_mpi_init 5ms 0.14% 82.04% 32ms 0.88% PetscMallocA 0 0% 82.04% 32ms 0.88% PetscMemcpy (inline) 18ms 0.49% 82.54% 32ms 0.88% TimeStepper::AdvanceOneTimeStep 1ms 0.027% 82.57% 31ms 0.85% 25ms 0.69% 83.25% 28ms 0.77% AbstractParameterisedSystem::SetAnyVariable 1ms 0.027% 83.28% 27ms 0.74% PetscMallocAlign 26ms 0.71% 83.99% 26ms 0.71% DistributedVector::Iterator::operator!= 26ms 0.71% 84.70% 26ms 0.71% TimeStepper::CalculateNextTime 1ms 0.027% 84.73% 25ms 0.69% VecCreate 25ms 0.69% 85.42% 25ms 0.69% VecMAXPY_Seq 4ms 0.11% 85.53% 24ms 0.66% VecCreate_MPI_Private 1ms 0.027% 85.55% 24ms 0.66% VecNorm_MPI 0 0% 85.55% 24ms 0.66% orte_init 1ms 0.027% 85.58% 23ms 0.63% VecDestroy 0 0% 85.58% 23ms 0.63% VecNorm_MPI_Default.constprop.0 0 0% 85.58% 23ms 0.63% std::vector::_M_assign_aux (inline) 0 0% 85.58% 23ms 0.63% std::vector::assign (inline) 17ms 0.47% 86.05% 22ms 0.6% AbstractOneStepIvpOdeSolver::Solve 22ms 0.6% 86.65% 22ms 0.6% [libchaste_ode.so] 11ms 0.3% 86.95% 20ms 0.55% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.027% 86.98% 20ms 0.55% std::__copy_move::__copy_m (inline) 0 0% 86.98% 20ms 0.55% std::__copy_move_a (inline) 0 0% 86.98% 20ms 0.55% std::__copy_move_a1 (inline) 0 0% 86.98% 20ms 0.55% std::__copy_move_a2 (inline) 0 0% 86.98% 20ms 0.55% std::copy (inline) 1ms 0.027% 87.01% 19ms 0.52% VecAXPY 0 0% 87.01% 19ms 0.52% VecCopy_Seq (partial-inline)