File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3712ms, 87.10% of 4262ms total Dropped 485 nodes (cum <= 21.31ms) flat flat% sum% cum cum% 0 0% 0% 4253ms 99.79% __libc_start_call_main 0 0% 0% 4253ms 99.79% __libc_start_main_impl 0 0% 0% 4253ms 99.79% _start 0 0% 0% 4250ms 99.72% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4250ms 99.72% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4250ms 99.72% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4250ms 99.72% main 0 0% 0% 4210ms 98.78% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4210ms 98.78% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4210ms 98.78% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 2ms 0.047% 0.047% 4203ms 98.62% AbstractCardiacProblem::Solve 0 0% 0.047% 4190ms 98.31% AbstractDynamicLinearPdeSolver::Solve 14ms 0.33% 0.38% 2128ms 49.93% AbstractCardiacTissue::SolveCellSystems 0 0% 0.38% 1740ms 40.83% LinearSystem::Solve 0 0% 0.38% 1703ms 39.96% KSPSolve 2ms 0.047% 0.42% 1703ms 39.96% KSPSolve_Private 4ms 0.094% 0.52% 1667ms 39.11% KSPSolve_SYMMLQ 28ms 0.66% 1.17% 1252ms 29.38% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.17% 1111ms 26.07% PCApply 0 0% 1.17% 1109ms 26.02% PCApply_BJacobi_Singleblock 24ms 0.56% 1.74% 1067ms 25.04% AbstractOneStepIvpOdeSolver::InternalSolve 0 0% 1.74% 953ms 22.36% KSPSolve_PREONLY 3ms 0.07% 1.81% 909ms 21.33% MatSolve 0 0% 1.81% 909ms 21.33% PCApply_ICC 49ms 1.15% 2.96% 908ms 21.30% EulerIvpOdeSolver::CalculateNextYValue 836ms 19.62% 22.57% 902ms 21.16% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 248ms 5.82% 28.39% 845ms 19.83% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 28.39% 817ms 19.17% KSP_PCApply.lto_priv.18 337ms 7.91% 36.30% 741ms 17.39% __GI___exp 16ms 0.38% 36.67% 700ms 16.42% AbstractCardiacTissue::UpdateCaches (inline) 232ms 5.44% 42.12% 653ms 15.32% CellLuoRudy1991FromCellML::GetIIonic 3ms 0.07% 42.19% 404ms 9.48% MatMult 2ms 0.047% 42.23% 395ms 9.27% MatMult_SeqAIJ 393ms 9.22% 51.45% 395ms 9.27% MatMult_SeqAIJ_Inode (inline) 363ms 8.52% 59.97% 390ms 9.15% __ieee754_exp_fma 0 0% 59.97% 385ms 9.03% KSPConvergedDefault 0 0% 59.97% 358ms 8.40% KSP_PCApply (partial-inline) 52ms 1.22% 61.19% 269ms 6.31% BidomainSolver::SetupLinearSystem 1ms 0.023% 61.22% 221ms 5.19% std::pow (inline) 17ms 0.4% 61.61% 220ms 5.16% __pow 37ms 0.87% 62.48% 202ms 4.74% __ieee754_pow_fma 61ms 1.43% 63.91% 128ms 3.00% CellLuoRudy1991FromCellML::VerifyStateVariables 6ms 0.14% 64.05% 116ms 2.72% MatNullSpaceRemove 110ms 2.58% 66.64% 110ms 2.58% __memcpy_avx_unaligned_erms 0 0% 66.64% 101ms 2.37% VecDuplicate 101ms 2.37% 69.01% 101ms 2.37% log_inline (inline) 0 0% 69.01% 94ms 2.21% PetscMemcpy (inline) 19ms 0.45% 69.45% 85ms 1.99% MPI_Wtime 0 0% 69.45% 72ms 1.69% VecMDot 2ms 0.047% 69.50% 72ms 1.69% VecMXDot_Private 3ms 0.07% 69.57% 66ms 1.55% __GI___clock_gettime 63ms 1.48% 71.05% 63ms 1.48% [[vdso]] 13ms 0.31% 71.35% 62ms 1.45% PetscLogEventEndDefault 60ms 1.41% 72.76% 60ms 1.41% ddot_ 29ms 0.68% 73.44% 59ms 1.38% TimeStepper::TimeStepper 57ms 1.34% 74.78% 58ms 1.36% exp_inline (inline) 4ms 0.094% 74.87% 55ms 1.29% VecCopy 2ms 0.047% 74.92% 55ms 1.29% VecDuplicate_MPI 13ms 0.31% 75.22% 52ms 1.22% PetscLogEventBeginDefault 0 0% 75.22% 51ms 1.20% VecDot 49ms 1.15% 76.37% 49ms 1.15% VecMDot_Seq 0 0% 76.37% 48ms 1.13% KSP_RemoveNullSpace (inline) 6ms 0.14% 76.51% 48ms 1.13% VecAXPY 11ms 0.26% 76.77% 46ms 1.08% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 76.77% 46ms 1.08% AbstractBidomainSolver::FinaliseLinearSystem 2ms 0.047% 76.82% 46ms 1.08% VecDuplicate_Seq 43ms 1.01% 77.83% 44ms 1.03% __ieee754_log_fma 11ms 0.26% 78.09% 43ms 1.01% AbstractCardiacCell::SetVoltage (partial-inline) 4ms 0.094% 78.18% 43ms 1.01% VecDestroy 0 0% 78.18% 42ms 0.99% VecDot_Seq 2ms 0.047% 78.23% 42ms 0.99% VecNorm 1ms 0.023% 78.25% 42ms 0.99% VecXDot_Seq_Private.constprop.0 36ms 0.84% 79.09% 40ms 0.94% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 4ms 0.094% 79.19% 39ms 0.92% PetscMallocA 35ms 0.82% 80.01% 38ms 0.89% AbstractOneStepIvpOdeSolver::Solve 2ms 0.047% 80.06% 38ms 0.89% VecMAXPY 0 0% 80.06% 36ms 0.84% CxxTest::RealWorldDescription::setUp 0 0% 80.06% 36ms 0.84% PetscInitialize 0 0% 80.06% 36ms 0.84% PetscSetup::setUpWorld 0 0% 80.06% 36ms 0.84% PetscSetupUtils::CommonSetup 0 0% 80.06% 36ms 0.84% PetscSetupUtils::InitialisePetsc 2ms 0.047% 80.10% 36ms 0.84% VecCreate 0 0% 80.10% 35ms 0.82% PMPI_Init_thread 1ms 0.023% 80.13% 35ms 0.82% PetscMallocAlign (partial-inline) 35ms 0.82% 80.95% 35ms 0.82% TimeStepper::CalculateNextTime 0 0% 80.95% 35ms 0.82% ompi_mpi_init 18ms 0.42% 81.37% 34ms 0.8% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 81.37% 34ms 0.8% VecNorm_Seq 33ms 0.77% 82.14% 33ms 0.77% DistributedVector::Iterator::operator!= 0 0% 82.14% 33ms 0.77% VecAXPY_Seq 2ms 0.047% 82.19% 33ms 0.77% VecCreate_MPI_Private 11ms 0.26% 82.45% 31ms 0.73% top12 (inline) 0 0% 82.45% 29ms 0.68% PetscTimeSubtract (inline) 29ms 0.68% 83.13% 29ms 0.68% daxpy_ 29ms 0.68% 83.81% 29ms 0.68% std::isinf (inline) 1ms 0.023% 83.83% 28ms 0.66% 0 0% 83.83% 28ms 0.66% PetscMemzero (inline) 1ms 0.023% 83.86% 28ms 0.66% VecCopy_Seq (partial-inline) 28ms 0.66% 84.51% 28ms 0.66% __memset_avx2_unaligned_erms 2ms 0.047% 84.56% 26ms 0.61% VecSet 0 0% 84.56% 26ms 0.61% VecSetType 20ms 0.47% 85.03% 25ms 0.59% AbstractParameterisedSystem::SetAnyVariable 25ms 0.59% 85.62% 25ms 0.59% DistributedVector::Stripe::operator[] (inline) 5ms 0.12% 85.73% 25ms 0.59% PetscOptionsFindPair 24ms 0.56% 86.30% 24ms 0.56% [libchaste_heart.so] 9ms 0.21% 86.51% 24ms 0.56% __GI___libc_malloc 24ms 0.56% 87.07% 24ms 0.56% asuint64 (inline) 0 0% 87.07% 24ms 0.56% orte_init 0 0% 87.07% 23ms 0.54% VecNorm_MPI 0 0% 87.07% 23ms 0.54% VecNorm_MPI_Default.constprop.0 1ms 0.023% 87.10% 23ms 0.54% std::vector::_M_assign_aux (inline) 0 0% 87.10% 23ms 0.54% std::vector::assign (inline)