File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3903ms, 89.60% of 4356ms total Dropped 396 nodes (cum <= 21.78ms) flat flat% sum% cum cum% 0 0% 0% 4346ms 99.77% __libc_start_call_main 0 0% 0% 4346ms 99.77% __libc_start_main_impl 0 0% 0% 4346ms 99.77% _start 0 0% 0% 4343ms 99.70% main 0 0% 0% 4299ms 98.69% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4292ms 98.53% AbstractCardiacProblem::Solve 4ms 0.092% 0.092% 4283ms 98.32% AbstractDynamicLinearPdeSolver::Solve 71ms 1.63% 1.72% 2219ms 50.94% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 1.74% 1556ms 35.72% LinearSystem::Solve 0 0% 1.74% 1464ms 33.61% KSPSolve 5ms 0.11% 1.86% 1464ms 33.61% KSPSolve_Private 5ms 0.11% 1.97% 1392ms 31.96% KSPSolve_SYMMLQ 31ms 0.71% 2.69% 1233ms 28.31% AbstractCardiacCell::ComputeExceptVoltage 34ms 0.78% 3.47% 1071ms 24.59% AbstractOneStepIvpOdeSolver::InternalSolve 61ms 1.40% 4.87% 892ms 20.48% EulerIvpOdeSolver::CalculateNextYValue 229ms 5.26% 10.12% 825ms 18.94% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 10.12% 780ms 17.91% PCApply 2ms 0.046% 10.17% 776ms 17.81% PCApply_BJacobi_Singleblock 356ms 8.17% 18.34% 744ms 17.08% __GI___exp 277ms 6.36% 24.70% 708ms 16.25% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.70% 693ms 15.91% KSP_PCApply.lto_priv.18 0 0% 24.70% 649ms 14.90% KSPSolve_PREONLY 2ms 0.046% 24.75% 615ms 14.12% PCApply_ICC 3ms 0.069% 24.82% 613ms 14.07% MatSolve 603ms 13.84% 38.66% 610ms 14.00% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 6ms 0.14% 38.80% 596ms 13.68% MatMult 14ms 0.32% 39.12% 577ms 13.25% MatMult_SeqAIJ (partial-inline) 554ms 12.72% 51.84% 576ms 13.22% MatMult_SeqAIJ_Inode (inline) 86ms 1.97% 53.81% 430ms 9.87% BidomainSolver::SetupLinearSystem 308ms 7.07% 60.88% 357ms 8.20% __ieee754_exp_fma 18ms 0.41% 61.29% 210ms 4.82% __pow 11ms 0.25% 61.55% 192ms 4.41% __ieee754_pow_fma 0 0% 61.55% 146ms 3.35% KSPConvergedDefault 0 0% 61.55% 146ms 3.35% KSP_PCApply (partial-inline) 1ms 0.023% 61.57% 123ms 2.82% VecDuplicate 82ms 1.88% 63.45% 107ms 2.46% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.023% 63.48% 105ms 2.41% MatNullSpaceRemove 103ms 2.36% 65.84% 103ms 2.36% log_inline (inline) 23ms 0.53% 66.37% 94ms 2.16% MPI_Wtime 5ms 0.11% 66.48% 77ms 1.77% VecDuplicate_MPI (partial-inline) 7ms 0.16% 66.64% 76ms 1.74% VecCopy 2ms 0.046% 66.69% 71ms 1.63% __GI___clock_gettime 69ms 1.58% 68.27% 69ms 1.58% [[vdso]] 67ms 1.54% 69.81% 68ms 1.56% exp_inline (inline) 33ms 0.76% 70.57% 67ms 1.54% TimeStepper::TimeStepper 0 0% 70.57% 65ms 1.49% AbstractBidomainSolver::FinaliseLinearSystem 8ms 0.18% 70.75% 65ms 1.49% PetscLogEventBeginDefault 13ms 0.3% 71.05% 65ms 1.49% PetscLogEventEndDefault 0 0% 71.05% 65ms 1.49% VecMDot 2ms 0.046% 71.10% 65ms 1.49% VecMXDot_Private 23ms 0.53% 71.63% 64ms 1.47% AbstractBidomainSolver::CheckCompatibilityCondition 2ms 0.046% 71.67% 61ms 1.40% VecNorm 61ms 1.40% 73.07% 61ms 1.40% __memcpy_avx_unaligned_erms 58ms 1.33% 74.40% 58ms 1.33% ddot_ 9ms 0.21% 74.61% 57ms 1.31% PetscMallocA 3ms 0.069% 74.68% 56ms 1.29% VecAXPY 53ms 1.22% 75.90% 53ms 1.22% VecMDot_Seq 0 0% 75.90% 49ms 1.12% PetscMemcpy (inline) 49ms 1.12% 77.02% 49ms 1.12% [libchaste_heart.so] 4ms 0.092% 77.11% 48ms 1.10% PetscMallocAlign (partial-inline) 0 0% 77.11% 48ms 1.10% VecDot 2ms 0.046% 77.16% 47ms 1.08% VecNorm_Seq 0 0% 77.16% 46ms 1.06% VecCreate 0 0% 77.16% 45ms 1.03% VecDuplicate_Seq 44ms 1.01% 78.17% 44ms 1.01% TimeStepper::CalculateNextTime 1ms 0.023% 78.19% 42ms 0.96% VecCreate_MPI_Private 0 0% 78.19% 42ms 0.96% VecDot_Seq 0 0% 78.19% 42ms 0.96% VecXDot_Seq_Private.constprop.0 32ms 0.73% 78.93% 41ms 0.94% top12 (inline) 0 0% 78.93% 40ms 0.92% CxxTest::RealWorldDescription::setUp 0 0% 78.93% 40ms 0.92% PetscInitialize 0 0% 78.93% 40ms 0.92% PetscSetup::setUpWorld 0 0% 78.93% 40ms 0.92% PetscSetupUtils::CommonSetup 0 0% 78.93% 40ms 0.92% PetscSetupUtils::InitialisePetsc 39ms 0.9% 79.82% 40ms 0.92% __ieee754_log_fma 39ms 0.9% 80.72% 39ms 0.9% DistributedVector::Iterator::operator!= 0 0% 80.72% 39ms 0.9% PMPI_Init_thread 3ms 0.069% 80.79% 39ms 0.9% VecMAXPY 0 0% 80.79% 39ms 0.9% ompi_mpi_init 0 0% 80.79% 38ms 0.87% VecNorm_MPI 1ms 0.023% 80.81% 38ms 0.87% VecNorm_MPI_Default.constprop.0 1ms 0.023% 80.83% 37ms 0.85% VecCopy_Seq (partial-inline) 2ms 0.046% 80.88% 36ms 0.83% 22ms 0.51% 81.38% 36ms 0.83% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 2ms 0.046% 81.43% 35ms 0.8% VecDestroy 31ms 0.71% 82.14% 33ms 0.76% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.023% 82.16% 33ms 0.76% KSP_RemoveNullSpace (inline) 0 0% 82.16% 31ms 0.71% VecAXPY_Seq 31ms 0.71% 82.87% 31ms 0.71% [libm.so.6] 31ms 0.71% 83.59% 31ms 0.71% daxpy_ 14ms 0.32% 83.91% 30ms 0.69% TimeStepper::AdvanceOneTimeStep 25ms 0.57% 84.48% 29ms 0.67% AbstractOneStepIvpOdeSolver::Solve 29ms 0.67% 85.15% 29ms 0.67% asuint64 (inline) 29ms 0.67% 85.81% 29ms 0.67% dasum_ 5ms 0.11% 85.93% 28ms 0.64% __posix_memalign 2ms 0.046% 85.97% 27ms 0.62% VecSetType 26ms 0.6% 86.57% 26ms 0.6% AbstractParameterisedSystem::SetAnyVariable 24ms 0.55% 87.12% 26ms 0.6% VecMAXPY_Seq 1ms 0.023% 87.14% 26ms 0.6% VecStashCreate_Private 0 0% 87.14% 26ms 0.6% orte_init 24ms 0.55% 87.70% 24ms 0.55% __memset_avx2_unaligned_erms 0 0% 87.70% 23ms 0.53% PetscMemzero (inline) 23ms 0.53% 88.22% 23ms 0.53% RegularStimulus::GetStimulus 5ms 0.11% 88.34% 23ms 0.53% __GI___libc_malloc 12ms 0.28% 88.61% 22ms 0.51% AbstractCardiacCell::SetVoltage 22ms 0.51% 89.12% 22ms 0.51% AbstractParameterisedSystem::GetAnyVariable 2ms 0.046% 89.16% 22ms 0.51% PetscHeaderCreate_Private 19ms 0.44% 89.60% 22ms 0.51% std::__cxx11::basic_string::basic_string