File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 4487ms, 90.81% of 4941ms total Dropped 424 nodes (cum <= 24.70ms) flat flat% sum% cum cum% 0 0% 0% 4935ms 99.88% __libc_start_call_main 0 0% 0% 4935ms 99.88% __libc_start_main_impl 0 0% 0% 4935ms 99.88% _start 0 0% 0% 4933ms 99.84% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4933ms 99.84% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4933ms 99.84% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4933ms 99.84% main 0 0% 0% 4899ms 99.15% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4899ms 99.15% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4899ms 99.15% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 1ms 0.02% 0.02% 4892ms 99.01% AbstractCardiacProblem::Solve 2ms 0.04% 0.061% 4874ms 98.64% AbstractDynamicLinearPdeSolver::Solve 10ms 0.2% 0.26% 2272ms 45.98% AbstractCardiacTissue::SolveCellSystems 1ms 0.02% 0.28% 2092ms 42.34% LinearSystem::Solve 0 0% 0.28% 2044ms 41.37% KSPSolve 4ms 0.081% 0.36% 2044ms 41.37% KSPSolve_Private 2ms 0.04% 0.4% 2003ms 40.54% KSPSolve_SYMMLQ 17ms 0.34% 0.75% 1297ms 26.25% AbstractCardiacCell::ComputeExceptVoltage 16ms 0.32% 1.07% 1159ms 23.46% AbstractOneStepIvpOdeSolver::InternalSolve 4ms 0.081% 1.15% 1121ms 22.69% MatMult 13ms 0.26% 1.42% 1116ms 22.59% MatMult_SeqAIJ (partial-inline) 1083ms 21.92% 23.34% 1109ms 22.44% MatMult_SeqAIJ_Inode (inline) 2ms 0.04% 23.38% 1004ms 20.32% PCApply 1ms 0.02% 23.40% 999ms 20.22% PCApply_BJacobi_Singleblock 99ms 2.00% 25.40% 966ms 19.55% EulerIvpOdeSolver::CalculateNextYValue 308ms 6.23% 31.63% 862ms 17.45% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.02% 31.65% 856ms 17.32% KSPSolve_PREONLY (partial-inline) 36ms 0.73% 32.38% 819ms 16.58% AbstractCardiacTissue::UpdateCaches (inline) 1ms 0.02% 32.40% 810ms 16.39% MatSolve 0 0% 32.40% 810ms 16.39% PCApply_ICC 806ms 16.31% 48.71% 808ms 16.35% MatSolve_SeqSBAIJ_1_NaturalOrdering 388ms 7.85% 56.57% 769ms 15.56% CellLuoRudy1991FromCellML::GetIIonic 0 0% 56.57% 716ms 14.49% KSP_PCApply.lto_priv.18 223ms 4.51% 61.08% 624ms 12.63% __GI___exp 42ms 0.85% 61.93% 480ms 9.71% BidomainSolver::SetupLinearSystem 1ms 0.02% 61.95% 362ms 7.33% KSPConvergedDefault 0 0% 61.95% 350ms 7.08% KSP_PCApply (partial-inline) 315ms 6.38% 68.33% 315ms 6.38% __ieee754_exp_fma 3ms 0.061% 68.39% 188ms 3.80% std::pow (inline) 15ms 0.3% 68.69% 178ms 3.60% __pow 9ms 0.18% 68.87% 162ms 3.28% __ieee754_pow_fma 127ms 2.57% 71.44% 127ms 2.57% [libchaste_heart.so] 0 0% 71.44% 122ms 2.47% MatNullSpaceRemove 80ms 1.62% 73.06% 113ms 2.29% CellLuoRudy1991FromCellML::VerifyStateVariables 97ms 1.96% 75.03% 97ms 1.96% [libm.so.6] 83ms 1.68% 76.71% 83ms 1.68% ddot_ 82ms 1.66% 78.36% 82ms 1.66% log_inline (inline) 0 0% 78.36% 81ms 1.64% VecDuplicate 71ms 1.44% 79.80% 71ms 1.44% TimeStepper::CalculateNextTime 20ms 0.4% 80.21% 70ms 1.42% TimeStepper::TimeStepper 67ms 1.36% 81.56% 69ms 1.40% exp_inline (inline) 0 0% 81.56% 67ms 1.36% VecMDot 3ms 0.061% 81.62% 67ms 1.36% VecMXDot_Private 23ms 0.47% 82.09% 60ms 1.21% MPI_Wtime 0 0% 82.09% 60ms 1.21% VecDot 0 0% 82.09% 58ms 1.17% VecDot_Seq 0 0% 82.09% 58ms 1.17% VecXDot_Seq_Private.constprop.0 6ms 0.12% 82.21% 55ms 1.11% VecMAXPY 2ms 0.04% 82.25% 54ms 1.09% VecDestroy 50ms 1.01% 83.26% 51ms 1.03% VecMDot_Seq 51ms 1.03% 84.29% 51ms 1.03% __ieee754_log_fma 2ms 0.04% 84.34% 49ms 0.99% VecCopy 1ms 0.02% 84.36% 48ms 0.97% VecNorm 17ms 0.34% 84.70% 47ms 0.95% TimeStepper::AdvanceOneTimeStep 46ms 0.93% 85.63% 46ms 0.93% __memcpy_evex_unaligned_erms 0 0% 85.63% 43ms 0.87% VecNorm_Seq 11ms 0.22% 85.85% 42ms 0.85% PetscLogEventBeginDefault 7ms 0.14% 85.99% 42ms 0.85% PetscLogEventEndDefault 9ms 0.18% 86.18% 42ms 0.85% PetscMallocA 1ms 0.02% 86.20% 41ms 0.83% VecDuplicate_MPI 3ms 0.061% 86.26% 40ms 0.81% VecAXPY 0 0% 86.26% 40ms 0.81% VecDuplicate_Seq 30ms 0.61% 86.87% 37ms 0.75% AbstractOneStepIvpOdeSolver::Solve 1ms 0.02% 86.89% 37ms 0.75% __GI___clock_gettime 36ms 0.73% 87.61% 36ms 0.73% [[vdso]] 36ms 0.73% 88.34% 36ms 0.73% [libchaste_ode.so] 21ms 0.43% 88.77% 35ms 0.71% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 88.77% 35ms 0.71% VecCreate 4ms 0.081% 88.85% 33ms 0.67% PetscMallocAlign 32ms 0.65% 89.50% 33ms 0.67% VecMAXPY_Seq 1ms 0.02% 89.52% 30ms 0.61% VecAXPY_Seq 0 0% 89.52% 30ms 0.61% std::vector::_M_assign_aux (inline) 0 0% 89.52% 30ms 0.61% std::vector::assign (inline) 13ms 0.26% 89.78% 29ms 0.59% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 89.78% 29ms 0.59% CxxTest::RealWorldDescription::setUp 0 0% 89.78% 29ms 0.59% PMPI_Init_thread 0 0% 89.78% 29ms 0.59% PetscInitialize 0 0% 89.78% 29ms 0.59% PetscSetup::setUpWorld 0 0% 89.78% 29ms 0.59% PetscSetupUtils::CommonSetup 0 0% 89.78% 29ms 0.59% PetscSetupUtils::InitialisePetsc 0 0% 89.78% 29ms 0.59% ompi_mpi_init 6ms 0.12% 89.90% 27ms 0.55% __GI___libc_free 27ms 0.55% 90.45% 27ms 0.55% daxpy_ 0 0% 90.45% 27ms 0.55% std::__copy_move::__copy_m (inline) 0 0% 90.45% 27ms 0.55% std::__copy_move_a (inline) 0 0% 90.45% 27ms 0.55% std::__copy_move_a1 (inline) 0 0% 90.45% 27ms 0.55% std::__copy_move_a2 (inline) 0 0% 90.45% 27ms 0.55% std::copy (inline) 1ms 0.02% 90.47% 26ms 0.53% 2ms 0.04% 90.51% 26ms 0.53% PetscFreeAlign 0 0% 90.51% 26ms 0.53% PetscMemcpy (inline) 4ms 0.081% 90.59% 26ms 0.53% VecCreate_MPI_Private 0 0% 90.59% 26ms 0.53% VecNorm_MPI 1ms 0.02% 90.61% 26ms 0.53% VecNorm_MPI_Default.constprop.0 0 0% 90.61% 25ms 0.51% AbstractBidomainSolver::FinaliseLinearSystem 9ms 0.18% 90.79% 25ms 0.51% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.02% 90.81% 25ms 0.51% VecCopy_Seq (partial-inline)