File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3669ms, 86.51% of 4241ms total Dropped 451 nodes (cum <= 21.20ms) flat flat% sum% cum cum% 0 0% 0% 4233ms 99.81% __libc_start_call_main 0 0% 0% 4233ms 99.81% __libc_start_main_impl 0 0% 0% 4233ms 99.81% _start 0 0% 0% 4230ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4230ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4230ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4230ms 99.74% main 0 0% 0% 4194ms 98.89% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4194ms 98.89% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4194ms 98.89% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 1ms 0.024% 0.024% 4187ms 98.73% AbstractCardiacProblem::Solve 1ms 0.024% 0.047% 4177ms 98.49% AbstractDynamicLinearPdeSolver::Solve 7ms 0.17% 0.21% 2281ms 53.78% AbstractCardiacTissue::SolveCellSystems 0 0% 0.21% 1588ms 37.44% LinearSystem::Solve 0 0% 0.21% 1531ms 36.10% KSPSolve 4ms 0.094% 0.31% 1531ms 36.10% KSPSolve_Private 4ms 0.094% 0.4% 1480ms 34.90% KSPSolve_SYMMLQ 32ms 0.75% 1.16% 1323ms 31.20% AbstractCardiacCell::ComputeExceptVoltage 26ms 0.61% 1.77% 1107ms 26.10% AbstractOneStepIvpOdeSolver::InternalSolve 43ms 1.01% 2.78% 920ms 21.69% EulerIvpOdeSolver::CalculateNextYValue 6ms 0.14% 2.92% 912ms 21.50% PCApply 1ms 0.024% 2.95% 904ms 21.32% PCApply_BJacobi_Singleblock 245ms 5.78% 8.72% 863ms 20.35% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 8.72% 781ms 18.42% KSPSolve_PREONLY (partial-inline) 379ms 8.94% 17.66% 780ms 18.39% __GI___exp 35ms 0.83% 18.49% 762ms 17.97% AbstractCardiacTissue::UpdateCaches (inline) 7ms 0.17% 18.65% 729ms 17.19% MatSolve 0 0% 18.65% 729ms 17.19% PCApply_ICC 712ms 16.79% 35.44% 716ms 16.88% MatSolve_SeqSBAIJ_1_NaturalOrdering 234ms 5.52% 40.96% 701ms 16.53% CellLuoRudy1991FromCellML::GetIIonic 0 0% 40.96% 680ms 16.03% KSP_PCApply.lto_priv.18 3ms 0.071% 41.03% 422ms 9.95% MatMult 3ms 0.071% 41.10% 415ms 9.79% MatMult_SeqAIJ 405ms 9.55% 50.65% 414ms 9.76% MatMult_SeqAIJ_Inode (inline) 351ms 8.28% 58.92% 383ms 9.03% __ieee754_exp_fma 0 0% 58.92% 321ms 7.57% KSPConvergedDefault 0 0% 58.92% 316ms 7.45% KSP_PCApply (partial-inline) 64ms 1.51% 60.43% 262ms 6.18% BidomainSolver::SetupLinearSystem 1ms 0.024% 60.46% 250ms 5.89% std::pow (inline) 26ms 0.61% 61.07% 249ms 5.87% __pow 24ms 0.57% 61.64% 222ms 5.23% __ieee754_pow_fma 69ms 1.63% 63.26% 150ms 3.54% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 63.26% 131ms 3.09% MatNullSpaceRemove 102ms 2.41% 65.67% 102ms 2.41% log_inline (inline) 0 0% 65.67% 87ms 2.05% VecDuplicate 0 0% 65.67% 83ms 1.96% VecMDot 6ms 0.14% 65.81% 83ms 1.96% VecMXDot_Private 83ms 1.96% 67.77% 83ms 1.96% exp_inline (inline) 22ms 0.52% 68.29% 77ms 1.82% MPI_Wtime 38ms 0.9% 69.18% 70ms 1.65% TimeStepper::TimeStepper 68ms 1.60% 70.79% 68ms 1.60% ddot_ 13ms 0.31% 71.09% 64ms 1.51% PetscLogEventBeginDefault 7ms 0.17% 71.26% 60ms 1.41% VecCopy 14ms 0.33% 71.59% 59ms 1.39% PetscLogEventEndDefault 1ms 0.024% 71.61% 58ms 1.37% VecDot 3ms 0.071% 71.68% 58ms 1.37% VecDuplicate_MPI 56ms 1.32% 73.00% 57ms 1.34% VecMDot_Seq 55ms 1.30% 74.30% 55ms 1.30% [[vdso]] 0 0% 74.30% 55ms 1.30% __GI___clock_gettime 43ms 1.01% 75.31% 53ms 1.25% AbstractOneStepIvpOdeSolver::Solve 12ms 0.28% 75.60% 51ms 1.20% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.024% 75.62% 48ms 1.13% VecDot_Seq 6ms 0.14% 75.76% 48ms 1.13% VecMAXPY 0 0% 75.76% 47ms 1.11% VecXDot_Seq_Private.constprop.0 4ms 0.094% 75.85% 45ms 1.06% VecAXPY 44ms 1.04% 76.89% 44ms 1.04% TimeStepper::CalculateNextTime 3ms 0.071% 76.96% 44ms 1.04% VecDestroy 2ms 0.047% 77.01% 43ms 1.01% VecNorm 24ms 0.57% 77.58% 43ms 1.01% top12 (inline) 28ms 0.66% 78.24% 41ms 0.97% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 78.26% 39ms 0.92% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 78.26% 39ms 0.92% PetscTimeSubtract (inline) 38ms 0.9% 79.16% 39ms 0.92% __ieee754_log_fma 9ms 0.21% 79.37% 38ms 0.9% AbstractBidomainSolver::CheckCompatibilityCondition 33ms 0.78% 80.15% 38ms 0.9% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.024% 80.17% 37ms 0.87% VecNorm_Seq 37ms 0.87% 81.04% 37ms 0.87% std::isinf (inline) 3ms 0.071% 81.11% 36ms 0.85% VecCreate_MPI_Private 36ms 0.85% 81.96% 36ms 0.85% __memcpy_avx_unaligned_erms 5ms 0.12% 82.08% 35ms 0.83% PetscMallocA 35ms 0.83% 82.90% 35ms 0.83% [libchaste_heart.so] 0 0% 82.90% 34ms 0.8% VecCreate 0 0% 82.90% 33ms 0.78% PetscMemcpy (inline) 0 0% 82.90% 31ms 0.73% CxxTest::RealWorldDescription::setUp 0 0% 82.90% 31ms 0.73% PMPI_Init_thread 0 0% 82.90% 31ms 0.73% PetscInitialize 0 0% 82.90% 31ms 0.73% PetscSetup::setUpWorld 0 0% 82.90% 31ms 0.73% PetscSetupUtils::CommonSetup 0 0% 82.90% 31ms 0.73% PetscSetupUtils::InitialisePetsc 0 0% 82.90% 31ms 0.73% ompi_mpi_init 1ms 0.024% 82.93% 30ms 0.71% PetscMallocAlign 9ms 0.21% 83.14% 30ms 0.71% std::__cxx11::basic_string::basic_string 23ms 0.54% 83.68% 29ms 0.68% AbstractParameterisedSystem::SetAnyVariable 2ms 0.047% 83.73% 29ms 0.68% VecDuplicate_Seq 0 0% 83.73% 29ms 0.68% VecNorm_MPI 0 0% 83.73% 29ms 0.68% VecNorm_MPI_Default.constprop.0 0 0% 83.73% 28ms 0.66% VecAXPY_Seq 1ms 0.024% 83.75% 27ms 0.64% 11ms 0.26% 84.01% 27ms 0.64% TimeStepper::AdvanceOneTimeStep 1ms 0.024% 84.04% 26ms 0.61% VecCopy_Seq (partial-inline) 25ms 0.59% 84.63% 25ms 0.59% daxpy_ 10ms 0.24% 84.86% 24ms 0.57% AbstractCardiacCell::GetVoltage (partial-inline) 23ms 0.54% 85.40% 24ms 0.57% VecMAXPY_Seq 23ms 0.54% 85.95% 23ms 0.54% DistributedVector::Iterator::operator!= 2ms 0.047% 85.99% 22ms 0.52% PetscOptionsFindPair 22ms 0.52% 86.51% 22ms 0.52% asuint64 (inline) 0 0% 86.51% 22ms 0.52% orte_init