File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3705ms, 87.18% of 4250ms total Dropped 475 nodes (cum <= 21.25ms) flat flat% sum% cum cum% 0 0% 0% 4240ms 99.76% __libc_start_call_main 0 0% 0% 4240ms 99.76% __libc_start_main_impl 0 0% 0% 4240ms 99.76% _start 0 0% 0% 4237ms 99.69% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4237ms 99.69% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4237ms 99.69% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4237ms 99.69% main 0 0% 0% 4195ms 98.71% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4195ms 98.71% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4195ms 98.71% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4187ms 98.52% AbstractCardiacProblem::Solve 3ms 0.071% 0.071% 4171ms 98.14% AbstractDynamicLinearPdeSolver::Solve 16ms 0.38% 0.45% 2251ms 52.96% AbstractCardiacTissue::SolveCellSystems 0 0% 0.45% 1532ms 36.05% LinearSystem::Solve 0 0% 0.45% 1478ms 34.78% KSPSolve 2ms 0.047% 0.49% 1478ms 34.78% KSPSolve_Private 2ms 0.047% 0.54% 1421ms 33.44% KSPSolve_SYMMLQ 26ms 0.61% 1.15% 1242ms 29.22% AbstractCardiacCell::ComputeExceptVoltage 21ms 0.49% 1.65% 1047ms 24.64% AbstractOneStepIvpOdeSolver::InternalSolve 68ms 1.60% 3.25% 884ms 20.80% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.024% 3.27% 868ms 20.42% PCApply 2ms 0.047% 3.32% 858ms 20.19% PCApply_BJacobi_Singleblock 17ms 0.4% 3.72% 826ms 19.44% AbstractCardiacTissue::UpdateCaches (inline) 208ms 4.89% 8.61% 804ms 18.92% CellLuoRudy1991FromCellML::EvaluateYDerivatives 260ms 6.12% 14.73% 784ms 18.45% CellLuoRudy1991FromCellML::GetIIonic 367ms 8.64% 23.36% 766ms 18.02% __GI___exp 0 0% 23.36% 750ms 17.65% KSPSolve_PREONLY (partial-inline) 2ms 0.047% 23.41% 703ms 16.54% MatSolve 0 0% 23.41% 703ms 16.54% PCApply_ICC 690ms 16.24% 39.65% 695ms 16.35% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 39.65% 623ms 14.66% KSP_PCApply.lto_priv.18 4ms 0.094% 39.74% 450ms 10.59% MatMult 8ms 0.19% 39.93% 442ms 10.40% MatMult_SeqAIJ (partial-inline) 424ms 9.98% 49.91% 442ms 10.40% MatMult_SeqAIJ_Inode (inline) 314ms 7.39% 57.29% 377ms 8.87% __ieee754_exp_fma 0 0% 57.29% 328ms 7.72% KSPConvergedDefault 57ms 1.34% 58.64% 327ms 7.69% BidomainSolver::SetupLinearSystem 0 0% 58.64% 315ms 7.41% KSP_PCApply (partial-inline) 3ms 0.071% 58.71% 274ms 6.45% std::pow (inline) 27ms 0.64% 59.34% 270ms 6.35% __pow 22ms 0.52% 59.86% 243ms 5.72% __ieee754_pow_fma 126ms 2.96% 62.82% 126ms 2.96% log_inline (inline) 64ms 1.51% 64.33% 124ms 2.92% CellLuoRudy1991FromCellML::VerifyStateVariables 2ms 0.047% 64.38% 112ms 2.64% MatNullSpaceRemove 0 0% 64.38% 99ms 2.33% VecDuplicate 26ms 0.61% 64.99% 89ms 2.09% MPI_Wtime 81ms 1.91% 66.89% 82ms 1.93% exp_inline (inline) 27ms 0.64% 67.53% 72ms 1.69% TimeStepper::TimeStepper 67ms 1.58% 69.11% 67ms 1.58% [libchaste_heart.so] 66ms 1.55% 70.66% 66ms 1.55% ddot_ 1ms 0.024% 70.68% 65ms 1.53% VecDuplicate_MPI 1ms 0.024% 70.71% 63ms 1.48% VecMDot 63ms 1.48% 72.19% 63ms 1.48% [[vdso]] 0 0% 72.19% 63ms 1.48% __GI___clock_gettime 3ms 0.071% 72.26% 62ms 1.46% VecMXDot_Private 11ms 0.26% 72.52% 61ms 1.44% AbstractCardiacCell::SetVoltage (partial-inline) 13ms 0.31% 72.82% 60ms 1.41% PetscLogEventBeginDefault 13ms 0.31% 73.13% 56ms 1.32% PetscLogEventEndDefault 46ms 1.08% 74.21% 54ms 1.27% top12 (inline) 2ms 0.047% 74.26% 52ms 1.22% VecNorm 0 0% 74.26% 51ms 1.20% AbstractBidomainSolver::FinaliseLinearSystem 4ms 0.094% 74.35% 51ms 1.20% VecCopy 21ms 0.49% 74.85% 50ms 1.18% AbstractBidomainSolver::CheckCompatibilityCondition 48ms 1.13% 75.98% 49ms 1.15% VecMDot_Seq 2ms 0.047% 76.02% 47ms 1.11% VecMAXPY 46ms 1.08% 77.11% 46ms 1.08% TimeStepper::CalculateNextTime 3ms 0.071% 77.18% 46ms 1.08% VecAXPY 1ms 0.024% 77.20% 44ms 1.04% VecDot 2ms 0.047% 77.25% 43ms 1.01% VecCreate 0 0% 77.25% 42ms 0.99% VecNorm_Seq 21ms 0.49% 77.74% 41ms 0.96% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 77.76% 41ms 0.96% KSP_RemoveNullSpace (inline) 40ms 0.94% 78.71% 40ms 0.94% __ieee754_log_fma 27ms 0.64% 79.34% 39ms 0.92% AbstractOneStepIvpOdeSolver::Solve 5ms 0.12% 79.46% 39ms 0.92% PetscMallocA 35ms 0.82% 80.28% 38ms 0.89% AbstractParameterisedSystem::SetAnyVariable 0 0% 80.28% 38ms 0.89% CxxTest::RealWorldDescription::setUp 0 0% 80.28% 38ms 0.89% PMPI_Init_thread 0 0% 80.28% 38ms 0.89% PetscInitialize 0 0% 80.28% 38ms 0.89% PetscSetup::setUpWorld 0 0% 80.28% 38ms 0.89% PetscSetupUtils::CommonSetup 0 0% 80.28% 38ms 0.89% PetscSetupUtils::InitialisePetsc 0 0% 80.28% 38ms 0.89% VecDot_Seq 1ms 0.024% 80.31% 38ms 0.89% VecXDot_Seq_Private.constprop.0 0 0% 80.31% 38ms 0.89% ompi_mpi_init 2ms 0.047% 80.35% 37ms 0.87% VecDestroy 1ms 0.024% 80.38% 36ms 0.85% 3ms 0.071% 80.45% 36ms 0.85% VecCreate_MPI_Private 30ms 0.71% 81.15% 35ms 0.82% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.024% 81.18% 34ms 0.8% PetscMallocAlign 1ms 0.024% 81.20% 34ms 0.8% VecDuplicate_Seq 32ms 0.75% 81.95% 32ms 0.75% __memcpy_avx_unaligned_erms 31ms 0.73% 82.68% 31ms 0.73% asuint64 (inline) 0 0% 82.68% 30ms 0.71% PetscMemcpy (inline) 28ms 0.66% 83.34% 29ms 0.68% VecMAXPY_Seq 13ms 0.31% 83.65% 28ms 0.66% AbstractCardiacCell::GetVoltage (partial-inline) 0 0% 83.65% 27ms 0.64% VecAXPY_Seq 27ms 0.64% 84.28% 27ms 0.64% daxpy_ 18ms 0.42% 84.71% 27ms 0.64% std::__cxx11::basic_string::basic_string 16ms 0.38% 85.08% 25ms 0.59% AbstractParameterisedSystem::GetAnyVariable 14ms 0.33% 85.41% 25ms 0.59% TimeStepper::AdvanceOneTimeStep 24ms 0.56% 85.98% 24ms 0.56% DistributedVector::Iterator::operator!= 3ms 0.071% 86.05% 23ms 0.54% PMPI_Comm_get_attr 4ms 0.094% 86.14% 23ms 0.54% PetscOptionsFindPair 0 0% 86.14% 23ms 0.54% VecNorm_MPI 0 0% 86.14% 23ms 0.54% VecNorm_MPI_Default.constprop.0 0 0% 86.14% 23ms 0.54% VecStashCreate_Private 22ms 0.52% 86.66% 22ms 0.52% DistributedVector::Stripe::operator[] (inline) 0 0% 86.66% 22ms 0.52% VecCopy_Seq (partial-inline) 22ms 0.52% 87.18% 22ms 0.52% [libm.so.6] 0 0% 87.18% 22ms 0.52% orte_init