File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3667ms, 87.94% of 4170ms total Dropped 442 nodes (cum <= 20.85ms) flat flat% sum% cum cum% 0 0% 0% 4163ms 99.83% __libc_start_call_main 0 0% 0% 4163ms 99.83% __libc_start_main_impl 0 0% 0% 4163ms 99.83% _start 0 0% 0% 4160ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4160ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4160ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4160ms 99.76% main 0 0% 0% 4126ms 98.94% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4126ms 98.94% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4126ms 98.94% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4119ms 98.78% AbstractCardiacProblem::Solve 2ms 0.048% 0.048% 4107ms 98.49% AbstractDynamicLinearPdeSolver::Solve 18ms 0.43% 0.48% 2309ms 55.37% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.5% 1468ms 35.20% LinearSystem::Solve 0 0% 0.5% 1422ms 34.10% KSPSolve 1ms 0.024% 0.53% 1422ms 34.10% KSPSolve_Private 0 0% 0.53% 1372ms 32.90% KSPSolve_SYMMLQ 36ms 0.86% 1.39% 1339ms 32.11% AbstractCardiacCell::ComputeExceptVoltage 23ms 0.55% 1.94% 1125ms 26.98% AbstractOneStepIvpOdeSolver::InternalSolve 66ms 1.58% 3.53% 964ms 23.12% EulerIvpOdeSolver::CalculateNextYValue 248ms 5.95% 9.47% 879ms 21.08% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.024% 9.50% 822ms 19.71% PCApply 0 0% 9.50% 817ms 19.59% PCApply_BJacobi_Singleblock 358ms 8.59% 18.08% 803ms 19.26% __GI___exp 21ms 0.5% 18.59% 756ms 18.13% AbstractCardiacTissue::UpdateCaches (inline) 256ms 6.14% 24.72% 710ms 17.03% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.72% 696ms 16.69% KSPSolve_PREONLY (partial-inline) 4ms 0.096% 24.82% 662ms 15.88% MatSolve 0 0% 24.82% 662ms 15.88% PCApply_ICC 650ms 15.59% 40.41% 652ms 15.64% MatSolve_SeqSBAIJ_1_NaturalOrdering 1ms 0.024% 40.43% 624ms 14.96% KSP_PCApply.lto_priv.18 395ms 9.47% 49.90% 425ms 10.19% __ieee754_exp_fma 8ms 0.19% 50.10% 423ms 10.14% MatMult 4ms 0.096% 50.19% 411ms 9.86% MatMult_SeqAIJ 403ms 9.66% 59.86% 411ms 9.86% MatMult_SeqAIJ_Inode (inline) 0 0% 59.86% 290ms 6.95% KSPConvergedDefault 55ms 1.32% 61.18% 280ms 6.71% BidomainSolver::SetupLinearSystem 0 0% 61.18% 266ms 6.38% KSP_PCApply (partial-inline) 1ms 0.024% 61.20% 231ms 5.54% std::pow (inline) 29ms 0.7% 61.89% 230ms 5.52% __pow 28ms 0.67% 62.57% 201ms 4.82% __ieee754_pow_fma 63ms 1.51% 64.08% 146ms 3.50% CellLuoRudy1991FromCellML::VerifyStateVariables 110ms 2.64% 66.71% 110ms 2.64% log_inline (inline) 1ms 0.024% 66.74% 101ms 2.42% MatNullSpaceRemove 0 0% 66.74% 92ms 2.21% VecDuplicate 82ms 1.97% 68.71% 82ms 1.97% ddot_ 19ms 0.46% 69.16% 78ms 1.87% MPI_Wtime 1ms 0.024% 69.18% 66ms 1.58% VecMDot 35ms 0.84% 70.02% 65ms 1.56% TimeStepper::TimeStepper 5ms 0.12% 70.14% 65ms 1.56% VecMXDot_Private 0 0% 70.14% 59ms 1.41% VecDot 2ms 0.048% 70.19% 59ms 1.41% __GI___clock_gettime 57ms 1.37% 71.56% 57ms 1.37% [[vdso]] 12ms 0.29% 71.85% 56ms 1.34% PetscLogEventEndDefault 54ms 1.29% 73.14% 56ms 1.34% exp_inline (inline) 1ms 0.024% 73.17% 54ms 1.29% VecDuplicate_MPI 0 0% 73.17% 52ms 1.25% VecDot_Seq 1ms 0.024% 73.19% 52ms 1.25% VecNorm 1ms 0.024% 73.21% 52ms 1.25% VecXDot_Seq_Private.constprop.0 41ms 0.98% 74.20% 50ms 1.20% AbstractOneStepIvpOdeSolver::Solve 8ms 0.19% 74.39% 50ms 1.20% PetscLogEventBeginDefault 27ms 0.65% 75.04% 48ms 1.15% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 6ms 0.14% 75.18% 48ms 1.15% VecCopy 1ms 0.024% 75.20% 45ms 1.08% VecDestroy 0 0% 75.20% 45ms 1.08% VecNorm_Seq 0 0% 75.20% 44ms 1.06% AbstractBidomainSolver::FinaliseLinearSystem 40ms 0.96% 76.16% 44ms 1.06% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 5ms 0.12% 76.28% 44ms 1.06% PetscMallocA 12ms 0.29% 76.57% 43ms 1.03% AbstractBidomainSolver::CheckCompatibilityCondition 2ms 0.048% 76.62% 42ms 1.01% VecCreate 39ms 0.94% 77.55% 42ms 1.01% VecMDot_Seq 41ms 0.98% 78.54% 41ms 0.98% [libchaste_heart.so] 41ms 0.98% 79.52% 41ms 0.98% std::isinf (inline) 40ms 0.96% 80.48% 40ms 0.96% TimeStepper::CalculateNextTime 7ms 0.17% 80.65% 39ms 0.94% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 80.65% 39ms 0.94% PetscMallocAlign (partial-inline) 2ms 0.048% 80.70% 38ms 0.91% VecAXPY 1ms 0.024% 80.72% 38ms 0.91% VecDuplicate_Seq 36ms 0.86% 81.58% 36ms 0.86% __memcpy_avx_unaligned_erms 34ms 0.82% 82.40% 35ms 0.84% __ieee754_log_fma 14ms 0.34% 82.73% 35ms 0.84% top12 (inline) 1ms 0.024% 82.76% 34ms 0.82% VecMAXPY 0 0% 82.76% 33ms 0.79% VecNorm_MPI 0 0% 82.76% 33ms 0.79% VecNorm_MPI_Default.constprop.0 31ms 0.74% 83.50% 31ms 0.74% DistributedVector::Iterator::operator!= 8ms 0.19% 83.69% 31ms 0.74% __GI___libc_malloc 0 0% 83.69% 30ms 0.72% CxxTest::RealWorldDescription::setUp 1ms 0.024% 83.72% 30ms 0.72% PetscInitialize 0 0% 83.72% 30ms 0.72% PetscSetup::setUpWorld 0 0% 83.72% 30ms 0.72% PetscSetupUtils::CommonSetup 0 0% 83.72% 30ms 0.72% PetscSetupUtils::InitialisePetsc 5ms 0.12% 83.84% 30ms 0.72% VecCreate_MPI_Private 0 0% 83.84% 28ms 0.67% PMPI_Init_thread 1ms 0.024% 83.86% 28ms 0.67% __posix_memalign 0 0% 83.86% 28ms 0.67% ompi_mpi_init 25ms 0.6% 84.46% 26ms 0.62% AbstractParameterisedSystem::SetAnyVariable 26ms 0.62% 85.08% 26ms 0.62% asuint64 (inline) 9ms 0.22% 85.30% 26ms 0.62% std::__cxx11::basic_string::basic_string 0 0% 85.30% 25ms 0.6% PetscMemcpy (inline) 0 0% 85.30% 24ms 0.58% 1ms 0.024% 85.32% 24ms 0.58% VecAXPY_Seq 24ms 0.58% 85.90% 24ms 0.58% __memset_avx2_unaligned_erms 0 0% 85.90% 23ms 0.55% PetscMemzero (inline) 23ms 0.55% 86.45% 23ms 0.55% std::vector::operator[] (inline) 3ms 0.072% 86.52% 22ms 0.53% PetscHeaderCreate_Private 3ms 0.072% 86.59% 22ms 0.53% VecSet 0 0% 86.59% 21ms 0.5% AbstractFeVolumeIntegralAssembler::DoAssemble 14ms 0.34% 86.93% 21ms 0.5% AbstractParameterisedSystem::GetAnyVariable 21ms 0.5% 87.43% 21ms 0.5% DistributedVector::Stripe::operator[] (inline) 21ms 0.5% 87.94% 21ms 0.5% daxpy_