File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 4024ms, 89.98% of 4472ms total Dropped 466 nodes (cum <= 22.36ms) flat flat% sum% cum cum% 0 0% 0% 4463ms 99.80% __libc_start_call_main 0 0% 0% 4463ms 99.80% __libc_start_main_impl 0 0% 0% 4463ms 99.80% _start 0 0% 0% 4460ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4460ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4460ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4460ms 99.73% main 0 0% 0% 4425ms 98.95% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4425ms 98.95% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4425ms 98.95% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4417ms 98.77% AbstractCardiacProblem::Solve 0 0% 0% 4404ms 98.48% AbstractDynamicLinearPdeSolver::Solve 17ms 0.38% 0.38% 2305ms 51.54% AbstractCardiacTissue::SolveCellSystems 0 0% 0.38% 1616ms 36.14% LinearSystem::Solve 0 0% 0.38% 1587ms 35.49% KSPSolve 2ms 0.045% 0.42% 1587ms 35.49% KSPSolve_Private 1ms 0.022% 0.45% 1541ms 34.46% KSPSolve_SYMMLQ 11ms 0.25% 0.69% 1318ms 29.47% AbstractCardiacCell::ComputeExceptVoltage 27ms 0.6% 1.30% 1202ms 26.88% AbstractOneStepIvpOdeSolver::InternalSolve 109ms 2.44% 3.73% 1016ms 22.72% EulerIvpOdeSolver::CalculateNextYValue 299ms 6.69% 10.42% 900ms 20.13% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 10.42% 871ms 19.48% PCApply 0 0% 10.42% 867ms 19.39% PCApply_BJacobi_Singleblock 3ms 0.067% 10.49% 784ms 17.53% MatMult 27ms 0.6% 11.09% 780ms 17.44% AbstractCardiacTissue::UpdateCaches (inline) 5ms 0.11% 11.20% 778ms 17.40% MatMult_SeqAIJ (partial-inline) 773ms 17.29% 28.49% 778ms 17.40% MatMult_SeqAIJ_Inode (inline) 0 0% 28.49% 761ms 17.02% KSPSolve_PREONLY (partial-inline) 362ms 8.09% 36.58% 732ms 16.37% CellLuoRudy1991FromCellML::GetIIonic 2ms 0.045% 36.63% 724ms 16.19% MatSolve 0 0% 36.63% 724ms 16.19% PCApply_ICC 716ms 16.01% 52.64% 718ms 16.06% MatSolve_SeqSBAIJ_1_NaturalOrdering 249ms 5.57% 58.21% 686ms 15.34% __GI___exp 0 0% 58.21% 627ms 14.02% KSP_PCApply.lto_priv.18 54ms 1.21% 59.41% 449ms 10.04% BidomainSolver::SetupLinearSystem 378ms 8.45% 67.87% 378ms 8.45% __ieee754_exp_fma 0 0% 67.87% 306ms 6.84% KSPConvergedDefault 0 0% 67.87% 301ms 6.73% KSP_PCApply (partial-inline) 2ms 0.045% 67.91% 182ms 4.07% std::pow (inline) 14ms 0.31% 68.22% 179ms 4.00% __pow 6ms 0.13% 68.36% 163ms 3.64% __ieee754_pow_fma 94ms 2.10% 70.46% 156ms 3.49% CellLuoRudy1991FromCellML::VerifyStateVariables 135ms 3.02% 73.48% 135ms 3.02% [libchaste_heart.so] 1ms 0.022% 73.50% 100ms 2.24% MatNullSpaceRemove 37ms 0.83% 74.33% 80ms 1.79% TimeStepper::TimeStepper 71ms 1.59% 75.92% 80ms 1.79% exp_inline (inline) 75ms 1.68% 77.59% 75ms 1.68% log_inline (inline) 0 0% 77.59% 73ms 1.63% VecDuplicate 63ms 1.41% 79.00% 63ms 1.41% TimeStepper::CalculateNextTime 63ms 1.41% 80.41% 63ms 1.41% [libm.so.6] 0 0% 80.41% 60ms 1.34% VecMDot 4ms 0.089% 80.50% 60ms 1.34% VecMXDot_Private 12ms 0.27% 80.77% 58ms 1.30% MPI_Wtime 5ms 0.11% 80.88% 50ms 1.12% PetscLogEventEndDefault 50ms 1.12% 82.00% 50ms 1.12% ddot_ 1ms 0.022% 82.02% 46ms 1.03% __GI___clock_gettime 45ms 1.01% 83.03% 45ms 1.01% [[vdso]] 10ms 0.22% 83.25% 43ms 0.96% PetscLogEventBeginDefault 43ms 0.96% 84.21% 43ms 0.96% VecMDot_Seq 1ms 0.022% 84.24% 42ms 0.94% VecDot 12ms 0.27% 84.50% 39ms 0.87% TimeStepper::AdvanceOneTimeStep 1ms 0.022% 84.53% 39ms 0.87% VecDuplicate_MPI 0 0% 84.53% 39ms 0.87% VecMAXPY 4ms 0.089% 84.62% 38ms 0.85% VecAXPY 0 0% 84.62% 37ms 0.83% VecDot_Seq 0 0% 84.62% 37ms 0.83% VecXDot_Seq_Private.constprop.0 5ms 0.11% 84.73% 36ms 0.81% VecCopy 16ms 0.36% 85.08% 36ms 0.81% std::__cxx11::basic_string::basic_string 29ms 0.65% 85.73% 35ms 0.78% AbstractOneStepIvpOdeSolver::Solve 1ms 0.022% 85.76% 35ms 0.78% VecDestroy 0 0% 85.76% 34ms 0.76% VecCreate 0 0% 85.76% 34ms 0.76% VecDuplicate_Seq 10ms 0.22% 85.98% 33ms 0.74% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 85.98% 31ms 0.69% CxxTest::RealWorldDescription::setUp 0 0% 85.98% 31ms 0.69% PetscInitialize 0 0% 85.98% 31ms 0.69% PetscSetup::setUpWorld 0 0% 85.98% 31ms 0.69% PetscSetupUtils::CommonSetup 0 0% 85.98% 31ms 0.69% PetscSetupUtils::InitialisePetsc 0 0% 85.98% 30ms 0.67% PMPI_Init_thread 30ms 0.67% 86.65% 30ms 0.67% [libchaste_ode.so] 0 0% 86.65% 30ms 0.67% ompi_mpi_init 8ms 0.18% 86.83% 28ms 0.63% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 86.83% 28ms 0.63% AbstractBidomainSolver::FinaliseLinearSystem 27ms 0.6% 87.43% 28ms 0.63% VecMAXPY_Seq 16ms 0.36% 87.79% 27ms 0.6% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.022% 87.81% 26ms 0.58% VecNorm 25ms 0.56% 88.37% 25ms 0.56% __ieee754_log_fma 25ms 0.56% 88.93% 25ms 0.56% __memcpy_avx512_unaligned_erms 24ms 0.54% 89.47% 24ms 0.54% ReplicatableVector::operator[] 0 0% 89.47% 24ms 0.54% VecAXPY_Seq 0 0% 89.47% 23ms 0.51% 23ms 0.51% 89.98% 23ms 0.51% daxpy_