File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3661ms, 86.22% of 4246ms total Dropped 429 nodes (cum <= 21.23ms) flat flat% sum% cum cum% 0 0% 0% 4238ms 99.81% __libc_start_call_main 0 0% 0% 4238ms 99.81% __libc_start_main_impl 0 0% 0% 4238ms 99.81% _start 0 0% 0% 4235ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4235ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4235ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4235ms 99.74% main 0 0% 0% 4202ms 98.96% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4202ms 98.96% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4202ms 98.96% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4195ms 98.80% AbstractCardiacProblem::Solve 2ms 0.047% 0.047% 4186ms 98.59% AbstractDynamicLinearPdeSolver::Solve 9ms 0.21% 0.26% 2404ms 56.62% AbstractCardiacTissue::SolveCellSystems 36ms 0.85% 1.11% 1448ms 34.10% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.11% 1447ms 34.08% LinearSystem::Solve 0 0% 1.11% 1390ms 32.74% KSPSolve 5ms 0.12% 1.22% 1390ms 32.74% KSPSolve_Private 4ms 0.094% 1.32% 1343ms 31.63% KSPSolve_SYMMLQ 35ms 0.82% 2.14% 1222ms 28.78% AbstractOneStepIvpOdeSolver::InternalSolve 42ms 0.99% 3.13% 1015ms 23.90% EulerIvpOdeSolver::CalculateNextYValue 276ms 6.50% 9.63% 955ms 22.49% CellLuoRudy1991FromCellML::EvaluateYDerivatives 365ms 8.60% 18.23% 832ms 19.59% __GI___exp 2ms 0.047% 18.28% 826ms 19.45% PCApply 1ms 0.024% 18.30% 822ms 19.36% PCApply_BJacobi_Singleblock 24ms 0.57% 18.86% 742ms 17.48% AbstractCardiacTissue::UpdateCaches (inline) 235ms 5.53% 24.40% 695ms 16.37% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.40% 689ms 16.23% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 24.42% 648ms 15.26% PCApply_ICC 3ms 0.071% 24.49% 647ms 15.24% MatSolve 637ms 15.00% 39.50% 640ms 15.07% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 39.50% 587ms 13.82% KSP_PCApply.lto_priv.18 418ms 9.84% 49.34% 454ms 10.69% __ieee754_exp_fma 1ms 0.024% 49.36% 388ms 9.14% MatMult 4ms 0.094% 49.46% 381ms 8.97% MatMult_SeqAIJ 377ms 8.88% 58.34% 381ms 8.97% MatMult_SeqAIJ_Inode (inline) 0 0% 58.34% 330ms 7.77% KSPConvergedDefault 0 0% 58.34% 312ms 7.35% KSP_PCApply (partial-inline) 69ms 1.63% 59.96% 295ms 6.95% BidomainSolver::SetupLinearSystem 2ms 0.047% 60.01% 234ms 5.51% std::pow (inline) 25ms 0.59% 60.60% 232ms 5.46% __pow 27ms 0.64% 61.23% 207ms 4.88% __ieee754_pow_fma 69ms 1.63% 62.86% 159ms 3.74% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 62.86% 118ms 2.78% MatNullSpaceRemove 2ms 0.047% 62.91% 114ms 2.68% VecDuplicate 101ms 2.38% 65.28% 101ms 2.38% log_inline (inline) 25ms 0.59% 65.87% 78ms 1.84% MPI_Wtime 0 0% 65.87% 75ms 1.77% VecMDot 2ms 0.047% 65.92% 75ms 1.77% VecMXDot_Private 73ms 1.72% 67.64% 74ms 1.74% exp_inline (inline) 39ms 0.92% 68.56% 72ms 1.70% TimeStepper::TimeStepper 5ms 0.12% 68.68% 66ms 1.55% VecDuplicate_MPI (partial-inline) 11ms 0.26% 68.94% 62ms 1.46% PetscLogEventEndDefault 61ms 1.44% 70.37% 61ms 1.44% ddot_ 57ms 1.34% 71.71% 59ms 1.39% VecMDot_Seq 37ms 0.87% 72.59% 56ms 1.32% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 72.61% 56ms 1.32% VecDot 9ms 0.21% 72.82% 55ms 1.30% AbstractCardiacCell::SetVoltage (partial-inline) 6ms 0.14% 72.96% 55ms 1.30% PetscMallocA 8ms 0.19% 73.15% 55ms 1.30% VecCopy 4ms 0.094% 73.25% 53ms 1.25% __GI___clock_gettime 50ms 1.18% 74.42% 52ms 1.22% __ieee754_log_fma 39ms 0.92% 75.34% 49ms 1.15% AbstractOneStepIvpOdeSolver::Solve 3ms 0.071% 75.41% 49ms 1.15% PetscMallocAlign 2ms 0.047% 75.46% 49ms 1.15% VecDestroy 49ms 1.15% 76.61% 49ms 1.15% [[vdso]] 1ms 0.024% 76.64% 47ms 1.11% KSP_RemoveNullSpace (inline) 2ms 0.047% 76.68% 46ms 1.08% VecDuplicate_Seq 3ms 0.071% 76.75% 46ms 1.08% VecNorm 10ms 0.24% 76.99% 45ms 1.06% PetscLogEventBeginDefault 1ms 0.024% 77.01% 43ms 1.01% VecMAXPY 40ms 0.94% 77.96% 42ms 0.99% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 42ms 0.99% 78.94% 42ms 0.99% TimeStepper::CalculateNextTime 0 0% 78.94% 41ms 0.97% VecDot_Seq 0 0% 78.94% 41ms 0.97% VecXDot_Seq_Private.constprop.0 4ms 0.094% 79.04% 40ms 0.94% VecCreate 39ms 0.92% 79.96% 39ms 0.92% __memcpy_avx_unaligned_erms 13ms 0.31% 80.26% 39ms 0.92% top12 (inline) 2ms 0.047% 80.31% 37ms 0.87% VecAXPY 3ms 0.071% 80.38% 35ms 0.82% VecCreate_MPI_Private 35ms 0.82% 81.21% 35ms 0.82% [libchaste_heart.so] 0 0% 81.21% 34ms 0.8% VecNorm_Seq 14ms 0.33% 81.54% 34ms 0.8% std::__cxx11::basic_string::basic_string 11ms 0.26% 81.79% 33ms 0.78% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.79% 33ms 0.78% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 81.79% 32ms 0.75% PetscMemcpy (inline) 30ms 0.71% 82.50% 31ms 0.73% AbstractParameterisedSystem::SetAnyVariable 18ms 0.42% 82.93% 31ms 0.73% TimeStepper::AdvanceOneTimeStep 31ms 0.73% 83.66% 31ms 0.73% asuint64 (inline) 31ms 0.73% 84.39% 31ms 0.73% std::isinf (inline) 0 0% 84.39% 30ms 0.71% CxxTest::RealWorldDescription::setUp 0 0% 84.39% 30ms 0.71% PMPI_Init_thread 0 0% 84.39% 30ms 0.71% PetscInitialize 0 0% 84.39% 30ms 0.71% PetscSetup::setUpWorld 0 0% 84.39% 30ms 0.71% PetscSetupUtils::CommonSetup 0 0% 84.39% 30ms 0.71% PetscSetupUtils::InitialisePetsc 0 0% 84.39% 30ms 0.71% PetscTimeSubtract (inline) 0 0% 84.39% 30ms 0.71% ompi_mpi_init 4ms 0.094% 84.48% 27ms 0.64% __GI___libc_malloc 26ms 0.61% 85.09% 26ms 0.61% VecMAXPY_Seq 0 0% 85.09% 26ms 0.61% VecSetType 2ms 0.047% 85.14% 26ms 0.61% __posix_memalign 3ms 0.071% 85.21% 26ms 0.61% std::vector::_M_assign_aux (inline) 0 0% 85.21% 26ms 0.61% std::vector::assign (inline) 0 0% 85.21% 25ms 0.59% 4ms 0.094% 85.30% 25ms 0.59% VecAXPY_Seq 24ms 0.57% 85.87% 24ms 0.57% DistributedVector::Iterator::operator!= 3ms 0.071% 85.94% 24ms 0.57% PetscHeaderDestroy_Private 12ms 0.28% 86.22% 23ms 0.54% AbstractCardiacCell::GetVoltage (partial-inline) 0 0% 86.22% 23ms 0.54% VecNorm_MPI 0 0% 86.22% 23ms 0.54% VecNorm_MPI_Default.constprop.0 0 0% 86.22% 22ms 0.52% VecCopy_Seq (partial-inline)