File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3689ms, 86.86% of 4247ms total Dropped 440 nodes (cum <= 21.23ms) flat flat% sum% cum cum% 0 0% 0% 4239ms 99.81% __libc_start_call_main 0 0% 0% 4239ms 99.81% __libc_start_main_impl 0 0% 0% 4239ms 99.81% _start 0 0% 0% 4236ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4236ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4236ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4236ms 99.74% main 0 0% 0% 4198ms 98.85% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4198ms 98.85% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4198ms 98.85% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4193ms 98.73% AbstractCardiacProblem::Solve 2ms 0.047% 0.047% 4177ms 98.35% AbstractDynamicLinearPdeSolver::Solve 15ms 0.35% 0.4% 2254ms 53.07% AbstractCardiacTissue::SolveCellSystems 0 0% 0.4% 1563ms 36.80% LinearSystem::Solve 0 0% 0.4% 1509ms 35.53% KSPSolve 2ms 0.047% 0.45% 1509ms 35.53% KSPSolve_Private 3ms 0.071% 0.52% 1459ms 34.35% KSPSolve_SYMMLQ 44ms 1.04% 1.55% 1309ms 30.82% AbstractCardiacCell::ComputeExceptVoltage 22ms 0.52% 2.07% 1107ms 26.07% AbstractOneStepIvpOdeSolver::InternalSolve 6ms 0.14% 2.21% 925ms 21.78% PCApply 64ms 1.51% 3.72% 924ms 21.76% EulerIvpOdeSolver::CalculateNextYValue 0 0% 3.72% 913ms 21.50% PCApply_BJacobi_Singleblock 253ms 5.96% 9.68% 849ms 19.99% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 9.68% 767ms 18.06% KSPSolve_PREONLY (partial-inline) 334ms 7.86% 17.54% 735ms 17.31% __GI___exp 1ms 0.024% 17.57% 730ms 17.19% PCApply_ICC 4ms 0.094% 17.66% 729ms 17.17% MatSolve 714ms 16.81% 34.47% 718ms 16.91% MatSolve_SeqSBAIJ_1_NaturalOrdering 30ms 0.71% 35.18% 700ms 16.48% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 35.18% 679ms 15.99% KSP_PCApply.lto_priv.18 199ms 4.69% 39.86% 647ms 15.23% CellLuoRudy1991FromCellML::GetIIonic 4ms 0.094% 39.96% 473ms 11.14% MatMult 3ms 0.071% 40.03% 464ms 10.93% MatMult_SeqAIJ 460ms 10.83% 50.86% 464ms 10.93% MatMult_SeqAIJ_Inode (inline) 362ms 8.52% 59.38% 386ms 9.09% __ieee754_exp_fma 65ms 1.53% 60.91% 313ms 7.37% BidomainSolver::SetupLinearSystem 1ms 0.024% 60.94% 313ms 7.37% KSPConvergedDefault 0 0% 60.94% 300ms 7.06% KSP_PCApply (partial-inline) 1ms 0.024% 60.96% 234ms 5.51% std::pow (inline) 21ms 0.49% 61.46% 233ms 5.49% __pow 31ms 0.73% 62.19% 211ms 4.97% __ieee754_pow_fma 90ms 2.12% 64.30% 185ms 4.36% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 64.30% 117ms 2.75% VecDuplicate 106ms 2.50% 66.80% 106ms 2.50% log_inline (inline) 1ms 0.024% 66.82% 97ms 2.28% MatNullSpaceRemove 39ms 0.92% 67.74% 81ms 1.91% TimeStepper::TimeStepper 19ms 0.45% 68.19% 72ms 1.70% MPI_Wtime 71ms 1.67% 69.86% 71ms 1.67% exp_inline (inline) 6ms 0.14% 70.00% 60ms 1.41% VecDuplicate_MPI (partial-inline) 1ms 0.024% 70.03% 57ms 1.34% VecDuplicate_Seq 8ms 0.19% 70.21% 55ms 1.30% PetscMallocA 54ms 1.27% 71.49% 54ms 1.27% ddot_ 28ms 0.66% 72.15% 53ms 1.25% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 6ms 0.14% 72.29% 53ms 1.25% VecCreate 1ms 0.024% 72.31% 53ms 1.25% __GI___clock_gettime 2ms 0.047% 72.36% 52ms 1.22% VecDot 52ms 1.22% 73.58% 52ms 1.22% [[vdso]] 0 0% 73.58% 51ms 1.20% VecMDot 4ms 0.094% 73.68% 51ms 1.20% VecMXDot_Private 50ms 1.18% 74.85% 50ms 1.18% TimeStepper::CalculateNextTime 4ms 0.094% 74.95% 48ms 1.13% VecCopy 5ms 0.12% 75.06% 47ms 1.11% PetscMallocAlign (partial-inline) 3ms 0.071% 75.14% 47ms 1.11% VecDestroy 6ms 0.14% 75.28% 45ms 1.06% PetscLogEventBeginDefault 8ms 0.19% 75.47% 45ms 1.06% PetscLogEventEndDefault 1ms 0.024% 75.49% 45ms 1.06% VecMAXPY 35ms 0.82% 76.31% 43ms 1.01% AbstractOneStepIvpOdeSolver::Solve 42ms 0.99% 77.30% 43ms 1.01% __ieee754_log_fma 0 0% 77.30% 42ms 0.99% VecDot_Seq 2ms 0.047% 77.35% 42ms 0.99% VecXDot_Seq_Private.constprop.0 10ms 0.24% 77.58% 41ms 0.97% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 77.58% 41ms 0.97% AbstractBidomainSolver::FinaliseLinearSystem 41ms 0.97% 78.55% 41ms 0.97% __memcpy_avx_unaligned_erms 0 0% 78.55% 40ms 0.94% PetscMemcpy (inline) 7ms 0.16% 78.71% 38ms 0.89% AbstractCardiacCell::SetVoltage (partial-inline) 38ms 0.89% 79.61% 38ms 0.89% [libchaste_heart.so] 38ms 0.89% 80.50% 38ms 0.89% std::isinf (inline) 8ms 0.19% 80.69% 37ms 0.87% std::__cxx11::basic_string::basic_string 1ms 0.024% 80.72% 34ms 0.8% KSP_RemoveNullSpace (inline) 34ms 0.8% 81.52% 34ms 0.8% VecMDot_Seq 0 0% 81.52% 33ms 0.78% CxxTest::RealWorldDescription::setUp 0 0% 81.52% 33ms 0.78% PMPI_Init_thread 0 0% 81.52% 33ms 0.78% PetscInitialize 0 0% 81.52% 33ms 0.78% PetscSetup::setUpWorld 0 0% 81.52% 33ms 0.78% PetscSetupUtils::CommonSetup 0 0% 81.52% 33ms 0.78% PetscSetupUtils::InitialisePetsc 0 0% 81.52% 33ms 0.78% ompi_mpi_init 0 0% 81.52% 32ms 0.75% VecNorm 30ms 0.71% 82.22% 31ms 0.73% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 31ms 0.73% 82.95% 31ms 0.73% DistributedVector::Iterator::operator!= 1ms 0.024% 82.98% 31ms 0.73% VecCopy_Seq (partial-inline) 0 0% 82.98% 30ms 0.71% PetscTimeAdd (inline) 2ms 0.047% 83.02% 30ms 0.71% VecAXPY 20ms 0.47% 83.49% 29ms 0.68% AbstractCardiacCell::GetVoltage (partial-inline) 28ms 0.66% 84.15% 29ms 0.68% VecMAXPY_Seq 1ms 0.024% 84.18% 28ms 0.66% VecCreate_MPI_Private 1ms 0.024% 84.20% 28ms 0.66% VecNorm_Seq 1ms 0.024% 84.22% 27ms 0.64% 24ms 0.57% 84.79% 27ms 0.64% AbstractParameterisedSystem::SetAnyVariable 27ms 0.64% 85.43% 27ms 0.64% DistributedVector::Stripe::operator[] (inline) 12ms 0.28% 85.71% 27ms 0.64% TimeStepper::AdvanceOneTimeStep 1ms 0.024% 85.73% 25ms 0.59% std::char_traits::length (inline) 3ms 0.071% 85.80% 24ms 0.57% PetscHeaderDestroy_Private 0 0% 85.80% 24ms 0.57% PetscMemzero (inline) 0 0% 85.80% 24ms 0.57% VecNorm_MPI 0 0% 85.80% 24ms 0.57% VecNorm_MPI_Default.constprop.0 4ms 0.094% 85.90% 24ms 0.57% __posix_memalign 2ms 0.047% 85.94% 23ms 0.54% VecSetType 8ms 0.19% 86.13% 23ms 0.54% __GI___libc_malloc 23ms 0.54% 86.67% 23ms 0.54% __strlen_avx2 7ms 0.16% 86.84% 23ms 0.54% top12 (inline) 1ms 0.024% 86.86% 22ms 0.52% VecAXPY_Seq 0 0% 86.86% 22ms 0.52% orte_init