File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3688ms, 86.35% of 4271ms total Dropped 509 nodes (cum <= 21.36ms) flat flat% sum% cum cum% 0 0% 0% 4261ms 99.77% __libc_start_call_main 0 0% 0% 4261ms 99.77% __libc_start_main_impl 0 0% 0% 4261ms 99.77% _start 0 0% 0% 4257ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4257ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4257ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4257ms 99.67% main 0 0% 0% 4214ms 98.67% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4214ms 98.67% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4214ms 98.67% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4206ms 98.48% AbstractCardiacProblem::Solve 4ms 0.094% 0.094% 4191ms 98.13% AbstractDynamicLinearPdeSolver::Solve 23ms 0.54% 0.63% 2248ms 52.63% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.66% 1598ms 37.42% LinearSystem::Solve 0 0% 0.66% 1546ms 36.20% KSPSolve 8ms 0.19% 0.84% 1546ms 36.20% KSPSolve_Private 3ms 0.07% 0.91% 1490ms 34.89% KSPSolve_SYMMLQ 22ms 0.52% 1.43% 1240ms 29.03% AbstractCardiacCell::ComputeExceptVoltage 29ms 0.68% 2.11% 1070ms 25.05% AbstractOneStepIvpOdeSolver::InternalSolve 4ms 0.094% 2.20% 923ms 21.61% PCApply 2ms 0.047% 2.25% 915ms 21.42% PCApply_BJacobi_Singleblock 59ms 1.38% 3.63% 896ms 20.98% EulerIvpOdeSolver::CalculateNextYValue 216ms 5.06% 8.69% 828ms 19.39% CellLuoRudy1991FromCellML::EvaluateYDerivatives 26ms 0.61% 9.30% 797ms 18.66% AbstractCardiacTissue::UpdateCaches (inline) 381ms 8.92% 18.22% 768ms 17.98% __GI___exp 0 0% 18.22% 765ms 17.91% KSPSolve_PREONLY (partial-inline) 276ms 6.46% 24.68% 724ms 16.95% CellLuoRudy1991FromCellML::GetIIonic 3ms 0.07% 24.75% 707ms 16.55% MatSolve 0 0% 24.75% 707ms 16.55% PCApply_ICC 697ms 16.32% 41.07% 701ms 16.41% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 41.07% 689ms 16.13% KSP_PCApply.lto_priv.18 2ms 0.047% 41.11% 438ms 10.26% MatMult 14ms 0.33% 41.44% 428ms 10.02% MatMult_SeqAIJ (partial-inline) 414ms 9.69% 51.14% 427ms 10.00% MatMult_SeqAIJ_Inode (inline) 310ms 7.26% 58.39% 370ms 8.66% __ieee754_exp_fma 1ms 0.023% 58.42% 333ms 7.80% KSPConvergedDefault 0 0% 58.42% 315ms 7.38% KSP_PCApply (partial-inline) 55ms 1.29% 59.70% 297ms 6.95% BidomainSolver::SetupLinearSystem 0 0% 59.70% 226ms 5.29% std::pow (inline) 23ms 0.54% 60.24% 223ms 5.22% __pow 17ms 0.4% 60.64% 200ms 4.68% __ieee754_pow_fma 1ms 0.023% 60.66% 134ms 3.14% MatNullSpaceRemove 0 0% 60.66% 122ms 2.86% VecDuplicate 57ms 1.33% 62.00% 121ms 2.83% CellLuoRudy1991FromCellML::VerifyStateVariables 91ms 2.13% 64.13% 93ms 2.18% exp_inline (inline) 0 0% 64.13% 85ms 1.99% VecMDot 3ms 0.07% 64.20% 85ms 1.99% VecMXDot_Private 81ms 1.90% 66.10% 81ms 1.90% log_inline (inline) 21ms 0.49% 66.59% 80ms 1.87% MPI_Wtime 19ms 0.44% 67.03% 73ms 1.71% PetscLogEventEndDefault 72ms 1.69% 68.72% 72ms 1.69% ddot_ 29ms 0.68% 69.40% 66ms 1.55% TimeStepper::TimeStepper 20ms 0.47% 69.87% 63ms 1.48% AbstractCardiacCell::SetVoltage (partial-inline) 4ms 0.094% 69.96% 63ms 1.48% VecDuplicate_MPI 2ms 0.047% 70.01% 59ms 1.38% VecDuplicate_Seq 59ms 1.38% 71.39% 59ms 1.38% [[vdso]] 0 0% 71.39% 59ms 1.38% __GI___clock_gettime 56ms 1.31% 72.70% 56ms 1.31% VecMDot_Seq 56ms 1.31% 74.01% 56ms 1.31% [libchaste_heart.so] 7ms 0.16% 74.17% 55ms 1.29% VecCopy 5ms 0.12% 74.29% 52ms 1.22% PetscLogEventBeginDefault 3ms 0.07% 74.36% 52ms 1.22% VecCreate 1ms 0.023% 74.39% 51ms 1.19% VecDot 5ms 0.12% 74.50% 49ms 1.15% PetscMallocA 2ms 0.047% 74.55% 49ms 1.15% VecDestroy 1ms 0.023% 74.57% 48ms 1.12% VecMAXPY 42ms 0.98% 75.56% 47ms 1.10% top12 (inline) 0 0% 75.56% 46ms 1.08% VecDot_Seq 0 0% 75.56% 46ms 1.08% VecXDot_Seq_Private.constprop.0 20ms 0.47% 76.02% 45ms 1.05% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 2ms 0.047% 76.07% 45ms 1.05% PetscMallocAlign (partial-inline) 45ms 1.05% 77.12% 45ms 1.05% TimeStepper::CalculateNextTime 0 0% 77.12% 45ms 1.05% VecNorm 3ms 0.07% 77.20% 44ms 1.03% VecAXPY 1ms 0.023% 77.22% 40ms 0.94% VecNorm_Seq 40ms 0.94% 78.15% 40ms 0.94% __memcpy_avx_unaligned_erms 13ms 0.3% 78.46% 38ms 0.89% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 78.46% 38ms 0.89% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 78.46% 38ms 0.89% CxxTest::RealWorldDescription::setUp 0 0% 78.46% 38ms 0.89% PetscInitialize 0 0% 78.46% 38ms 0.89% PetscSetup::setUpWorld 0 0% 78.46% 38ms 0.89% PetscSetupUtils::CommonSetup 0 0% 78.46% 38ms 0.89% PetscSetupUtils::InitialisePetsc 0 0% 78.46% 37ms 0.87% PMPI_Init_thread 0 0% 78.46% 37ms 0.87% ompi_mpi_init 28ms 0.66% 79.11% 35ms 0.82% AbstractParameterisedSystem::SetAnyVariable 4ms 0.094% 79.21% 35ms 0.82% VecCreate_MPI_Private 0 0% 79.21% 34ms 0.8% VecNorm_MPI 0 0% 79.21% 34ms 0.8% VecNorm_MPI_Default.constprop.0 30ms 0.7% 79.91% 33ms 0.77% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 26ms 0.61% 80.52% 33ms 0.77% AbstractParameterisedSystem::GetAnyVariable 0 0% 80.52% 32ms 0.75% 29ms 0.68% 81.20% 32ms 0.75% VecMAXPY_Seq 5ms 0.12% 81.32% 31ms 0.73% PetscHeaderDestroy_Private 0 0% 81.32% 31ms 0.73% PetscMemcpy (inline) 0 0% 81.32% 29ms 0.68% VecAXPY_Seq 29ms 0.68% 81.99% 29ms 0.68% asuint64 (inline) 29ms 0.68% 82.67% 29ms 0.68% daxpy_ 23ms 0.54% 83.21% 28ms 0.66% AbstractOneStepIvpOdeSolver::Solve 14ms 0.33% 83.54% 27ms 0.63% TimeStepper::AdvanceOneTimeStep 27ms 0.63% 84.17% 27ms 0.63% __memset_avx2_unaligned_erms 0 0% 84.17% 26ms 0.61% PetscMemzero (inline) 26ms 0.61% 84.78% 26ms 0.61% RegularStimulus::GetStimulus 26ms 0.61% 85.39% 26ms 0.61% __ieee754_log_fma 5ms 0.12% 85.51% 24ms 0.56% PetscOptionsFindPair 0 0% 85.51% 24ms 0.56% VecCopy_Seq (partial-inline) 0 0% 85.51% 24ms 0.56% VecSetType 0 0% 85.51% 24ms 0.56% orte_init 22ms 0.52% 86.02% 22ms 0.52% DistributedVector::Stripe::operator[] (inline) 14ms 0.33% 86.35% 22ms 0.52% std::__cxx11::basic_string::basic_string