File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3774ms, 87.71% of 4303ms total Dropped 460 nodes (cum <= 21.52ms) flat flat% sum% cum cum% 0 0% 0% 4294ms 99.79% __libc_start_call_main 0 0% 0% 4294ms 99.79% __libc_start_main_impl 0 0% 0% 4294ms 99.79% _start 0 0% 0% 4290ms 99.70% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4290ms 99.70% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4290ms 99.70% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4290ms 99.70% main 0 0% 0% 4241ms 98.56% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4241ms 98.56% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4241ms 98.56% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.023% 0.023% 4232ms 98.35% AbstractCardiacProblem::Solve 3ms 0.07% 0.093% 4217ms 98.00% AbstractDynamicLinearPdeSolver::Solve 27ms 0.63% 0.72% 2353ms 54.68% AbstractCardiacTissue::SolveCellSystems 2ms 0.046% 0.77% 1446ms 33.60% LinearSystem::Solve 0 0% 0.77% 1397ms 32.47% KSPSolve 7ms 0.16% 0.93% 1397ms 32.47% KSPSolve_Private 2ms 0.046% 0.98% 1360ms 31.61% KSPSolve_SYMMLQ 36ms 0.84% 1.81% 1320ms 30.68% AbstractCardiacCell::ComputeExceptVoltage 26ms 0.6% 2.42% 1142ms 26.54% AbstractOneStepIvpOdeSolver::InternalSolve 73ms 1.70% 4.11% 945ms 21.96% EulerIvpOdeSolver::CalculateNextYValue 213ms 4.95% 9.06% 859ms 19.96% CellLuoRudy1991FromCellML::EvaluateYDerivatives 5ms 0.12% 9.18% 836ms 19.43% PCApply 0 0% 9.18% 827ms 19.22% PCApply_BJacobi_Singleblock 38ms 0.88% 10.06% 826ms 19.20% AbstractCardiacTissue::UpdateCaches (inline) 383ms 8.90% 18.96% 793ms 18.43% __GI___exp 259ms 6.02% 24.98% 752ms 17.48% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.98% 705ms 16.38% KSPSolve_PREONLY (partial-inline) 1ms 0.023% 25.01% 657ms 15.27% PCApply_ICC 1ms 0.023% 25.03% 656ms 15.25% MatSolve 646ms 15.01% 40.04% 651ms 15.13% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 40.04% 598ms 13.90% KSP_PCApply.lto_priv.18 3ms 0.07% 40.11% 456ms 10.60% MatMult 9ms 0.21% 40.32% 446ms 10.36% MatMult_SeqAIJ (partial-inline) 433ms 10.06% 50.38% 446ms 10.36% MatMult_SeqAIJ_Inode (inline) 337ms 7.83% 58.22% 385ms 8.95% __ieee754_exp_fma 77ms 1.79% 60.00% 370ms 8.60% BidomainSolver::SetupLinearSystem 1ms 0.023% 60.03% 317ms 7.37% KSPConvergedDefault 0 0% 60.03% 308ms 7.16% KSP_PCApply (partial-inline) 1ms 0.023% 60.05% 277ms 6.44% std::pow (inline) 23ms 0.53% 60.59% 276ms 6.41% __pow 19ms 0.44% 61.03% 253ms 5.88% __ieee754_pow_fma 58ms 1.35% 62.38% 128ms 2.97% CellLuoRudy1991FromCellML::VerifyStateVariables 123ms 2.86% 65.23% 123ms 2.86% log_inline (inline) 1ms 0.023% 65.26% 113ms 2.63% MatNullSpaceRemove 101ms 2.35% 67.60% 104ms 2.42% exp_inline (inline) 19ms 0.44% 68.05% 89ms 2.07% MPI_Wtime 0 0% 68.05% 76ms 1.77% VecMDot 5ms 0.12% 68.16% 76ms 1.77% VecMXDot_Private 0 0% 68.16% 75ms 1.74% VecDuplicate 30ms 0.7% 68.86% 72ms 1.67% TimeStepper::TimeStepper 72ms 1.67% 70.53% 72ms 1.67% ddot_ 1ms 0.023% 70.56% 70ms 1.63% __GI___clock_gettime 69ms 1.60% 72.16% 69ms 1.60% [[vdso]] 11ms 0.26% 72.41% 60ms 1.39% AbstractCardiacCell::SetVoltage (partial-inline) 7ms 0.16% 72.58% 60ms 1.39% PetscLogEventBeginDefault 10ms 0.23% 72.81% 60ms 1.39% PetscLogEventEndDefault 57ms 1.32% 74.13% 57ms 1.32% [libchaste_heart.so] 0 0% 74.13% 56ms 1.30% VecNorm 4ms 0.093% 74.23% 54ms 1.25% VecCopy 49ms 1.14% 75.37% 52ms 1.21% VecMDot_Seq 0 0% 75.37% 48ms 1.12% VecDot 1ms 0.023% 75.39% 48ms 1.12% VecNorm_Seq 0 0% 75.39% 45ms 1.05% CxxTest::RealWorldDescription::setUp 0 0% 75.39% 45ms 1.05% PMPI_Init_thread 0 0% 75.39% 45ms 1.05% PetscInitialize 0 0% 75.39% 45ms 1.05% PetscSetup::setUpWorld 0 0% 75.39% 45ms 1.05% PetscSetupUtils::CommonSetup 0 0% 75.39% 45ms 1.05% PetscSetupUtils::InitialisePetsc 45ms 1.05% 76.44% 45ms 1.05% TimeStepper::CalculateNextTime 0 0% 76.44% 45ms 1.05% ompi_mpi_init 44ms 1.02% 77.46% 44ms 1.02% __memcpy_avx_unaligned_erms 2ms 0.046% 77.50% 42ms 0.98% VecAXPY 33ms 0.77% 78.27% 41ms 0.95% AbstractParameterisedSystem::SetAnyVariable 0 0% 78.27% 41ms 0.95% VecDuplicate_Seq 31ms 0.72% 78.99% 41ms 0.95% top12 (inline) 3ms 0.07% 79.06% 39ms 0.91% 12ms 0.28% 79.34% 39ms 0.91% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 79.34% 39ms 0.91% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 79.34% 39ms 0.91% KSP_RemoveNullSpace (inline) 0 0% 79.34% 39ms 0.91% VecDot_Seq 0 0% 79.34% 39ms 0.91% VecXDot_Seq_Private.constprop.0 2ms 0.046% 79.39% 38ms 0.88% VecDestroy 0 0% 79.39% 37ms 0.86% VecNorm_MPI 0 0% 79.39% 37ms 0.86% VecNorm_MPI_Default.constprop.0 0 0% 79.39% 36ms 0.84% VecMAXPY 35ms 0.81% 80.20% 35ms 0.81% __ieee754_log_fma 28ms 0.65% 80.85% 34ms 0.79% AbstractOneStepIvpOdeSolver::Solve 0 0% 80.85% 34ms 0.79% VecDuplicate_MPI 5ms 0.12% 80.97% 33ms 0.77% PetscMallocA 0 0% 80.97% 32ms 0.74% PetscMemcpy (inline) 15ms 0.35% 81.32% 31ms 0.72% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 28ms 0.65% 81.97% 28ms 0.65% DistributedVector::Stripe::operator[] (inline) 2ms 0.046% 82.01% 28ms 0.65% PetscMallocAlign (partial-inline) 17ms 0.4% 82.41% 28ms 0.65% TimeStepper::AdvanceOneTimeStep 0 0% 82.41% 28ms 0.65% VecSetType 28ms 0.65% 83.06% 28ms 0.65% std::isinf (inline) 23ms 0.53% 83.59% 27ms 0.63% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 27ms 0.63% 84.22% 27ms 0.63% DistributedVector::Iterator::operator!= 1ms 0.023% 84.24% 27ms 0.63% VecCopy_Seq (partial-inline) 27ms 0.63% 84.87% 27ms 0.63% asuint64 (inline) 4ms 0.093% 84.96% 26ms 0.6% VecCreate 26ms 0.6% 85.57% 26ms 0.6% [libm.so.6] 16ms 0.37% 85.94% 25ms 0.58% AbstractParameterisedSystem::GetAnyVariable 25ms 0.58% 86.52% 25ms 0.58% TimeStepper::GetNextTimeStep 4ms 0.093% 86.61% 25ms 0.58% VecSet 0 0% 86.61% 24ms 0.56% PetscMemzero (inline) 24ms 0.56% 87.17% 24ms 0.56% __memset_avx2_unaligned_erms 0 0% 87.17% 24ms 0.56% orte_init 23ms 0.53% 87.71% 23ms 0.53% VecMAXPY_Seq 0 0% 87.71% 22ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 0 0% 87.71% 22ms 0.51% VecAXPY_Seq