File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3633ms, 85.79% of 4235ms total Dropped 493 nodes (cum <= 21.18ms) flat flat% sum% cum cum% 0 0% 0% 4227ms 99.81% __libc_start_call_main 0 0% 0% 4227ms 99.81% __libc_start_main_impl 0 0% 0% 4227ms 99.81% _start 0 0% 0% 4224ms 99.74% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4224ms 99.74% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4224ms 99.74% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4224ms 99.74% main 0 0% 0% 4183ms 98.77% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4183ms 98.77% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4183ms 98.77% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4176ms 98.61% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4162ms 98.28% AbstractDynamicLinearPdeSolver::Solve 10ms 0.24% 0.26% 2287ms 54.00% AbstractCardiacTissue::SolveCellSystems 0 0% 0.26% 1586ms 37.45% LinearSystem::Solve 0 0% 0.26% 1539ms 36.34% KSPSolve 13ms 0.31% 0.57% 1539ms 36.34% KSPSolve_Private 1ms 0.024% 0.59% 1482ms 34.99% KSPSolve_SYMMLQ 46ms 1.09% 1.68% 1326ms 31.31% AbstractCardiacCell::ComputeExceptVoltage 23ms 0.54% 2.22% 1116ms 26.35% AbstractOneStepIvpOdeSolver::InternalSolve 6ms 0.14% 2.36% 1013ms 23.92% PCApply 2ms 0.047% 2.41% 1004ms 23.71% PCApply_BJacobi_Singleblock 75ms 1.77% 4.18% 952ms 22.48% EulerIvpOdeSolver::CalculateNextYValue 0 0% 4.18% 870ms 20.54% KSPSolve_PREONLY (partial-inline) 226ms 5.34% 9.52% 866ms 20.45% CellLuoRudy1991FromCellML::EvaluateYDerivatives 2ms 0.047% 9.56% 819ms 19.34% PCApply_ICC 2ms 0.047% 9.61% 817ms 19.29% MatSolve 808ms 19.08% 28.69% 812ms 19.17% MatSolve_SeqSBAIJ_1_NaturalOrdering 337ms 7.96% 36.65% 812ms 19.17% __GI___exp 36ms 0.85% 37.50% 766ms 18.09% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 37.50% 717ms 16.93% KSP_PCApply.lto_priv.18 239ms 5.64% 43.14% 704ms 16.62% CellLuoRudy1991FromCellML::GetIIonic 429ms 10.13% 53.27% 450ms 10.63% __ieee754_exp_fma 6ms 0.14% 53.41% 401ms 9.47% MatMult 6ms 0.14% 53.55% 387ms 9.14% MatMult_SeqAIJ (partial-inline) 375ms 8.85% 62.41% 387ms 9.14% MatMult_SeqAIJ_Inode (inline) 3ms 0.071% 62.48% 362ms 8.55% KSPConvergedDefault 0 0% 62.48% 356ms 8.41% KSP_PCApply (partial-inline) 47ms 1.11% 63.59% 252ms 5.95% BidomainSolver::SetupLinearSystem 3ms 0.071% 63.66% 232ms 5.48% std::pow (inline) 17ms 0.4% 64.06% 229ms 5.41% __pow 23ms 0.54% 64.60% 211ms 4.98% __ieee754_pow_fma 56ms 1.32% 65.93% 146ms 3.45% CellLuoRudy1991FromCellML::VerifyStateVariables 106ms 2.50% 68.43% 106ms 2.50% log_inline (inline) 2ms 0.047% 68.48% 99ms 2.34% MatNullSpaceRemove 0 0% 68.48% 83ms 1.96% VecDuplicate 18ms 0.43% 68.90% 72ms 1.70% MPI_Wtime 71ms 1.68% 70.58% 72ms 1.70% exp_inline (inline) 70ms 1.65% 72.23% 70ms 1.65% ddot_ 33ms 0.78% 73.01% 64ms 1.51% TimeStepper::TimeStepper 10ms 0.24% 73.25% 58ms 1.37% PetscLogEventEndDefault 0 0% 73.25% 56ms 1.32% VecMDot 4ms 0.094% 73.34% 56ms 1.32% VecMXDot_Private 54ms 1.28% 74.62% 54ms 1.28% [[vdso]] 0 0% 74.62% 54ms 1.28% __GI___clock_gettime 1ms 0.024% 74.64% 53ms 1.25% VecNorm 10ms 0.24% 74.88% 50ms 1.18% AbstractCardiacCell::SetVoltage (partial-inline) 4ms 0.094% 74.97% 50ms 1.18% VecCopy 1ms 0.024% 74.99% 50ms 1.18% VecDuplicate_MPI 1ms 0.024% 75.02% 47ms 1.11% VecDot 24ms 0.57% 75.58% 46ms 1.09% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 75.61% 46ms 1.09% VecDestroy 0 0% 75.61% 46ms 1.09% VecNorm_Seq 7ms 0.17% 75.77% 45ms 1.06% PetscLogEventBeginDefault 44ms 1.04% 76.81% 44ms 1.04% std::isinf (inline) 30ms 0.71% 77.52% 42ms 0.99% AbstractOneStepIvpOdeSolver::Solve 2ms 0.047% 77.57% 41ms 0.97% VecMAXPY 41ms 0.97% 78.54% 41ms 0.97% __ieee754_log_fma 38ms 0.9% 79.43% 40ms 0.94% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 79.43% 40ms 0.94% VecDot_Seq 1ms 0.024% 79.46% 40ms 0.94% VecXDot_Seq_Private.constprop.0 35ms 0.83% 80.28% 38ms 0.9% VecMDot_Seq 37ms 0.87% 81.16% 37ms 0.87% TimeStepper::CalculateNextTime 0 0% 81.16% 36ms 0.85% CxxTest::RealWorldDescription::setUp 0 0% 81.16% 36ms 0.85% PetscInitialize 0 0% 81.16% 36ms 0.85% PetscSetup::setUpWorld 0 0% 81.16% 36ms 0.85% PetscSetupUtils::CommonSetup 0 0% 81.16% 36ms 0.85% PetscSetupUtils::InitialisePetsc 0 0% 81.16% 35ms 0.83% PMPI_Init_thread 0 0% 81.16% 35ms 0.83% ompi_mpi_init 2ms 0.047% 81.20% 33ms 0.78% VecDuplicate_Seq 20ms 0.47% 81.68% 32ms 0.76% TimeStepper::AdvanceOneTimeStep 4ms 0.094% 81.77% 32ms 0.76% VecCreate_MPI_Private 0 0% 81.77% 32ms 0.76% VecNorm_MPI 0 0% 81.77% 32ms 0.76% VecNorm_MPI_Default.constprop.0 27ms 0.64% 82.41% 31ms 0.73% AbstractParameterisedSystem::SetAnyVariable 7ms 0.17% 82.57% 31ms 0.73% PetscMallocA 0 0% 82.57% 31ms 0.73% VecAXPY 1ms 0.024% 82.60% 31ms 0.73% VecCreate 30ms 0.71% 83.31% 30ms 0.71% __memcpy_avx_unaligned_erms 15ms 0.35% 83.66% 29ms 0.68% top12 (inline) 8ms 0.19% 83.85% 28ms 0.66% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 83.85% 28ms 0.66% AbstractBidomainSolver::FinaliseLinearSystem 2ms 0.047% 83.90% 27ms 0.64% 0 0% 83.90% 26ms 0.61% PetscMemcpy (inline) 26ms 0.61% 84.51% 26ms 0.61% [libchaste_heart.so] 26ms 0.61% 85.12% 26ms 0.61% [libm.so.6] 4ms 0.094% 85.22% 24ms 0.57% PetscMallocAlign 2ms 0.047% 85.27% 24ms 0.57% VecCopy_Seq (partial-inline) 0 0% 85.27% 24ms 0.57% orte_init 22ms 0.52% 85.79% 23ms 0.54% VecMAXPY_Seq