File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3685ms, 87.20% of 4226ms total Dropped 452 nodes (cum <= 21.13ms) flat flat% sum% cum cum% 0 0% 0% 4218ms 99.81% __libc_start_call_main 0 0% 0% 4218ms 99.81% __libc_start_main_impl 0 0% 0% 4218ms 99.81% _start 0 0% 0% 4215ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4215ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4215ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4215ms 99.74% main 0 0% 0% 4179ms 98.89% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4179ms 98.89% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4179ms 98.89% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4171ms 98.70% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4155ms 98.32% AbstractDynamicLinearPdeSolver::Solve 12ms 0.28% 0.31% 2247ms 53.17% AbstractCardiacTissue::SolveCellSystems 0 0% 0.31% 1609ms 38.07% LinearSystem::Solve 0 0% 0.31% 1552ms 36.73% KSPSolve 7ms 0.17% 0.47% 1552ms 36.73% KSPSolve_Private 2ms 0.047% 0.52% 1506ms 35.64% KSPSolve_SYMMLQ 34ms 0.8% 1.33% 1318ms 31.19% AbstractCardiacCell::ComputeExceptVoltage 29ms 0.69% 2.01% 1113ms 26.34% AbstractOneStepIvpOdeSolver::InternalSolve 3ms 0.071% 2.08% 967ms 22.88% PCApply 2ms 0.047% 2.13% 958ms 22.67% PCApply_BJacobi_Singleblock 47ms 1.11% 3.24% 909ms 21.51% EulerIvpOdeSolver::CalculateNextYValue 248ms 5.87% 9.11% 843ms 19.95% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 9.11% 808ms 19.12% KSPSolve_PREONLY (partial-inline) 3ms 0.071% 9.18% 766ms 18.13% MatSolve 0 0% 9.18% 766ms 18.13% PCApply_ICC 747ms 17.68% 26.86% 754ms 17.84% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 326ms 7.71% 34.57% 753ms 17.82% __GI___exp 22ms 0.52% 35.09% 731ms 17.30% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 35.09% 716ms 16.94% KSP_PCApply.lto_priv.18 220ms 5.21% 40.30% 690ms 16.33% CellLuoRudy1991FromCellML::GetIIonic 382ms 9.04% 49.34% 404ms 9.56% __ieee754_exp_fma 5ms 0.12% 49.46% 393ms 9.30% MatMult 3ms 0.071% 49.53% 385ms 9.11% MatMult_SeqAIJ 377ms 8.92% 58.45% 385ms 9.11% MatMult_SeqAIJ_Inode (inline) 1ms 0.024% 58.47% 343ms 8.12% KSPConvergedDefault 0 0% 58.47% 327ms 7.74% KSP_PCApply (partial-inline) 40ms 0.95% 59.42% 244ms 5.77% BidomainSolver::SetupLinearSystem 3ms 0.071% 59.49% 243ms 5.75% std::pow (inline) 17ms 0.4% 59.89% 240ms 5.68% __pow 30ms 0.71% 60.60% 223ms 5.28% __ieee754_pow_fma 73ms 1.73% 62.33% 152ms 3.60% CellLuoRudy1991FromCellML::VerifyStateVariables 3ms 0.071% 62.40% 128ms 3.03% MatNullSpaceRemove 116ms 2.74% 65.14% 116ms 2.74% log_inline (inline) 33ms 0.78% 65.93% 100ms 2.37% MPI_Wtime 1ms 0.024% 65.95% 90ms 2.13% VecDuplicate 36ms 0.85% 66.80% 82ms 1.94% TimeStepper::TimeStepper 0 0% 66.80% 80ms 1.89% VecMDot 2ms 0.047% 66.85% 80ms 1.89% VecMXDot_Private 5ms 0.12% 66.97% 76ms 1.80% VecCopy 75ms 1.77% 68.74% 75ms 1.77% exp_inline (inline) 9ms 0.21% 68.95% 74ms 1.75% PetscLogEventEndDefault 1ms 0.024% 68.98% 66ms 1.56% __GI___clock_gettime 65ms 1.54% 70.52% 65ms 1.54% [[vdso]] 12ms 0.28% 70.80% 61ms 1.44% PetscLogEventBeginDefault 61ms 1.44% 72.24% 61ms 1.44% __memcpy_avx_unaligned_erms 61ms 1.44% 73.69% 61ms 1.44% ddot_ 48ms 1.14% 74.82% 58ms 1.37% AbstractOneStepIvpOdeSolver::Solve 0 0% 74.82% 54ms 1.28% PetscMemcpy (inline) 50ms 1.18% 76.01% 54ms 1.28% VecMDot_Seq 0 0% 76.01% 52ms 1.23% VecDestroy 49ms 1.16% 77.17% 49ms 1.16% TimeStepper::CalculateNextTime 1ms 0.024% 77.19% 48ms 1.14% AbstractBidomainSolver::FinaliseLinearSystem 3ms 0.071% 77.26% 48ms 1.14% VecDuplicate_MPI 46ms 1.09% 78.35% 47ms 1.11% __ieee754_log_fma 13ms 0.31% 78.66% 46ms 1.09% AbstractBidomainSolver::CheckCompatibilityCondition 2ms 0.047% 78.70% 46ms 1.09% VecNorm 1ms 0.024% 78.73% 45ms 1.06% VecCopy_Seq (partial-inline) 1ms 0.024% 78.75% 45ms 1.06% VecDot 4ms 0.095% 78.85% 45ms 1.06% VecMAXPY 20ms 0.47% 79.32% 43ms 1.02% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 3ms 0.071% 79.39% 41ms 0.97% VecAXPY 3ms 0.071% 79.46% 41ms 0.97% VecDuplicate_Seq 20ms 0.47% 79.93% 41ms 0.97% std::__cxx11::basic_string::basic_string 0 0% 79.93% 40ms 0.95% VecDot_Seq 0 0% 79.93% 40ms 0.95% VecXDot_Seq_Private.constprop.0 1ms 0.024% 79.96% 39ms 0.92% PetscTimeSubtract (inline) 0 0% 79.96% 39ms 0.92% VecNorm_Seq 8ms 0.19% 80.15% 38ms 0.9% AbstractCardiacCell::SetVoltage (partial-inline) 5ms 0.12% 80.27% 37ms 0.88% PetscMallocA 35ms 0.83% 81.09% 35ms 0.83% DistributedVector::Iterator::operator!= 25ms 0.59% 81.68% 34ms 0.8% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.024% 81.71% 34ms 0.8% VecCreate 34ms 0.8% 82.51% 34ms 0.8% [libchaste_heart.so] 1ms 0.024% 82.54% 32ms 0.76% PetscMallocAlign 0 0% 82.54% 32ms 0.76% VecNorm_MPI 0 0% 82.54% 32ms 0.76% VecNorm_MPI_Default.constprop.0 0 0% 82.54% 31ms 0.73% CxxTest::RealWorldDescription::setUp 0 0% 82.54% 31ms 0.73% PetscInitialize 0 0% 82.54% 31ms 0.73% PetscSetup::setUpWorld 0 0% 82.54% 31ms 0.73% PetscSetupUtils::CommonSetup 0 0% 82.54% 31ms 0.73% PetscSetupUtils::InitialisePetsc 16ms 0.38% 82.92% 31ms 0.73% TimeStepper::AdvanceOneTimeStep 0 0% 82.92% 30ms 0.71% PMPI_Init_thread 0 0% 82.92% 30ms 0.71% ompi_mpi_init 27ms 0.64% 83.55% 29ms 0.69% VecMAXPY_Seq 1ms 0.024% 83.58% 26ms 0.62% 26ms 0.62% 84.19% 26ms 0.62% std::isinf (inline) 0 0% 84.19% 25ms 0.59% VecAXPY_Seq 4ms 0.095% 84.29% 25ms 0.59% VecCreate_MPI_Private 10ms 0.24% 84.52% 25ms 0.59% __GI___libc_malloc 20ms 0.47% 85.00% 24ms 0.57% AbstractParameterisedSystem::GetAnyVariable 24ms 0.57% 85.57% 24ms 0.57% daxpy_ 9ms 0.21% 85.78% 24ms 0.57% top12 (inline) 12ms 0.28% 86.06% 23ms 0.54% AbstractCardiacCell::GetVoltage (partial-inline) 21ms 0.5% 86.56% 23ms 0.54% AbstractParameterisedSystem::SetAnyVariable 23ms 0.54% 87.10% 23ms 0.54% [libm.so.6] 4ms 0.095% 87.20% 22ms 0.52% PetscHeaderDestroy_Private