File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3678ms, 88.16% of 4172ms total Dropped 472 nodes (cum <= 20.86ms) flat flat% sum% cum cum% 0 0% 0% 4164ms 99.81% __libc_start_call_main 0 0% 0% 4164ms 99.81% __libc_start_main_impl 0 0% 0% 4164ms 99.81% _start 0 0% 0% 4161ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4161ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4161ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4161ms 99.74% main 0 0% 0% 4122ms 98.80% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4122ms 98.80% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4122ms 98.80% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4114ms 98.61% AbstractCardiacProblem::Solve 2ms 0.048% 0.048% 4100ms 98.27% AbstractDynamicLinearPdeSolver::Solve 12ms 0.29% 0.34% 2309ms 55.35% AbstractCardiacTissue::SolveCellSystems 0 0% 0.34% 1486ms 35.62% LinearSystem::Solve 0 0% 0.34% 1445ms 34.64% KSPSolve 3ms 0.072% 0.41% 1445ms 34.64% KSPSolve_Private 0 0% 0.41% 1388ms 33.27% KSPSolve_SYMMLQ 45ms 1.08% 1.49% 1350ms 32.36% AbstractCardiacCell::ComputeExceptVoltage 15ms 0.36% 1.85% 1115ms 26.73% AbstractOneStepIvpOdeSolver::InternalSolve 51ms 1.22% 3.07% 917ms 21.98% EulerIvpOdeSolver::CalculateNextYValue 245ms 5.87% 8.94% 856ms 20.52% CellLuoRudy1991FromCellML::EvaluateYDerivatives 3ms 0.072% 9.01% 824ms 19.75% PCApply 1ms 0.024% 9.04% 818ms 19.61% PCApply_BJacobi_Singleblock 366ms 8.77% 17.81% 759ms 18.19% __GI___exp 18ms 0.43% 18.24% 739ms 17.71% AbstractCardiacTissue::UpdateCaches (inline) 255ms 6.11% 24.35% 689ms 16.51% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.35% 676ms 16.20% KSPSolve_PREONLY (partial-inline) 4ms 0.096% 24.45% 633ms 15.17% MatSolve 0 0% 24.45% 633ms 15.17% PCApply_ICC 0 0% 24.45% 632ms 15.15% KSP_PCApply.lto_priv.18 617ms 14.79% 39.24% 619ms 14.84% MatSolve_SeqSBAIJ_1_NaturalOrdering 4ms 0.096% 39.33% 398ms 9.54% MatMult 3ms 0.072% 39.41% 386ms 9.25% MatMult_SeqAIJ 377ms 9.04% 48.44% 386ms 9.25% MatMult_SeqAIJ_Inode (inline) 349ms 8.37% 56.81% 372ms 8.92% __ieee754_exp_fma 2ms 0.048% 56.86% 302ms 7.24% KSPConvergedDefault 0 0% 56.86% 273ms 6.54% KSP_PCApply (partial-inline) 65ms 1.56% 58.41% 257ms 6.16% BidomainSolver::SetupLinearSystem 2ms 0.048% 58.46% 221ms 5.30% std::pow (inline) 16ms 0.38% 58.84% 219ms 5.25% __pow 33ms 0.79% 59.64% 203ms 4.87% __ieee754_pow_fma 66ms 1.58% 61.22% 155ms 3.72% CellLuoRudy1991FromCellML::VerifyStateVariables 88ms 2.11% 63.33% 129ms 3.09% TimeStepper::TimeStepper 2ms 0.048% 63.37% 127ms 3.04% MatNullSpaceRemove 0 0% 63.37% 104ms 2.49% VecDuplicate 22ms 0.53% 63.90% 92ms 2.21% MPI_Wtime 87ms 2.09% 65.99% 87ms 2.09% log_inline (inline) 0 0% 65.99% 81ms 1.94% VecMDot 4ms 0.096% 66.08% 81ms 1.94% VecMXDot_Private 75ms 1.80% 67.88% 76ms 1.82% exp_inline (inline) 70ms 1.68% 69.56% 70ms 1.68% [[vdso]] 0 0% 69.56% 70ms 1.68% __GI___clock_gettime 33ms 0.79% 70.35% 69ms 1.65% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 65ms 1.56% 71.91% 65ms 1.56% ddot_ 8ms 0.19% 72.10% 63ms 1.51% PetscLogEventEndDefault 10ms 0.24% 72.34% 61ms 1.46% PetscLogEventBeginDefault 5ms 0.12% 72.46% 57ms 1.37% VecCopy 6ms 0.14% 72.60% 56ms 1.34% VecDuplicate_MPI (partial-inline) 53ms 1.27% 73.87% 55ms 1.32% VecMDot_Seq 3ms 0.072% 73.95% 51ms 1.22% VecAXPY 1ms 0.024% 73.97% 51ms 1.22% VecNorm 10ms 0.24% 74.21% 50ms 1.20% PetscMallocA 2ms 0.048% 74.26% 50ms 1.20% VecDot 1ms 0.024% 74.28% 48ms 1.15% VecDuplicate_Seq 1ms 0.024% 74.30% 46ms 1.10% VecDestroy 46ms 1.10% 75.41% 46ms 1.10% __ieee754_log_fma 8ms 0.19% 75.60% 45ms 1.08% AbstractCardiacCell::SetVoltage (partial-inline) 45ms 1.08% 76.68% 45ms 1.08% TimeStepper::CalculateNextTime 5ms 0.12% 76.80% 44ms 1.05% VecMAXPY 41ms 0.98% 77.78% 41ms 0.98% std::isinf (inline) 5ms 0.12% 77.90% 40ms 0.96% PetscMallocAlign (partial-inline) 0 0% 77.90% 40ms 0.96% VecDot_Seq 0 0% 77.90% 40ms 0.96% VecXDot_Seq_Private.constprop.0 37ms 0.89% 78.79% 39ms 0.93% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 30ms 0.72% 79.51% 38ms 0.91% AbstractOneStepIvpOdeSolver::Solve 22ms 0.53% 80.03% 37ms 0.89% AbstractCardiacCell::GetVoltage (partial-inline) 0 0% 80.03% 37ms 0.89% VecNorm_Seq 36ms 0.86% 80.90% 36ms 0.86% [libchaste_heart.so] 1ms 0.024% 80.92% 35ms 0.84% AbstractBidomainSolver::FinaliseLinearSystem 9ms 0.22% 81.14% 34ms 0.81% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.14% 34ms 0.81% CxxTest::RealWorldDescription::setUp 0 0% 81.14% 34ms 0.81% PetscInitialize 0 0% 81.14% 34ms 0.81% PetscMemcpy (inline) 0 0% 81.14% 34ms 0.81% PetscSetup::setUpWorld 0 0% 81.14% 34ms 0.81% PetscSetupUtils::CommonSetup 0 0% 81.14% 34ms 0.81% PetscSetupUtils::InitialisePetsc 4ms 0.096% 81.23% 34ms 0.81% VecCreate 26ms 0.62% 81.86% 33ms 0.79% AbstractParameterisedSystem::GetAnyVariable 0 0% 81.86% 33ms 0.79% PMPI_Init_thread 33ms 0.79% 82.65% 33ms 0.79% __memcpy_avx_unaligned_erms 0 0% 82.65% 33ms 0.79% ompi_mpi_init 16ms 0.38% 83.03% 33ms 0.79% std::__cxx11::basic_string::basic_string 32ms 0.77% 83.80% 32ms 0.77% DistributedVector::Iterator::operator!= 5ms 0.12% 83.92% 32ms 0.77% VecCreate_MPI_Private 29ms 0.7% 84.61% 31ms 0.74% AbstractParameterisedSystem::SetAnyVariable 1ms 0.024% 84.64% 31ms 0.74% VecAXPY_Seq 3ms 0.072% 84.71% 31ms 0.74% VecSetType 2ms 0.048% 84.76% 30ms 0.72% 0 0% 84.76% 30ms 0.72% VecNorm_MPI 2ms 0.048% 84.80% 30ms 0.72% VecNorm_MPI_Default.constprop.0 14ms 0.34% 85.14% 30ms 0.72% top12 (inline) 25ms 0.6% 85.74% 28ms 0.67% VecMAXPY_Seq 28ms 0.67% 86.41% 28ms 0.67% daxpy_ 2ms 0.048% 86.46% 26ms 0.62% VecCopy_Seq (partial-inline) 3ms 0.072% 86.53% 24ms 0.58% PetscHeaderDestroy_Private 24ms 0.58% 87.10% 24ms 0.58% RegularStimulus::GetStimulus 0 0% 87.10% 23ms 0.55% orte_init 15ms 0.36% 87.46% 22ms 0.53% TimeStepper::AdvanceOneTimeStep 1ms 0.024% 87.49% 22ms 0.53% __posix_memalign 0 0% 87.49% 21ms 0.5% PetscMemzero (inline) 0 0% 87.49% 21ms 0.5% VecCreate_Seq 21ms 0.5% 87.99% 21ms 0.5% [libm.so.6] 7ms 0.17% 88.16% 21ms 0.5% __GI___libc_malloc