File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3746ms, 86.81% of 4315ms total Dropped 466 nodes (cum <= 21.57ms) flat flat% sum% cum cum% 0 0% 0% 4308ms 99.84% __libc_start_call_main 0 0% 0% 4308ms 99.84% __libc_start_main_impl 0 0% 0% 4308ms 99.84% _start 0 0% 0% 4305ms 99.77% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4305ms 99.77% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4305ms 99.77% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4305ms 99.77% main 0 0% 0% 4263ms 98.79% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4263ms 98.79% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4263ms 98.79% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4256ms 98.63% AbstractCardiacProblem::Solve 0 0% 0% 4244ms 98.35% AbstractDynamicLinearPdeSolver::Solve 25ms 0.58% 0.58% 2217ms 51.38% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.6% 1706ms 39.54% LinearSystem::Solve 0 0% 0.6% 1653ms 38.31% KSPSolve 7ms 0.16% 0.76% 1653ms 38.31% KSPSolve_Private 2ms 0.046% 0.81% 1609ms 37.29% KSPSolve_SYMMLQ 41ms 0.95% 1.76% 1321ms 30.61% AbstractCardiacCell::ComputeExceptVoltage 26ms 0.6% 2.36% 1115ms 25.84% AbstractOneStepIvpOdeSolver::InternalSolve 4ms 0.093% 2.46% 1027ms 23.80% PCApply 0 0% 2.46% 1014ms 23.50% PCApply_BJacobi_Singleblock 90ms 2.09% 4.54% 952ms 22.06% EulerIvpOdeSolver::CalculateNextYValue 0 0% 4.54% 865ms 20.05% KSPSolve_PREONLY (partial-inline) 228ms 5.28% 9.83% 847ms 19.63% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.023% 9.85% 808ms 18.73% PCApply_ICC 4ms 0.093% 9.94% 807ms 18.70% MatSolve 793ms 18.38% 28.32% 796ms 18.45% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 28.32% 770ms 17.84% KSP_PCApply.lto_priv.18 334ms 7.74% 36.06% 762ms 17.66% __GI___exp 25ms 0.58% 36.64% 686ms 15.90% AbstractCardiacTissue::UpdateCaches (inline) 213ms 4.94% 41.58% 638ms 14.79% CellLuoRudy1991FromCellML::GetIIonic 9ms 0.21% 41.78% 435ms 10.08% MatMult 1ms 0.023% 41.81% 421ms 9.76% MatMult_SeqAIJ 416ms 9.64% 51.45% 421ms 9.76% MatMult_SeqAIJ_Inode (inline) 378ms 8.76% 60.21% 402ms 9.32% __ieee754_exp_fma 1ms 0.023% 60.23% 348ms 8.06% KSPConvergedDefault 0 0% 60.23% 342ms 7.93% KSP_PCApply (partial-inline) 49ms 1.14% 61.37% 278ms 6.44% BidomainSolver::SetupLinearSystem 5ms 0.12% 61.48% 224ms 5.19% std::pow (inline) 21ms 0.49% 61.97% 219ms 5.08% __pow 35ms 0.81% 62.78% 198ms 4.59% __ieee754_pow_fma 1ms 0.023% 62.80% 138ms 3.20% MatNullSpaceRemove 64ms 1.48% 64.29% 136ms 3.15% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 64.29% 97ms 2.25% VecDuplicate 31ms 0.72% 65.01% 95ms 2.20% MPI_Wtime 86ms 1.99% 67.00% 86ms 1.99% log_inline (inline) 1ms 0.023% 67.02% 80ms 1.85% VecMDot 5ms 0.12% 67.14% 79ms 1.83% VecMXDot_Private 17ms 0.39% 67.53% 75ms 1.74% PetscLogEventBeginDefault 72ms 1.67% 69.20% 73ms 1.69% exp_inline (inline) 70ms 1.62% 70.82% 70ms 1.62% ddot_ 28ms 0.65% 71.47% 69ms 1.60% TimeStepper::TimeStepper 15ms 0.35% 71.82% 66ms 1.53% PetscLogEventEndDefault 5ms 0.12% 71.94% 63ms 1.46% __GI___clock_gettime 59ms 1.37% 73.30% 60ms 1.39% VecMDot_Seq 1ms 0.023% 73.33% 58ms 1.34% VecDuplicate_MPI 58ms 1.34% 74.67% 58ms 1.34% [[vdso]] 2ms 0.046% 74.72% 57ms 1.32% VecMAXPY 2ms 0.046% 74.76% 56ms 1.30% VecAXPY 1ms 0.023% 74.79% 53ms 1.23% VecCopy 46ms 1.07% 75.85% 50ms 1.16% AbstractOneStepIvpOdeSolver::Solve 0 0% 75.85% 50ms 1.16% VecDot 1ms 0.023% 75.87% 49ms 1.14% VecNorm 46ms 1.07% 76.94% 46ms 1.07% __ieee754_log_fma 0 0% 76.94% 45ms 1.04% VecDestroy 10ms 0.23% 77.17% 44ms 1.02% PetscMallocA 0 0% 77.17% 44ms 1.02% VecDot_Seq 0 0% 77.17% 44ms 1.02% VecXDot_Seq_Private.constprop.0 44ms 1.02% 78.19% 44ms 1.02% __memcpy_avx_unaligned_erms 38ms 0.88% 79.07% 43ms 1% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 42ms 0.97% 80.05% 42ms 0.97% TimeStepper::CalculateNextTime 4ms 0.093% 80.14% 42ms 0.97% VecCreate 0 0% 80.14% 42ms 0.97% VecNorm_Seq 7ms 0.16% 80.30% 40ms 0.93% AbstractCardiacCell::SetVoltage (partial-inline) 23ms 0.53% 80.83% 40ms 0.93% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 40ms 0.93% 81.76% 40ms 0.93% std::isinf (inline) 0 0% 81.76% 39ms 0.9% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 81.76% 39ms 0.9% VecDuplicate_Seq 16ms 0.37% 82.13% 38ms 0.88% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 82.13% 38ms 0.88% CxxTest::RealWorldDescription::setUp 0 0% 82.13% 38ms 0.88% PMPI_Init_thread 0 0% 82.13% 38ms 0.88% PetscInitialize 0 0% 82.13% 38ms 0.88% PetscMemcpy (inline) 0 0% 82.13% 38ms 0.88% PetscSetup::setUpWorld 0 0% 82.13% 38ms 0.88% PetscSetupUtils::CommonSetup 0 0% 82.13% 38ms 0.88% PetscSetupUtils::InitialisePetsc 0 0% 82.13% 38ms 0.88% ompi_mpi_init 36ms 0.83% 82.97% 36ms 0.83% [libchaste_heart.so] 3ms 0.07% 83.04% 34ms 0.79% PetscMallocAlign 0 0% 83.04% 34ms 0.79% VecNorm_MPI 0 0% 83.04% 34ms 0.79% VecNorm_MPI_Default.constprop.0 1ms 0.023% 83.06% 32ms 0.74% VecCopy_Seq (partial-inline) 4ms 0.093% 83.15% 32ms 0.74% VecCreate_MPI_Private 25ms 0.58% 83.73% 31ms 0.72% VecMAXPY_Seq 0 0% 83.73% 30ms 0.7% 1ms 0.023% 83.75% 30ms 0.7% VecAXPY_Seq 12ms 0.28% 84.03% 27ms 0.63% top12 (inline) 24ms 0.56% 84.59% 26ms 0.6% AbstractParameterisedSystem::SetAnyVariable 26ms 0.6% 85.19% 26ms 0.6% DistributedVector::Stripe::operator[] (inline) 26ms 0.6% 85.79% 26ms 0.6% [libm.so.6] 26ms 0.6% 86.40% 26ms 0.6% daxpy_ 0 0% 86.40% 25ms 0.58% orte_init 13ms 0.3% 86.70% 25ms 0.58% std::__cxx11::basic_string::basic_string 1ms 0.023% 86.72% 23ms 0.53% VecScale 1ms 0.023% 86.74% 22ms 0.51% VecSetType 3ms 0.07% 86.81% 22ms 0.51% __GI___libc_malloc