File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3707ms, 86.77% of 4272ms total Dropped 444 nodes (cum <= 21.36ms) flat flat% sum% cum cum% 0 0% 0% 4264ms 99.81% __libc_start_call_main 0 0% 0% 4264ms 99.81% __libc_start_main_impl 0 0% 0% 4264ms 99.81% _start 0 0% 0% 4261ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4261ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4261ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4261ms 99.74% main 0 0% 0% 4222ms 98.83% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4222ms 98.83% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4222ms 98.83% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4215ms 98.67% AbstractCardiacProblem::Solve 0 0% 0% 4194ms 98.17% AbstractDynamicLinearPdeSolver::Solve 22ms 0.51% 0.51% 2463ms 57.65% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.54% 1463ms 34.25% LinearSystem::Solve 0 0% 0.54% 1427ms 33.40% KSPSolve 2ms 0.047% 0.59% 1427ms 33.40% KSPSolve_Private 44ms 1.03% 1.62% 1416ms 33.15% AbstractCardiacCell::ComputeExceptVoltage 1ms 0.023% 1.64% 1380ms 32.30% KSPSolve_SYMMLQ 43ms 1.01% 2.65% 1177ms 27.55% AbstractOneStepIvpOdeSolver::InternalSolve 63ms 1.47% 4.12% 964ms 22.57% EulerIvpOdeSolver::CalculateNextYValue 4ms 0.094% 4.21% 892ms 20.88% PCApply 270ms 6.32% 10.53% 887ms 20.76% CellLuoRudy1991FromCellML::EvaluateYDerivatives 3ms 0.07% 10.60% 880ms 20.60% PCApply_BJacobi_Singleblock 368ms 8.61% 19.22% 803ms 18.80% __GI___exp 26ms 0.61% 19.83% 788ms 18.45% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 19.83% 750ms 17.56% KSPSolve_PREONLY (partial-inline) 266ms 6.23% 26.05% 738ms 17.28% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.023% 26.08% 704ms 16.48% PCApply_ICC 5ms 0.12% 26.19% 703ms 16.46% MatSolve 693ms 16.22% 42.42% 696ms 16.29% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 42.42% 646ms 15.12% KSP_PCApply.lto_priv.18 386ms 9.04% 51.45% 416ms 9.74% __ieee754_exp_fma 4ms 0.094% 51.54% 350ms 8.19% MatMult 2ms 0.047% 51.59% 342ms 8.01% MatMult_SeqAIJ 338ms 7.91% 59.50% 341ms 7.98% MatMult_SeqAIJ_Inode (inline) 3ms 0.07% 59.57% 320ms 7.49% KSPConvergedDefault 0 0% 59.57% 317ms 7.42% KSP_PCApply (partial-inline) 52ms 1.22% 60.79% 230ms 5.38% BidomainSolver::SetupLinearSystem 5ms 0.12% 60.91% 219ms 5.13% std::pow (inline) 20ms 0.47% 61.38% 214ms 5.01% __pow 29ms 0.68% 62.06% 194ms 4.54% __ieee754_pow_fma 87ms 2.04% 64.09% 183ms 4.28% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.023% 64.12% 115ms 2.69% MatNullSpaceRemove 1ms 0.023% 64.14% 90ms 2.11% VecDuplicate 34ms 0.8% 64.93% 84ms 1.97% TimeStepper::TimeStepper 80ms 1.87% 66.81% 80ms 1.87% log_inline (inline) 78ms 1.83% 68.63% 79ms 1.85% exp_inline (inline) 0 0% 68.63% 78ms 1.83% VecMDot 6ms 0.14% 68.77% 78ms 1.83% VecMXDot_Private 23ms 0.54% 69.31% 75ms 1.76% MPI_Wtime 26ms 0.61% 69.92% 63ms 1.47% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 19ms 0.44% 70.37% 62ms 1.45% PetscLogEventEndDefault 46ms 1.08% 71.44% 57ms 1.33% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 57ms 1.33% 72.78% 57ms 1.33% TimeStepper::CalculateNextTime 55ms 1.29% 74.06% 55ms 1.29% ddot_ 51ms 1.19% 75.26% 54ms 1.26% VecMDot_Seq 12ms 0.28% 75.54% 52ms 1.22% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.023% 75.56% 52ms 1.22% VecDestroy 6ms 0.14% 75.70% 50ms 1.17% VecCopy 1ms 0.023% 75.73% 50ms 1.17% __GI___clock_gettime 4ms 0.094% 75.82% 49ms 1.15% VecAXPY 49ms 1.15% 76.97% 49ms 1.15% [[vdso]] 48ms 1.12% 78.09% 49ms 1.15% __ieee754_log_fma 0 0% 78.09% 48ms 1.12% VecDuplicate_Seq 1ms 0.023% 78.11% 46ms 1.08% VecDot 44ms 1.03% 79.14% 44ms 1.03% std::isinf (inline) 6ms 0.14% 79.28% 41ms 0.96% PetscLogEventBeginDefault 0 0% 79.28% 41ms 0.96% VecDuplicate_MPI 38ms 0.89% 80.17% 38ms 0.89% __memcpy_avx_unaligned_erms 24ms 0.56% 80.74% 37ms 0.87% AbstractOneStepIvpOdeSolver::Solve 1ms 0.023% 80.76% 37ms 0.87% VecNorm 3ms 0.07% 80.83% 36ms 0.84% PetscMallocA 0 0% 80.83% 36ms 0.84% VecDot_Seq 3ms 0.07% 80.90% 36ms 0.84% VecMAXPY 1ms 0.023% 80.92% 36ms 0.84% VecXDot_Seq_Private.constprop.0 36ms 0.84% 81.76% 36ms 0.84% [libchaste_heart.so] 18ms 0.42% 82.19% 36ms 0.84% top12 (inline) 27ms 0.63% 82.82% 35ms 0.82% AbstractParameterisedSystem::GetAnyVariable 0 0% 82.82% 35ms 0.82% CxxTest::RealWorldDescription::setUp 0 0% 82.82% 35ms 0.82% PMPI_Init_thread 0 0% 82.82% 35ms 0.82% PetscInitialize 0 0% 82.82% 35ms 0.82% PetscSetup::setUpWorld 0 0% 82.82% 35ms 0.82% PetscSetupUtils::CommonSetup 0 0% 82.82% 35ms 0.82% PetscSetupUtils::InitialisePetsc 0 0% 82.82% 35ms 0.82% ompi_mpi_init 13ms 0.3% 83.12% 34ms 0.8% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 83.12% 34ms 0.8% AbstractBidomainSolver::FinaliseLinearSystem 13ms 0.3% 83.43% 34ms 0.8% std::__cxx11::basic_string::basic_string 0 0% 83.43% 33ms 0.77% PetscMallocAlign 29ms 0.68% 84.11% 32ms 0.75% AbstractParameterisedSystem::SetAnyVariable 0 0% 84.11% 32ms 0.75% VecAXPY_Seq 0 0% 84.11% 31ms 0.73% PetscMemcpy (inline) 19ms 0.44% 84.55% 31ms 0.73% TimeStepper::AdvanceOneTimeStep 2ms 0.047% 84.60% 31ms 0.73% VecCreate 31ms 0.73% 85.32% 31ms 0.73% daxpy_ 0 0% 85.32% 30ms 0.7% VecNorm_Seq 0 0% 85.32% 28ms 0.66% VecCopy_Seq (partial-inline) 2ms 0.047% 85.37% 28ms 0.66% VecSetType 1ms 0.023% 85.39% 27ms 0.63% 26ms 0.61% 86.00% 26ms 0.61% [libchaste_ode.so] 24ms 0.56% 86.56% 25ms 0.59% VecMAXPY_Seq 2ms 0.047% 86.61% 24ms 0.56% PetscHeaderDestroy_Private 2ms 0.047% 86.66% 24ms 0.56% PetscTimeSubtract (inline) 0 0% 86.66% 23ms 0.54% VecCreate_MPI_Private 0 0% 86.66% 23ms 0.54% orte_init 5ms 0.12% 86.77% 22ms 0.51% PetscFreeAlign