File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3729ms, 87.35% of 4269ms total Dropped 475 nodes (cum <= 21.34ms) flat flat% sum% cum cum% 0 0% 0% 4258ms 99.74% __libc_start_call_main 0 0% 0% 4258ms 99.74% __libc_start_main_impl 0 0% 0% 4258ms 99.74% _start 0 0% 0% 4255ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4255ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4255ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4255ms 99.67% main 0 0% 0% 4208ms 98.57% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4208ms 98.57% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4208ms 98.57% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.023% 0.023% 4200ms 98.38% AbstractCardiacProblem::Solve 0 0% 0.023% 4180ms 97.92% AbstractDynamicLinearPdeSolver::Solve 16ms 0.37% 0.4% 2278ms 53.36% AbstractCardiacTissue::SolveCellSystems 0 0% 0.4% 1502ms 35.18% LinearSystem::Solve 0 0% 0.4% 1454ms 34.06% KSPSolve 3ms 0.07% 0.47% 1454ms 34.06% KSPSolve_Private 1ms 0.023% 0.49% 1395ms 32.68% KSPSolve_SYMMLQ 20ms 0.47% 0.96% 1311ms 30.71% AbstractCardiacCell::ComputeExceptVoltage 33ms 0.77% 1.73% 1123ms 26.31% AbstractOneStepIvpOdeSolver::InternalSolve 65ms 1.52% 3.26% 934ms 21.88% EulerIvpOdeSolver::CalculateNextYValue 230ms 5.39% 8.64% 858ms 20.10% CellLuoRudy1991FromCellML::EvaluateYDerivatives 2ms 0.047% 8.69% 841ms 19.70% PCApply 0 0% 8.69% 838ms 19.63% PCApply_BJacobi_Singleblock 39ms 0.91% 9.60% 805ms 18.86% AbstractCardiacTissue::UpdateCaches (inline) 384ms 9.00% 18.60% 788ms 18.46% __GI___exp 238ms 5.58% 24.17% 731ms 17.12% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.023% 24.20% 715ms 16.75% KSPSolve_PREONLY (partial-inline) 1ms 0.023% 24.22% 674ms 15.79% MatSolve 0 0% 24.22% 674ms 15.79% PCApply_ICC 657ms 15.39% 39.61% 666ms 15.60% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1ms 0.023% 39.63% 596ms 13.96% KSP_PCApply.lto_priv.18 2ms 0.047% 39.68% 413ms 9.67% MatMult 18ms 0.42% 40.10% 404ms 9.46% MatMult_SeqAIJ (partial-inline) 383ms 8.97% 49.07% 402ms 9.42% MatMult_SeqAIJ_Inode (inline) 321ms 7.52% 56.59% 377ms 8.83% __ieee754_exp_fma 84ms 1.97% 58.56% 331ms 7.75% BidomainSolver::SetupLinearSystem 1ms 0.023% 58.59% 324ms 7.59% KSPConvergedDefault 0 0% 58.59% 307ms 7.19% KSP_PCApply (partial-inline) 1ms 0.023% 58.61% 254ms 5.95% std::pow (inline) 26ms 0.61% 59.22% 253ms 5.93% __pow 25ms 0.59% 59.80% 227ms 5.32% __ieee754_pow_fma 1ms 0.023% 59.83% 114ms 2.67% MatNullSpaceRemove 24ms 0.56% 60.39% 111ms 2.60% MPI_Wtime 103ms 2.41% 62.80% 103ms 2.41% log_inline (inline) 45ms 1.05% 63.86% 100ms 2.34% CellLuoRudy1991FromCellML::VerifyStateVariables 3ms 0.07% 63.93% 87ms 2.04% __GI___clock_gettime 35ms 0.82% 64.75% 86ms 2.01% TimeStepper::TimeStepper 84ms 1.97% 66.71% 84ms 1.97% [[vdso]] 0 0% 66.71% 83ms 1.94% VecDuplicate 81ms 1.90% 68.61% 83ms 1.94% exp_inline (inline) 12ms 0.28% 68.89% 75ms 1.76% PetscLogEventBeginDefault 13ms 0.3% 69.20% 75ms 1.76% PetscLogEventEndDefault 0 0% 69.20% 75ms 1.76% VecMDot 2ms 0.047% 69.24% 75ms 1.76% VecMXDot_Private 73ms 1.71% 70.95% 73ms 1.71% ddot_ 7ms 0.16% 71.12% 68ms 1.59% VecCopy 2ms 0.047% 71.16% 63ms 1.48% VecAXPY 12ms 0.28% 71.45% 59ms 1.38% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 71.45% 59ms 1.38% AbstractBidomainSolver::FinaliseLinearSystem 56ms 1.31% 72.76% 56ms 1.31% TimeStepper::CalculateNextTime 56ms 1.31% 74.07% 56ms 1.31% [libchaste_heart.so] 3ms 0.07% 74.14% 54ms 1.26% VecNorm 3ms 0.07% 74.21% 52ms 1.22% VecDot 50ms 1.17% 75.38% 52ms 1.22% VecMDot_Seq 38ms 0.89% 76.27% 49ms 1.15% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 7ms 0.16% 76.43% 48ms 1.12% AbstractCardiacCell::SetVoltage (partial-inline) 39ms 0.91% 77.35% 48ms 1.12% top12 (inline) 0 0% 77.35% 46ms 1.08% VecDot_Seq 0 0% 77.35% 46ms 1.08% VecXDot_Seq_Private.constprop.0 45ms 1.05% 78.40% 45ms 1.05% DistributedVector::Iterator::operator!= 5ms 0.12% 78.52% 45ms 1.05% VecDuplicate_MPI 43ms 1.01% 79.53% 43ms 1.01% __memcpy_avx_unaligned_erms 0 0% 79.53% 42ms 0.98% CxxTest::RealWorldDescription::setUp 0 0% 79.53% 42ms 0.98% PetscInitialize 0 0% 79.53% 42ms 0.98% PetscSetup::setUpWorld 0 0% 79.53% 42ms 0.98% PetscSetupUtils::CommonSetup 0 0% 79.53% 42ms 0.98% PetscSetupUtils::InitialisePetsc 1ms 0.023% 79.55% 42ms 0.98% VecNorm_Seq 0 0% 79.55% 41ms 0.96% PMPI_Init_thread 0 0% 79.55% 41ms 0.96% ompi_mpi_init 33ms 0.77% 80.32% 40ms 0.94% AbstractOneStepIvpOdeSolver::Solve 0 0% 80.32% 38ms 0.89% PetscMemcpy (inline) 0 0% 80.32% 38ms 0.89% VecDuplicate_Seq 3ms 0.07% 80.39% 38ms 0.89% VecMAXPY 1ms 0.023% 80.42% 37ms 0.87% VecDestroy 37ms 0.87% 81.28% 37ms 0.87% __ieee754_log_fma 1ms 0.023% 81.31% 36ms 0.84% 35ms 0.82% 82.13% 35ms 0.82% asuint64 (inline) 30ms 0.7% 82.83% 34ms 0.8% AbstractParameterisedSystem::SetAnyVariable 1ms 0.023% 82.85% 33ms 0.77% VecCreate 13ms 0.3% 83.16% 32ms 0.75% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 83.16% 32ms 0.75% VecAXPY_Seq 31ms 0.73% 83.88% 31ms 0.73% daxpy_ 23ms 0.54% 84.42% 30ms 0.7% AbstractParameterisedSystem::GetAnyVariable 0 0% 84.42% 30ms 0.7% VecNorm_MPI 0 0% 84.42% 30ms 0.7% VecNorm_MPI_Default.constprop.0 2ms 0.047% 84.47% 27ms 0.63% PetscMallocA 27ms 0.63% 85.10% 27ms 0.63% [libm.so.6] 12ms 0.28% 85.38% 26ms 0.61% TimeStepper::AdvanceOneTimeStep 0 0% 85.38% 26ms 0.61% VecCopy_Seq (partial-inline) 0 0% 85.38% 26ms 0.61% orte_init 3ms 0.07% 85.45% 25ms 0.59% PetscMallocAlign 3ms 0.07% 85.52% 24ms 0.56% VecCreate_MPI_Private 24ms 0.56% 86.09% 24ms 0.56% std::isinf (inline) 9ms 0.21% 86.30% 23ms 0.54% AbstractCardiacCell::GetVoltage (inline) 23ms 0.54% 86.84% 23ms 0.54% DistributedVector::Stripe::operator[] (inline) 22ms 0.52% 87.35% 23ms 0.54% VecMAXPY_Seq 0 0% 87.35% 22ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble