File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3374ms, 89.38% of 3775ms total Dropped 396 nodes (cum <= 18.88ms) flat flat% sum% cum cum% 0 0% 0% 3769ms 99.84% __libc_start_call_main 0 0% 0% 3769ms 99.84% __libc_start_main_impl 0 0% 0% 3769ms 99.84% _start 0 0% 0% 3767ms 99.79% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3767ms 99.79% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3767ms 99.79% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3767ms 99.79% main 0 0% 0% 3736ms 98.97% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3736ms 98.97% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3736ms 98.97% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 3732ms 98.86% AbstractCardiacProblem::Solve 1ms 0.026% 0.026% 3722ms 98.60% AbstractDynamicLinearPdeSolver::Solve 11ms 0.29% 0.32% 1883ms 49.88% AbstractCardiacTissue::SolveCellSystems 0 0% 0.32% 1490ms 39.47% LinearSystem::Solve 0 0% 0.32% 1465ms 38.81% KSPSolve 3ms 0.079% 0.4% 1465ms 38.81% KSPSolve_Private 3ms 0.079% 0.48% 1426ms 37.77% KSPSolve_SYMMLQ 13ms 0.34% 0.82% 1093ms 28.95% AbstractCardiacCell::ComputeExceptVoltage 21ms 0.56% 1.38% 976ms 25.85% AbstractOneStepIvpOdeSolver::InternalSolve 92ms 2.44% 3.81% 812ms 21.51% EulerIvpOdeSolver::CalculateNextYValue 4ms 0.11% 3.92% 799ms 21.17% PCApply 1ms 0.026% 3.95% 793ms 21.01% PCApply_BJacobi_Singleblock 240ms 6.36% 10.30% 711ms 18.83% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 10.30% 681ms 18.04% KSPSolve_PREONLY (partial-inline) 3ms 0.079% 10.38% 652ms 17.27% MatMult 0 0% 10.38% 649ms 17.19% MatSolve 0 0% 10.38% 649ms 17.19% PCApply_ICC 9ms 0.24% 10.62% 645ms 17.09% MatMult_SeqAIJ (partial-inline) 631ms 16.72% 27.34% 645ms 17.09% MatMult_SeqAIJ_Inode (inline) 638ms 16.90% 44.24% 641ms 16.98% MatSolve_SeqSBAIJ_1_NaturalOrdering 13ms 0.34% 44.58% 639ms 16.93% AbstractCardiacTissue::UpdateCaches (inline) 256ms 6.78% 51.36% 603ms 15.97% CellLuoRudy1991FromCellML::GetIIonic 0 0% 51.36% 600ms 15.89% KSP_PCApply.lto_priv.18 202ms 5.35% 56.72% 566ms 14.99% __GI___exp 37ms 0.98% 57.70% 320ms 8.48% BidomainSolver::SetupLinearSystem 311ms 8.24% 65.93% 312ms 8.26% __ieee754_exp_fma 2ms 0.053% 65.99% 280ms 7.42% KSPConvergedDefault 0 0% 65.99% 263ms 6.97% KSP_PCApply (partial-inline) 6ms 0.16% 66.15% 166ms 4.40% std::pow (inline) 8ms 0.21% 66.36% 160ms 4.24% __pow 5ms 0.13% 66.49% 150ms 3.97% __ieee754_pow_fma 74ms 1.96% 68.45% 113ms 2.99% CellLuoRudy1991FromCellML::VerifyStateVariables 113ms 2.99% 71.44% 113ms 2.99% [libchaste_heart.so] 1ms 0.026% 71.47% 112ms 2.97% MatNullSpaceRemove 33ms 0.87% 72.34% 76ms 2.01% TimeStepper::TimeStepper 64ms 1.70% 74.04% 76ms 2.01% exp_inline (inline) 18ms 0.48% 74.52% 74ms 1.96% MPI_Wtime 0 0% 74.52% 74ms 1.96% VecDuplicate 67ms 1.77% 76.29% 67ms 1.77% log_inline (inline) 0 0% 76.29% 57ms 1.51% VecMDot 3ms 0.079% 76.37% 57ms 1.51% VecMXDot_Private 7ms 0.19% 76.56% 56ms 1.48% PetscLogEventBeginDefault 56ms 1.48% 78.04% 56ms 1.48% [libm.so.6] 1ms 0.026% 78.07% 56ms 1.48% __GI___clock_gettime 55ms 1.46% 79.52% 55ms 1.46% [[vdso]] 4ms 0.11% 79.63% 54ms 1.43% VecMAXPY 53ms 1.40% 81.03% 53ms 1.40% TimeStepper::CalculateNextTime 8ms 0.21% 81.25% 47ms 1.25% PetscLogEventEndDefault 47ms 1.25% 82.49% 47ms 1.25% ddot_ 4ms 0.11% 82.60% 41ms 1.09% VecDuplicate_MPI 3ms 0.079% 82.68% 39ms 1.03% VecDot 1ms 0.026% 82.70% 38ms 1.01% KSP_RemoveNullSpace (inline) 0 0% 82.70% 37ms 0.98% VecCopy 36ms 0.95% 83.66% 37ms 0.98% VecMDot_Seq 35ms 0.93% 84.58% 35ms 0.93% __memcpy_avx512_unaligned_erms 15ms 0.4% 84.98% 33ms 0.87% TimeStepper::AdvanceOneTimeStep 0 0% 84.98% 33ms 0.87% VecDuplicate_Seq 2ms 0.053% 85.03% 32ms 0.85% VecDestroy 0 0% 85.03% 32ms 0.85% VecDot_Seq 29ms 0.77% 85.80% 32ms 0.85% VecMAXPY_Seq 0 0% 85.80% 32ms 0.85% VecNorm 1ms 0.026% 85.83% 32ms 0.85% VecXDot_Seq_Private.constprop.0 6ms 0.16% 85.99% 29ms 0.77% AbstractCardiacCell::SetVoltage (partial-inline) 19ms 0.5% 86.49% 28ms 0.74% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 19ms 0.5% 86.99% 27ms 0.72% AbstractOneStepIvpOdeSolver::Solve 0 0% 86.99% 27ms 0.72% CxxTest::RealWorldDescription::setUp 0 0% 86.99% 27ms 0.72% PMPI_Init_thread 0 0% 86.99% 27ms 0.72% PetscInitialize 1ms 0.026% 87.02% 27ms 0.72% PetscMallocA 0 0% 87.02% 27ms 0.72% PetscSetup::setUpWorld 0 0% 87.02% 27ms 0.72% PetscSetupUtils::CommonSetup 0 0% 87.02% 27ms 0.72% PetscSetupUtils::InitialisePetsc 0 0% 87.02% 27ms 0.72% ompi_mpi_init 2ms 0.053% 87.07% 26ms 0.69% 1ms 0.026% 87.10% 26ms 0.69% PetscMallocAlign 1ms 0.026% 87.13% 25ms 0.66% AbstractBidomainSolver::FinaliseLinearSystem 1ms 0.026% 87.15% 25ms 0.66% VecCreate 0 0% 87.15% 25ms 0.66% VecNorm_Seq 4ms 0.11% 87.26% 24ms 0.64% AbstractBidomainSolver::CheckCompatibilityCondition 9ms 0.24% 87.50% 24ms 0.64% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 87.50% 23ms 0.61% PetscMemcpy (inline) 19ms 0.5% 88.00% 22ms 0.58% AbstractParameterisedSystem::GetAnyVariable 0 0% 88.00% 21ms 0.56% VecCreate_MPI_Private 1ms 0.026% 88.03% 21ms 0.56% VecSetType 3ms 0.079% 88.11% 20ms 0.53% VecAXPY 20ms 0.53% 88.64% 20ms 0.53% __ieee754_log_fma 2ms 0.053% 88.69% 20ms 0.53% __posix_memalign 1ms 0.026% 88.72% 19ms 0.5% VecCopy_Seq (partial-inline) 1ms 0.026% 88.74% 19ms 0.5% VecCreate_Seq 19ms 0.5% 89.25% 19ms 0.5% [libchaste_ode.so] 5ms 0.13% 89.38% 19ms 0.5% __GI___libc_malloc