File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3702ms, 86.60% of 4275ms total Dropped 444 nodes (cum <= 21.38ms) flat flat% sum% cum cum% 0 0% 0% 4266ms 99.79% __libc_start_call_main 0 0% 0% 4266ms 99.79% __libc_start_main_impl 0 0% 0% 4266ms 99.79% _start 0 0% 0% 4263ms 99.72% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4263ms 99.72% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4263ms 99.72% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4263ms 99.72% main 0 0% 0% 4225ms 98.83% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4225ms 98.83% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4225ms 98.83% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4218ms 98.67% AbstractCardiacProblem::Solve 1ms 0.023% 0.023% 4205ms 98.36% AbstractDynamicLinearPdeSolver::Solve 22ms 0.51% 0.54% 2212ms 51.74% AbstractCardiacTissue::SolveCellSystems 0 0% 0.54% 1502ms 35.13% LinearSystem::Solve 0 0% 0.54% 1466ms 34.29% KSPSolve 5ms 0.12% 0.65% 1466ms 34.29% KSPSolve_Private 2ms 0.047% 0.7% 1416ms 33.12% KSPSolve_SYMMLQ 21ms 0.49% 1.19% 1203ms 28.14% AbstractCardiacCell::ComputeExceptVoltage 30ms 0.7% 1.89% 1066ms 24.94% AbstractOneStepIvpOdeSolver::InternalSolve 55ms 1.29% 3.18% 875ms 20.47% EulerIvpOdeSolver::CalculateNextYValue 2ms 0.047% 3.23% 837ms 19.58% PCApply 2ms 0.047% 3.27% 829ms 19.39% PCApply_BJacobi_Singleblock 34ms 0.8% 4.07% 808ms 18.90% AbstractCardiacTissue::UpdateCaches (inline) 233ms 5.45% 9.52% 808ms 18.90% CellLuoRudy1991FromCellML::EvaluateYDerivatives 364ms 8.51% 18.04% 737ms 17.24% __GI___exp 291ms 6.81% 24.84% 733ms 17.15% CellLuoRudy1991FromCellML::GetIIonic 0 0% 24.84% 694ms 16.23% KSPSolve_PREONLY (partial-inline) 1ms 0.023% 24.87% 638ms 14.92% PCApply_ICC 2ms 0.047% 24.91% 637ms 14.90% MatSolve 625ms 14.62% 39.53% 631ms 14.76% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1ms 0.023% 39.56% 573ms 13.40% KSP_PCApply.lto_priv.18 3ms 0.07% 39.63% 507ms 11.86% MatMult 14ms 0.33% 39.95% 496ms 11.60% MatMult_SeqAIJ (partial-inline) 480ms 11.23% 51.18% 495ms 11.58% MatMult_SeqAIJ_Inode (inline) 99ms 2.32% 53.50% 434ms 10.15% BidomainSolver::SetupLinearSystem 0 0% 53.50% 356ms 8.33% KSPConvergedDefault 301ms 7.04% 60.54% 354ms 8.28% __ieee754_exp_fma 0 0% 60.54% 338ms 7.91% KSP_PCApply (partial-inline) 28ms 0.65% 61.19% 214ms 5.01% __pow 0 0% 61.19% 214ms 5.01% std::pow (inline) 25ms 0.58% 61.78% 185ms 4.33% __ieee754_pow_fma 2ms 0.047% 61.82% 138ms 3.23% MatNullSpaceRemove 66ms 1.54% 63.37% 109ms 2.55% CellLuoRudy1991FromCellML::VerifyStateVariables 18ms 0.42% 63.79% 93ms 2.18% MPI_Wtime 0 0% 63.79% 91ms 2.13% VecMDot 2ms 0.047% 63.84% 91ms 2.13% VecMXDot_Private 85ms 1.99% 65.82% 85ms 1.99% log_inline (inline) 27ms 0.63% 66.46% 78ms 1.82% TimeStepper::TimeStepper 2ms 0.047% 66.50% 78ms 1.82% VecDuplicate 13ms 0.3% 66.81% 77ms 1.80% PetscLogEventEndDefault 77ms 1.80% 68.61% 77ms 1.80% ddot_ 2ms 0.047% 68.65% 74ms 1.73% __GI___clock_gettime 72ms 1.68% 70.34% 72ms 1.68% [[vdso]] 64ms 1.50% 71.84% 66ms 1.54% exp_inline (inline) 13ms 0.3% 72.14% 59ms 1.38% AbstractCardiacCell::SetVoltage (partial-inline) 59ms 1.38% 73.52% 59ms 1.38% VecMDot_Seq 59ms 1.38% 74.90% 59ms 1.38% [libchaste_heart.so] 6ms 0.14% 75.04% 55ms 1.29% PetscLogEventBeginDefault 54ms 1.26% 76.30% 54ms 1.26% TimeStepper::CalculateNextTime 3ms 0.07% 76.37% 54ms 1.26% VecNorm 3ms 0.07% 76.44% 53ms 1.24% VecDestroy 1ms 0.023% 76.47% 49ms 1.15% AbstractBidomainSolver::FinaliseLinearSystem 20ms 0.47% 76.94% 48ms 1.12% AbstractBidomainSolver::CheckCompatibilityCondition 7ms 0.16% 77.10% 48ms 1.12% VecCopy 0 0% 77.10% 48ms 1.12% VecNorm_Seq 47ms 1.10% 78.20% 47ms 1.10% DistributedVector::Stripe::operator[] (inline) 3ms 0.07% 78.27% 47ms 1.10% VecDuplicate_MPI 37ms 0.87% 79.13% 46ms 1.08% top12 (inline) 2ms 0.047% 79.18% 45ms 1.05% VecAXPY 4ms 0.094% 79.27% 45ms 1.05% VecMAXPY 0 0% 79.27% 42ms 0.98% VecDot 0 0% 79.27% 40ms 0.94% KSP_RemoveNullSpace (inline) 32ms 0.75% 80.02% 39ms 0.91% AbstractParameterisedSystem::SetAnyVariable 0 0% 80.02% 39ms 0.91% VecDot_Seq 0 0% 80.02% 39ms 0.91% VecXDot_Seq_Private.constprop.0 39ms 0.91% 80.94% 39ms 0.91% __memcpy_avx_unaligned_erms 2ms 0.047% 80.98% 36ms 0.84% VecCreate 0 0% 80.98% 34ms 0.8% CxxTest::RealWorldDescription::setUp 0 0% 80.98% 34ms 0.8% PetscInitialize 0 0% 80.98% 34ms 0.8% PetscSetup::setUpWorld 0 0% 80.98% 34ms 0.8% PetscSetupUtils::CommonSetup 0 0% 80.98% 34ms 0.8% PetscSetupUtils::InitialisePetsc 0 0% 80.98% 33ms 0.77% PMPI_Init_thread 6ms 0.14% 81.12% 33ms 0.77% PetscMallocA 0 0% 81.12% 33ms 0.77% ompi_mpi_init 16ms 0.37% 81.50% 31ms 0.73% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 31ms 0.73% 82.22% 31ms 0.73% DistributedVector::Iterator::operator!= 0 0% 82.22% 30ms 0.7% PetscMemcpy (inline) 0 0% 82.22% 29ms 0.68% VecDuplicate_Seq 0 0% 82.22% 29ms 0.68% VecNorm_MPI 0 0% 82.22% 29ms 0.68% VecNorm_MPI_Default.constprop.0 0 0% 82.22% 27ms 0.63% 3ms 0.07% 82.29% 27ms 0.63% PetscHeaderDestroy_Private 3ms 0.07% 82.36% 27ms 0.63% PetscMallocAlign 27ms 0.63% 82.99% 27ms 0.63% asuint64 (inline) 22ms 0.51% 83.51% 26ms 0.61% AbstractOneStepIvpOdeSolver::Solve 16ms 0.37% 83.88% 26ms 0.61% TimeStepper::AdvanceOneTimeStep 24ms 0.56% 84.44% 24ms 0.56% TimeStepper::GetNextTimeStep 24ms 0.56% 85.01% 24ms 0.56% VecMAXPY_Seq 1ms 0.023% 85.03% 23ms 0.54% VecCopy_Seq (partial-inline) 3ms 0.07% 85.10% 23ms 0.54% VecCreate_MPI_Private 23ms 0.54% 85.64% 23ms 0.54% __ieee754_log_fma 0 0% 85.64% 23ms 0.54% orte_init 19ms 0.44% 86.08% 22ms 0.51% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 22ms 0.51% 86.60% 22ms 0.51% RegularStimulus::GetStimulus 0 0% 86.60% 22ms 0.51% VecAXPY_Seq