File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3597ms, 86.74% of 4147ms total Dropped 467 nodes (cum <= 20.73ms) flat flat% sum% cum cum% 0 0% 0% 4141ms 99.86% __libc_start_call_main 0 0% 0% 4141ms 99.86% __libc_start_main_impl 0 0% 0% 4141ms 99.86% _start 0 0% 0% 4139ms 99.81% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4139ms 99.81% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4139ms 99.81% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4139ms 99.81% main 0 0% 0% 4105ms 98.99% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4105ms 98.99% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4105ms 98.99% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.024% 0.024% 4096ms 98.77% AbstractCardiacProblem::Solve 0 0% 0.024% 4090ms 98.63% AbstractDynamicLinearPdeSolver::Solve 11ms 0.27% 0.29% 2523ms 60.84% AbstractCardiacTissue::SolveCellSystems 48ms 1.16% 1.45% 1465ms 35.33% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.45% 1246ms 30.05% LinearSystem::Solve 22ms 0.53% 1.98% 1238ms 29.85% AbstractOneStepIvpOdeSolver::InternalSolve 0 0% 1.98% 1207ms 29.11% KSPSolve 4ms 0.096% 2.07% 1207ms 29.11% KSPSolve_Private 2ms 0.048% 2.12% 1154ms 27.83% KSPSolve_SYMMLQ 56ms 1.35% 3.47% 1070ms 25.80% EulerIvpOdeSolver::CalculateNextYValue 266ms 6.41% 9.89% 998ms 24.07% CellLuoRudy1991FromCellML::EvaluateYDerivatives 412ms 9.93% 19.82% 924ms 22.28% __GI___exp 31ms 0.75% 20.57% 826ms 19.92% AbstractCardiacTissue::UpdateCaches (inline) 280ms 6.75% 27.32% 770ms 18.57% CellLuoRudy1991FromCellML::GetIIonic 2ms 0.048% 27.37% 706ms 17.02% PCApply 1ms 0.024% 27.39% 701ms 16.90% PCApply_BJacobi_Singleblock 1ms 0.024% 27.42% 565ms 13.62% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 27.44% 530ms 12.78% PCApply_ICC 1ms 0.024% 27.47% 529ms 12.76% MatSolve 520ms 12.54% 40.00% 523ms 12.61% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 40.00% 520ms 12.54% KSP_PCApply.lto_priv.18 456ms 11.00% 51.00% 494ms 11.91% __ieee754_exp_fma 4ms 0.096% 51.10% 367ms 8.85% MatMult 2ms 0.048% 51.15% 355ms 8.56% MatMult_SeqAIJ 350ms 8.44% 59.59% 355ms 8.56% MatMult_SeqAIJ_Inode (inline) 51ms 1.23% 60.82% 275ms 6.63% BidomainSolver::SetupLinearSystem 0 0% 60.82% 250ms 6.03% KSPConvergedDefault 6ms 0.14% 60.96% 238ms 5.74% std::pow (inline) 0 0% 60.96% 236ms 5.69% KSP_PCApply (partial-inline) 22ms 0.53% 61.49% 232ms 5.59% __pow 29ms 0.7% 62.19% 210ms 5.06% __ieee754_pow_fma 71ms 1.71% 63.90% 173ms 4.17% CellLuoRudy1991FromCellML::VerifyStateVariables 103ms 2.48% 66.39% 103ms 2.48% log_inline (inline) 0 0% 66.39% 98ms 2.36% VecDuplicate 3ms 0.072% 66.46% 84ms 2.03% MatNullSpaceRemove 24ms 0.58% 67.04% 68ms 1.64% MPI_Wtime 66ms 1.59% 68.63% 67ms 1.62% exp_inline (inline) 9ms 0.22% 68.84% 66ms 1.59% VecCopy 31ms 0.75% 69.59% 64ms 1.54% TimeStepper::TimeStepper 59ms 1.42% 71.02% 59ms 1.42% ddot_ 46ms 1.11% 72.12% 55ms 1.33% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 72.12% 54ms 1.30% VecDuplicate_MPI 12ms 0.29% 72.41% 53ms 1.28% PetscLogEventBeginDefault 15ms 0.36% 72.78% 53ms 1.28% PetscLogEventEndDefault 0 0% 72.78% 52ms 1.25% VecMDot 8ms 0.19% 72.97% 52ms 1.25% VecMXDot_Private 21ms 0.51% 73.47% 48ms 1.16% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 47ms 1.13% 74.61% 47ms 1.13% TimeStepper::CalculateNextTime 27ms 0.65% 75.26% 47ms 1.13% top12 (inline) 46ms 1.11% 76.37% 46ms 1.11% __memcpy_avx_unaligned_erms 45ms 1.09% 77.45% 45ms 1.09% std::isinf (inline) 6ms 0.14% 77.60% 44ms 1.06% PetscMallocA 2ms 0.048% 77.65% 44ms 1.06% VecDestroy 2ms 0.048% 77.69% 44ms 1.06% VecDot 1ms 0.024% 77.72% 44ms 1.06% VecDuplicate_Seq 1ms 0.024% 77.74% 44ms 1.06% __GI___clock_gettime 0 0% 77.74% 43ms 1.04% VecNorm 43ms 1.04% 78.78% 43ms 1.04% [[vdso]] 42ms 1.01% 79.79% 42ms 1.01% __ieee754_log_fma 0 0% 79.79% 41ms 0.99% VecCreate 16ms 0.39% 80.18% 40ms 0.96% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 80.18% 40ms 0.96% AbstractBidomainSolver::FinaliseLinearSystem 11ms 0.27% 80.44% 40ms 0.96% AbstractCardiacCell::SetVoltage (partial-inline) 35ms 0.84% 81.29% 39ms 0.94% AbstractOneStepIvpOdeSolver::Solve 2ms 0.048% 81.34% 39ms 0.94% VecNorm_Seq 1ms 0.024% 81.36% 38ms 0.92% PetscMallocAlign 0 0% 81.36% 38ms 0.92% PetscMemcpy (inline) 19ms 0.46% 81.82% 36ms 0.87% AbstractCardiacCell::GetVoltage (partial-inline) 3ms 0.072% 81.89% 35ms 0.84% VecCreate_MPI_Private 13ms 0.31% 82.20% 35ms 0.84% std::__cxx11::basic_string::basic_string 0 0% 82.20% 34ms 0.82% VecDot_Seq 0 0% 82.20% 34ms 0.82% VecXDot_Seq_Private.constprop.0 0 0% 82.20% 33ms 0.8% PetscTimeSubtract (inline) 31ms 0.75% 82.95% 32ms 0.77% VecMDot_Seq 0 0% 82.95% 31ms 0.75% CxxTest::RealWorldDescription::setUp 0 0% 82.95% 31ms 0.75% PMPI_Init_thread 0 0% 82.95% 31ms 0.75% PetscInitialize 0 0% 82.95% 31ms 0.75% PetscSetup::setUpWorld 0 0% 82.95% 31ms 0.75% PetscSetupUtils::CommonSetup 0 0% 82.95% 31ms 0.75% PetscSetupUtils::InitialisePetsc 1ms 0.024% 82.98% 31ms 0.75% VecCopy_Seq (partial-inline) 0 0% 82.98% 31ms 0.75% ompi_mpi_init 0 0% 82.98% 29ms 0.7% KSP_RemoveNullSpace (inline) 2ms 0.048% 83.02% 29ms 0.7% VecMAXPY 23ms 0.55% 83.58% 27ms 0.65% AbstractParameterisedSystem::GetAnyVariable 27ms 0.65% 84.23% 27ms 0.65% [libchaste_heart.so] 12ms 0.29% 84.52% 26ms 0.63% __GI___libc_malloc 23ms 0.55% 85.07% 25ms 0.6% AbstractParameterisedSystem::SetAnyVariable 25ms 0.6% 85.68% 25ms 0.6% DistributedVector::Iterator::operator!= 8ms 0.19% 85.87% 25ms 0.6% TimeStepper::AdvanceOneTimeStep 0 0% 85.87% 24ms 0.58% 0 0% 85.87% 24ms 0.58% VecAXPY 4ms 0.096% 85.97% 24ms 0.58% __posix_memalign 0 0% 85.97% 23ms 0.55% VecNorm_MPI 0 0% 85.97% 23ms 0.55% VecNorm_MPI_Default.constprop.0 23ms 0.55% 86.52% 23ms 0.55% asuint64 (inline) 4ms 0.096% 86.62% 22ms 0.53% PetscHeaderDestroy_Private 0 0% 86.62% 22ms 0.53% orte_init 0 0% 86.62% 21ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 2ms 0.048% 86.67% 21ms 0.51% PetscHeaderCreate_Private 3ms 0.072% 86.74% 21ms 0.51% VecStashCreate_Private