File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3738ms, 87.40% of 4277ms total Dropped 483 nodes (cum <= 21.39ms) flat flat% sum% cum cum% 0 0% 0% 4270ms 99.84% __libc_start_call_main 0 0% 0% 4270ms 99.84% __libc_start_main_impl 0 0% 0% 4270ms 99.84% _start 0 0% 0% 4267ms 99.77% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4267ms 99.77% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4267ms 99.77% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4267ms 99.77% main 0 0% 0% 4228ms 98.85% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4228ms 98.85% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4228ms 98.85% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4221ms 98.69% AbstractCardiacProblem::Solve 4ms 0.094% 0.094% 4214ms 98.53% AbstractDynamicLinearPdeSolver::Solve 14ms 0.33% 0.42% 2125ms 49.68% AbstractCardiacTissue::SolveCellSystems 0 0% 0.42% 1775ms 41.50% LinearSystem::Solve 0 0% 0.42% 1735ms 40.57% KSPSolve 8ms 0.19% 0.61% 1735ms 40.57% KSPSolve_Private 7ms 0.16% 0.77% 1687ms 39.44% KSPSolve_SYMMLQ 29ms 0.68% 1.45% 1229ms 28.74% AbstractCardiacCell::ComputeExceptVoltage 1ms 0.023% 1.47% 1142ms 26.70% PCApply 0 0% 1.47% 1125ms 26.30% PCApply_BJacobi_Singleblock 30ms 0.7% 2.17% 1044ms 24.41% AbstractOneStepIvpOdeSolver::InternalSolve 0 0% 2.17% 964ms 22.54% KSPSolve_PREONLY (partial-inline) 2ms 0.047% 2.22% 909ms 21.25% MatSolve 0 0% 2.22% 909ms 21.25% PCApply_ICC 805ms 18.82% 21.04% 899ms 21.02% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 49ms 1.15% 22.19% 872ms 20.39% EulerIvpOdeSolver::CalculateNextYValue 0 0% 22.19% 840ms 19.64% KSP_PCApply.lto_priv.18 226ms 5.28% 27.47% 801ms 18.73% CellLuoRudy1991FromCellML::EvaluateYDerivatives 323ms 7.55% 35.02% 744ms 17.40% __GI___exp 27ms 0.63% 35.66% 717ms 16.76% AbstractCardiacTissue::UpdateCaches (inline) 240ms 5.61% 41.27% 670ms 15.67% CellLuoRudy1991FromCellML::GetIIonic 3ms 0.07% 41.34% 447ms 10.45% MatMult 4ms 0.094% 41.43% 440ms 10.29% MatMult_SeqAIJ 429ms 10.03% 51.46% 439ms 10.26% MatMult_SeqAIJ_Inode (inline) 363ms 8.49% 59.95% 399ms 9.33% __ieee754_exp_fma 2ms 0.047% 60.00% 379ms 8.86% KSPConvergedDefault 0 0% 60.00% 367ms 8.58% KSP_PCApply (partial-inline) 46ms 1.08% 61.07% 274ms 6.41% BidomainSolver::SetupLinearSystem 18ms 0.42% 61.49% 213ms 4.98% __pow 0 0% 61.49% 213ms 4.98% std::pow (inline) 29ms 0.68% 62.17% 195ms 4.56% __ieee754_pow_fma 67ms 1.57% 63.74% 131ms 3.06% CellLuoRudy1991FromCellML::VerifyStateVariables 2ms 0.047% 63.78% 127ms 2.97% MatNullSpaceRemove 124ms 2.90% 66.68% 124ms 2.90% __memcpy_avx_unaligned_erms 0 0% 66.68% 113ms 2.64% PetscMemcpy (inline) 29ms 0.68% 67.36% 109ms 2.55% MPI_Wtime 0 0% 67.36% 105ms 2.45% VecDuplicate 94ms 2.20% 69.56% 94ms 2.20% log_inline (inline) 2ms 0.047% 69.60% 80ms 1.87% __GI___clock_gettime 78ms 1.82% 71.43% 78ms 1.82% [[vdso]] 13ms 0.3% 71.73% 77ms 1.80% PetscLogEventBeginDefault 0 0% 71.73% 76ms 1.78% VecMDot 6ms 0.14% 71.87% 76ms 1.78% VecMXDot_Private 16ms 0.37% 72.25% 75ms 1.75% PetscLogEventEndDefault 68ms 1.59% 73.84% 69ms 1.61% exp_inline (inline) 67ms 1.57% 75.40% 67ms 1.57% ddot_ 31ms 0.72% 76.13% 57ms 1.33% TimeStepper::TimeStepper 3ms 0.07% 76.20% 55ms 1.29% VecDot 3ms 0.07% 76.27% 55ms 1.29% VecDuplicate_MPI 1ms 0.023% 76.29% 50ms 1.17% VecDuplicate_Seq 0 0% 76.29% 49ms 1.15% PetscTimeAdd (inline) 5ms 0.12% 76.41% 49ms 1.15% VecMAXPY 3ms 0.07% 76.48% 48ms 1.12% VecCopy 46ms 1.08% 77.55% 47ms 1.10% VecMDot_Seq 2ms 0.047% 77.60% 45ms 1.05% VecCreate 36ms 0.84% 78.44% 44ms 1.03% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 2ms 0.047% 78.49% 44ms 1.03% VecDestroy 0 0% 78.49% 44ms 1.03% VecDot_Seq 0 0% 78.49% 44ms 1.03% VecXDot_Seq_Private.constprop.0 34ms 0.79% 79.28% 43ms 1.01% AbstractOneStepIvpOdeSolver::Solve 3ms 0.07% 79.35% 42ms 0.98% PetscMallocA 2ms 0.047% 79.40% 39ms 0.91% PetscMallocAlign 38ms 0.89% 80.29% 38ms 0.89% TimeStepper::CalculateNextTime 0 0% 80.29% 38ms 0.89% VecNorm 12ms 0.28% 80.57% 38ms 0.89% top12 (inline) 1ms 0.023% 80.59% 37ms 0.87% VecAXPY 9ms 0.21% 80.80% 36ms 0.84% AbstractCardiacCell::SetVoltage (partial-inline) 17ms 0.4% 81.20% 36ms 0.84% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 81.20% 34ms 0.79% CxxTest::RealWorldDescription::setUp 0 0% 81.20% 34ms 0.79% PetscInitialize 0 0% 81.20% 34ms 0.79% PetscSetup::setUpWorld 0 0% 81.20% 34ms 0.79% PetscSetupUtils::CommonSetup 0 0% 81.20% 34ms 0.79% PetscSetupUtils::InitialisePetsc 0 0% 81.20% 33ms 0.77% PMPI_Init_thread 0 0% 81.20% 33ms 0.77% ompi_mpi_init 31ms 0.72% 81.93% 32ms 0.75% __ieee754_log_fma 11ms 0.26% 82.18% 31ms 0.72% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 82.18% 31ms 0.72% AbstractBidomainSolver::FinaliseLinearSystem 13ms 0.3% 82.49% 30ms 0.7% TimeStepper::AdvanceOneTimeStep 1ms 0.023% 82.51% 30ms 0.7% VecCreate_MPI_Private 2ms 0.047% 82.56% 30ms 0.7% VecNorm_Seq 29ms 0.68% 83.24% 29ms 0.68% asuint64 (inline) 27ms 0.63% 83.87% 27ms 0.63% [libchaste_heart.so] 2ms 0.047% 83.91% 26ms 0.61% 26ms 0.61% 84.52% 26ms 0.61% std::isinf (inline) 22ms 0.51% 85.04% 24ms 0.56% VecMAXPY_Seq 20ms 0.47% 85.50% 22ms 0.51% AbstractParameterisedSystem::GetAnyVariable 22ms 0.51% 86.02% 22ms 0.51% DistributedVector::Iterator::operator!= 3ms 0.07% 86.09% 22ms 0.51% PetscHeaderDestroy_Private 0 0% 86.09% 22ms 0.51% VecAXPY_Seq 22ms 0.51% 86.60% 22ms 0.51% [libm.so.6] 5ms 0.12% 86.72% 22ms 0.51% __GI___libc_malloc 22ms 0.51% 87.23% 22ms 0.51% daxpy_ 0 0% 87.23% 22ms 0.51% orte_init 7ms 0.16% 87.40% 22ms 0.51% std::__cxx11::basic_string::basic_string