File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3644ms, 87.39% of 4170ms total Dropped 465 nodes (cum <= 20.85ms) flat flat% sum% cum cum% 0 0% 0% 4160ms 99.76% __libc_start_call_main 0 0% 0% 4160ms 99.76% __libc_start_main_impl 0 0% 0% 4160ms 99.76% _start 0 0% 0% 4157ms 99.69% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4157ms 99.69% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4157ms 99.69% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4157ms 99.69% main 0 0% 0% 4117ms 98.73% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4117ms 98.73% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4117ms 98.73% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.024% 0.024% 4109ms 98.54% AbstractCardiacProblem::Solve 2ms 0.048% 0.072% 4094ms 98.18% AbstractDynamicLinearPdeSolver::Solve 14ms 0.34% 0.41% 2397ms 57.48% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.43% 1395ms 33.45% LinearSystem::Solve 44ms 1.06% 1.49% 1381ms 33.12% AbstractCardiacCell::ComputeExceptVoltage 1ms 0.024% 1.51% 1348ms 32.33% KSPSolve 6ms 0.14% 1.65% 1348ms 32.33% KSPSolve_Private 3ms 0.072% 1.73% 1290ms 30.94% KSPSolve_SYMMLQ 28ms 0.67% 2.40% 1132ms 27.15% AbstractOneStepIvpOdeSolver::InternalSolve 56ms 1.34% 3.74% 938ms 22.49% EulerIvpOdeSolver::CalculateNextYValue 279ms 6.69% 10.43% 870ms 20.86% CellLuoRudy1991FromCellML::EvaluateYDerivatives 3ms 0.072% 10.50% 826ms 19.81% PCApply 0 0% 10.50% 814ms 19.52% PCApply_BJacobi_Singleblock 27ms 0.65% 11.15% 803ms 19.26% AbstractCardiacTissue::UpdateCaches (inline) 368ms 8.82% 19.98% 788ms 18.90% __GI___exp 258ms 6.19% 26.16% 740ms 17.75% CellLuoRudy1991FromCellML::GetIIonic 0 0% 26.16% 666ms 15.97% KSPSolve_PREONLY (partial-inline) 3ms 0.072% 26.24% 629ms 15.08% MatSolve 0 0% 26.24% 629ms 15.08% PCApply_ICC 613ms 14.70% 40.94% 619ms 14.84% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 40.94% 601ms 14.41% KSP_PCApply.lto_priv.18 376ms 9.02% 49.95% 405ms 9.71% __ieee754_exp_fma 4ms 0.096% 50.05% 357ms 8.56% MatMult 8ms 0.19% 50.24% 348ms 8.35% MatMult_SeqAIJ 337ms 8.08% 58.32% 341ms 8.18% MatMult_SeqAIJ_Inode (inline) 1ms 0.024% 58.35% 287ms 6.88% KSPConvergedDefault 0 0% 58.35% 278ms 6.67% KSP_PCApply (partial-inline) 58ms 1.39% 59.74% 256ms 6.14% BidomainSolver::SetupLinearSystem 19ms 0.46% 60.19% 225ms 5.40% __pow 0 0% 60.19% 225ms 5.40% std::pow (inline) 28ms 0.67% 60.86% 206ms 4.94% __ieee754_pow_fma 76ms 1.82% 62.69% 160ms 3.84% CellLuoRudy1991FromCellML::VerifyStateVariables 109ms 2.61% 65.30% 109ms 2.61% log_inline (inline) 2ms 0.048% 65.35% 100ms 2.40% MatNullSpaceRemove 0 0% 65.35% 86ms 2.06% VecDuplicate 44ms 1.06% 66.40% 76ms 1.82% TimeStepper::TimeStepper 9ms 0.22% 66.62% 69ms 1.65% MPI_Wtime 65ms 1.56% 68.18% 65ms 1.56% ddot_ 62ms 1.49% 69.66% 63ms 1.51% exp_inline (inline) 2ms 0.048% 69.71% 61ms 1.46% __GI___clock_gettime 0 0% 69.71% 60ms 1.44% VecMDot 4ms 0.096% 69.81% 60ms 1.44% VecMXDot_Private 59ms 1.41% 71.22% 59ms 1.41% [[vdso]] 46ms 1.10% 72.33% 56ms 1.34% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 6ms 0.14% 72.47% 56ms 1.34% PetscLogEventBeginDefault 30ms 0.72% 73.19% 53ms 1.27% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 34ms 0.82% 74.00% 53ms 1.27% AbstractOneStepIvpOdeSolver::Solve 5ms 0.12% 74.12% 50ms 1.20% VecCopy 1ms 0.024% 74.15% 50ms 1.20% VecNorm 3ms 0.072% 74.22% 49ms 1.18% VecDot 6ms 0.14% 74.36% 48ms 1.15% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.024% 74.39% 48ms 1.15% VecDestroy 13ms 0.31% 74.70% 47ms 1.13% PetscLogEventEndDefault 1ms 0.024% 74.72% 45ms 1.08% VecDuplicate_Seq 45ms 1.08% 75.80% 45ms 1.08% std::isinf (inline) 44ms 1.06% 76.86% 44ms 1.06% TimeStepper::CalculateNextTime 2ms 0.048% 76.91% 44ms 1.06% VecAXPY 0 0% 76.91% 44ms 1.06% VecNorm_Seq 0 0% 76.91% 42ms 1.01% VecDot_Seq 0 0% 76.91% 42ms 1.01% VecXDot_Seq_Private.constprop.0 2ms 0.048% 76.95% 41ms 0.98% VecDuplicate_MPI 41ms 0.98% 77.94% 41ms 0.98% __memcpy_avx_unaligned_erms 40ms 0.96% 78.90% 40ms 0.96% __ieee754_log_fma 5ms 0.12% 79.02% 39ms 0.94% PetscMallocA 1ms 0.024% 79.04% 38ms 0.91% VecMAXPY 16ms 0.38% 79.42% 37ms 0.89% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 79.42% 37ms 0.89% AbstractBidomainSolver::FinaliseLinearSystem 36ms 0.86% 80.29% 37ms 0.89% VecMDot_Seq 37ms 0.89% 81.18% 37ms 0.89% [libchaste_heart.so] 0 0% 81.18% 36ms 0.86% CxxTest::RealWorldDescription::setUp 0 0% 81.18% 36ms 0.86% PMPI_Init_thread 0 0% 81.18% 36ms 0.86% PetscInitialize 0 0% 81.18% 36ms 0.86% PetscSetup::setUpWorld 0 0% 81.18% 36ms 0.86% PetscSetupUtils::CommonSetup 0 0% 81.18% 36ms 0.86% PetscSetupUtils::InitialisePetsc 0 0% 81.18% 36ms 0.86% ompi_mpi_init 0 0% 81.18% 35ms 0.84% PetscMemcpy (inline) 13ms 0.31% 81.49% 35ms 0.84% top12 (inline) 3ms 0.072% 81.56% 34ms 0.82% PetscMallocAlign 16ms 0.38% 81.94% 34ms 0.82% TimeStepper::AdvanceOneTimeStep 2ms 0.048% 81.99% 34ms 0.82% VecCreate 27ms 0.65% 82.64% 32ms 0.77% AbstractParameterisedSystem::SetAnyVariable 0 0% 82.64% 32ms 0.77% VecAXPY_Seq 0 0% 82.64% 31ms 0.74% VecNorm_MPI 0 0% 82.64% 31ms 0.74% VecNorm_MPI_Default.constprop.0 1ms 0.024% 82.66% 30ms 0.72% 28ms 0.67% 83.33% 28ms 0.67% daxpy_ 2ms 0.048% 83.38% 27ms 0.65% VecCopy_Seq (partial-inline) 22ms 0.53% 83.91% 26ms 0.62% AbstractParameterisedSystem::GetAnyVariable 10ms 0.24% 84.15% 25ms 0.6% __GI___libc_malloc 24ms 0.58% 84.72% 25ms 0.6% std::vector::operator[] (inline) 1ms 0.024% 84.75% 24ms 0.58% VecCreate_MPI_Private 0 0% 84.75% 24ms 0.58% orte_init 12ms 0.29% 85.04% 23ms 0.55% AbstractCardiacCell::GetVoltage (partial-inline) 23ms 0.55% 85.59% 23ms 0.55% DistributedVector::Iterator::operator!= 23ms 0.55% 86.14% 23ms 0.55% asuint64 (inline) 22ms 0.53% 86.67% 22ms 0.53% RegularStimulus::GetStimulus 21ms 0.5% 87.17% 22ms 0.53% VecMAXPY_Seq 2ms 0.048% 87.22% 22ms 0.53% VecSetType 2ms 0.048% 87.27% 22ms 0.53% __posix_memalign 1ms 0.024% 87.29% 21ms 0.5% PetscOptionsFindPair 4ms 0.096% 87.39% 21ms 0.5% std::vector::_M_assign_aux (inline) 0 0% 87.39% 21ms 0.5% std::vector::assign (inline)