File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3610ms, 86.78% of 4160ms total Dropped 452 nodes (cum <= 20.80ms) flat flat% sum% cum cum% 0 0% 0% 4152ms 99.81% __libc_start_call_main 0 0% 0% 4152ms 99.81% __libc_start_main_impl 0 0% 0% 4152ms 99.81% _start 0 0% 0% 4149ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4149ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4149ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4149ms 99.74% main 0 0% 0% 4115ms 98.92% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4115ms 98.92% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4115ms 98.92% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4107ms 98.73% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4104ms 98.65% AbstractDynamicLinearPdeSolver::Solve 14ms 0.34% 0.36% 2337ms 56.18% AbstractCardiacTissue::SolveCellSystems 0 0% 0.36% 1465ms 35.22% LinearSystem::Solve 0 0% 0.36% 1416ms 34.04% KSPSolve 2ms 0.048% 0.41% 1416ms 34.04% KSPSolve_Private 7ms 0.17% 0.58% 1366ms 32.84% KSPSolve_SYMMLQ 31ms 0.75% 1.32% 1352ms 32.50% AbstractCardiacCell::ComputeExceptVoltage 36ms 0.87% 2.19% 1148ms 27.60% AbstractOneStepIvpOdeSolver::InternalSolve 61ms 1.47% 3.65% 963ms 23.15% EulerIvpOdeSolver::CalculateNextYValue 255ms 6.13% 9.78% 886ms 21.30% CellLuoRudy1991FromCellML::EvaluateYDerivatives 5ms 0.12% 9.90% 836ms 20.10% PCApply 1ms 0.024% 9.93% 824ms 19.81% PCApply_BJacobi_Singleblock 363ms 8.73% 18.65% 800ms 19.23% __GI___exp 32ms 0.77% 19.42% 782ms 18.80% AbstractCardiacTissue::UpdateCaches (inline) 254ms 6.11% 25.53% 719ms 17.28% CellLuoRudy1991FromCellML::GetIIonic 0 0% 25.53% 674ms 16.20% KSPSolve_PREONLY (partial-inline) 2ms 0.048% 25.58% 638ms 15.34% MatSolve 0 0% 25.58% 638ms 15.34% PCApply_ICC 631ms 15.17% 40.75% 633ms 15.22% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 40.75% 631ms 15.17% KSP_PCApply.lto_priv.18 386ms 9.28% 50.02% 415ms 9.98% __ieee754_exp_fma 6ms 0.14% 50.17% 381ms 9.16% MatMult 22ms 0.53% 50.70% 371ms 8.92% MatMult_SeqAIJ 347ms 8.34% 59.04% 352ms 8.46% MatMult_SeqAIJ_Inode (inline) 3ms 0.072% 59.11% 301ms 7.24% KSPConvergedDefault 0 0% 59.11% 271ms 6.51% KSP_PCApply (partial-inline) 70ms 1.68% 60.79% 257ms 6.18% BidomainSolver::SetupLinearSystem 24ms 0.58% 61.37% 244ms 5.87% __pow 0 0% 61.37% 244ms 5.87% std::pow (inline) 26ms 0.62% 62.00% 219ms 5.26% __ieee754_pow_fma 75ms 1.80% 63.80% 153ms 3.68% CellLuoRudy1991FromCellML::VerifyStateVariables 112ms 2.69% 66.49% 112ms 2.69% log_inline (inline) 1ms 0.024% 66.51% 104ms 2.50% VecDuplicate 2ms 0.048% 66.56% 99ms 2.38% MatNullSpaceRemove 20ms 0.48% 67.04% 84ms 2.02% MPI_Wtime 73ms 1.75% 68.80% 73ms 1.75% exp_inline (inline) 3ms 0.072% 68.87% 63ms 1.51% __GI___clock_gettime 63ms 1.51% 70.38% 63ms 1.51% ddot_ 60ms 1.44% 71.83% 60ms 1.44% [[vdso]] 9ms 0.22% 72.04% 58ms 1.39% PetscLogEventEndDefault 7ms 0.17% 72.21% 57ms 1.37% PetscLogEventBeginDefault 0 0% 72.21% 55ms 1.32% VecMDot 2ms 0.048% 72.26% 55ms 1.32% VecMXDot_Private 5ms 0.12% 72.38% 53ms 1.27% VecCopy 2ms 0.048% 72.43% 53ms 1.27% VecDuplicate_MPI 1ms 0.024% 72.45% 52ms 1.25% VecNorm 24ms 0.58% 73.03% 51ms 1.23% TimeStepper::TimeStepper 0 0% 73.03% 50ms 1.20% VecDuplicate_Seq 1ms 0.024% 73.05% 48ms 1.15% VecDestroy 37ms 0.89% 73.94% 47ms 1.13% AbstractOneStepIvpOdeSolver::Solve 42ms 1.01% 74.95% 46ms 1.11% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.024% 74.98% 45ms 1.08% VecDot 17ms 0.41% 75.38% 43ms 1.03% TimeStepper::AdvanceOneTimeStep 11ms 0.26% 75.65% 42ms 1.01% AbstractCardiacCell::SetVoltage (partial-inline) 3ms 0.072% 75.72% 42ms 1.01% VecMAXPY 1ms 0.024% 75.75% 42ms 1.01% VecNorm_Seq 5ms 0.12% 75.87% 41ms 0.99% PetscMallocA 41ms 0.99% 76.85% 41ms 0.99% TimeStepper::CalculateNextTime 2ms 0.048% 76.90% 41ms 0.99% VecCreate 4ms 0.096% 77.00% 40ms 0.96% VecAXPY 1ms 0.024% 77.02% 40ms 0.96% VecDot_Seq 40ms 0.96% 77.98% 40ms 0.96% std::isinf (inline) 8ms 0.19% 78.17% 39ms 0.94% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 78.17% 39ms 0.94% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 78.17% 39ms 0.94% VecXDot_Seq_Private.constprop.0 36ms 0.87% 79.04% 38ms 0.91% VecMDot_Seq 37ms 0.89% 79.93% 37ms 0.89% [libchaste_heart.so] 3ms 0.072% 80.00% 36ms 0.87% PetscMallocAlign 19ms 0.46% 80.46% 36ms 0.87% top12 (inline) 19ms 0.46% 80.91% 35ms 0.84% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 33ms 0.79% 81.71% 33ms 0.79% __memcpy_avx_unaligned_erms 0 0% 81.71% 32ms 0.77% VecNorm_MPI 0 0% 81.71% 32ms 0.77% VecNorm_MPI_Default.constprop.0 31ms 0.75% 82.45% 32ms 0.77% __ieee754_log_fma 0 0% 82.45% 30ms 0.72% CxxTest::RealWorldDescription::setUp 0 0% 82.45% 30ms 0.72% PMPI_Init_thread 0 0% 82.45% 30ms 0.72% PetscInitialize 0 0% 82.45% 30ms 0.72% PetscSetup::setUpWorld 0 0% 82.45% 30ms 0.72% PetscSetupUtils::CommonSetup 0 0% 82.45% 30ms 0.72% PetscSetupUtils::InitialisePetsc 0 0% 82.45% 30ms 0.72% ompi_mpi_init 0 0% 82.45% 29ms 0.7% PetscMemcpy (inline) 17ms 0.41% 82.86% 28ms 0.67% AbstractCardiacCell::GetVoltage (partial-inline) 1ms 0.024% 82.88% 28ms 0.67% VecAXPY_Seq 3ms 0.072% 82.96% 27ms 0.65% VecCreate_MPI_Private 0 0% 82.96% 27ms 0.65% VecSetType 0 0% 82.96% 26ms 0.62% 26ms 0.62% 83.58% 26ms 0.62% DistributedVector::Iterator::operator!= 23ms 0.55% 84.13% 25ms 0.6% AbstractParameterisedSystem::SetAnyVariable 25ms 0.6% 84.74% 25ms 0.6% daxpy_ 1ms 0.024% 84.76% 24ms 0.58% VecCreate_Seq 21ms 0.5% 85.26% 24ms 0.58% VecMAXPY_Seq 23ms 0.55% 85.82% 23ms 0.55% [libm.so.6] 22ms 0.53% 86.35% 22ms 0.53% RegularStimulus::GetStimulus 1ms 0.024% 86.37% 22ms 0.53% VecCopy_Seq (partial-inline) 8ms 0.19% 86.56% 22ms 0.53% std::__cxx11::basic_string::basic_string 0 0% 86.56% 21ms 0.5% AbstractFeVolumeIntegralAssembler::DoAssemble 1ms 0.024% 86.59% 21ms 0.5% KSP_RemoveNullSpace (inline) 7ms 0.17% 86.75% 21ms 0.5% __GI___libc_malloc 1ms 0.024% 86.78% 21ms 0.5% __posix_memalign 0 0% 86.78% 21ms 0.5% orte_init