File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 2812ms, 84.90% of 3312ms total Dropped 435 nodes (cum <= 16.56ms) flat flat% sum% cum cum% 0 0% 0% 3306ms 99.82% __libc_start_call_main 0 0% 0% 3306ms 99.82% __libc_start_main_impl 0 0% 0% 3306ms 99.82% _start 0 0% 0% 3304ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3304ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3304ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3304ms 99.76% main 0 0% 0% 3265ms 98.58% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3265ms 98.58% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3265ms 98.58% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 3259ms 98.40% AbstractCardiacProblem::Solve 3ms 0.091% 0.091% 3241ms 97.86% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.091% 1768ms 53.38% LinearSystem::Solve 0 0% 0.091% 1726ms 52.11% KSPSolve 3ms 0.091% 0.18% 1726ms 52.11% KSPSolve_Private 3ms 0.091% 0.27% 1688ms 50.97% KSPSolve_SYMMLQ 14ms 0.42% 0.69% 1215ms 36.68% AbstractCardiacTissue::SolveCellSystems 2ms 0.06% 0.75% 1100ms 33.21% PCApply 1ms 0.03% 0.79% 1088ms 32.85% PCApply_BJacobi_Singleblock 0 0% 0.79% 924ms 27.90% KSPSolve_PREONLY (partial-inline) 1ms 0.03% 0.82% 870ms 26.27% PCApply_ICC 6ms 0.18% 1% 869ms 26.24% MatSolve 849ms 25.63% 26.63% 857ms 25.88% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 26.63% 771ms 23.28% KSP_PCApply.lto_priv.18 11ms 0.33% 26.96% 678ms 20.47% AbstractCardiacCell::ComputeExceptVoltage 13ms 0.39% 27.36% 581ms 17.54% AbstractOneStepIvpOdeSolver::InternalSolve 46ms 1.39% 28.74% 481ms 14.52% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.03% 28.77% 443ms 13.38% KSPConvergedDefault 120ms 3.62% 32.40% 429ms 12.95% CellLuoRudy1991FromCellML::EvaluateYDerivatives 15ms 0.45% 32.85% 424ms 12.80% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 32.85% 424ms 12.80% KSP_PCApply (partial-inline) 148ms 4.47% 37.32% 394ms 11.90% CellLuoRudy1991FromCellML::GetIIonic 5ms 0.15% 37.47% 391ms 11.81% MatMult 168ms 5.07% 42.54% 385ms 11.62% __GI___exp 9ms 0.27% 42.81% 382ms 11.53% MatMult_SeqAIJ (partial-inline) 373ms 11.26% 54.08% 382ms 11.53% MatMult_SeqAIJ_Inode (inline) 42ms 1.27% 55.34% 217ms 6.55% BidomainSolver::SetupLinearSystem 178ms 5.37% 60.72% 207ms 6.25% __ieee754_exp_fma 1ms 0.03% 60.75% 157ms 4.74% MatNullSpaceRemove 1ms 0.03% 60.78% 130ms 3.93% std::pow (inline) 14ms 0.42% 61.20% 129ms 3.89% __pow 12ms 0.36% 61.56% 115ms 3.47% __ieee754_pow_fma 3ms 0.091% 61.65% 106ms 3.20% VecDuplicate 21ms 0.63% 62.29% 102ms 3.08% MPI_Wtime 0 0% 62.29% 90ms 2.72% VecMDot 1ms 0.03% 62.32% 90ms 2.72% VecMXDot_Private 1ms 0.03% 62.35% 81ms 2.45% __GI___clock_gettime 16ms 0.48% 62.83% 80ms 2.42% PetscLogEventBeginDefault 80ms 2.42% 65.25% 80ms 2.42% [[vdso]] 15ms 0.45% 65.70% 77ms 2.32% PetscLogEventEndDefault 76ms 2.29% 68.00% 76ms 2.29% ddot_ 7ms 0.21% 68.21% 66ms 1.99% VecMAXPY 34ms 1.03% 69.23% 64ms 1.93% CellLuoRudy1991FromCellML::VerifyStateVariables 62ms 1.87% 71.11% 62ms 1.87% log_inline (inline) 4ms 0.12% 71.23% 60ms 1.81% VecDuplicate_MPI (partial-inline) 58ms 1.75% 72.98% 58ms 1.75% VecMDot_Seq 2ms 0.06% 73.04% 55ms 1.66% VecNorm 0 0% 73.04% 54ms 1.63% VecDot 1ms 0.03% 73.07% 49ms 1.48% PetscTimeSubtract (inline) 4ms 0.12% 73.19% 47ms 1.42% PetscMallocA 2ms 0.06% 73.25% 47ms 1.42% VecCopy 0 0% 73.25% 47ms 1.42% VecNorm_Seq 0 0% 73.25% 46ms 1.39% VecDestroy 2ms 0.06% 73.31% 45ms 1.36% VecAXPY 1ms 0.03% 73.34% 44ms 1.33% VecCreate 0 0% 73.34% 44ms 1.33% VecDot_Seq 0 0% 73.34% 44ms 1.33% VecXDot_Seq_Private.constprop.0 2ms 0.06% 73.40% 43ms 1.30% PetscMallocAlign (partial-inline) 1ms 0.03% 73.43% 43ms 1.30% VecDuplicate_Seq 11ms 0.33% 73.76% 40ms 1.21% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 73.76% 38ms 1.15% PetscMemcpy (inline) 12ms 0.36% 74.12% 37ms 1.12% TimeStepper::TimeStepper 37ms 1.12% 75.24% 37ms 1.12% exp_inline (inline) 0 0% 75.24% 35ms 1.06% CxxTest::RealWorldDescription::setUp 0 0% 75.24% 35ms 1.06% PMPI_Init_thread 0 0% 75.24% 35ms 1.06% PetscInitialize 0 0% 75.24% 35ms 1.06% PetscSetup::setUpWorld 0 0% 75.24% 35ms 1.06% PetscSetupUtils::CommonSetup 0 0% 75.24% 35ms 1.06% PetscSetupUtils::InitialisePetsc 33ms 1% 76.24% 35ms 1.06% VecMAXPY_Seq 35ms 1.06% 77.29% 35ms 1.06% __memcpy_avx512_unaligned_erms 0 0% 77.29% 35ms 1.06% ompi_mpi_init 31ms 0.94% 78.23% 33ms 1% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.03% 78.26% 32ms 0.97% AbstractBidomainSolver::FinaliseLinearSystem 1ms 0.03% 78.29% 31ms 0.94% 7ms 0.21% 78.50% 31ms 0.94% AbstractBidomainSolver::CheckCompatibilityCondition 31ms 0.94% 79.44% 31ms 0.94% TimeStepper::CalculateNextTime 0 0% 79.44% 28ms 0.85% VecNorm_MPI 0 0% 79.44% 28ms 0.85% VecNorm_MPI_Default.constprop.0 28ms 0.85% 80.28% 28ms 0.85% [libchaste_heart.so] 3ms 0.091% 80.37% 27ms 0.82% VecCreate_MPI_Private 2ms 0.06% 80.43% 26ms 0.79% __posix_memalign 1ms 0.03% 80.46% 25ms 0.75% VecSetType 20ms 0.6% 81.07% 24ms 0.72% top12 (inline) 2ms 0.06% 81.13% 23ms 0.69% VecAXPY_Seq 0 0% 81.13% 23ms 0.69% VecCopy_Seq (partial-inline) 2ms 0.06% 81.19% 23ms 0.69% __GI___libc_malloc 15ms 0.45% 81.64% 22ms 0.66% AbstractParameterisedSystem::SetAnyVariable 0 0% 81.64% 22ms 0.66% PetscMemzero (inline) 0 0% 81.64% 22ms 0.66% VecCreate_Seq 22ms 0.66% 82.31% 22ms 0.66% __memset_avx512_unaligned_erms 0 0% 82.31% 22ms 0.66% orte_init 2ms 0.06% 82.37% 21ms 0.63% PetscHeaderDestroy_Private 21ms 0.63% 83.00% 21ms 0.63% __ieee754_log_fma 21ms 0.63% 83.64% 21ms 0.63% daxpy_ 11ms 0.33% 83.97% 20ms 0.6% TimeStepper::AdvanceOneTimeStep 8ms 0.24% 84.21% 20ms 0.6% _int_malloc 19ms 0.57% 84.78% 19ms 0.57% DistributedVector::Iterator::operator!= 1ms 0.03% 84.81% 19ms 0.57% VecScale 0 0% 84.81% 18ms 0.54% AbstractFeVolumeIntegralAssembler::DoAssemble 2ms 0.06% 84.87% 18ms 0.54% VecSet 1ms 0.03% 84.90% 17ms 0.51% PetscHeaderCreate_Private 0 0% 84.90% 17ms 0.51% __GI__dl_catch_exception 0 0% 84.90% 17ms 0.51% _dl_catch_error 0 0% 84.90% 17ms 0.51% _dlerror_run