File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3640ms, 85.59% of 4253ms total Dropped 507 nodes (cum <= 21.27ms) flat flat% sum% cum cum% 0 0% 0% 4245ms 99.81% __libc_start_call_main 0 0% 0% 4245ms 99.81% __libc_start_main_impl 0 0% 0% 4245ms 99.81% _start 0 0% 0% 4241ms 99.72% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4241ms 99.72% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4241ms 99.72% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4241ms 99.72% main 0 0% 0% 4200ms 98.75% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4199ms 98.73% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4199ms 98.73% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 4ms 0.094% 0.094% 4191ms 98.54% AbstractCardiacProblem::Solve 1ms 0.024% 0.12% 4166ms 97.95% AbstractDynamicLinearPdeSolver::Solve 11ms 0.26% 0.38% 2254ms 53.00% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.4% 1548ms 36.40% LinearSystem::Solve 0 0% 0.4% 1492ms 35.08% KSPSolve 3ms 0.071% 0.47% 1492ms 35.08% KSPSolve_Private 2ms 0.047% 0.52% 1447ms 34.02% KSPSolve_SYMMLQ 24ms 0.56% 1.08% 1264ms 29.72% AbstractCardiacCell::ComputeExceptVoltage 25ms 0.59% 1.67% 1086ms 25.53% AbstractOneStepIvpOdeSolver::InternalSolve 62ms 1.46% 3.13% 901ms 21.19% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.024% 3.15% 901ms 21.19% PCApply 0 0% 3.15% 893ms 21.00% PCApply_BJacobi_Singleblock 218ms 5.13% 8.28% 830ms 19.52% CellLuoRudy1991FromCellML::EvaluateYDerivatives 32ms 0.75% 9.03% 797ms 18.74% AbstractCardiacTissue::UpdateCaches (inline) 357ms 8.39% 17.42% 769ms 18.08% __GI___exp 2ms 0.047% 17.47% 767ms 18.03% KSPSolve_PREONLY (partial-inline) 4ms 0.094% 17.56% 721ms 16.95% MatSolve 0 0% 17.56% 721ms 16.95% PCApply_ICC 254ms 5.97% 23.54% 719ms 16.91% CellLuoRudy1991FromCellML::GetIIonic 703ms 16.53% 40.07% 711ms 16.72% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1ms 0.024% 40.09% 667ms 15.68% KSP_PCApply.lto_priv.18 3ms 0.071% 40.16% 423ms 9.95% MatMult 10ms 0.24% 40.40% 416ms 9.78% MatMult_SeqAIJ (partial-inline) 402ms 9.45% 49.85% 414ms 9.73% MatMult_SeqAIJ_Inode (inline) 331ms 7.78% 57.63% 392ms 9.22% __ieee754_exp_fma 0 0% 57.63% 324ms 7.62% KSPConvergedDefault 0 0% 57.63% 313ms 7.36% KSP_PCApply (partial-inline) 66ms 1.55% 59.18% 310ms 7.29% BidomainSolver::SetupLinearSystem 0 0% 59.18% 232ms 5.45% std::pow (inline) 26ms 0.61% 59.79% 231ms 5.43% __pow 14ms 0.33% 60.12% 205ms 4.82% __ieee754_pow_fma 72ms 1.69% 61.82% 136ms 3.20% CellLuoRudy1991FromCellML::VerifyStateVariables 117ms 2.75% 64.57% 117ms 2.75% log_inline (inline) 1ms 0.024% 64.59% 115ms 2.70% MatNullSpaceRemove 21ms 0.49% 65.08% 97ms 2.28% MPI_Wtime 1ms 0.024% 65.11% 79ms 1.86% VecDuplicate 2ms 0.047% 65.15% 76ms 1.79% __GI___clock_gettime 12ms 0.28% 65.44% 74ms 1.74% PetscLogEventBeginDefault 74ms 1.74% 67.18% 74ms 1.74% [[vdso]] 74ms 1.74% 68.92% 74ms 1.74% ddot_ 0 0% 68.92% 69ms 1.62% VecMDot 8ms 0.19% 69.10% 69ms 1.62% VecMXDot_Private 22ms 0.52% 69.62% 65ms 1.53% TimeStepper::TimeStepper 60ms 1.41% 71.03% 65ms 1.53% exp_inline (inline) 10ms 0.24% 71.27% 63ms 1.48% PetscLogEventEndDefault 58ms 1.36% 72.63% 58ms 1.36% [libchaste_heart.so] 0 0% 72.63% 57ms 1.34% VecDot 5ms 0.12% 72.75% 56ms 1.32% VecAXPY 4ms 0.094% 72.84% 55ms 1.29% KSP_RemoveNullSpace (inline) 11ms 0.26% 73.10% 53ms 1.25% AbstractCardiacCell::SetVoltage (partial-inline) 3ms 0.071% 73.17% 53ms 1.25% VecDestroy 38ms 0.89% 74.07% 53ms 1.25% top12 (inline) 8ms 0.19% 74.25% 52ms 1.22% VecCopy 0 0% 74.25% 52ms 1.22% VecDot_Seq 0 0% 74.25% 52ms 1.22% VecXDot_Seq_Private.constprop.0 2ms 0.047% 74.30% 48ms 1.13% VecDuplicate_MPI 45ms 1.06% 75.36% 45ms 1.06% TimeStepper::CalculateNextTime 2ms 0.047% 75.41% 45ms 1.06% VecMAXPY 9ms 0.21% 75.62% 43ms 1.01% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 75.62% 43ms 1.01% AbstractBidomainSolver::FinaliseLinearSystem 2ms 0.047% 75.66% 43ms 1.01% VecNorm 42ms 0.99% 76.65% 42ms 0.99% __ieee754_log_fma 41ms 0.96% 77.62% 41ms 0.96% __memcpy_avx_unaligned_erms 1ms 0.024% 77.64% 38ms 0.89% VecCreate 23ms 0.54% 78.18% 37ms 0.87% AbstractOneStepIvpOdeSolver::Solve 0 0% 78.18% 37ms 0.87% CxxTest::RealWorldDescription::setUp 0 0% 78.18% 37ms 0.87% PMPI_Init_thread 0 0% 78.18% 37ms 0.87% PetscInitialize 0 0% 78.18% 37ms 0.87% PetscSetup::setUpWorld 0 0% 78.18% 37ms 0.87% PetscSetupUtils::CommonSetup 0 0% 78.18% 37ms 0.87% PetscSetupUtils::InitialisePetsc 37ms 0.87% 79.05% 37ms 0.87% asuint64 (inline) 0 0% 79.05% 37ms 0.87% ompi_mpi_init 7ms 0.16% 79.21% 36ms 0.85% PetscMallocA 35ms 0.82% 80.04% 36ms 0.85% VecMDot_Seq 0 0% 80.04% 36ms 0.85% VecNorm_Seq 31ms 0.73% 80.77% 35ms 0.82% AbstractParameterisedSystem::SetAnyVariable 19ms 0.45% 81.21% 33ms 0.78% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 26ms 0.61% 81.82% 31ms 0.73% AbstractParameterisedSystem::GetAnyVariable 3ms 0.071% 81.90% 30ms 0.71% 26ms 0.61% 82.51% 30ms 0.71% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 15ms 0.35% 82.86% 30ms 0.71% TimeStepper::AdvanceOneTimeStep 0 0% 82.86% 30ms 0.71% VecDuplicate_Seq 4ms 0.094% 82.95% 29ms 0.68% PetscMallocAlign 0 0% 82.95% 29ms 0.68% PetscMemcpy (inline) 0 0% 82.95% 28ms 0.66% VecAXPY_Seq 28ms 0.66% 83.61% 28ms 0.66% daxpy_ 0 0% 83.61% 27ms 0.63% VecNorm_MPI 0 0% 83.61% 27ms 0.63% VecNorm_MPI_Default.constprop.0 6ms 0.14% 83.75% 26ms 0.61% AbstractCardiacCell::GetVoltage (inline) 26ms 0.61% 84.36% 26ms 0.61% DistributedVector::Iterator::operator!= 0 0% 84.36% 25ms 0.59% orte_init 1ms 0.024% 84.39% 24ms 0.56% VecCopy_Seq (partial-inline) 2ms 0.047% 84.43% 24ms 0.56% VecCreate_MPI_Private 4ms 0.094% 84.53% 23ms 0.54% PetscHeaderDestroy_Private 23ms 0.54% 85.07% 23ms 0.54% std::isinf (inline) 22ms 0.52% 85.59% 22ms 0.52% RegularStimulus::GetStimulus