File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3749ms, 87.41% of 4289ms total Dropped 455 nodes (cum <= 21.45ms) flat flat% sum% cum cum% 0 0% 0% 4282ms 99.84% __libc_start_call_main 0 0% 0% 4282ms 99.84% __libc_start_main_impl 0 0% 0% 4282ms 99.84% _start 0 0% 0% 4279ms 99.77% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4279ms 99.77% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4279ms 99.77% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4279ms 99.77% main 0 0% 0% 4241ms 98.88% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4241ms 98.88% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4241ms 98.88% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4235ms 98.74% AbstractCardiacProblem::Solve 3ms 0.07% 0.07% 4220ms 98.39% AbstractDynamicLinearPdeSolver::Solve 14ms 0.33% 0.4% 2306ms 53.77% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.42% 1595ms 37.19% LinearSystem::Solve 0 0% 0.42% 1545ms 36.02% KSPSolve 5ms 0.12% 0.54% 1545ms 36.02% KSPSolve_Private 1ms 0.023% 0.56% 1493ms 34.81% KSPSolve_SYMMLQ 31ms 0.72% 1.28% 1362ms 31.76% AbstractCardiacCell::ComputeExceptVoltage 20ms 0.47% 1.75% 1186ms 27.65% AbstractOneStepIvpOdeSolver::InternalSolve 90ms 2.10% 3.85% 983ms 22.92% EulerIvpOdeSolver::CalculateNextYValue 3ms 0.07% 3.92% 945ms 22.03% PCApply 0 0% 3.92% 932ms 21.73% PCApply_BJacobi_Singleblock 234ms 5.46% 9.37% 880ms 20.52% CellLuoRudy1991FromCellML::EvaluateYDerivatives 351ms 8.18% 17.56% 797ms 18.58% __GI___exp 0 0% 17.56% 778ms 18.14% KSPSolve_PREONLY (partial-inline) 23ms 0.54% 18.09% 739ms 17.23% AbstractCardiacTissue::UpdateCaches (inline) 3ms 0.07% 18.16% 732ms 17.07% MatSolve 0 0% 18.16% 732ms 17.07% PCApply_ICC 718ms 16.74% 34.90% 721ms 16.81% MatSolve_SeqSBAIJ_1_NaturalOrdering 237ms 5.53% 40.43% 688ms 16.04% CellLuoRudy1991FromCellML::GetIIonic 0 0% 40.43% 685ms 15.97% KSP_PCApply.lto_priv.18 4ms 0.093% 40.52% 451ms 10.52% MatMult 2ms 0.047% 40.57% 440ms 10.26% MatMult_SeqAIJ 434ms 10.12% 50.69% 440ms 10.26% MatMult_SeqAIJ_Inode (inline) 390ms 9.09% 59.78% 421ms 9.82% __ieee754_exp_fma 0 0% 59.78% 341ms 7.95% KSPConvergedDefault 0 0% 59.78% 326ms 7.60% KSP_PCApply (partial-inline) 60ms 1.40% 61.18% 278ms 6.48% BidomainSolver::SetupLinearSystem 1ms 0.023% 61.20% 232ms 5.41% std::pow (inline) 12ms 0.28% 61.48% 231ms 5.39% __pow 28ms 0.65% 62.14% 219ms 5.11% __ieee754_pow_fma 66ms 1.54% 63.67% 142ms 3.31% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.023% 63.70% 121ms 2.82% MatNullSpaceRemove 0 0% 63.70% 107ms 2.49% VecDuplicate 95ms 2.21% 65.91% 95ms 2.21% log_inline (inline) 90ms 2.10% 68.01% 90ms 2.10% exp_inline (inline) 21ms 0.49% 68.50% 78ms 1.82% MPI_Wtime 0 0% 68.50% 75ms 1.75% VecMDot 9ms 0.21% 68.71% 75ms 1.75% VecMXDot_Private 41ms 0.96% 69.67% 70ms 1.63% TimeStepper::TimeStepper 60ms 1.40% 71.07% 60ms 1.40% ddot_ 2ms 0.047% 71.11% 57ms 1.33% __GI___clock_gettime 12ms 0.28% 71.39% 56ms 1.31% PetscLogEventEndDefault 55ms 1.28% 72.67% 55ms 1.28% TimeStepper::CalculateNextTime 55ms 1.28% 73.96% 55ms 1.28% [[vdso]] 1ms 0.023% 73.98% 54ms 1.26% VecDestroy 2ms 0.047% 74.03% 54ms 1.26% VecDuplicate_MPI 11ms 0.26% 74.28% 53ms 1.24% PetscLogEventBeginDefault 4ms 0.093% 74.38% 53ms 1.24% VecAXPY 2ms 0.047% 74.42% 53ms 1.24% VecDuplicate_Seq 4ms 0.093% 74.52% 52ms 1.21% VecCopy 51ms 1.19% 75.71% 52ms 1.21% VecMDot_Seq 7ms 0.16% 75.87% 47ms 1.10% AbstractCardiacCell::SetVoltage (partial-inline) 6ms 0.14% 76.01% 46ms 1.07% VecCreate 46ms 1.07% 77.08% 46ms 1.07% __ieee754_log_fma 5ms 0.12% 77.20% 45ms 1.05% VecMAXPY 2ms 0.047% 77.24% 41ms 0.96% VecDot 18ms 0.42% 77.66% 39ms 0.91% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 10ms 0.23% 77.90% 38ms 0.89% TimeStepper::AdvanceOneTimeStep 0 0% 77.90% 38ms 0.89% VecDot_Seq 0 0% 77.90% 38ms 0.89% VecNorm 0 0% 77.90% 38ms 0.89% VecXDot_Seq_Private.constprop.0 26ms 0.61% 78.50% 37ms 0.86% AbstractOneStepIvpOdeSolver::Solve 6ms 0.14% 78.64% 37ms 0.86% PetscMallocA 35ms 0.82% 79.46% 35ms 0.82% __memcpy_avx_unaligned_erms 28ms 0.65% 80.11% 34ms 0.79% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 29ms 0.68% 80.79% 34ms 0.79% AbstractParameterisedSystem::SetAnyVariable 0 0% 80.79% 34ms 0.79% PetscTimeSubtract (inline) 0 0% 80.79% 34ms 0.79% VecAXPY_Seq 13ms 0.3% 81.09% 33ms 0.77% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.09% 33ms 0.77% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 81.09% 33ms 0.77% CxxTest::RealWorldDescription::setUp 0 0% 81.09% 33ms 0.77% PetscInitialize 0 0% 81.09% 33ms 0.77% PetscSetup::setUpWorld 0 0% 81.09% 33ms 0.77% PetscSetupUtils::CommonSetup 0 0% 81.09% 33ms 0.77% PetscSetupUtils::InitialisePetsc 1ms 0.023% 81.11% 33ms 0.77% VecNorm_Seq 33ms 0.77% 81.88% 33ms 0.77% std::isinf (inline) 0 0% 81.88% 32ms 0.75% PMPI_Init_thread 32ms 0.75% 82.63% 32ms 0.75% [libchaste_heart.so] 32ms 0.75% 83.38% 32ms 0.75% daxpy_ 0 0% 83.38% 32ms 0.75% ompi_mpi_init 1ms 0.023% 83.40% 31ms 0.72% PetscMallocAlign (partial-inline) 0 0% 83.40% 30ms 0.7% PetscMemcpy (inline) 11ms 0.26% 83.66% 30ms 0.7% top12 (inline) 1ms 0.023% 83.68% 29ms 0.68% VecCopy_Seq (partial-inline) 1ms 0.023% 83.70% 28ms 0.65% VecCreate_MPI_Private 1ms 0.023% 83.73% 28ms 0.65% VecSetType 24ms 0.56% 84.29% 27ms 0.63% VecMAXPY_Seq 26ms 0.61% 84.89% 26ms 0.61% asuint64 (inline) 9ms 0.21% 85.10% 26ms 0.61% std::__cxx11::basic_string::basic_string 2ms 0.047% 85.15% 25ms 0.58% 0 0% 85.15% 25ms 0.58% PetscMemzero (inline) 0 0% 85.15% 25ms 0.58% VecNorm_MPI 0 0% 85.15% 25ms 0.58% VecNorm_MPI_Default.constprop.0 25ms 0.58% 85.73% 25ms 0.58% [libm.so.6] 3ms 0.07% 85.80% 24ms 0.56% PetscHeaderCreate_Private 23ms 0.54% 86.34% 23ms 0.54% RegularStimulus::GetStimulus 23ms 0.54% 86.87% 23ms 0.54% __memset_avx2_unaligned_erms 0 0% 86.87% 23ms 0.54% orte_init 22ms 0.51% 87.39% 22ms 0.51% DistributedVector::Iterator::operator!= 1ms 0.023% 87.41% 22ms 0.51% VecDestroy_MPI