File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 2144ms, 86.94% of 2466ms total Dropped 396 nodes (cum <= 12.33ms) flat flat% sum% cum cum% 0 0% 0% 2460ms 99.76% __libc_start_call_main 0 0% 0% 2460ms 99.76% __libc_start_main_impl 0 0% 0% 2460ms 99.76% _start 0 0% 0% 2455ms 99.55% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 2455ms 99.55% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 2455ms 99.55% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 2455ms 99.55% main 0 0% 0% 2416ms 97.97% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 2416ms 97.97% CxxTest::TestRunner::runTest (inline) 0 0% 0% 2416ms 97.97% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 2411ms 97.77% AbstractCardiacProblem::Solve 0 0% 0% 2404ms 97.49% AbstractDynamicLinearPdeSolver::Solve 6ms 0.24% 0.24% 1130ms 45.82% AbstractCardiacTissue::SolveCellSystems 0 0% 0.24% 1092ms 44.28% LinearSystem::Solve 0 0% 0.24% 1070ms 43.39% KSPSolve 3ms 0.12% 0.36% 1070ms 43.39% KSPSolve_Private 1ms 0.041% 0.41% 1043ms 42.30% KSPSolve_SYMMLQ 0 0% 0.41% 661ms 26.80% PCApply 0 0% 0.41% 657ms 26.64% PCApply_BJacobi_Singleblock 11ms 0.45% 0.85% 620ms 25.14% AbstractCardiacCell::ComputeExceptVoltage 0 0% 0.85% 558ms 22.63% KSPSolve_PREONLY (partial-inline) 17ms 0.69% 1.54% 536ms 21.74% AbstractOneStepIvpOdeSolver::InternalSolve 0 0% 1.54% 519ms 21.05% MatSolve 0 0% 1.54% 519ms 21.05% PCApply_ICC 513ms 20.80% 22.34% 516ms 20.92% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 44ms 1.78% 24.13% 460ms 18.65% EulerIvpOdeSolver::CalculateNextYValue 0 0% 24.13% 433ms 17.56% KSP_PCApply.lto_priv.18 10ms 0.41% 24.53% 413ms 16.75% AbstractCardiacTissue::UpdateCaches (inline) 142ms 5.76% 30.29% 410ms 16.63% CellLuoRudy1991FromCellML::EvaluateYDerivatives 157ms 6.37% 36.66% 390ms 15.82% CellLuoRudy1991FromCellML::GetIIonic 133ms 5.39% 42.05% 334ms 13.54% __GI___exp 0 0% 42.05% 305ms 12.37% KSPConvergedDefault 2ms 0.081% 42.13% 297ms 12.04% MatMult 2ms 0.081% 42.21% 290ms 11.76% MatMult_SeqAIJ 287ms 11.64% 53.85% 290ms 11.76% MatMult_SeqAIJ_Inode (inline) 0 0% 53.85% 284ms 11.52% KSP_PCApply (partial-inline) 168ms 6.81% 60.67% 188ms 7.62% __ieee754_exp_fma 20ms 0.81% 61.48% 162ms 6.57% BidomainSolver::SetupLinearSystem 0 0% 61.48% 131ms 5.31% std::pow (inline) 13ms 0.53% 62.00% 128ms 5.19% __pow 13ms 0.53% 62.53% 115ms 4.66% __ieee754_pow_fma 0 0% 62.53% 99ms 4.01% MatNullSpaceRemove 14ms 0.57% 63.10% 63ms 2.55% MPI_Wtime 38ms 1.54% 64.64% 61ms 2.47% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 64.64% 60ms 2.43% VecMDot 2ms 0.081% 64.72% 60ms 2.43% VecMXDot_Private 1ms 0.041% 64.76% 58ms 2.35% VecDuplicate 48ms 1.95% 66.71% 53ms 2.15% exp_inline (inline) 5ms 0.2% 66.91% 52ms 2.11% PetscLogEventBeginDefault 5ms 0.2% 67.11% 49ms 1.99% __GI___clock_gettime 47ms 1.91% 69.02% 47ms 1.91% VecMDot_Seq 3ms 0.12% 69.14% 46ms 1.87% VecCopy 46ms 1.87% 71.01% 46ms 1.87% log_inline (inline) 44ms 1.78% 72.79% 44ms 1.78% [[vdso]] 12ms 0.49% 73.28% 40ms 1.62% PetscLogEventEndDefault 5ms 0.2% 73.48% 39ms 1.58% VecMAXPY 39ms 1.58% 75.06% 39ms 1.58% ddot_ 0 0% 75.06% 35ms 1.42% CxxTest::RealWorldDescription::setUp 0 0% 75.06% 35ms 1.42% PetscInitialize 0 0% 75.06% 35ms 1.42% PetscSetup::setUpWorld 0 0% 75.06% 35ms 1.42% PetscSetupUtils::CommonSetup 0 0% 75.06% 35ms 1.42% PetscSetupUtils::InitialisePetsc 0 0% 75.06% 34ms 1.38% PMPI_Init_thread 4ms 0.16% 75.22% 34ms 1.38% PetscMallocA 0 0% 75.22% 34ms 1.38% ompi_mpi_init 0 0% 75.22% 30ms 1.22% 1ms 0.041% 75.26% 30ms 1.22% PetscMallocAlign 0 0% 75.26% 30ms 1.22% VecDuplicate_Seq 0 0% 75.26% 29ms 1.18% VecNorm 29ms 1.18% 76.44% 29ms 1.18% [libchaste_heart.so] 10ms 0.41% 76.85% 28ms 1.14% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 76.85% 28ms 1.14% VecDestroy 2ms 0.081% 76.93% 27ms 1.09% VecDuplicate_MPI 12ms 0.49% 77.41% 27ms 1.09% top12 (inline) 0 0% 77.41% 25ms 1.01% VecNorm_Seq 25ms 1.01% 78.43% 25ms 1.01% __memcpy_avx512_unaligned_erms 9ms 0.36% 78.79% 23ms 0.93% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 78.79% 23ms 0.93% PetscMemcpy (inline) 2ms 0.081% 78.87% 23ms 0.93% VecAXPY 0 0% 78.87% 23ms 0.93% VecDot 0 0% 78.87% 22ms 0.89% orte_init 1ms 0.041% 78.91% 21ms 0.85% VecCopy_Seq (partial-inline) 1ms 0.041% 78.95% 21ms 0.85% VecDot_Seq 3ms 0.12% 79.08% 21ms 0.85% __posix_memalign 19ms 0.77% 79.85% 20ms 0.81% VecMAXPY_Seq 0 0% 79.85% 20ms 0.81% VecSetType 0 0% 79.85% 20ms 0.81% VecXDot_Seq_Private.constprop.0 19ms 0.77% 80.62% 19ms 0.77% __ieee754_log_fma 1ms 0.041% 80.66% 18ms 0.73% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 80.66% 18ms 0.73% VecNorm_MPI 0 0% 80.66% 18ms 0.73% VecNorm_MPI_Default.constprop.0 3ms 0.12% 80.78% 17ms 0.69% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 80.78% 17ms 0.69% VecCreate 12ms 0.49% 81.27% 16ms 0.65% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 9ms 0.36% 81.63% 16ms 0.65% AbstractOneStepIvpOdeSolver::Solve 10ms 0.41% 82.04% 16ms 0.65% TimeStepper::TimeStepper 1ms 0.041% 82.08% 16ms 0.65% VecCreate_MPI_Private 0 0% 82.08% 16ms 0.65% VecCreate_Seq 0 0% 82.08% 16ms 0.65% __GI__dl_catch_exception 0 0% 82.08% 16ms 0.65% _dl_catch_error 0 0% 82.08% 16ms 0.65% _dlerror_run 16ms 0.65% 82.73% 16ms 0.65% asuint64 (inline) 15ms 0.61% 83.33% 15ms 0.61% DistributedVector::Iterator::operator!= 5ms 0.2% 83.54% 15ms 0.61% __GI___libc_free 3ms 0.12% 83.66% 15ms 0.61% __GI___libc_malloc 0 0% 83.66% 15ms 0.61% opal_stackframe_output 11ms 0.45% 84.10% 14ms 0.57% AbstractCardiacCell::GetVoltage (partial-inline) 8ms 0.32% 84.43% 14ms 0.57% AbstractParameterisedSystem::GetAnyVariable 14ms 0.57% 85.00% 14ms 0.57% ReplicatableVector::operator[] 5ms 0.2% 85.20% 14ms 0.57% TimeStepper::AdvanceOneTimeStep 0 0% 85.20% 14ms 0.57% ___dlopen 0 0% 85.20% 14ms 0.57% _dl_open 0 0% 85.20% 14ms 0.57% dl_open_worker 0 0% 85.20% 14ms 0.57% dlopen_doit 0 0% 85.20% 14ms 0.57% dlopen_implementation (inline) 0 0% 85.20% 14ms 0.57% hwloc_topology_load 0 0% 85.20% 14ms 0.57% mca_base_framework_components_register 0 0% 85.20% 14ms 0.57% mca_base_framework_open 0 0% 85.20% 14ms 0.57% mca_base_framework_register 0 0% 85.20% 13ms 0.53% AbstractFeVolumeIntegralAssembler::DoAssemble 11ms 0.45% 85.64% 13ms 0.53% AbstractParameterisedSystem::SetAnyVariable 0 0% 85.64% 13ms 0.53% PMPI_Comm_get_attr 1ms 0.041% 85.69% 13ms 0.53% VecAXPY_Seq 13ms 0.53% 86.21% 13ms 0.53% [libm.so.6] 0 0% 86.21% 13ms 0.53% _dl_init 0 0% 86.21% 13ms 0.53% call_init (inline) 0 0% 86.21% 13ms 0.53% hwloc_linux_get_tid_last_cpu_location 0 0% 86.21% 13ms 0.53% mca_base_component_find 0 0% 86.21% 13ms 0.53% mca_base_component_repository_open 5ms 0.2% 86.42% 13ms 0.53% ompi_attr_get_c 13ms 0.53% 86.94% 13ms 0.53% std::vector::size (inline)