File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3672ms, 87.47% of 4198ms total Dropped 454 nodes (cum <= 20.99ms) flat flat% sum% cum cum% 0 0% 0% 4190ms 99.81% __libc_start_call_main 0 0% 0% 4190ms 99.81% __libc_start_main_impl 0 0% 0% 4190ms 99.81% _start 0 0% 0% 4187ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4187ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4187ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4187ms 99.74% main 0 0% 0% 4151ms 98.88% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4151ms 98.88% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4151ms 98.88% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4143ms 98.69% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4135ms 98.50% AbstractDynamicLinearPdeSolver::Solve 18ms 0.43% 0.45% 2274ms 54.17% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.48% 1590ms 37.88% LinearSystem::Solve 0 0% 0.48% 1546ms 36.83% KSPSolve 7ms 0.17% 0.64% 1546ms 36.83% KSPSolve_Private 1ms 0.024% 0.67% 1486ms 35.40% KSPSolve_SYMMLQ 43ms 1.02% 1.69% 1303ms 31.04% AbstractCardiacCell::ComputeExceptVoltage 23ms 0.55% 2.24% 1118ms 26.63% AbstractOneStepIvpOdeSolver::InternalSolve 52ms 1.24% 3.48% 934ms 22.25% EulerIvpOdeSolver::CalculateNextYValue 3ms 0.071% 3.55% 903ms 21.51% PCApply 0 0% 3.55% 892ms 21.25% PCApply_BJacobi_Singleblock 252ms 6.00% 9.55% 868ms 20.68% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 9.55% 782ms 18.63% KSPSolve_PREONLY (partial-inline) 352ms 8.38% 17.94% 779ms 18.56% __GI___exp 24ms 0.57% 18.51% 769ms 18.32% AbstractCardiacTissue::UpdateCaches (inline) 1ms 0.024% 18.53% 744ms 17.72% MatSolve 0 0% 18.53% 744ms 17.72% PCApply_ICC 731ms 17.41% 35.95% 737ms 17.56% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 273ms 6.50% 42.45% 719ms 17.13% CellLuoRudy1991FromCellML::GetIIonic 0 0% 42.45% 646ms 15.39% KSP_PCApply.lto_priv.18 5ms 0.12% 42.57% 411ms 9.79% MatMult 383ms 9.12% 51.69% 408ms 9.72% __ieee754_exp_fma 4ms 0.095% 51.79% 400ms 9.53% MatMult_SeqAIJ 394ms 9.39% 61.17% 400ms 9.53% MatMult_SeqAIJ_Inode (inline) 1ms 0.024% 61.20% 355ms 8.46% KSPConvergedDefault 0 0% 61.20% 329ms 7.84% KSP_PCApply (partial-inline) 49ms 1.17% 62.36% 229ms 5.45% BidomainSolver::SetupLinearSystem 4ms 0.095% 62.46% 226ms 5.38% std::pow (inline) 17ms 0.4% 62.86% 222ms 5.29% __pow 20ms 0.48% 63.34% 205ms 4.88% __ieee754_pow_fma 62ms 1.48% 64.82% 147ms 3.50% CellLuoRudy1991FromCellML::VerifyStateVariables 116ms 2.76% 67.58% 116ms 2.76% log_inline (inline) 2ms 0.048% 67.63% 102ms 2.43% MatNullSpaceRemove 1ms 0.024% 67.65% 99ms 2.36% VecDuplicate 71ms 1.69% 69.34% 95ms 2.26% TimeStepper::TimeStepper 27ms 0.64% 69.99% 88ms 2.10% MPI_Wtime 67ms 1.60% 71.58% 67ms 1.60% exp_inline (inline) 0 0% 71.58% 64ms 1.52% VecMDot 5ms 0.12% 71.70% 64ms 1.52% VecMXDot_Private 64ms 1.52% 73.23% 64ms 1.52% ddot_ 2ms 0.048% 73.27% 62ms 1.48% VecDuplicate_MPI 1ms 0.024% 73.30% 61ms 1.45% __GI___clock_gettime 60ms 1.43% 74.73% 60ms 1.43% [[vdso]] 8ms 0.19% 74.92% 58ms 1.38% PetscLogEventEndDefault 5ms 0.12% 75.04% 55ms 1.31% PetscLogEventBeginDefault 3ms 0.071% 75.11% 54ms 1.29% VecCopy 4ms 0.095% 75.20% 53ms 1.26% VecDestroy 4ms 0.095% 75.30% 48ms 1.14% VecAXPY 1ms 0.024% 75.32% 48ms 1.14% VecDot 3ms 0.071% 75.39% 46ms 1.10% PetscMallocA 23ms 0.55% 75.94% 45ms 1.07% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 75.96% 43ms 1.02% PetscMallocAlign (partial-inline) 41ms 0.98% 76.94% 43ms 1.02% VecMDot_Seq 6ms 0.14% 77.08% 42ms 1.00% VecNorm 0 0% 77.08% 41ms 0.98% VecDot_Seq 0 0% 77.08% 41ms 0.98% VecXDot_Seq_Private.constprop.0 41ms 0.98% 78.06% 41ms 0.98% __memcpy_avx_unaligned_erms 0 0% 78.06% 40ms 0.95% VecCreate 31ms 0.74% 78.80% 39ms 0.93% AbstractOneStepIvpOdeSolver::Solve 0 0% 78.80% 38ms 0.91% PetscMemcpy (inline) 11ms 0.26% 79.06% 37ms 0.88% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 79.06% 37ms 0.88% AbstractBidomainSolver::FinaliseLinearSystem 2ms 0.048% 79.11% 36ms 0.86% VecCreate_MPI_Private 1ms 0.024% 79.13% 36ms 0.86% VecDuplicate_Seq 1ms 0.024% 79.16% 36ms 0.86% VecMAXPY 36ms 0.86% 80.01% 36ms 0.86% __ieee754_log_fma 10ms 0.24% 80.25% 35ms 0.83% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 80.25% 32ms 0.76% CxxTest::RealWorldDescription::setUp 0 0% 80.25% 32ms 0.76% PMPI_Init_thread 0 0% 80.25% 32ms 0.76% PetscInitialize 0 0% 80.25% 32ms 0.76% PetscSetup::setUpWorld 0 0% 80.25% 32ms 0.76% PetscSetupUtils::CommonSetup 0 0% 80.25% 32ms 0.76% PetscSetupUtils::InitialisePetsc 0 0% 80.25% 32ms 0.76% VecNorm_Seq 0 0% 80.25% 32ms 0.76% ompi_mpi_init 12ms 0.29% 80.54% 32ms 0.76% std::__cxx11::basic_string::basic_string 32ms 0.76% 81.30% 32ms 0.76% std::isinf (inline) 31ms 0.74% 82.04% 31ms 0.74% TimeStepper::CalculateNextTime 0 0% 82.04% 31ms 0.74% VecAXPY_Seq 0 0% 82.04% 30ms 0.71% VecCopy_Seq (partial-inline) 30ms 0.71% 82.75% 30ms 0.71% daxpy_ 25ms 0.6% 83.35% 29ms 0.69% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 29ms 0.69% 84.04% 29ms 0.69% [libchaste_heart.so] 1ms 0.024% 84.06% 27ms 0.64% 17ms 0.4% 84.47% 27ms 0.64% AbstractParameterisedSystem::GetAnyVariable 9ms 0.21% 84.68% 27ms 0.64% top12 (inline) 10ms 0.24% 84.92% 26ms 0.62% __GI___libc_malloc 4ms 0.095% 85.02% 25ms 0.6% PetscOptionsFindPair 25ms 0.6% 85.61% 25ms 0.6% __memset_avx2_unaligned_erms 2ms 0.048% 85.66% 25ms 0.6% __posix_memalign 0 0% 85.66% 24ms 0.57% PetscMemzero (inline) 23ms 0.55% 86.21% 23ms 0.55% DistributedVector::Iterator::operator!= 13ms 0.31% 86.52% 23ms 0.55% TimeStepper::AdvanceOneTimeStep 21ms 0.5% 87.02% 22ms 0.52% VecMAXPY_Seq 0 0% 87.02% 22ms 0.52% orte_init 0 0% 87.02% 21ms 0.5% AbstractFeVolumeIntegralAssembler::DoAssemble 0 0% 87.02% 21ms 0.5% VecStashCreate_Private 19ms 0.45% 87.47% 21ms 0.5% std::vector::operator[] (inline)