File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3600ms, 86.87% of 4144ms total Dropped 468 nodes (cum <= 20.72ms) flat flat% sum% cum cum% 0 0% 0% 4138ms 99.86% __libc_start_call_main 0 0% 0% 4138ms 99.86% __libc_start_main_impl 0 0% 0% 4138ms 99.86% _start 0 0% 0% 4135ms 99.78% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4135ms 99.78% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4135ms 99.78% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4135ms 99.78% main 0 0% 0% 4100ms 98.94% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4100ms 98.94% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4100ms 98.94% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4092ms 98.75% AbstractCardiacProblem::Solve 0 0% 0% 4082ms 98.50% AbstractDynamicLinearPdeSolver::Solve 18ms 0.43% 0.43% 2428ms 58.59% AbstractCardiacTissue::SolveCellSystems 40ms 0.97% 1.40% 1408ms 33.98% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.40% 1286ms 31.03% LinearSystem::Solve 0 0% 1.40% 1254ms 30.26% KSPSolve 3ms 0.072% 1.47% 1254ms 30.26% KSPSolve_Private 0 0% 1.47% 1207ms 29.13% KSPSolve_SYMMLQ 33ms 0.8% 2.27% 1202ms 29.01% AbstractOneStepIvpOdeSolver::InternalSolve 59ms 1.42% 3.69% 989ms 23.87% EulerIvpOdeSolver::CalculateNextYValue 243ms 5.86% 9.56% 915ms 22.08% CellLuoRudy1991FromCellML::EvaluateYDerivatives 386ms 9.31% 18.87% 849ms 20.49% __GI___exp 26ms 0.63% 19.50% 789ms 19.04% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 19.50% 752ms 18.15% PCApply 0 0% 19.50% 747ms 18.03% PCApply_BJacobi_Singleblock 263ms 6.35% 25.84% 733ms 17.69% CellLuoRudy1991FromCellML::GetIIonic 2ms 0.048% 25.89% 639ms 15.42% KSPSolve_PREONLY (partial-inline) 3ms 0.072% 25.97% 593ms 14.31% MatSolve 0 0% 25.97% 593ms 14.31% PCApply_ICC 579ms 13.97% 39.94% 586ms 14.14% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 39.94% 557ms 13.44% KSP_PCApply.lto_priv.18 415ms 10.01% 49.95% 440ms 10.62% __ieee754_exp_fma 3ms 0.072% 50.02% 432ms 10.42% MatMult 3ms 0.072% 50.10% 420ms 10.14% MatMult_SeqAIJ 414ms 9.99% 60.09% 420ms 10.14% MatMult_SeqAIJ_Inode (inline) 51ms 1.23% 61.32% 326ms 7.87% BidomainSolver::SetupLinearSystem 2ms 0.048% 61.37% 259ms 6.25% KSPConvergedDefault 0 0% 61.37% 258ms 6.23% KSP_PCApply (partial-inline) 1ms 0.024% 61.39% 224ms 5.41% std::pow (inline) 22ms 0.53% 61.92% 223ms 5.38% __pow 24ms 0.58% 62.50% 201ms 4.85% __ieee754_pow_fma 71ms 1.71% 64.21% 154ms 3.72% CellLuoRudy1991FromCellML::VerifyStateVariables 2ms 0.048% 64.26% 104ms 2.51% MatNullSpaceRemove 101ms 2.44% 66.70% 101ms 2.44% log_inline (inline) 26ms 0.63% 67.33% 84ms 2.03% MPI_Wtime 40ms 0.97% 68.29% 84ms 2.03% TimeStepper::TimeStepper 0 0% 68.29% 70ms 1.69% VecDuplicate 67ms 1.62% 69.91% 68ms 1.64% exp_inline (inline) 0 0% 69.91% 66ms 1.59% VecMDot 4ms 0.097% 70.00% 66ms 1.59% VecMXDot_Private 13ms 0.31% 70.32% 60ms 1.45% PetscLogEventBeginDefault 58ms 1.40% 71.72% 58ms 1.40% [[vdso]] 0 0% 71.72% 58ms 1.40% __GI___clock_gettime 54ms 1.30% 73.02% 54ms 1.30% TimeStepper::CalculateNextTime 54ms 1.30% 74.32% 54ms 1.30% ddot_ 11ms 0.27% 74.59% 53ms 1.28% PetscLogEventEndDefault 12ms 0.29% 74.88% 50ms 1.21% AbstractCardiacCell::SetVoltage (partial-inline) 44ms 1.06% 75.94% 47ms 1.13% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 46ms 1.11% 77.05% 47ms 1.13% __ieee754_log_fma 25ms 0.6% 77.65% 44ms 1.06% AbstractOneStepIvpOdeSolver::Solve 2ms 0.048% 77.70% 44ms 1.06% VecDot 41ms 0.99% 78.69% 44ms 1.06% VecMDot_Seq 2ms 0.048% 78.74% 41ms 0.99% VecAXPY 27ms 0.65% 79.39% 40ms 0.97% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 2ms 0.048% 79.44% 39ms 0.94% VecDuplicate_MPI 1ms 0.024% 79.46% 38ms 0.92% VecDestroy 0 0% 79.46% 37ms 0.89% VecDot_Seq 0 0% 79.46% 37ms 0.89% VecXDot_Seq_Private.constprop.0 37ms 0.89% 80.36% 37ms 0.89% [libchaste_heart.so] 1ms 0.024% 80.38% 36ms 0.87% AbstractBidomainSolver::FinaliseLinearSystem 3ms 0.072% 80.45% 36ms 0.87% VecMAXPY 12ms 0.29% 80.74% 35ms 0.84% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 80.74% 34ms 0.82% VecNorm 33ms 0.8% 81.54% 33ms 0.8% std::isinf (inline) 0 0% 81.54% 31ms 0.75% CxxTest::RealWorldDescription::setUp 0 0% 81.54% 31ms 0.75% PetscInitialize 0 0% 81.54% 31ms 0.75% PetscSetup::setUpWorld 0 0% 81.54% 31ms 0.75% PetscSetupUtils::CommonSetup 0 0% 81.54% 31ms 0.75% PetscSetupUtils::InitialisePetsc 0 0% 81.54% 31ms 0.75% VecDuplicate_Seq 0 0% 81.54% 30ms 0.72% PMPI_Init_thread 3ms 0.072% 81.61% 30ms 0.72% VecCopy 0 0% 81.61% 30ms 0.72% ompi_mpi_init 3ms 0.072% 81.68% 29ms 0.7% PetscMallocA 0 0% 81.68% 29ms 0.7% VecNorm_Seq 14ms 0.34% 82.02% 29ms 0.7% top12 (inline) 28ms 0.68% 82.70% 28ms 0.68% AbstractParameterisedSystem::SetAnyVariable 12ms 0.29% 82.99% 28ms 0.68% TimeStepper::AdvanceOneTimeStep 15ms 0.36% 83.35% 28ms 0.68% std::__cxx11::basic_string::basic_string 27ms 0.65% 84.00% 27ms 0.65% __memcpy_avx_unaligned_erms 1ms 0.024% 84.03% 26ms 0.63% PetscMallocAlign (partial-inline) 2ms 0.048% 84.07% 26ms 0.63% VecCreate 26ms 0.63% 84.70% 26ms 0.63% std::vector::operator[] (inline) 0 0% 84.70% 24ms 0.58% PetscMemzero (inline) 0 0% 84.70% 24ms 0.58% VecCreate_MPI_Private 0 0% 84.70% 23ms 0.56% 23ms 0.56% 85.26% 23ms 0.56% DistributedVector::Iterator::operator!= 1ms 0.024% 85.28% 23ms 0.56% VecAXPY_Seq 23ms 0.56% 85.83% 23ms 0.56% [libm.so.6] 22ms 0.53% 86.37% 22ms 0.53% __memset_avx2_unaligned_erms 0 0% 86.37% 22ms 0.53% orte_init 21ms 0.51% 86.87% 21ms 0.51% asuint64 (inline)