File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3737ms, 87.15% of 4288ms total Dropped 480 nodes (cum <= 21.44ms) flat flat% sum% cum cum% 0 0% 0% 4281ms 99.84% __libc_start_call_main 0 0% 0% 4281ms 99.84% __libc_start_main_impl 0 0% 0% 4281ms 99.84% _start 0 0% 0% 4278ms 99.77% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4278ms 99.77% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4278ms 99.77% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4278ms 99.77% main 0 0% 0% 4239ms 98.86% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4239ms 98.86% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4239ms 98.86% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4232ms 98.69% AbstractCardiacProblem::Solve 1ms 0.023% 0.023% 4222ms 98.46% AbstractDynamicLinearPdeSolver::Solve 14ms 0.33% 0.35% 2360ms 55.04% AbstractCardiacTissue::SolveCellSystems 0 0% 0.35% 1587ms 37.01% LinearSystem::Solve 0 0% 0.35% 1553ms 36.22% KSPSolve 11ms 0.26% 0.61% 1553ms 36.22% KSPSolve_Private 3ms 0.07% 0.68% 1497ms 34.91% KSPSolve_SYMMLQ 35ms 0.82% 1.49% 1365ms 31.83% AbstractCardiacCell::ComputeExceptVoltage 31ms 0.72% 2.22% 1145ms 26.70% AbstractOneStepIvpOdeSolver::InternalSolve 3ms 0.07% 2.29% 1014ms 23.65% PCApply 0 0% 2.29% 1007ms 23.48% PCApply_BJacobi_Singleblock 44ms 1.03% 3.31% 930ms 21.69% EulerIvpOdeSolver::CalculateNextYValue 243ms 5.67% 8.98% 869ms 20.27% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 8.98% 835ms 19.47% KSPSolve_PREONLY (partial-inline) 395ms 9.21% 18.19% 816ms 19.03% __GI___exp 2ms 0.047% 18.24% 798ms 18.61% MatSolve 0 0% 18.24% 798ms 18.61% PCApply_ICC 21ms 0.49% 18.73% 793ms 18.49% AbstractCardiacTissue::UpdateCaches (inline) 785ms 18.31% 37.03% 788ms 18.38% MatSolve_SeqSBAIJ_1_NaturalOrdering 265ms 6.18% 43.21% 747ms 17.42% CellLuoRudy1991FromCellML::GetIIonic 0 0% 43.21% 717ms 16.72% KSP_PCApply.lto_priv.18 356ms 8.30% 51.52% 398ms 9.28% __ieee754_exp_fma 1ms 0.023% 51.54% 365ms 8.51% KSPConvergedDefault 2ms 0.047% 51.59% 363ms 8.47% MatMult 0 0% 51.59% 359ms 8.37% KSP_PCApply (partial-inline) 1ms 0.023% 51.61% 357ms 8.33% MatMult_SeqAIJ 347ms 8.09% 59.70% 357ms 8.33% MatMult_SeqAIJ_Inode (inline) 1ms 0.023% 59.72% 236ms 5.50% std::pow (inline) 24ms 0.56% 60.28% 235ms 5.48% __pow 41ms 0.96% 61.24% 228ms 5.32% BidomainSolver::SetupLinearSystem 26ms 0.61% 61.85% 210ms 4.90% __ieee754_pow_fma 61ms 1.42% 63.27% 143ms 3.33% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.023% 63.29% 109ms 2.54% VecDuplicate 1ms 0.023% 63.32% 108ms 2.52% MatNullSpaceRemove 95ms 2.22% 65.53% 95ms 2.22% log_inline (inline) 27ms 0.63% 66.16% 78ms 1.82% MPI_Wtime 75ms 1.75% 67.91% 76ms 1.77% exp_inline (inline) 40ms 0.93% 68.84% 67ms 1.56% TimeStepper::TimeStepper 4ms 0.093% 68.94% 65ms 1.52% VecCopy 1ms 0.023% 68.96% 64ms 1.49% VecDuplicate_Seq 0 0% 68.96% 63ms 1.47% VecMDot 3ms 0.07% 69.03% 63ms 1.47% VecMXDot_Private 9ms 0.21% 69.24% 61ms 1.42% PetscLogEventBeginDefault 13ms 0.3% 69.54% 61ms 1.42% PetscLogEventEndDefault 41ms 0.96% 70.50% 54ms 1.26% AbstractOneStepIvpOdeSolver::Solve 9ms 0.21% 70.71% 52ms 1.21% AbstractCardiacCell::SetVoltage (partial-inline) 6ms 0.14% 70.85% 52ms 1.21% PetscMallocA 3ms 0.07% 70.92% 51ms 1.19% VecDestroy 51ms 1.19% 72.11% 51ms 1.19% [[vdso]] 0 0% 72.11% 51ms 1.19% __GI___clock_gettime 51ms 1.19% 73.30% 51ms 1.19% ddot_ 25ms 0.58% 73.88% 51ms 1.19% top12 (inline) 33ms 0.77% 74.65% 47ms 1.10% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 6ms 0.14% 74.79% 47ms 1.10% VecCreate 1ms 0.023% 74.81% 47ms 1.10% VecDot 3ms 0.07% 74.88% 46ms 1.07% PetscMallocAlign (partial-inline) 46ms 1.07% 75.96% 46ms 1.07% VecMDot_Seq 44ms 1.03% 76.98% 44ms 1.03% TimeStepper::CalculateNextTime 0 0% 76.98% 44ms 1.03% VecDuplicate_MPI 6ms 0.14% 77.12% 44ms 1.03% VecMAXPY 44ms 1.03% 78.15% 44ms 1.03% __memcpy_avx_unaligned_erms 12ms 0.28% 78.43% 41ms 0.96% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 78.43% 41ms 0.96% AbstractBidomainSolver::FinaliseLinearSystem 3ms 0.07% 78.50% 41ms 0.96% VecAXPY 0 0% 78.50% 41ms 0.96% VecDot_Seq 1ms 0.023% 78.52% 41ms 0.96% VecXDot_Seq_Private.constprop.0 30ms 0.7% 79.22% 40ms 0.93% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 34ms 0.79% 80.01% 37ms 0.86% AbstractParameterisedSystem::SetAnyVariable 37ms 0.86% 80.88% 37ms 0.86% [libchaste_heart.so] 37ms 0.86% 81.74% 37ms 0.86% std::isinf (inline) 0 0% 81.74% 35ms 0.82% CxxTest::RealWorldDescription::setUp 0 0% 81.74% 35ms 0.82% PMPI_Init_thread 0 0% 81.74% 35ms 0.82% PetscInitialize 0 0% 81.74% 35ms 0.82% PetscMemcpy (inline) 0 0% 81.74% 35ms 0.82% PetscSetup::setUpWorld 0 0% 81.74% 35ms 0.82% PetscSetupUtils::CommonSetup 0 0% 81.74% 35ms 0.82% PetscSetupUtils::InitialisePetsc 14ms 0.33% 82.07% 35ms 0.82% TimeStepper::AdvanceOneTimeStep 0 0% 82.07% 35ms 0.82% ompi_mpi_init 32ms 0.75% 82.81% 32ms 0.75% asuint64 (inline) 30ms 0.7% 83.51% 31ms 0.72% __ieee754_log_fma 14ms 0.33% 83.84% 31ms 0.72% std::__cxx11::basic_string::basic_string 1ms 0.023% 83.86% 28ms 0.65% 1ms 0.023% 83.89% 28ms 0.65% VecCopy_Seq (partial-inline) 1ms 0.023% 83.91% 28ms 0.65% VecCreate_MPI_Private 1ms 0.023% 83.93% 28ms 0.65% VecSetType 0 0% 83.93% 27ms 0.63% PetscMemzero (inline) 0 0% 83.93% 26ms 0.61% VecAXPY_Seq 1ms 0.023% 83.96% 26ms 0.61% VecNorm 26ms 0.61% 84.56% 26ms 0.61% __memset_avx2_unaligned_erms 25ms 0.58% 85.14% 25ms 0.58% DistributedVector::Iterator::operator!= 5ms 0.12% 85.26% 24ms 0.56% PetscHeaderDestroy_Private 24ms 0.56% 85.82% 24ms 0.56% [libm.so.6] 3ms 0.07% 85.89% 24ms 0.56% __posix_memalign 24ms 0.56% 86.45% 24ms 0.56% daxpy_ 23ms 0.54% 86.99% 23ms 0.54% [libchaste_ode.so] 7ms 0.16% 87.15% 23ms 0.54% __GI___libc_malloc 0 0% 87.15% 22ms 0.51% VecCreate_Seq 0 0% 87.15% 22ms 0.51% orte_init