File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3635ms, 86.26% of 4214ms total Dropped 462 nodes (cum <= 21.07ms) flat flat% sum% cum cum% 0 0% 0% 4206ms 99.81% __libc_start_call_main 0 0% 0% 4206ms 99.81% __libc_start_main_impl 0 0% 0% 4206ms 99.81% _start 0 0% 0% 4203ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4203ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4203ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4203ms 99.74% main 0 0% 0% 4167ms 98.88% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4167ms 98.88% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4167ms 98.88% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4160ms 98.72% AbstractCardiacProblem::Solve 0 0% 0% 4146ms 98.39% AbstractDynamicLinearPdeSolver::Solve 8ms 0.19% 0.19% 2278ms 54.06% AbstractCardiacTissue::SolveCellSystems 0 0% 0.19% 1584ms 37.59% LinearSystem::Solve 0 0% 0.19% 1543ms 36.62% KSPSolve 4ms 0.095% 0.28% 1543ms 36.62% KSPSolve_Private 5ms 0.12% 0.4% 1501ms 35.62% KSPSolve_SYMMLQ 27ms 0.64% 1.04% 1260ms 29.90% AbstractCardiacCell::ComputeExceptVoltage 30ms 0.71% 1.76% 1072ms 25.44% AbstractOneStepIvpOdeSolver::InternalSolve 3ms 0.071% 1.83% 979ms 23.23% PCApply 1ms 0.024% 1.85% 975ms 23.14% PCApply_BJacobi_Singleblock 53ms 1.26% 3.11% 881ms 20.91% EulerIvpOdeSolver::CalculateNextYValue 212ms 5.03% 8.14% 815ms 19.34% CellLuoRudy1991FromCellML::EvaluateYDerivatives 26ms 0.62% 8.76% 812ms 19.27% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 8.76% 801ms 19.01% KSPSolve_PREONLY (partial-inline) 398ms 9.44% 18.20% 792ms 18.79% __GI___exp 248ms 5.89% 24.09% 759ms 18.01% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.024% 24.11% 742ms 17.61% PCApply_ICC 2ms 0.047% 24.16% 741ms 17.58% MatSolve 727ms 17.25% 41.41% 733ms 17.39% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1ms 0.024% 41.43% 712ms 16.90% KSP_PCApply.lto_priv.18 7ms 0.17% 41.60% 402ms 9.54% MatMult 6ms 0.14% 41.74% 386ms 9.16% MatMult_SeqAIJ (partial-inline) 377ms 8.95% 50.69% 386ms 9.16% MatMult_SeqAIJ_Inode (inline) 353ms 8.38% 59.07% 375ms 8.90% __ieee754_exp_fma 0 0% 59.07% 343ms 8.14% KSP_PCApply (partial-inline) 0 0% 59.07% 339ms 8.04% KSPConvergedDefault 5ms 0.12% 59.18% 268ms 6.36% std::pow (inline) 27ms 0.64% 59.82% 263ms 6.24% __pow 55ms 1.31% 61.13% 248ms 5.89% BidomainSolver::SetupLinearSystem 30ms 0.71% 61.84% 236ms 5.60% __ieee754_pow_fma 73ms 1.73% 63.57% 162ms 3.84% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 63.60% 126ms 2.99% MatNullSpaceRemove 0 0% 63.60% 103ms 2.44% VecDuplicate 102ms 2.42% 66.02% 102ms 2.42% log_inline (inline) 95ms 2.25% 68.27% 98ms 2.33% exp_inline (inline) 28ms 0.66% 68.94% 88ms 2.09% MPI_Wtime 0 0% 68.94% 75ms 1.78% VecMDot 5ms 0.12% 69.06% 75ms 1.78% VecMXDot_Private 41ms 0.97% 70.03% 73ms 1.73% TimeStepper::TimeStepper 13ms 0.31% 70.34% 67ms 1.59% PetscLogEventBeginDefault 1ms 0.024% 70.36% 59ms 1.40% __GI___clock_gettime 12ms 0.28% 70.65% 58ms 1.38% PetscLogEventEndDefault 58ms 1.38% 72.02% 58ms 1.38% [[vdso]] 58ms 1.38% 73.40% 58ms 1.38% ddot_ 0 0% 73.40% 57ms 1.35% VecDuplicate_Seq 4ms 0.095% 73.49% 55ms 1.31% VecCopy 25ms 0.59% 74.09% 54ms 1.28% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 2ms 0.047% 74.13% 51ms 1.21% VecCreate 48ms 1.14% 75.27% 51ms 1.21% VecMDot_Seq 3ms 0.071% 75.34% 50ms 1.19% VecMAXPY 1ms 0.024% 75.37% 47ms 1.12% PetscMallocA 1ms 0.024% 75.39% 47ms 1.12% VecDestroy 0 0% 75.39% 46ms 1.09% PetscMallocAlign (partial-inline) 1ms 0.024% 75.42% 46ms 1.09% VecDuplicate_MPI 2ms 0.047% 75.46% 45ms 1.07% VecDot 43ms 1.02% 76.48% 43ms 1.02% TimeStepper::CalculateNextTime 10ms 0.24% 76.72% 43ms 1.02% std::__cxx11::basic_string::basic_string 35ms 0.83% 77.55% 42ms 1% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 2ms 0.047% 77.60% 40ms 0.95% VecAXPY 0 0% 77.60% 39ms 0.93% KSP_RemoveNullSpace (inline) 0 0% 77.60% 39ms 0.93% VecDot_Seq 0 0% 77.60% 39ms 0.93% VecXDot_Seq_Private.constprop.0 39ms 0.93% 78.52% 39ms 0.93% __memcpy_avx_unaligned_erms 23ms 0.55% 79.07% 38ms 0.9% AbstractOneStepIvpOdeSolver::Solve 37ms 0.88% 79.95% 38ms 0.9% __ieee754_log_fma 1ms 0.024% 79.97% 35ms 0.83% VecNorm 35ms 0.83% 80.80% 35ms 0.83% std::isinf (inline) 0 0% 80.80% 34ms 0.81% PetscMemcpy (inline) 3ms 0.071% 80.87% 34ms 0.81% __posix_memalign 0 0% 80.87% 32ms 0.76% CxxTest::RealWorldDescription::setUp 0 0% 80.87% 32ms 0.76% PetscInitialize 0 0% 80.87% 32ms 0.76% PetscSetup::setUpWorld 0 0% 80.87% 32ms 0.76% PetscSetupUtils::CommonSetup 0 0% 80.87% 32ms 0.76% PetscSetupUtils::InitialisePetsc 8ms 0.19% 81.06% 31ms 0.74% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 81.06% 31ms 0.74% PMPI_Init_thread 0 0% 81.06% 31ms 0.74% ompi_mpi_init 15ms 0.36% 81.42% 30ms 0.71% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.42% 30ms 0.71% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 81.42% 30ms 0.71% VecNorm_Seq 0 0% 81.42% 29ms 0.69% VecCopy_Seq (partial-inline) 4ms 0.095% 81.51% 29ms 0.69% __GI___libc_malloc 15ms 0.36% 81.87% 29ms 0.69% top12 (inline) 24ms 0.57% 82.44% 28ms 0.66% VecMAXPY_Seq 0 0% 82.44% 27ms 0.64% VecCreate_MPI_Private 26ms 0.62% 83.06% 26ms 0.62% DistributedVector::Iterator::operator!= 1ms 0.024% 83.08% 26ms 0.62% VecAXPY_Seq 3ms 0.071% 83.15% 26ms 0.62% VecSet 26ms 0.62% 83.77% 26ms 0.62% [libchaste_heart.so] 7ms 0.17% 83.93% 24ms 0.57% TimeStepper::AdvanceOneTimeStep 15ms 0.36% 84.29% 24ms 0.57% _int_malloc 0 0% 84.29% 24ms 0.57% orte_init 0 0% 84.29% 23ms 0.55% 16ms 0.38% 84.67% 23ms 0.55% AbstractCardiacCell::GetVoltage (partial-inline) 20ms 0.47% 85.14% 23ms 0.55% AbstractParameterisedSystem::GetAnyVariable 2ms 0.047% 85.19% 23ms 0.55% std::char_traits::length (inline) 0 0% 85.19% 22ms 0.52% PetscMemzero (inline) 0 0% 85.19% 22ms 0.52% VecNorm_MPI 1ms 0.024% 85.22% 22ms 0.52% VecNorm_MPI_Default.constprop.0 22ms 0.52% 85.74% 22ms 0.52% __memset_avx2_unaligned_erms 22ms 0.52% 86.26% 22ms 0.52% daxpy_