File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 2850ms, 86.26% of 3304ms total Dropped 478 nodes (cum <= 16.52ms) flat flat% sum% cum cum% 0 0% 0% 3295ms 99.73% __libc_start_call_main 0 0% 0% 3295ms 99.73% __libc_start_main_impl 0 0% 0% 3295ms 99.73% _start 0 0% 0% 3293ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3293ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3293ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3293ms 99.67% main 0 0% 0% 3255ms 98.52% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3255ms 98.52% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3255ms 98.52% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 3248ms 98.31% AbstractCardiacProblem::Solve 0 0% 0% 3232ms 97.82% AbstractDynamicLinearPdeSolver::Solve 1ms 0.03% 0.03% 1513ms 45.79% LinearSystem::Solve 0 0% 0.03% 1468ms 44.43% KSPSolve 4ms 0.12% 0.15% 1468ms 44.43% KSPSolve_Private 12ms 0.36% 0.51% 1454ms 44.01% AbstractCardiacTissue::SolveCellSystems 2ms 0.061% 0.58% 1420ms 42.98% KSPSolve_SYMMLQ 6ms 0.18% 0.76% 870ms 26.33% PCApply 0 0% 0.76% 855ms 25.88% PCApply_BJacobi_Singleblock 19ms 0.58% 1.33% 808ms 24.46% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.33% 728ms 22.03% KSPSolve_PREONLY (partial-inline) 15ms 0.45% 1.79% 687ms 20.79% AbstractOneStepIvpOdeSolver::InternalSolve 2ms 0.061% 1.85% 678ms 20.52% MatSolve 0 0% 1.85% 678ms 20.52% PCApply_ICC 669ms 20.25% 22.09% 670ms 20.28% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 22.09% 612ms 18.52% KSP_PCApply.lto_priv.18 43ms 1.30% 23.40% 582ms 17.62% EulerIvpOdeSolver::CalculateNextYValue 135ms 4.09% 27.48% 538ms 16.28% CellLuoRudy1991FromCellML::EvaluateYDerivatives 17ms 0.51% 28.00% 528ms 15.98% AbstractCardiacTissue::UpdateCaches (inline) 237ms 7.17% 35.17% 500ms 15.13% __GI___exp 164ms 4.96% 40.13% 487ms 14.74% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.03% 40.16% 381ms 11.53% MatMult 10ms 0.3% 40.47% 375ms 11.35% MatMult_SeqAIJ (partial-inline) 362ms 10.96% 51.42% 374ms 11.32% MatMult_SeqAIJ_Inode (inline) 0 0% 51.42% 345ms 10.44% KSPConvergedDefault 0 0% 51.42% 326ms 9.87% KSP_PCApply (partial-inline) 205ms 6.20% 57.63% 248ms 7.51% __ieee754_exp_fma 45ms 1.36% 58.99% 225ms 6.81% BidomainSolver::SetupLinearSystem 0 0% 58.99% 176ms 5.33% std::pow (inline) 20ms 0.61% 59.59% 175ms 5.30% __pow 14ms 0.42% 60.02% 155ms 4.69% __ieee754_pow_fma 2ms 0.061% 60.08% 109ms 3.30% MatNullSpaceRemove 0 0% 60.08% 95ms 2.88% VecDuplicate 16ms 0.48% 60.56% 77ms 2.33% MPI_Wtime 77ms 2.33% 62.89% 77ms 2.33% ddot_ 74ms 2.24% 65.13% 74ms 2.24% log_inline (inline) 31ms 0.94% 66.07% 67ms 2.03% CellLuoRudy1991FromCellML::VerifyStateVariables 18ms 0.54% 66.62% 67ms 2.03% PetscLogEventEndDefault 0 0% 66.62% 66ms 2.00% VecMDot 5ms 0.15% 66.77% 66ms 2.00% VecMXDot_Private 3ms 0.091% 66.86% 65ms 1.97% VecCopy 10ms 0.3% 67.16% 61ms 1.85% PetscLogEventBeginDefault 1ms 0.03% 67.19% 60ms 1.82% __GI___clock_gettime 57ms 1.73% 68.92% 60ms 1.82% exp_inline (inline) 59ms 1.79% 70.70% 59ms 1.79% [[vdso]] 1ms 0.03% 70.73% 57ms 1.73% VecDot 2ms 0.061% 70.79% 57ms 1.73% VecDuplicate_MPI 2ms 0.061% 70.85% 51ms 1.54% VecDestroy 0 0% 70.85% 49ms 1.48% VecDot_Seq 0 0% 70.85% 49ms 1.48% VecXDot_Seq_Private.constprop.0 1ms 0.03% 70.88% 47ms 1.42% VecNorm 20ms 0.61% 71.49% 44ms 1.33% TimeStepper::TimeStepper 5ms 0.15% 71.64% 41ms 1.24% PetscMallocA 2ms 0.061% 71.70% 41ms 1.24% VecMAXPY 41ms 1.24% 72.94% 41ms 1.24% VecMDot_Seq 8ms 0.24% 73.18% 40ms 1.21% AbstractCardiacCell::SetVoltage (partial-inline) 25ms 0.76% 73.94% 39ms 1.18% top12 (inline) 4ms 0.12% 74.06% 38ms 1.15% VecDuplicate_Seq 3ms 0.091% 74.15% 36ms 1.09% PetscMallocAlign (partial-inline) 4ms 0.12% 74.27% 36ms 1.09% VecAXPY 0 0% 74.27% 35ms 1.06% VecNorm_Seq 35ms 1.06% 75.33% 35ms 1.06% __memcpy_avx512_unaligned_erms 8ms 0.24% 75.58% 34ms 1.03% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 75.58% 34ms 1.03% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 75.58% 34ms 1.03% CxxTest::RealWorldDescription::setUp 0 0% 75.58% 34ms 1.03% PetscInitialize 0 0% 75.58% 34ms 1.03% PetscSetup::setUpWorld 0 0% 75.58% 34ms 1.03% PetscSetupUtils::CommonSetup 0 0% 75.58% 34ms 1.03% PetscSetupUtils::InitialisePetsc 34ms 1.03% 76.60% 34ms 1.03% [libchaste_heart.so] 0 0% 76.60% 33ms 1% PMPI_Init_thread 0 0% 76.60% 33ms 1% ompi_mpi_init 4ms 0.12% 76.73% 32ms 0.97% VecCreate_MPI_Private 0 0% 76.73% 30ms 0.91% PetscMemcpy (inline) 2ms 0.061% 76.79% 29ms 0.88% 3ms 0.091% 76.88% 29ms 0.88% VecCreate 28ms 0.85% 77.72% 28ms 0.85% TimeStepper::CalculateNextTime 3ms 0.091% 77.81% 28ms 0.85% VecCopy_Seq (partial-inline) 28ms 0.85% 78.66% 28ms 0.85% asuint64 (inline) 23ms 0.7% 79.36% 27ms 0.82% AbstractParameterisedSystem::SetAnyVariable 26ms 0.79% 80.15% 26ms 0.79% DistributedVector::Iterator::operator!= 22ms 0.67% 80.81% 24ms 0.73% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 80.81% 24ms 0.73% orte_init 0 0% 80.81% 23ms 0.7% VecSetType 16ms 0.48% 81.30% 22ms 0.67% AbstractOneStepIvpOdeSolver::Solve 0 0% 81.30% 22ms 0.67% PetscMemzero (inline) 1ms 0.03% 81.33% 22ms 0.67% VecAXPY_Seq 22ms 0.67% 81.99% 22ms 0.67% __ieee754_log_fma 22ms 0.67% 82.66% 22ms 0.67% __memset_avx512_unaligned_erms 3ms 0.091% 82.75% 21ms 0.64% VecSet 16ms 0.48% 83.23% 21ms 0.64% _int_malloc 6ms 0.18% 83.41% 20ms 0.61% PetscHeaderDestroy_Private 9ms 0.27% 83.69% 20ms 0.61% TimeStepper::AdvanceOneTimeStep 18ms 0.54% 84.23% 20ms 0.61% VecMAXPY_Seq 2ms 0.061% 84.29% 20ms 0.61% __GI___libc_malloc 20ms 0.61% 84.90% 20ms 0.61% daxpy_ 11ms 0.33% 85.23% 19ms 0.58% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.03% 85.26% 19ms 0.58% __posix_memalign 0 0% 85.26% 18ms 0.54% VecCreate_Seq 14ms 0.42% 85.68% 17ms 0.51% AbstractParameterisedSystem::GetAnyVariable 17ms 0.51% 86.20% 17ms 0.51% DistributedVector::Stripe::operator[] (inline) 2ms 0.061% 86.26% 17ms 0.51% VecDestroy_MPI