File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 2834ms, 89.74% of 3158ms total Dropped 407 nodes (cum <= 15.79ms) flat flat% sum% cum cum% 0 0% 0% 3153ms 99.84% __libc_start_call_main 0 0% 0% 3153ms 99.84% __libc_start_main_impl 0 0% 0% 3153ms 99.84% _start 0 0% 0% 3151ms 99.78% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3151ms 99.78% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3151ms 99.78% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3151ms 99.78% main 0 0% 0% 3115ms 98.64% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3115ms 98.64% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3115ms 98.64% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 3109ms 98.45% AbstractCardiacProblem::Solve 1ms 0.032% 0.032% 3108ms 98.42% AbstractDynamicLinearPdeSolver::Solve 5ms 0.16% 0.19% 1463ms 46.33% AbstractCardiacTissue::SolveCellSystems 0 0% 0.19% 1290ms 40.85% LinearSystem::Solve 0 0% 0.19% 1266ms 40.09% KSPSolve 0 0% 0.19% 1266ms 40.09% KSPSolve_Private 0 0% 0.19% 1241ms 39.30% KSPSolve_SYMMLQ 7ms 0.22% 0.41% 816ms 25.84% AbstractCardiacCell::ComputeExceptVoltage 23ms 0.73% 1.14% 743ms 23.53% AbstractOneStepIvpOdeSolver::InternalSolve 3ms 0.095% 1.23% 710ms 22.48% MatMult 18ms 0.57% 1.80% 703ms 22.26% MatMult_SeqAIJ 685ms 21.69% 23.50% 687ms 21.75% MatMult_SeqAIJ_Inode (inline) 0 0% 23.50% 681ms 21.56% PCApply 3ms 0.095% 23.59% 673ms 21.31% PCApply_BJacobi_Singleblock 64ms 2.03% 25.62% 626ms 19.82% EulerIvpOdeSolver::CalculateNextYValue 0 0% 25.62% 562ms 17.80% KSPSolve_PREONLY (partial-inline) 196ms 6.21% 31.82% 552ms 17.48% CellLuoRudy1991FromCellML::EvaluateYDerivatives 6ms 0.19% 32.01% 546ms 17.29% AbstractCardiacTissue::UpdateCaches (inline) 2ms 0.063% 32.08% 536ms 16.97% MatSolve 0 0% 32.08% 536ms 16.97% PCApply_ICC 532ms 16.85% 48.92% 532ms 16.85% MatSolve_SeqSBAIJ_1_NaturalOrdering 227ms 7.19% 56.11% 530ms 16.78% CellLuoRudy1991FromCellML::GetIIonic 0 0% 56.11% 510ms 16.15% KSP_PCApply.lto_priv.18 168ms 5.32% 61.43% 436ms 13.81% __GI___exp 15ms 0.47% 61.91% 330ms 10.45% BidomainSolver::SetupLinearSystem 234ms 7.41% 69.32% 234ms 7.41% __ieee754_exp_fma 0 0% 69.32% 222ms 7.03% KSPConvergedDefault 0 0% 69.32% 220ms 6.97% KSP_PCApply (partial-inline) 7ms 0.22% 69.54% 150ms 4.75% std::pow (inline) 3ms 0.095% 69.63% 141ms 4.46% __pow 13ms 0.41% 70.04% 137ms 4.34% __ieee754_pow_fma 90ms 2.85% 72.89% 90ms 2.85% [libchaste_heart.so] 3ms 0.095% 72.99% 81ms 2.56% MatNullSpaceRemove 53ms 1.68% 74.67% 78ms 2.47% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 74.67% 64ms 2.03% VecDuplicate 56ms 1.77% 76.44% 63ms 1.99% exp_inline (inline) 60ms 1.90% 78.34% 60ms 1.90% log_inline (inline) 14ms 0.44% 78.78% 48ms 1.52% MPI_Wtime 0 0% 78.78% 43ms 1.36% VecMDot 1ms 0.032% 78.82% 43ms 1.36% VecMXDot_Private 40ms 1.27% 80.08% 40ms 1.27% [libm.so.6] 0 0% 80.08% 38ms 1.20% VecDuplicate_Seq 8ms 0.25% 80.34% 36ms 1.14% PetscLogEventEndDefault 1ms 0.032% 80.37% 35ms 1.11% VecMAXPY 1ms 0.032% 80.40% 34ms 1.08% __GI___clock_gettime 0 0% 80.40% 33ms 1.04% CxxTest::RealWorldDescription::setUp 0 0% 80.40% 33ms 1.04% PetscInitialize 0 0% 80.40% 33ms 1.04% PetscSetup::setUpWorld 0 0% 80.40% 33ms 1.04% PetscSetupUtils::CommonSetup 0 0% 80.40% 33ms 1.04% PetscSetupUtils::InitialisePetsc 33ms 1.04% 81.44% 33ms 1.04% [[vdso]] 0 0% 81.44% 32ms 1.01% PMPI_Init_thread 6ms 0.19% 81.63% 32ms 1.01% PetscLogEventBeginDefault 3ms 0.095% 81.73% 32ms 1.01% VecDestroy 32ms 1.01% 82.74% 32ms 1.01% [libchaste_ode.so] 0 0% 82.74% 32ms 1.01% ompi_mpi_init 2ms 0.063% 82.81% 30ms 0.95% VecCreate 29ms 0.92% 83.72% 30ms 0.95% VecMDot_Seq 30ms 0.95% 84.67% 30ms 0.95% ddot_ 12ms 0.38% 85.05% 29ms 0.92% TimeStepper::AdvanceOneTimeStep 12ms 0.38% 85.43% 29ms 0.92% TimeStepper::TimeStepper 0 0% 85.43% 26ms 0.82% 14ms 0.44% 85.88% 26ms 0.82% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 26ms 0.82% 86.70% 26ms 0.82% TimeStepper::CalculateNextTime 5ms 0.16% 86.86% 26ms 0.82% VecCopy 0 0% 86.86% 26ms 0.82% VecDuplicate_MPI 2ms 0.063% 86.92% 26ms 0.82% VecNorm 3ms 0.095% 87.02% 24ms 0.76% PetscMallocA 1ms 0.032% 87.05% 23ms 0.73% PetscTimeAdd (inline) 0 0% 87.05% 23ms 0.73% orte_init 0 0% 87.05% 22ms 0.7% VecNorm_Seq 1ms 0.032% 87.08% 21ms 0.66% PMPI_Comm_get_attr 0 0% 87.08% 21ms 0.66% PetscMallocAlign 21ms 0.66% 87.75% 21ms 0.66% __ieee754_log_fma 21ms 0.66% 88.41% 21ms 0.66% __memcpy_avx512_unaligned_erms 0 0% 88.41% 20ms 0.63% VecAXPY 0 0% 88.41% 20ms 0.63% VecDot 17ms 0.54% 88.95% 20ms 0.63% VecMAXPY_Seq 2ms 0.063% 89.01% 20ms 0.63% ompi_attr_get_c 0 0% 89.01% 19ms 0.6% PetscTimeSubtract (inline) 0 0% 89.01% 18ms 0.57% VecDot_Seq 1ms 0.032% 89.04% 18ms 0.57% VecXDot_Seq_Private.constprop.0 7ms 0.22% 89.27% 17ms 0.54% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 89.27% 17ms 0.54% AbstractBidomainSolver::FinaliseLinearSystem 1ms 0.032% 89.30% 17ms 0.54% VecCreate_MPI_Private 0 0% 89.30% 17ms 0.54% hwloc_topology_load 14ms 0.44% 89.74% 16ms 0.51% AbstractOneStepIvpOdeSolver::Solve 0 0% 89.74% 16ms 0.51% PetscHeaderCreate_Private