File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 4166ms, 89.57% of 4651ms total Dropped 433 nodes (cum <= 23.25ms) flat flat% sum% cum cum% 0 0% 0% 4642ms 99.81% __libc_start_call_main 0 0% 0% 4642ms 99.81% __libc_start_main_impl 0 0% 0% 4642ms 99.81% _start 0 0% 0% 4639ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4639ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4639ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4639ms 99.74% main 0 0% 0% 4602ms 98.95% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4602ms 98.95% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4602ms 98.95% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 0 0% 0% 4596ms 98.82% AbstractCardiacProblem::Solve 0 0% 0% 4586ms 98.60% AbstractDynamicLinearPdeSolver::Solve 12ms 0.26% 0.26% 2323ms 49.95% AbstractCardiacTissue::SolveCellSystems 0 0% 0.26% 1724ms 37.07% LinearSystem::Solve 0 0% 0.26% 1705ms 36.66% KSPSolve 0 0% 0.26% 1705ms 36.66% KSPSolve_Private 2ms 0.043% 0.3% 1673ms 35.97% KSPSolve_SYMMLQ 12ms 0.26% 0.56% 1298ms 27.91% AbstractCardiacCell::ComputeExceptVoltage 20ms 0.43% 0.99% 1170ms 25.16% AbstractOneStepIvpOdeSolver::InternalSolve 100ms 2.15% 3.14% 977ms 21.01% EulerIvpOdeSolver::CalculateNextYValue 3ms 0.065% 3.20% 905ms 19.46% PCApply 3ms 0.065% 3.27% 903ms 19.42% MatMult 7ms 0.15% 3.42% 897ms 19.29% MatMult_SeqAIJ (partial-inline) 889ms 19.11% 22.53% 897ms 19.29% MatMult_SeqAIJ_Inode (inline) 1ms 0.022% 22.55% 893ms 19.20% PCApply_BJacobi_Singleblock 279ms 6.00% 28.55% 863ms 18.56% CellLuoRudy1991FromCellML::EvaluateYDerivatives 21ms 0.45% 29.00% 831ms 17.87% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 29.00% 788ms 16.94% KSPSolve_PREONLY (partial-inline) 342ms 7.35% 36.36% 778ms 16.73% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.022% 36.38% 735ms 15.80% MatSolve 0 0% 36.38% 735ms 15.80% PCApply_ICC 1ms 0.022% 36.40% 731ms 15.72% KSP_PCApply.lto_priv.18 723ms 15.55% 51.95% 724ms 15.57% MatSolve_SeqSBAIJ_1_NaturalOrdering 236ms 5.07% 57.02% 680ms 14.62% __GI___exp 64ms 1.38% 58.40% 515ms 11.07% BidomainSolver::SetupLinearSystem 388ms 8.34% 66.74% 391ms 8.41% __ieee754_exp_fma 0 0% 66.74% 270ms 5.81% KSPConvergedDefault 1ms 0.022% 66.76% 251ms 5.40% KSP_PCApply (partial-inline) 7ms 0.15% 66.91% 229ms 4.92% std::pow (inline) 11ms 0.24% 67.15% 222ms 4.77% __pow 9ms 0.19% 67.34% 208ms 4.47% __ieee754_pow_fma 143ms 3.07% 70.41% 143ms 3.07% [libchaste_heart.so] 80ms 1.72% 72.14% 137ms 2.95% CellLuoRudy1991FromCellML::VerifyStateVariables 3ms 0.065% 72.20% 117ms 2.52% MatNullSpaceRemove 99ms 2.13% 74.33% 113ms 2.43% exp_inline (inline) 84ms 1.81% 76.13% 84ms 1.81% log_inline (inline) 24ms 0.52% 76.65% 80ms 1.72% TimeStepper::TimeStepper 23ms 0.49% 77.14% 77ms 1.66% MPI_Wtime 2ms 0.043% 77.19% 74ms 1.59% VecDuplicate 72ms 1.55% 78.74% 72ms 1.55% TimeStepper::CalculateNextTime 0 0% 78.74% 64ms 1.38% VecMDot 3ms 0.065% 78.80% 64ms 1.38% VecMXDot_Private 58ms 1.25% 80.05% 58ms 1.25% [libm.so.6] 55ms 1.18% 81.23% 55ms 1.18% ddot_ 9ms 0.19% 81.42% 54ms 1.16% PetscLogEventEndDefault 54ms 1.16% 82.58% 54ms 1.16% [[vdso]] 0 0% 82.58% 53ms 1.14% __GI___clock_gettime 1ms 0.022% 82.61% 50ms 1.08% VecMAXPY 48ms 1.03% 83.64% 48ms 1.03% VecMDot_Seq 4ms 0.086% 83.72% 44ms 0.95% PetscLogEventBeginDefault 17ms 0.37% 84.09% 43ms 0.92% TimeStepper::AdvanceOneTimeStep 2ms 0.043% 84.13% 43ms 0.92% VecNorm 1ms 0.022% 84.15% 41ms 0.88% VecDestroy 1ms 0.022% 84.18% 41ms 0.88% VecDot 10ms 0.22% 84.39% 37ms 0.8% AbstractCardiacCell::SetVoltage (partial-inline) 37ms 0.8% 85.19% 37ms 0.8% __ieee754_log_fma 5ms 0.11% 85.29% 36ms 0.77% VecDuplicate_MPI 0 0% 85.29% 36ms 0.77% VecDuplicate_Seq 34ms 0.73% 86.02% 35ms 0.75% VecMAXPY_Seq 24ms 0.52% 86.54% 34ms 0.73% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 2ms 0.043% 86.58% 34ms 0.73% VecAXPY 0 0% 86.58% 34ms 0.73% VecCreate 27ms 0.58% 87.16% 33ms 0.71% AbstractOneStepIvpOdeSolver::Solve 0 0% 87.16% 33ms 0.71% CxxTest::RealWorldDescription::setUp 0 0% 87.16% 33ms 0.71% PetscInitialize 5ms 0.11% 87.27% 33ms 0.71% PetscMallocA 0 0% 87.27% 33ms 0.71% PetscSetup::setUpWorld 0 0% 87.27% 33ms 0.71% PetscSetupUtils::CommonSetup 0 0% 87.27% 33ms 0.71% PetscSetupUtils::InitialisePetsc 0 0% 87.27% 32ms 0.69% PMPI_Init_thread 0 0% 87.27% 32ms 0.69% VecNorm_Seq 0 0% 87.27% 32ms 0.69% ompi_mpi_init 2ms 0.043% 87.31% 31ms 0.67% VecCopy 6ms 0.13% 87.44% 31ms 0.67% std::__cxx11::basic_string::basic_string 1ms 0.022% 87.47% 30ms 0.65% 0 0% 87.47% 30ms 0.65% VecDot_Seq 1ms 0.022% 87.49% 30ms 0.65% VecXDot_Seq_Private.constprop.0 30ms 0.65% 88.13% 30ms 0.65% [libchaste_ode.so] 1ms 0.022% 88.15% 28ms 0.6% PetscMallocAlign 27ms 0.58% 88.73% 27ms 0.58% __memcpy_avx512_unaligned_erms 15ms 0.32% 89.06% 25ms 0.54% std::char_traits::length (inline) 24ms 0.52% 89.57% 24ms 0.52% DistributedVector::Stripe::operator[] (inline)