File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3816ms, 88.48% of 4313ms total Dropped 438 nodes (cum <= 21.57ms) flat flat% sum% cum cum% 0 0% 0% 4303ms 99.77% __libc_start_call_main 0 0% 0% 4303ms 99.77% __libc_start_main_impl 0 0% 0% 4303ms 99.77% _start 0 0% 0% 4300ms 99.70% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4300ms 99.70% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4300ms 99.70% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4300ms 99.70% main 0 0% 0% 4267ms 98.93% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4267ms 98.93% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4267ms 98.93% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4262ms 98.82% AbstractCardiacProblem::Solve 0 0% 0% 4255ms 98.66% AbstractDynamicLinearPdeSolver::Solve 14ms 0.32% 0.32% 2111ms 48.95% AbstractCardiacTissue::SolveCellSystems 0 0% 0.32% 1732ms 40.16% LinearSystem::Solve 0 0% 0.32% 1694ms 39.28% KSPSolve 5ms 0.12% 0.44% 1694ms 39.28% KSPSolve_Private 2ms 0.046% 0.49% 1654ms 38.35% KSPSolve_SYMMLQ 17ms 0.39% 0.88% 1234ms 28.61% AbstractCardiacCell::ComputeExceptVoltage 25ms 0.58% 1.46% 1098ms 25.46% AbstractOneStepIvpOdeSolver::InternalSolve 1ms 0.023% 1.48% 1011ms 23.44% PCApply 0 0% 1.48% 1005ms 23.30% PCApply_BJacobi_Singleblock 82ms 1.90% 3.39% 930ms 21.56% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.023% 3.41% 881ms 20.43% KSPSolve_PREONLY (partial-inline) 3ms 0.07% 3.48% 839ms 19.45% MatSolve 0 0% 3.48% 839ms 19.45% PCApply_ICC 303ms 7.03% 10.50% 835ms 19.36% CellLuoRudy1991FromCellML::EvaluateYDerivatives 823ms 19.08% 29.58% 828ms 19.20% MatSolve_SeqSBAIJ_1_NaturalOrdering 1ms 0.023% 29.61% 722ms 16.74% KSP_PCApply.lto_priv.18 16ms 0.37% 29.98% 699ms 16.21% AbstractCardiacTissue::UpdateCaches (inline) 7ms 0.16% 30.14% 662ms 15.35% MatMult 4ms 0.093% 30.23% 650ms 15.07% MatMult_SeqAIJ 643ms 14.91% 45.14% 650ms 15.07% MatMult_SeqAIJ_Inode (inline) 298ms 6.91% 52.05% 649ms 15.05% CellLuoRudy1991FromCellML::GetIIonic 209ms 4.85% 56.90% 613ms 14.21% __GI___exp 0 0% 56.90% 375ms 8.69% KSPConvergedDefault 48ms 1.11% 58.01% 373ms 8.65% BidomainSolver::SetupLinearSystem 0 0% 58.01% 357ms 8.28% KSP_PCApply (partial-inline) 345ms 8.00% 66.01% 346ms 8.02% __ieee754_exp_fma 8ms 0.19% 66.20% 191ms 4.43% std::pow (inline) 7ms 0.16% 66.36% 178ms 4.13% __pow 12ms 0.28% 66.64% 170ms 3.94% __ieee754_pow_fma 76ms 1.76% 68.40% 135ms 3.13% CellLuoRudy1991FromCellML::VerifyStateVariables 131ms 3.04% 71.44% 131ms 3.04% [libchaste_heart.so] 0 0% 71.44% 122ms 2.83% MatNullSpaceRemove 21ms 0.49% 71.92% 97ms 2.25% MPI_Wtime 81ms 1.88% 73.80% 88ms 2.04% exp_inline (inline) 22ms 0.51% 74.31% 77ms 1.79% TimeStepper::TimeStepper 0 0% 74.31% 76ms 1.76% VecDuplicate 4ms 0.093% 74.40% 75ms 1.74% __GI___clock_gettime 0 0% 74.40% 72ms 1.67% VecMDot 1ms 0.023% 74.43% 72ms 1.67% VecMXDot_Private 72ms 1.67% 76.10% 72ms 1.67% [[vdso]] 68ms 1.58% 77.67% 68ms 1.58% log_inline (inline) 7ms 0.16% 77.83% 64ms 1.48% PetscLogEventBeginDefault 64ms 1.48% 79.32% 64ms 1.48% TimeStepper::CalculateNextTime 60ms 1.39% 80.71% 60ms 1.39% [libm.so.6] 10ms 0.23% 80.94% 58ms 1.34% PetscLogEventEndDefault 5ms 0.12% 81.06% 50ms 1.16% VecMAXPY 0 0% 81.06% 48ms 1.11% VecDot 46ms 1.07% 82.12% 48ms 1.11% VecMDot_Seq 48ms 1.11% 83.24% 48ms 1.11% ddot_ 4ms 0.093% 83.33% 47ms 1.09% VecCopy 0 0% 83.33% 47ms 1.09% VecDuplicate_MPI 0 0% 83.33% 42ms 0.97% PetscTimeAdd (inline) 11ms 0.26% 83.58% 39ms 0.9% std::__cxx11::basic_string::basic_string 1ms 0.023% 83.61% 37ms 0.86% VecCreate 0 0% 83.61% 37ms 0.86% VecDot_Seq 0 0% 83.61% 37ms 0.86% VecXDot_Seq_Private.constprop.0 9ms 0.21% 83.82% 36ms 0.83% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 83.82% 36ms 0.83% AbstractBidomainSolver::FinaliseLinearSystem 7ms 0.16% 83.98% 36ms 0.83% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.023% 84.00% 36ms 0.83% VecDestroy 35ms 0.81% 84.81% 35ms 0.81% [libchaste_ode.so] 27ms 0.63% 85.44% 34ms 0.79% AbstractOneStepIvpOdeSolver::Solve 0 0% 85.44% 33ms 0.77% VecNorm 30ms 0.7% 86.13% 32ms 0.74% VecMAXPY_Seq 5ms 0.12% 86.25% 30ms 0.7% PetscMallocA 0 0% 86.25% 29ms 0.67% CxxTest::RealWorldDescription::setUp 0 0% 86.25% 29ms 0.67% PetscSetup::setUpWorld 0 0% 86.25% 29ms 0.67% PetscSetupUtils::CommonSetup 0 0% 86.25% 29ms 0.67% VecDuplicate_Seq 0 0% 86.25% 28ms 0.65% PMPI_Init_thread 0 0% 86.25% 28ms 0.65% PetscInitialize 0 0% 86.25% 28ms 0.65% PetscSetupUtils::InitialisePetsc 1ms 0.023% 86.27% 28ms 0.65% VecAXPY 0 0% 86.27% 28ms 0.65% ompi_mpi_init 1ms 0.023% 86.30% 27ms 0.63% VecNorm_Seq 9ms 0.21% 86.51% 27ms 0.63% std::char_traits::length (inline) 2ms 0.046% 86.55% 26ms 0.6% 13ms 0.3% 86.85% 26ms 0.6% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 2ms 0.046% 86.90% 25ms 0.58% PetscMallocAlign 2ms 0.046% 86.95% 25ms 0.58% VecCreate_MPI_Private 25ms 0.58% 87.53% 25ms 0.58% __memcpy_evex_unaligned_erms 24ms 0.56% 88.08% 24ms 0.56% ReplicatableVector::operator[] 0 0% 88.08% 23ms 0.53% PetscMemcpy (inline) 6ms 0.14% 88.22% 23ms 0.53% TimeStepper::AdvanceOneTimeStep 8ms 0.19% 88.41% 22ms 0.51% AbstractCardiacCell::GetVoltage 3ms 0.07% 88.48% 22ms 0.51% PMPI_Comm_get_attr