File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3641ms, 87.52% of 4160ms total Dropped 440 nodes (cum <= 20.80ms) flat flat% sum% cum cum% 0 0% 0% 4152ms 99.81% __libc_start_call_main 0 0% 0% 4152ms 99.81% __libc_start_main_impl 0 0% 0% 4152ms 99.81% _start 0 0% 0% 4149ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4149ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4149ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4149ms 99.74% main 0 0% 0% 4113ms 98.87% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4113ms 98.87% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4113ms 98.87% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4105ms 98.68% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4091ms 98.34% AbstractDynamicLinearPdeSolver::Solve 13ms 0.31% 0.34% 2334ms 56.11% AbstractCardiacTissue::SolveCellSystems 0 0% 0.34% 1429ms 34.35% LinearSystem::Solve 0 0% 0.34% 1373ms 33.00% KSPSolve 3ms 0.072% 0.41% 1373ms 33.00% KSPSolve_Private 41ms 0.99% 1.39% 1341ms 32.24% AbstractCardiacCell::ComputeExceptVoltage 3ms 0.072% 1.47% 1321ms 31.75% KSPSolve_SYMMLQ 27ms 0.65% 2.12% 1132ms 27.21% AbstractOneStepIvpOdeSolver::InternalSolve 70ms 1.68% 3.80% 948ms 22.79% EulerIvpOdeSolver::CalculateNextYValue 256ms 6.15% 9.95% 868ms 20.87% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.024% 9.98% 782ms 18.80% PCApply 353ms 8.49% 18.46% 780ms 18.75% __GI___exp 2ms 0.048% 18.51% 770ms 18.51% PCApply_BJacobi_Singleblock 27ms 0.65% 19.16% 748ms 17.98% AbstractCardiacTissue::UpdateCaches (inline) 261ms 6.27% 25.43% 700ms 16.83% CellLuoRudy1991FromCellML::GetIIonic 0 0% 25.43% 650ms 15.62% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 25.46% 618ms 14.86% PCApply_ICC 1ms 0.024% 25.48% 617ms 14.83% MatSolve 611ms 14.69% 40.17% 614ms 14.76% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 40.17% 580ms 13.94% KSP_PCApply.lto_priv.18 3ms 0.072% 40.24% 435ms 10.46% MatMult 4ms 0.096% 40.34% 428ms 10.29% MatMult_SeqAIJ 421ms 10.12% 50.46% 428ms 10.29% MatMult_SeqAIJ_Inode (inline) 377ms 9.06% 59.52% 403ms 9.69% __ieee754_exp_fma 61ms 1.47% 60.99% 290ms 6.97% BidomainSolver::SetupLinearSystem 3ms 0.072% 61.06% 288ms 6.92% KSPConvergedDefault 0 0% 61.06% 260ms 6.25% KSP_PCApply (partial-inline) 2ms 0.048% 61.11% 219ms 5.26% std::pow (inline) 21ms 0.5% 61.61% 217ms 5.22% __pow 30ms 0.72% 62.33% 195ms 4.69% __ieee754_pow_fma 71ms 1.71% 64.04% 180ms 4.33% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 64.04% 108ms 2.60% VecDuplicate 0 0% 64.04% 101ms 2.43% MatNullSpaceRemove 87ms 2.09% 66.13% 87ms 2.09% log_inline (inline) 14ms 0.34% 66.47% 83ms 2.00% MPI_Wtime 77ms 1.85% 68.32% 77ms 1.85% exp_inline (inline) 37ms 0.89% 69.21% 73ms 1.75% TimeStepper::TimeStepper 5ms 0.12% 69.33% 69ms 1.66% VecDuplicate_MPI 2ms 0.048% 69.38% 68ms 1.63% __GI___clock_gettime 66ms 1.59% 70.96% 66ms 1.59% [[vdso]] 0 0% 70.96% 62ms 1.49% VecMDot 1ms 0.024% 70.99% 62ms 1.49% VecMXDot_Private 4ms 0.096% 71.08% 60ms 1.44% VecCopy 11ms 0.26% 71.35% 59ms 1.42% PetscLogEventBeginDefault 56ms 1.35% 72.69% 56ms 1.35% ddot_ 43ms 1.03% 73.73% 55ms 1.32% AbstractOneStepIvpOdeSolver::Solve 9ms 0.22% 73.94% 55ms 1.32% PetscLogEventEndDefault 49ms 1.18% 75.12% 49ms 1.18% TimeStepper::CalculateNextTime 3ms 0.072% 75.19% 49ms 1.18% VecDot 49ms 1.18% 76.37% 49ms 1.18% [libchaste_heart.so] 12ms 0.29% 76.66% 46ms 1.11% AbstractCardiacCell::SetVoltage (partial-inline) 44ms 1.06% 77.72% 46ms 1.11% VecMDot_Seq 5ms 0.12% 77.84% 45ms 1.08% PetscMallocA 45ms 1.08% 78.92% 45ms 1.08% std::isinf (inline) 44ms 1.06% 79.98% 44ms 1.06% __memcpy_avx_unaligned_erms 16ms 0.38% 80.36% 43ms 1.03% std::__cxx11::basic_string::basic_string 2ms 0.048% 80.41% 42ms 1.01% VecDestroy 3ms 0.072% 80.48% 42ms 1.01% VecNorm 3ms 0.072% 80.55% 41ms 0.99% VecCreate_MPI_Private 26ms 0.62% 81.18% 40ms 0.96% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 2ms 0.048% 81.23% 40ms 0.96% PetscMallocAlign (partial-inline) 0 0% 81.23% 39ms 0.94% VecDot_Seq 0 0% 81.23% 39ms 0.94% VecDuplicate_Seq 2ms 0.048% 81.27% 39ms 0.94% VecMAXPY 1ms 0.024% 81.30% 39ms 0.94% VecXDot_Seq_Private.constprop.0 1ms 0.024% 81.32% 38ms 0.91% PetscTimeSubtract (inline) 1ms 0.024% 81.35% 38ms 0.91% VecCreate 28ms 0.67% 82.02% 36ms 0.87% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 2ms 0.048% 82.07% 36ms 0.87% VecAXPY 0 0% 82.07% 35ms 0.84% PetscMemcpy (inline) 0 0% 82.07% 35ms 0.84% VecNorm_Seq 9ms 0.22% 82.28% 32ms 0.77% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 82.28% 32ms 0.77% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 82.28% 32ms 0.77% CxxTest::RealWorldDescription::setUp 0 0% 82.28% 32ms 0.77% PMPI_Init_thread 0 0% 82.28% 32ms 0.77% PetscInitialize 0 0% 82.28% 32ms 0.77% PetscSetup::setUpWorld 0 0% 82.28% 32ms 0.77% PetscSetupUtils::CommonSetup 0 0% 82.28% 32ms 0.77% PetscSetupUtils::InitialisePetsc 0 0% 82.28% 32ms 0.77% ompi_mpi_init 1ms 0.024% 82.31% 31ms 0.75% 14ms 0.34% 82.64% 31ms 0.75% TimeStepper::AdvanceOneTimeStep 30ms 0.72% 83.37% 31ms 0.75% __ieee754_log_fma 15ms 0.36% 83.73% 28ms 0.67% AbstractCardiacCell::GetVoltage (partial-inline) 1ms 0.024% 83.75% 28ms 0.67% VecCopy_Seq (partial-inline) 0 0% 83.75% 27ms 0.65% PetscMemzero (inline) 24ms 0.58% 84.33% 25ms 0.6% AbstractParameterisedSystem::SetAnyVariable 0 0% 84.33% 25ms 0.6% VecNorm_MPI 0 0% 84.33% 25ms 0.6% VecNorm_MPI_Default.constprop.0 1ms 0.024% 84.35% 25ms 0.6% VecStashCreate_Private 25ms 0.6% 84.95% 25ms 0.6% [libm.so.6] 24ms 0.58% 85.53% 24ms 0.58% __memset_avx2_unaligned_erms 24ms 0.58% 86.11% 24ms 0.58% asuint64 (inline) 1ms 0.024% 86.13% 22ms 0.53% VecAXPY_Seq 22ms 0.53% 86.66% 22ms 0.53% VecMAXPY_Seq 4ms 0.096% 86.75% 22ms 0.53% top12 (inline) 21ms 0.5% 87.26% 21ms 0.5% DistributedVector::Iterator::operator!= 3ms 0.072% 87.33% 21ms 0.5% PetscOptionsFindPair 3ms 0.072% 87.40% 21ms 0.5% VecSetType 5ms 0.12% 87.52% 21ms 0.5% __GI___libc_malloc 0 0% 87.52% 21ms 0.5% orte_init