File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3601ms, 87.00% of 4139ms total Dropped 449 nodes (cum <= 20.70ms) flat flat% sum% cum cum% 0 0% 0% 4130ms 99.78% __libc_start_call_main 0 0% 0% 4130ms 99.78% __libc_start_main_impl 0 0% 0% 4130ms 99.78% _start 0 0% 0% 4127ms 99.71% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4127ms 99.71% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4127ms 99.71% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4127ms 99.71% main 0 0% 0% 4087ms 98.74% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4087ms 98.74% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4087ms 98.74% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4080ms 98.57% AbstractCardiacProblem::Solve 0 0% 0% 4076ms 98.48% AbstractDynamicLinearPdeSolver::Solve 11ms 0.27% 0.27% 2090ms 50.50% AbstractCardiacTissue::SolveCellSystems 0 0% 0.27% 1499ms 36.22% LinearSystem::Solve 0 0% 0.27% 1412ms 34.11% KSPSolve 4ms 0.097% 0.36% 1412ms 34.11% KSPSolve_Private 5ms 0.12% 0.48% 1323ms 31.96% KSPSolve_SYMMLQ 29ms 0.7% 1.18% 1124ms 27.16% AbstractCardiacCell::ComputeExceptVoltage 27ms 0.65% 1.84% 969ms 23.41% AbstractOneStepIvpOdeSolver::InternalSolve 1ms 0.024% 1.86% 818ms 19.76% PCApply 47ms 1.14% 3.00% 814ms 19.67% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.024% 3.02% 813ms 19.64% PCApply_BJacobi_Singleblock 204ms 4.93% 7.95% 759ms 18.34% CellLuoRudy1991FromCellML::EvaluateYDerivatives 33ms 0.8% 8.75% 743ms 17.95% AbstractCardiacTissue::UpdateCaches (inline) 308ms 7.44% 16.19% 706ms 17.06% __GI___exp 272ms 6.57% 22.76% 688ms 16.62% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.024% 22.78% 681ms 16.45% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 22.81% 651ms 15.73% MatSolve 0 0% 22.81% 651ms 15.73% PCApply_ICC 638ms 15.41% 38.22% 647ms 15.63% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 38.22% 637ms 15.39% KSP_PCApply.lto_priv.18 5ms 0.12% 38.34% 540ms 13.05% MatMult 7ms 0.17% 38.51% 527ms 12.73% MatMult_SeqAIJ (partial-inline) 517ms 12.49% 51.00% 527ms 12.73% MatMult_SeqAIJ_Inode (inline) 64ms 1.55% 52.55% 389ms 9.40% BidomainSolver::SetupLinearSystem 354ms 8.55% 61.10% 379ms 9.16% __ieee754_exp_fma 0 0% 61.10% 227ms 5.48% KSPConvergedDefault 0 0% 61.10% 226ms 5.46% KSP_PCApply (partial-inline) 19ms 0.46% 61.56% 196ms 4.74% __pow 0 0% 61.56% 196ms 4.74% std::pow (inline) 78ms 1.88% 63.45% 183ms 4.42% CellLuoRudy1991FromCellML::VerifyStateVariables 17ms 0.41% 63.86% 177ms 4.28% __ieee754_pow_fma 0 0% 63.86% 129ms 3.12% VecDuplicate 1ms 0.024% 63.88% 103ms 2.49% MatNullSpaceRemove 28ms 0.68% 64.56% 100ms 2.42% MPI_Wtime 0 0% 64.56% 93ms 2.25% AbstractBidomainSolver::FinaliseLinearSystem 29ms 0.7% 65.26% 90ms 2.17% AbstractBidomainSolver::CheckCompatibilityCondition 4ms 0.097% 65.35% 86ms 2.08% VecDuplicate_MPI 77ms 1.86% 67.21% 77ms 1.86% exp_inline (inline) 2ms 0.048% 67.26% 74ms 1.79% VecCopy 73ms 1.76% 69.03% 73ms 1.76% log_inline (inline) 0 0% 69.03% 72ms 1.74% VecMDot 5ms 0.12% 69.15% 72ms 1.74% VecMXDot_Private 2ms 0.048% 69.20% 72ms 1.74% __GI___clock_gettime 70ms 1.69% 70.89% 70ms 1.69% [[vdso]] 65ms 1.57% 72.46% 65ms 1.57% std::isinf (inline) 10ms 0.24% 72.70% 64ms 1.55% PetscLogEventEndDefault 11ms 0.27% 72.96% 62ms 1.50% PetscMallocA 8ms 0.19% 73.16% 59ms 1.43% PetscLogEventBeginDefault 31ms 0.75% 73.91% 59ms 1.43% TimeStepper::TimeStepper 3ms 0.072% 73.98% 56ms 1.35% VecCreate 3ms 0.072% 74.05% 51ms 1.23% PetscMallocAlign (partial-inline) 0 0% 74.05% 51ms 1.23% PetscMemcpy (inline) 5ms 0.12% 74.17% 51ms 1.23% VecCreate_MPI_Private 51ms 1.23% 75.40% 51ms 1.23% [libchaste_heart.so] 49ms 1.18% 76.59% 49ms 1.18% __memcpy_avx_unaligned_erms 46ms 1.11% 77.70% 46ms 1.11% VecMDot_Seq 37ms 0.89% 78.59% 45ms 1.09% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 2ms 0.048% 78.64% 43ms 1.04% VecDuplicate_Seq 0 0% 78.64% 42ms 1.01% VecNorm 0 0% 78.64% 40ms 0.97% VecNorm_Seq 0 0% 78.64% 39ms 0.94% VecCopy_Seq (partial-inline) 0 0% 78.64% 36ms 0.87% CxxTest::RealWorldDescription::setUp 0 0% 78.64% 36ms 0.87% PetscSetup::setUpWorld 1ms 0.024% 78.67% 36ms 0.87% PetscSetupUtils::CommonSetup 36ms 0.87% 79.54% 36ms 0.87% __ieee754_log_fma 23ms 0.56% 80.09% 35ms 0.85% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 35ms 0.85% 80.94% 35ms 0.85% TimeStepper::CalculateNextTime 35ms 0.85% 81.78% 35ms 0.85% ddot_ 34ms 0.82% 82.60% 34ms 0.82% DistributedVector::Iterator::operator!= 0 0% 82.60% 34ms 0.82% PMPI_Init_thread 0 0% 82.60% 34ms 0.82% PetscInitialize 0 0% 82.60% 34ms 0.82% PetscSetupUtils::InitialisePetsc 0 0% 82.60% 34ms 0.82% VecNorm_MPI 0 0% 82.60% 34ms 0.82% VecNorm_MPI_Default.constprop.0 0 0% 82.60% 34ms 0.82% ompi_mpi_init 18ms 0.43% 83.04% 32ms 0.77% top12 (inline) 1ms 0.024% 83.06% 31ms 0.75% 1ms 0.024% 83.09% 31ms 0.75% VecDot 3ms 0.072% 83.16% 30ms 0.72% VecMAXPY 30ms 0.72% 83.88% 30ms 0.72% dasum_ 0 0% 83.88% 29ms 0.7% PetscMemzero (inline) 3ms 0.072% 83.96% 29ms 0.7% VecDestroy 5ms 0.12% 84.08% 28ms 0.68% VecAXPY 28ms 0.68% 84.75% 28ms 0.68% __memset_avx2_unaligned_erms 21ms 0.51% 85.26% 27ms 0.65% AbstractOneStepIvpOdeSolver::Solve 26ms 0.63% 85.89% 26ms 0.63% DistributedVector::Stripe::operator[] (inline) 5ms 0.12% 86.01% 25ms 0.6% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 86.01% 25ms 0.6% VecDot_Seq 3ms 0.072% 86.08% 25ms 0.6% VecStashCreate_Private 0 0% 86.08% 25ms 0.6% VecXDot_Seq_Private.constprop.0 10ms 0.24% 86.33% 25ms 0.6% std::__cxx11::basic_string::basic_string 13ms 0.31% 86.64% 24ms 0.58% TimeStepper::AdvanceOneTimeStep 8ms 0.19% 86.83% 23ms 0.56% PetscHeaderCreate_Private 3ms 0.072% 86.91% 23ms 0.56% __posix_memalign 4ms 0.097% 87.00% 22ms 0.53% PMPI_Comm_get_attr 0 0% 87.00% 22ms 0.53% orte_init