File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3693ms, 88.82% of 4158ms total Dropped 421 nodes (cum <= 20.79ms) flat flat% sum% cum cum% 0 0% 0% 4151ms 99.83% __libc_start_call_main 0 0% 0% 4151ms 99.83% __libc_start_main_impl 0 0% 0% 4151ms 99.83% _start 0 0% 0% 4148ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4148ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4148ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4148ms 99.76% main 0 0% 0% 4117ms 99.01% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4117ms 99.01% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4117ms 99.01% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4109ms 98.82% AbstractCardiacProblem::Solve 0 0% 0% 4100ms 98.61% AbstractDynamicLinearPdeSolver::Solve 17ms 0.41% 0.41% 2372ms 57.05% AbstractCardiacTissue::SolveCellSystems 36ms 0.87% 1.27% 1416ms 34.05% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.27% 1385ms 33.31% LinearSystem::Solve 0 0% 1.27% 1339ms 32.20% KSPSolve 6ms 0.14% 1.42% 1339ms 32.20% KSPSolve_Private 4ms 0.096% 1.52% 1300ms 31.27% KSPSolve_SYMMLQ 25ms 0.6% 2.12% 1214ms 29.20% AbstractOneStepIvpOdeSolver::InternalSolve 74ms 1.78% 3.90% 1002ms 24.10% EulerIvpOdeSolver::CalculateNextYValue 259ms 6.23% 10.13% 913ms 21.96% CellLuoRudy1991FromCellML::EvaluateYDerivatives 386ms 9.28% 19.41% 840ms 20.20% __GI___exp 0 0% 19.41% 804ms 19.34% PCApply 1ms 0.024% 19.43% 799ms 19.22% PCApply_BJacobi_Singleblock 20ms 0.48% 19.91% 745ms 17.92% AbstractCardiacTissue::UpdateCaches (inline) 213ms 5.12% 25.04% 694ms 16.69% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.024% 25.06% 669ms 16.09% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 25.08% 630ms 15.15% PCApply_ICC 2ms 0.048% 25.13% 629ms 15.13% MatSolve 621ms 14.94% 40.07% 626ms 15.06% MatSolve_SeqSBAIJ_1_NaturalOrdering 1ms 0.024% 40.09% 609ms 14.65% KSP_PCApply.lto_priv.18 401ms 9.64% 49.74% 436ms 10.49% __ieee754_exp_fma 2ms 0.048% 49.78% 410ms 9.86% MatMult 3ms 0.072% 49.86% 404ms 9.72% MatMult_SeqAIJ 394ms 9.48% 59.33% 404ms 9.72% MatMult_SeqAIJ_Inode (inline) 59ms 1.42% 60.75% 308ms 7.41% BidomainSolver::SetupLinearSystem 3ms 0.072% 60.82% 286ms 6.88% KSPConvergedDefault 0 0% 60.82% 266ms 6.40% KSP_PCApply (partial-inline) 2ms 0.048% 60.87% 237ms 5.70% std::pow (inline) 28ms 0.67% 61.54% 234ms 5.63% __pow 18ms 0.43% 61.98% 206ms 4.95% __ieee754_pow_fma 63ms 1.52% 63.49% 142ms 3.42% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 63.52% 116ms 2.79% MatNullSpaceRemove 94ms 2.26% 65.78% 94ms 2.26% log_inline (inline) 2ms 0.048% 65.82% 92ms 2.21% VecDuplicate 87ms 2.09% 67.92% 88ms 2.12% exp_inline (inline) 28ms 0.67% 68.59% 79ms 1.90% MPI_Wtime 42ms 1.01% 69.60% 74ms 1.78% TimeStepper::TimeStepper 0 0% 69.60% 67ms 1.61% VecMDot 4ms 0.096% 69.70% 67ms 1.61% VecMXDot_Private 7ms 0.17% 69.87% 63ms 1.52% PetscLogEventBeginDefault 5ms 0.12% 69.99% 59ms 1.42% VecCopy 56ms 1.35% 71.33% 56ms 1.35% ddot_ 40ms 0.96% 72.29% 54ms 1.30% AbstractOneStepIvpOdeSolver::Solve 51ms 1.23% 73.52% 51ms 1.23% TimeStepper::CalculateNextTime 51ms 1.23% 74.75% 51ms 1.23% [[vdso]] 0 0% 74.75% 51ms 1.23% __GI___clock_gettime 2ms 0.048% 74.80% 48ms 1.15% VecDuplicate_MPI 6ms 0.14% 74.94% 48ms 1.15% VecMAXPY 1ms 0.024% 74.96% 48ms 1.15% VecNorm 12ms 0.29% 75.25% 47ms 1.13% AbstractCardiacCell::SetVoltage (partial-inline) 9ms 0.22% 75.47% 47ms 1.13% PetscLogEventEndDefault 0 0% 75.47% 43ms 1.03% VecDot 0 0% 75.47% 42ms 1.01% VecDuplicate_Seq 39ms 0.94% 76.41% 41ms 0.99% VecMDot_Seq 41ms 0.99% 77.39% 41ms 0.99% [libchaste_heart.so] 13ms 0.31% 77.71% 39ms 0.94% TimeStepper::AdvanceOneTimeStep 14ms 0.34% 78.04% 39ms 0.94% top12 (inline) 17ms 0.41% 78.45% 37ms 0.89% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 35ms 0.84% 79.29% 37ms 0.89% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 4ms 0.096% 79.39% 37ms 0.89% PetscMallocA 36ms 0.87% 80.25% 37ms 0.89% __ieee754_log_fma 0 0% 80.25% 36ms 0.87% VecAXPY 0 0% 80.25% 36ms 0.87% VecDot_Seq 1ms 0.024% 80.28% 36ms 0.87% VecXDot_Seq_Private.constprop.0 0 0% 80.28% 35ms 0.84% VecCreate 1ms 0.024% 80.30% 34ms 0.82% VecDestroy 0 0% 80.30% 34ms 0.82% VecNorm_Seq 34ms 0.82% 81.12% 34ms 0.82% __memcpy_avx_unaligned_erms 34ms 0.82% 81.94% 34ms 0.82% std::isinf (inline) 2ms 0.048% 81.99% 33ms 0.79% PetscMallocAlign 0 0% 81.99% 32ms 0.77% PetscMemcpy (inline) 0 0% 81.99% 31ms 0.75% AbstractBidomainSolver::FinaliseLinearSystem 17ms 0.41% 82.40% 30ms 0.72% AbstractBidomainSolver::CheckCompatibilityCondition 2ms 0.048% 82.44% 30ms 0.72% VecCopy_Seq (partial-inline) 26ms 0.63% 83.07% 29ms 0.7% AbstractParameterisedSystem::SetAnyVariable 1ms 0.024% 83.09% 29ms 0.7% VecCreate_MPI_Private 29ms 0.7% 83.79% 29ms 0.7% asuint64 (inline) 0 0% 83.79% 28ms 0.67% VecNorm_MPI 1ms 0.024% 83.81% 28ms 0.67% VecNorm_MPI_Default.constprop.0 23ms 0.55% 84.37% 27ms 0.65% AbstractParameterisedSystem::GetAnyVariable 27ms 0.65% 85.02% 27ms 0.65% std::vector::operator[] (inline) 0 0% 85.02% 26ms 0.63% CxxTest::RealWorldDescription::setUp 0 0% 85.02% 26ms 0.63% PetscInitialize 0 0% 85.02% 26ms 0.63% PetscSetup::setUpWorld 0 0% 85.02% 26ms 0.63% PetscSetupUtils::CommonSetup 0 0% 85.02% 26ms 0.63% PetscSetupUtils::InitialisePetsc 25ms 0.6% 85.62% 26ms 0.63% VecMAXPY_Seq 0 0% 85.62% 25ms 0.6% PMPI_Init_thread 0 0% 85.62% 25ms 0.6% ompi_mpi_init 8ms 0.19% 85.81% 25ms 0.6% std::__cxx11::basic_string::basic_string 10ms 0.24% 86.05% 24ms 0.58% AbstractCardiacCell::GetVoltage (partial-inline) 0 0% 86.05% 24ms 0.58% VecAXPY_Seq 4ms 0.096% 86.15% 24ms 0.58% VecSetType 24ms 0.58% 86.72% 24ms 0.58% [libchaste_ode.so] 23ms 0.55% 87.28% 23ms 0.55% DistributedVector::Stripe::operator[] (inline) 23ms 0.55% 87.83% 23ms 0.55% daxpy_ 22ms 0.53% 88.36% 22ms 0.53% RegularStimulus::GetStimulus 1ms 0.024% 88.38% 21ms 0.51% 18ms 0.43% 88.82% 21ms 0.51% PetscStageLogGetCurrent