File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3660ms, 86.52% of 4230ms total Dropped 489 nodes (cum <= 21.15ms) flat flat% sum% cum cum% 0 0% 0% 4222ms 99.81% __libc_start_call_main 0 0% 0% 4222ms 99.81% __libc_start_main_impl 0 0% 0% 4222ms 99.81% _start 0 0% 0% 4219ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4219ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4219ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4219ms 99.74% main 0 0% 0% 4183ms 98.89% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4183ms 98.89% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4183ms 98.89% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4175ms 98.70% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4152ms 98.16% AbstractDynamicLinearPdeSolver::Solve 19ms 0.45% 0.47% 2279ms 53.88% AbstractCardiacTissue::SolveCellSystems 2ms 0.047% 0.52% 1511ms 35.72% LinearSystem::Solve 0 0% 0.52% 1465ms 34.63% KSPSolve 6ms 0.14% 0.66% 1465ms 34.63% KSPSolve_Private 1ms 0.024% 0.69% 1422ms 33.62% KSPSolve_SYMMLQ 29ms 0.69% 1.37% 1313ms 31.04% AbstractCardiacCell::ComputeExceptVoltage 31ms 0.73% 2.10% 1126ms 26.62% AbstractOneStepIvpOdeSolver::InternalSolve 63ms 1.49% 3.59% 924ms 21.84% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.024% 3.62% 860ms 20.33% PCApply 2ms 0.047% 3.66% 853ms 20.17% PCApply_BJacobi_Singleblock 215ms 5.08% 8.75% 851ms 20.12% CellLuoRudy1991FromCellML::EvaluateYDerivatives 39ms 0.92% 9.67% 786ms 18.58% AbstractCardiacTissue::UpdateCaches (inline) 373ms 8.82% 18.49% 777ms 18.37% __GI___exp 248ms 5.86% 24.35% 709ms 16.76% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.35% 699ms 16.52% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 24.37% 650ms 15.37% MatSolve 0 0% 24.37% 650ms 15.37% PCApply_ICC 637ms 15.06% 39.43% 642ms 15.18% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1ms 0.024% 39.46% 633ms 14.96% KSP_PCApply.lto_priv.18 1ms 0.024% 39.48% 416ms 9.83% MatMult 4ms 0.095% 39.57% 408ms 9.65% MatMult_SeqAIJ 398ms 9.41% 48.98% 408ms 9.65% MatMult_SeqAIJ_Inode (inline) 312ms 7.38% 56.36% 372ms 8.79% __ieee754_exp_fma 57ms 1.35% 57.71% 313ms 7.40% BidomainSolver::SetupLinearSystem 0 0% 57.71% 310ms 7.33% KSPConvergedDefault 0 0% 57.71% 296ms 7.00% KSP_PCApply (partial-inline) 0 0% 57.71% 236ms 5.58% std::pow (inline) 25ms 0.59% 58.30% 235ms 5.56% __pow 15ms 0.35% 58.65% 210ms 4.96% __ieee754_pow_fma 1ms 0.024% 58.68% 121ms 2.86% MatNullSpaceRemove 119ms 2.81% 61.49% 119ms 2.81% log_inline (inline) 57ms 1.35% 62.84% 110ms 2.60% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 62.84% 92ms 2.17% VecDuplicate 18ms 0.43% 63.26% 88ms 2.08% MPI_Wtime 32ms 0.76% 64.02% 83ms 1.96% TimeStepper::TimeStepper 13ms 0.31% 64.33% 75ms 1.77% PetscLogEventEndDefault 0 0% 64.33% 75ms 1.77% VecMDot 6ms 0.14% 64.47% 75ms 1.77% VecMXDot_Private 1ms 0.024% 64.49% 70ms 1.65% __GI___clock_gettime 70ms 1.65% 66.15% 70ms 1.65% ddot_ 69ms 1.63% 67.78% 69ms 1.63% [[vdso]] 68ms 1.61% 69.39% 68ms 1.61% exp_inline (inline) 12ms 0.28% 69.67% 67ms 1.58% PetscLogEventBeginDefault 2ms 0.047% 69.72% 66ms 1.56% VecDestroy 64ms 1.51% 71.23% 64ms 1.51% [libchaste_heart.so] 0 0% 71.23% 57ms 1.35% VecDot 56ms 1.32% 72.55% 56ms 1.32% TimeStepper::CalculateNextTime 5ms 0.12% 72.67% 55ms 1.30% VecAXPY 1ms 0.024% 72.70% 55ms 1.30% VecDuplicate_MPI 2ms 0.047% 72.74% 53ms 1.25% VecCopy 8ms 0.19% 72.93% 51ms 1.21% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 72.93% 51ms 1.21% VecDot_Seq 51ms 1.21% 74.14% 51ms 1.21% VecMDot_Seq 0 0% 74.14% 51ms 1.21% VecXDot_Seq_Private.constprop.0 7ms 0.17% 74.30% 48ms 1.13% PetscMallocA 4ms 0.095% 74.40% 45ms 1.06% VecMAXPY 45ms 1.06% 75.46% 45ms 1.06% __memcpy_avx_unaligned_erms 37ms 0.87% 76.34% 45ms 1.06% top12 (inline) 1ms 0.024% 76.36% 42ms 0.99% AbstractBidomainSolver::FinaliseLinearSystem 14ms 0.33% 76.69% 41ms 0.97% AbstractBidomainSolver::CheckCompatibilityCondition 2ms 0.047% 76.74% 41ms 0.97% PetscMallocAlign (partial-inline) 14ms 0.33% 77.07% 40ms 0.95% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 40ms 0.95% 78.01% 40ms 0.95% __ieee754_log_fma 33ms 0.78% 78.79% 38ms 0.9% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 35ms 0.83% 79.62% 38ms 0.9% AbstractParameterisedSystem::SetAnyVariable 0 0% 79.62% 37ms 0.87% KSP_RemoveNullSpace (inline) 0 0% 79.62% 37ms 0.87% VecDuplicate_Seq 1ms 0.024% 79.65% 36ms 0.85% VecCreate 2ms 0.047% 79.69% 36ms 0.85% VecNorm 25ms 0.59% 80.28% 34ms 0.8% AbstractOneStepIvpOdeSolver::Solve 26ms 0.61% 80.90% 32ms 0.76% AbstractParameterisedSystem::GetAnyVariable 0 0% 80.90% 32ms 0.76% CxxTest::RealWorldDescription::setUp 0 0% 80.90% 32ms 0.76% PMPI_Init_thread 4ms 0.095% 80.99% 32ms 0.76% PetscHeaderDestroy_Private 0 0% 80.99% 32ms 0.76% PetscInitialize 0 0% 80.99% 32ms 0.76% PetscMemcpy (inline) 0 0% 80.99% 32ms 0.76% PetscSetup::setUpWorld 0 0% 80.99% 32ms 0.76% PetscSetupUtils::CommonSetup 0 0% 80.99% 32ms 0.76% PetscSetupUtils::InitialisePetsc 32ms 0.76% 81.75% 32ms 0.76% [libm.so.6] 0 0% 81.75% 32ms 0.76% ompi_mpi_init 1ms 0.024% 81.77% 31ms 0.73% VecCreate_MPI_Private 1ms 0.024% 81.80% 31ms 0.73% VecNorm_Seq 31ms 0.73% 82.53% 31ms 0.73% asuint64 (inline) 16ms 0.38% 82.91% 29ms 0.69% TimeStepper::AdvanceOneTimeStep 29ms 0.69% 83.59% 29ms 0.69% __memset_avx2_unaligned_erms 1ms 0.024% 83.62% 28ms 0.66% 0 0% 83.62% 28ms 0.66% PetscMemzero (inline) 0 0% 83.62% 28ms 0.66% VecAXPY_Seq 1ms 0.024% 83.64% 27ms 0.64% VecCopy_Seq (partial-inline) 26ms 0.61% 84.26% 27ms 0.64% VecMAXPY_Seq 27ms 0.64% 84.89% 27ms 0.64% daxpy_ 26ms 0.61% 85.51% 26ms 0.61% DistributedVector::Iterator::operator!= 26ms 0.61% 86.12% 26ms 0.61% DistributedVector::Stripe::operator[] (inline) 7ms 0.17% 86.29% 23ms 0.54% PetscFreeAlign 2ms 0.047% 86.34% 23ms 0.54% VecSet 0 0% 86.34% 22ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble 8ms 0.19% 86.52% 22ms 0.52% __GI___libc_free