File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3282ms, 88.65% of 3702ms total Dropped 425 nodes (cum <= 18.51ms) flat flat% sum% cum cum% 0 0% 0% 3696ms 99.84% __libc_start_call_main 0 0% 0% 3696ms 99.84% __libc_start_main_impl 0 0% 0% 3696ms 99.84% _start 0 0% 0% 3694ms 99.78% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3694ms 99.78% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3694ms 99.78% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3694ms 99.78% main 0 0% 0% 3664ms 98.97% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3664ms 98.97% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3664ms 98.97% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 3659ms 98.84% AbstractCardiacProblem::Solve 2ms 0.054% 0.054% 3654ms 98.70% AbstractDynamicLinearPdeSolver::Solve 12ms 0.32% 0.38% 1920ms 51.86% AbstractCardiacTissue::SolveCellSystems 0 0% 0.38% 1352ms 36.52% LinearSystem::Solve 0 0% 0.38% 1327ms 35.85% KSPSolve 0 0% 0.38% 1327ms 35.85% KSPSolve_Private 2ms 0.054% 0.43% 1306ms 35.28% KSPSolve_SYMMLQ 11ms 0.3% 0.73% 1059ms 28.61% AbstractCardiacCell::ComputeExceptVoltage 16ms 0.43% 1.16% 953ms 25.74% AbstractOneStepIvpOdeSolver::InternalSolve 1ms 0.027% 1.19% 812ms 21.93% PCApply 1ms 0.027% 1.22% 806ms 21.77% PCApply_BJacobi_Singleblock 97ms 2.62% 3.84% 795ms 21.47% EulerIvpOdeSolver::CalculateNextYValue 254ms 6.86% 10.70% 694ms 18.75% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 10.70% 694ms 18.75% KSPSolve_PREONLY (partial-inline) 29ms 0.78% 11.48% 683ms 18.45% AbstractCardiacTissue::UpdateCaches (inline) 2ms 0.054% 11.53% 654ms 17.67% MatSolve 0 0% 11.53% 654ms 17.67% PCApply_ICC 643ms 17.37% 28.90% 648ms 17.50% MatSolve_SeqSBAIJ_1_NaturalOrdering 304ms 8.21% 37.12% 631ms 17.04% CellLuoRudy1991FromCellML::GetIIonic 0 0% 37.12% 607ms 16.40% KSP_PCApply.lto_priv.18 3ms 0.081% 37.20% 577ms 15.59% MatMult 5ms 0.14% 37.33% 569ms 15.37% MatMult_SeqAIJ (partial-inline) 560ms 15.13% 52.46% 569ms 15.37% MatMult_SeqAIJ_Inode (inline) 162ms 4.38% 56.83% 506ms 13.67% __GI___exp 38ms 1.03% 57.86% 355ms 9.59% BidomainSolver::SetupLinearSystem 302ms 8.16% 66.02% 303ms 8.18% __ieee754_exp_fma 0 0% 66.02% 256ms 6.92% KSPConvergedDefault 0 0% 66.02% 255ms 6.89% KSP_PCApply (partial-inline) 4ms 0.11% 66.13% 177ms 4.78% std::pow (inline) 9ms 0.24% 66.37% 170ms 4.59% __pow 14ms 0.38% 66.75% 159ms 4.29% __ieee754_pow_fma 85ms 2.30% 69.04% 133ms 3.59% CellLuoRudy1991FromCellML::VerifyStateVariables 120ms 3.24% 72.29% 120ms 3.24% [libchaste_heart.so] 1ms 0.027% 72.31% 88ms 2.38% MatNullSpaceRemove 78ms 2.11% 74.42% 78ms 2.11% log_inline (inline) 0 0% 74.42% 70ms 1.89% VecDuplicate 28ms 0.76% 75.18% 67ms 1.81% TimeStepper::TimeStepper 56ms 1.51% 76.69% 67ms 1.81% exp_inline (inline) 30ms 0.81% 77.50% 64ms 1.73% MPI_Wtime 56ms 1.51% 79.01% 56ms 1.51% TimeStepper::CalculateNextTime 0 0% 79.01% 52ms 1.40% VecMDot 4ms 0.11% 79.12% 52ms 1.40% VecMXDot_Private 45ms 1.22% 80.33% 45ms 1.22% [libm.so.6] 3ms 0.081% 80.42% 39ms 1.05% PetscLogEventBeginDefault 4ms 0.11% 80.52% 38ms 1.03% PetscLogEventEndDefault 12ms 0.32% 80.85% 38ms 1.03% TimeStepper::AdvanceOneTimeStep 2ms 0.054% 80.90% 37ms 1% VecDuplicate_MPI 33ms 0.89% 81.79% 36ms 0.97% VecMDot_Seq 1ms 0.027% 81.82% 35ms 0.95% VecMAXPY 0 0% 81.82% 34ms 0.92% VecDot 34ms 0.92% 82.74% 34ms 0.92% [[vdso]] 0 0% 82.74% 34ms 0.92% __GI___clock_gettime 8ms 0.22% 82.96% 33ms 0.89% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.027% 82.98% 33ms 0.89% VecDestroy 1ms 0.027% 83.01% 33ms 0.89% VecDuplicate_Seq 33ms 0.89% 83.90% 33ms 0.89% ddot_ 2ms 0.054% 83.95% 31ms 0.84% VecCopy 0 0% 83.95% 30ms 0.81% VecAXPY 0 0% 83.95% 28ms 0.76% VecDot_Seq 0 0% 83.95% 28ms 0.76% VecXDot_Seq_Private.constprop.0 0 0% 83.95% 27ms 0.73% VecCreate 25ms 0.68% 84.63% 26ms 0.7% VecMAXPY_Seq 20ms 0.54% 85.17% 25ms 0.68% AbstractOneStepIvpOdeSolver::Solve 1ms 0.027% 85.20% 25ms 0.68% VecAXPY_Seq 6ms 0.16% 85.36% 25ms 0.68% std::__cxx11::basic_string::basic_string 0 0% 85.36% 24ms 0.65% CxxTest::RealWorldDescription::setUp 1ms 0.027% 85.39% 24ms 0.65% PMPI_Comm_get_attr 0 0% 85.39% 24ms 0.65% PetscInitialize 0 0% 85.39% 24ms 0.65% PetscMemcpy (inline) 0 0% 85.39% 24ms 0.65% PetscSetup::setUpWorld 0 0% 85.39% 24ms 0.65% PetscSetupUtils::CommonSetup 0 0% 85.39% 24ms 0.65% PetscSetupUtils::InitialisePetsc 0 0% 85.39% 23ms 0.62% PMPI_Init_thread 1ms 0.027% 85.41% 23ms 0.62% VecCreate_MPI_Private 23ms 0.62% 86.03% 23ms 0.62% __memcpy_avx512_unaligned_erms 1ms 0.027% 86.06% 23ms 0.62% ompi_attr_get_c 0 0% 86.06% 23ms 0.62% ompi_mpi_init 4ms 0.11% 86.17% 22ms 0.59% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 86.17% 22ms 0.59% AbstractBidomainSolver::FinaliseLinearSystem 17ms 0.46% 86.63% 22ms 0.59% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 22ms 0.59% 87.22% 22ms 0.59% [libchaste_ode.so] 22ms 0.59% 87.82% 22ms 0.59% __ieee754_log_fma 22ms 0.59% 88.41% 22ms 0.59% daxpy_ 9ms 0.24% 88.65% 21ms 0.57% AbstractCardiacCellInterface::SetVoltageDerivativeToZero