File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3664ms, 87.16% of 4204ms total Dropped 467 nodes (cum <= 21.02ms) flat flat% sum% cum cum% 0 0% 0% 4196ms 99.81% __libc_start_call_main 0 0% 0% 4196ms 99.81% __libc_start_main_impl 0 0% 0% 4196ms 99.81% _start 0 0% 0% 4193ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4193ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4193ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4193ms 99.74% main 0 0% 0% 4158ms 98.91% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4158ms 98.91% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4158ms 98.91% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4150ms 98.72% AbstractCardiacProblem::Solve 0 0% 0% 4139ms 98.45% AbstractDynamicLinearPdeSolver::Solve 18ms 0.43% 0.43% 2293ms 54.54% AbstractCardiacTissue::SolveCellSystems 0 0% 0.43% 1556ms 37.01% LinearSystem::Solve 0 0% 0.43% 1506ms 35.82% KSPSolve 7ms 0.17% 0.59% 1506ms 35.82% KSPSolve_Private 2ms 0.048% 0.64% 1454ms 34.59% KSPSolve_SYMMLQ 35ms 0.83% 1.47% 1318ms 31.35% AbstractCardiacCell::ComputeExceptVoltage 31ms 0.74% 2.21% 1117ms 26.57% AbstractOneStepIvpOdeSolver::InternalSolve 70ms 1.67% 3.88% 928ms 22.07% EulerIvpOdeSolver::CalculateNextYValue 4ms 0.095% 3.97% 917ms 21.81% PCApply 0 0% 3.97% 901ms 21.43% PCApply_BJacobi_Singleblock 232ms 5.52% 9.49% 849ms 20.20% CellLuoRudy1991FromCellML::EvaluateYDerivatives 313ms 7.45% 16.94% 781ms 18.58% __GI___exp 36ms 0.86% 17.79% 753ms 17.91% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 17.79% 752ms 17.89% KSPSolve_PREONLY (partial-inline) 243ms 5.78% 23.57% 696ms 16.56% CellLuoRudy1991FromCellML::GetIIonic 5ms 0.12% 23.69% 692ms 16.46% MatSolve 0 0% 23.69% 692ms 16.46% PCApply_ICC 679ms 16.15% 39.84% 683ms 16.25% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 39.84% 652ms 15.51% KSP_PCApply.lto_priv.18 408ms 9.71% 49.55% 447ms 10.63% __ieee754_exp_fma 4ms 0.095% 49.64% 430ms 10.23% MatMult 4ms 0.095% 49.74% 421ms 10.01% MatMult_SeqAIJ 414ms 9.85% 59.59% 421ms 10.01% MatMult_SeqAIJ_Inode (inline) 0 0% 59.59% 334ms 7.94% KSPConvergedDefault 0 0% 59.59% 334ms 7.94% KSP_PCApply (partial-inline) 46ms 1.09% 60.68% 249ms 5.92% BidomainSolver::SetupLinearSystem 1ms 0.024% 60.70% 237ms 5.64% std::pow (inline) 21ms 0.5% 61.20% 236ms 5.61% __pow 33ms 0.78% 61.99% 215ms 5.11% __ieee754_pow_fma 91ms 2.16% 64.15% 168ms 4.00% CellLuoRudy1991FromCellML::VerifyStateVariables 2ms 0.048% 64.20% 117ms 2.78% MatNullSpaceRemove 0 0% 64.20% 104ms 2.47% VecDuplicate 97ms 2.31% 66.51% 97ms 2.31% log_inline (inline) 19ms 0.45% 66.96% 85ms 2.02% MPI_Wtime 73ms 1.74% 68.70% 75ms 1.78% exp_inline (inline) 27ms 0.64% 69.34% 68ms 1.62% TimeStepper::TimeStepper 0 0% 69.34% 67ms 1.59% VecMDot 5ms 0.12% 69.46% 67ms 1.59% VecMXDot_Private 67ms 1.59% 71.05% 67ms 1.59% ddot_ 66ms 1.57% 72.62% 66ms 1.57% [[vdso]] 0 0% 72.62% 66ms 1.57% __GI___clock_gettime 12ms 0.29% 72.91% 65ms 1.55% PetscLogEventBeginDefault 2ms 0.048% 72.95% 59ms 1.40% VecDuplicate_MPI 10ms 0.24% 73.19% 57ms 1.36% PetscLogEventEndDefault 1ms 0.024% 73.22% 54ms 1.28% VecDot 7ms 0.17% 73.38% 50ms 1.19% VecAXPY 2ms 0.048% 73.43% 50ms 1.19% VecDestroy 2ms 0.048% 73.48% 48ms 1.14% VecMAXPY 2ms 0.048% 73.53% 48ms 1.14% VecNorm 43ms 1.02% 74.55% 47ms 1.12% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 36ms 0.86% 75.40% 46ms 1.09% AbstractOneStepIvpOdeSolver::Solve 6ms 0.14% 75.55% 46ms 1.09% VecCopy 20ms 0.48% 76.02% 46ms 1.09% top12 (inline) 28ms 0.67% 76.69% 45ms 1.07% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 76.69% 45ms 1.07% VecDot_Seq 1ms 0.024% 76.71% 45ms 1.07% VecDuplicate_Seq 0 0% 76.71% 45ms 1.07% VecXDot_Seq_Private.constprop.0 3ms 0.071% 76.78% 43ms 1.02% VecCreate 42ms 1% 77.78% 43ms 1.02% VecMDot_Seq 40ms 0.95% 78.73% 40ms 0.95% __ieee754_log_fma 8ms 0.19% 78.92% 39ms 0.93% PetscMallocA 10ms 0.24% 79.16% 36ms 0.86% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 79.16% 36ms 0.86% AbstractBidomainSolver::FinaliseLinearSystem 5ms 0.12% 79.28% 36ms 0.86% AbstractCardiacCell::SetVoltage (partial-inline) 35ms 0.83% 80.11% 35ms 0.83% TimeStepper::CalculateNextTime 35ms 0.83% 80.95% 35ms 0.83% __memcpy_avx_unaligned_erms 0 0% 80.95% 34ms 0.81% VecNorm_Seq 1ms 0.024% 80.97% 33ms 0.78% VecCreate_MPI_Private 31ms 0.74% 81.71% 33ms 0.78% VecMAXPY_Seq 1ms 0.024% 81.73% 31ms 0.74% PetscMallocAlign 0 0% 81.73% 31ms 0.74% PetscMemcpy (inline) 31ms 0.74% 82.47% 31ms 0.74% asuint64 (inline) 14ms 0.33% 82.80% 31ms 0.74% std::__cxx11::basic_string::basic_string 0 0% 82.80% 30ms 0.71% CxxTest::RealWorldDescription::setUp 0 0% 82.80% 30ms 0.71% PMPI_Init_thread 0 0% 82.80% 30ms 0.71% PetscInitialize 0 0% 82.80% 30ms 0.71% PetscSetup::setUpWorld 0 0% 82.80% 30ms 0.71% PetscSetupUtils::CommonSetup 0 0% 82.80% 30ms 0.71% PetscSetupUtils::InitialisePetsc 30ms 0.71% 83.52% 30ms 0.71% [libchaste_heart.so] 0 0% 83.52% 30ms 0.71% ompi_mpi_init 29ms 0.69% 84.21% 29ms 0.69% std::isinf (inline) 2ms 0.048% 84.25% 28ms 0.67% VecAXPY_Seq 25ms 0.59% 84.85% 27ms 0.64% AbstractParameterisedSystem::SetAnyVariable 0 0% 84.85% 27ms 0.64% VecNorm_MPI 0 0% 84.85% 27ms 0.64% VecNorm_MPI_Default.constprop.0 21ms 0.5% 85.35% 25ms 0.59% AbstractParameterisedSystem::GetAnyVariable 0 0% 85.35% 24ms 0.57% 2ms 0.048% 85.39% 24ms 0.57% VecSetType 24ms 0.57% 85.97% 24ms 0.57% [libchaste_ode.so] 24ms 0.57% 86.54% 24ms 0.57% daxpy_ 5ms 0.12% 86.66% 23ms 0.55% __GI___libc_malloc 4ms 0.095% 86.75% 23ms 0.55% __posix_memalign 4ms 0.095% 86.85% 22ms 0.52% PMPI_Comm_get_attr 13ms 0.31% 87.16% 22ms 0.52% TimeStepper::AdvanceOneTimeStep