File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3712ms, 87.51% of 4242ms total Dropped 431 nodes (cum <= 21.21ms) flat flat% sum% cum cum% 0 0% 0% 4235ms 99.83% __libc_start_call_main 0 0% 0% 4235ms 99.83% __libc_start_main_impl 0 0% 0% 4235ms 99.83% _start 0 0% 0% 4232ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4232ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4232ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4232ms 99.76% main 0 0% 0% 4197ms 98.94% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4197ms 98.94% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4197ms 98.94% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4191ms 98.80% AbstractCardiacProblem::Solve 0 0% 0% 4181ms 98.56% AbstractDynamicLinearPdeSolver::Solve 20ms 0.47% 0.47% 2314ms 54.55% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.5% 1575ms 37.13% LinearSystem::Solve 0 0% 0.5% 1529ms 36.04% KSPSolve 8ms 0.19% 0.68% 1529ms 36.04% KSPSolve_Private 1ms 0.024% 0.71% 1491ms 35.15% KSPSolve_SYMMLQ 49ms 1.16% 1.86% 1343ms 31.66% AbstractCardiacCell::ComputeExceptVoltage 25ms 0.59% 2.45% 1128ms 26.59% AbstractOneStepIvpOdeSolver::InternalSolve 58ms 1.37% 3.82% 946ms 22.30% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.024% 3.84% 919ms 21.66% PCApply 3ms 0.071% 3.91% 906ms 21.36% PCApply_BJacobi_Singleblock 239ms 5.63% 9.55% 870ms 20.51% CellLuoRudy1991FromCellML::EvaluateYDerivatives 357ms 8.42% 17.96% 812ms 19.14% __GI___exp 28ms 0.66% 18.62% 752ms 17.73% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 18.62% 745ms 17.56% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 18.65% 705ms 16.62% PCApply_ICC 7ms 0.17% 18.81% 704ms 16.60% MatSolve 237ms 5.59% 24.40% 697ms 16.43% CellLuoRudy1991FromCellML::GetIIonic 685ms 16.15% 40.55% 692ms 16.31% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 40.55% 691ms 16.29% KSP_PCApply.lto_priv.18 10ms 0.24% 40.78% 445ms 10.49% MatMult 4ms 0.094% 40.88% 431ms 10.16% MatMult_SeqAIJ 423ms 9.97% 50.85% 431ms 10.16% MatMult_SeqAIJ_Inode (inline) 393ms 9.26% 60.11% 428ms 10.09% __ieee754_exp_fma 1ms 0.024% 60.14% 311ms 7.33% KSPConvergedDefault 0 0% 60.14% 295ms 6.95% KSP_PCApply (partial-inline) 53ms 1.25% 61.39% 261ms 6.15% BidomainSolver::SetupLinearSystem 1ms 0.024% 61.41% 222ms 5.23% std::pow (inline) 32ms 0.75% 62.16% 221ms 5.21% __pow 23ms 0.54% 62.71% 189ms 4.46% __ieee754_pow_fma 73ms 1.72% 64.43% 156ms 3.68% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 64.45% 109ms 2.57% MatNullSpaceRemove 0 0% 64.45% 103ms 2.43% VecDuplicate 86ms 2.03% 66.48% 86ms 2.03% log_inline (inline) 74ms 1.74% 68.22% 74ms 1.74% ddot_ 69ms 1.63% 69.85% 72ms 1.70% exp_inline (inline) 16ms 0.38% 70.23% 71ms 1.67% MPI_Wtime 17ms 0.4% 70.63% 67ms 1.58% PetscLogEventBeginDefault 30ms 0.71% 71.33% 65ms 1.53% TimeStepper::TimeStepper 0 0% 71.33% 63ms 1.49% VecMDot 7ms 0.17% 71.50% 63ms 1.49% VecMXDot_Private 3ms 0.071% 71.57% 58ms 1.37% VecCopy 1ms 0.024% 71.59% 58ms 1.37% VecDuplicate_Seq 13ms 0.31% 71.90% 57ms 1.34% AbstractCardiacCell::SetVoltage (partial-inline) 2ms 0.047% 71.95% 53ms 1.25% VecDot 1ms 0.024% 71.97% 53ms 1.25% __GI___clock_gettime 52ms 1.23% 73.20% 52ms 1.23% [[vdso]] 1ms 0.024% 73.22% 50ms 1.18% VecNorm 0 0% 73.22% 48ms 1.13% VecCreate 0 0% 73.22% 45ms 1.06% VecDot_Seq 1ms 0.024% 73.24% 45ms 1.06% VecDuplicate_MPI 4ms 0.094% 73.34% 45ms 1.06% VecMAXPY 0 0% 73.34% 45ms 1.06% VecXDot_Seq_Private.constprop.0 11ms 0.26% 73.60% 44ms 1.04% PetscLogEventEndDefault 17ms 0.4% 74.00% 44ms 1.04% top12 (inline) 35ms 0.83% 74.82% 43ms 1.01% AbstractOneStepIvpOdeSolver::Solve 0 0% 74.82% 43ms 1.01% VecNorm_Seq 8ms 0.19% 75.01% 42ms 0.99% PetscMallocA 38ms 0.9% 75.91% 42ms 0.99% VecMDot_Seq 41ms 0.97% 76.87% 41ms 0.97% TimeStepper::CalculateNextTime 3ms 0.071% 76.94% 41ms 0.97% VecAXPY 41ms 0.97% 77.91% 41ms 0.97% __memcpy_avx_unaligned_erms 23ms 0.54% 78.45% 39ms 0.92% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 34ms 0.8% 79.26% 39ms 0.92% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.024% 79.28% 39ms 0.92% PetscTimeSubtract (inline) 3ms 0.071% 79.35% 38ms 0.9% VecDestroy 37ms 0.87% 80.22% 37ms 0.87% std::isinf (inline) 36ms 0.85% 81.07% 36ms 0.85% __ieee754_log_fma 6ms 0.14% 81.21% 34ms 0.8% PetscMallocAlign (partial-inline) 1ms 0.024% 81.24% 33ms 0.78% VecAXPY_Seq 0 0% 81.24% 33ms 0.78% VecNorm_MPI 0 0% 81.24% 33ms 0.78% VecNorm_MPI_Default.constprop.0 18ms 0.42% 81.66% 32ms 0.75% TimeStepper::AdvanceOneTimeStep 32ms 0.75% 82.41% 32ms 0.75% [libchaste_heart.so] 30ms 0.71% 83.12% 31ms 0.73% AbstractParameterisedSystem::SetAnyVariable 0 0% 83.12% 31ms 0.73% CxxTest::RealWorldDescription::setUp 31ms 0.73% 83.85% 31ms 0.73% DistributedVector::Iterator::operator!= 0 0% 83.85% 31ms 0.73% PMPI_Init_thread 0 0% 83.85% 31ms 0.73% PetscInitialize 0 0% 83.85% 31ms 0.73% PetscSetup::setUpWorld 0 0% 83.85% 31ms 0.73% PetscSetupUtils::CommonSetup 0 0% 83.85% 31ms 0.73% PetscSetupUtils::InitialisePetsc 0 0% 83.85% 31ms 0.73% ompi_mpi_init 0 0% 83.85% 30ms 0.71% VecCreate_MPI_Private 30ms 0.71% 84.56% 30ms 0.71% daxpy_ 29ms 0.68% 85.24% 29ms 0.68% asuint64 (inline) 1ms 0.024% 85.27% 28ms 0.66% AbstractBidomainSolver::FinaliseLinearSystem 1ms 0.024% 85.29% 28ms 0.66% VecCopy_Seq (partial-inline) 12ms 0.28% 85.57% 28ms 0.66% std::__cxx11::basic_string::basic_string 4ms 0.094% 85.67% 27ms 0.64% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 85.67% 27ms 0.64% PetscMemcpy (inline) 27ms 0.64% 86.30% 27ms 0.64% [libm.so.6] 21ms 0.5% 86.80% 26ms 0.61% VecMAXPY_Seq 1ms 0.024% 86.82% 25ms 0.59% 3ms 0.071% 86.89% 25ms 0.59% PetscHeaderCreate_Private 24ms 0.57% 87.46% 24ms 0.57% DistributedVector::Stripe::operator[] (inline) 0 0% 87.46% 23ms 0.54% PetscMemzero (inline) 2ms 0.047% 87.51% 22ms 0.52% VecSetType 0 0% 87.51% 22ms 0.52% orte_init