File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3602ms, 86.84% of 4148ms total Dropped 480 nodes (cum <= 20.74ms) flat flat% sum% cum cum% 0 0% 0% 4141ms 99.83% __libc_start_call_main 0 0% 0% 4141ms 99.83% __libc_start_main_impl 0 0% 0% 4141ms 99.83% _start 0 0% 0% 4138ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4138ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4138ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4138ms 99.76% main 0 0% 0% 4100ms 98.84% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4100ms 98.84% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4100ms 98.84% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4092ms 98.65% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4081ms 98.38% AbstractDynamicLinearPdeSolver::Solve 15ms 0.36% 0.39% 2310ms 55.69% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.41% 1342ms 32.35% LinearSystem::Solve 18ms 0.43% 0.84% 1323ms 31.89% AbstractCardiacCell::ComputeExceptVoltage 0 0% 0.84% 1276ms 30.76% KSPSolve 4ms 0.096% 0.94% 1276ms 30.76% KSPSolve_Private 0 0% 0.94% 1207ms 29.10% KSPSolve_SYMMLQ 25ms 0.6% 1.54% 1144ms 27.58% AbstractOneStepIvpOdeSolver::InternalSolve 51ms 1.23% 2.77% 986ms 23.77% EulerIvpOdeSolver::CalculateNextYValue 272ms 6.56% 9.33% 918ms 22.13% CellLuoRudy1991FromCellML::EvaluateYDerivatives 411ms 9.91% 19.24% 827ms 19.94% __GI___exp 25ms 0.6% 19.84% 773ms 18.64% AbstractCardiacTissue::UpdateCaches (inline) 4ms 0.096% 19.94% 740ms 17.84% PCApply 2ms 0.048% 19.99% 731ms 17.62% PCApply_BJacobi_Singleblock 254ms 6.12% 26.11% 721ms 17.38% CellLuoRudy1991FromCellML::GetIIonic 0 0% 26.11% 591ms 14.25% KSPSolve_PREONLY (partial-inline) 4ms 0.096% 26.21% 563ms 13.57% MatSolve 0 0% 26.21% 563ms 13.57% PCApply_ICC 550ms 13.26% 39.46% 556ms 13.40% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 1ms 0.024% 39.49% 547ms 13.19% KSP_PCApply.lto_priv.18 2ms 0.048% 39.54% 460ms 11.09% MatMult 1ms 0.024% 39.56% 454ms 10.95% MatMult_SeqAIJ 444ms 10.70% 50.27% 454ms 10.95% MatMult_SeqAIJ_Inode (inline) 354ms 8.53% 58.80% 389ms 9.38% __ieee754_exp_fma 53ms 1.28% 60.08% 364ms 8.78% BidomainSolver::SetupLinearSystem 0 0% 60.08% 248ms 5.98% KSPConvergedDefault 0 0% 60.08% 232ms 5.59% KSP_PCApply (partial-inline) 3ms 0.072% 60.15% 224ms 5.40% std::pow (inline) 17ms 0.41% 60.56% 221ms 5.33% __pow 30ms 0.72% 61.28% 203ms 4.89% __ieee754_pow_fma 66ms 1.59% 62.87% 154ms 3.71% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 62.90% 128ms 3.09% VecDuplicate 89ms 2.15% 65.04% 89ms 2.15% exp_inline (inline) 25ms 0.6% 65.65% 88ms 2.12% MPI_Wtime 0 0% 65.65% 86ms 2.07% MatNullSpaceRemove 81ms 1.95% 67.60% 81ms 1.95% log_inline (inline) 6ms 0.14% 67.74% 73ms 1.76% VecDuplicate_MPI 55ms 1.33% 69.07% 69ms 1.66% AbstractOneStepIvpOdeSolver::Solve 7ms 0.17% 69.24% 63ms 1.52% VecCopy 2ms 0.048% 69.29% 63ms 1.52% __GI___clock_gettime 14ms 0.34% 69.62% 62ms 1.49% PetscLogEventEndDefault 61ms 1.47% 71.09% 61ms 1.47% [[vdso]] 2ms 0.048% 71.14% 60ms 1.45% AbstractBidomainSolver::FinaliseLinearSystem 12ms 0.29% 71.43% 58ms 1.40% AbstractBidomainSolver::CheckCompatibilityCondition 27ms 0.65% 72.08% 57ms 1.37% TimeStepper::TimeStepper 3ms 0.072% 72.16% 54ms 1.30% VecDuplicate_Seq 0 0% 72.16% 54ms 1.30% VecMDot 3ms 0.072% 72.23% 54ms 1.30% VecMXDot_Private 9ms 0.22% 72.44% 53ms 1.28% PetscLogEventBeginDefault 49ms 1.18% 73.63% 49ms 1.18% ddot_ 47ms 1.13% 74.76% 47ms 1.13% __memcpy_avx_unaligned_erms 10ms 0.24% 75.00% 45ms 1.08% AbstractCardiacCell::SetVoltage (partial-inline) 2ms 0.048% 75.05% 45ms 1.08% PetscMallocA 44ms 1.06% 76.11% 44ms 1.06% TimeStepper::CalculateNextTime 1ms 0.024% 76.13% 43ms 1.04% PetscMallocAlign (partial-inline) 2ms 0.048% 76.18% 42ms 1.01% VecDot 0 0% 76.18% 42ms 1.01% VecNorm 41ms 0.99% 77.17% 41ms 0.99% DistributedVector::Iterator::operator!= 0 0% 77.17% 41ms 0.99% PetscMemcpy (inline) 39ms 0.94% 78.11% 41ms 0.99% VecMDot_Seq 1ms 0.024% 78.13% 40ms 0.96% VecCreate 4ms 0.096% 78.23% 40ms 0.96% VecCreate_MPI_Private 39ms 0.94% 79.17% 39ms 0.94% std::isinf (inline) 37ms 0.89% 80.06% 38ms 0.92% __ieee754_log_fma 0 0% 80.06% 36ms 0.87% VecNorm_Seq 12ms 0.29% 80.35% 36ms 0.87% top12 (inline) 0 0% 80.35% 35ms 0.84% VecDot_Seq 2ms 0.048% 80.40% 35ms 0.84% VecSetType 0 0% 80.40% 35ms 0.84% VecXDot_Seq_Private.constprop.0 2ms 0.048% 80.45% 34ms 0.82% VecDestroy 27ms 0.65% 81.10% 33ms 0.8% AbstractParameterisedSystem::SetAnyVariable 0 0% 81.10% 33ms 0.8% CxxTest::RealWorldDescription::setUp 0 0% 81.10% 33ms 0.8% PetscInitialize 0 0% 81.10% 33ms 0.8% PetscSetup::setUpWorld 0 0% 81.10% 33ms 0.8% PetscSetupUtils::CommonSetup 0 0% 81.10% 33ms 0.8% PetscSetupUtils::InitialisePetsc 0 0% 81.10% 32ms 0.77% PMPI_Init_thread 1ms 0.024% 81.12% 32ms 0.77% VecMAXPY 0 0% 81.12% 32ms 0.77% ompi_mpi_init 25ms 0.6% 81.73% 31ms 0.75% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 9ms 0.22% 81.94% 30ms 0.72% std::__cxx11::basic_string::basic_string 0 0% 81.94% 29ms 0.7% VecAXPY 1ms 0.024% 81.97% 29ms 0.7% VecCopy_Seq (partial-inline) 29ms 0.7% 82.67% 29ms 0.7% [libchaste_heart.so] 18ms 0.43% 83.10% 28ms 0.68% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 83.10% 28ms 0.68% VecNorm_MPI 0 0% 83.10% 28ms 0.68% VecNorm_MPI_Default.constprop.0 28ms 0.68% 83.78% 28ms 0.68% [libm.so.6] 10ms 0.24% 84.02% 27ms 0.65% TimeStepper::AdvanceOneTimeStep 0 0% 84.02% 27ms 0.65% VecCreate_Seq 27ms 0.65% 84.67% 27ms 0.65% asuint64 (inline) 2ms 0.048% 84.72% 26ms 0.63% __posix_memalign 26ms 0.63% 85.34% 26ms 0.63% std::vector::operator[] (inline) 0 0% 85.34% 25ms 0.6% 4ms 0.096% 85.44% 24ms 0.58% PetscHeaderCreate_Private 6ms 0.14% 85.58% 24ms 0.58% __GI___libc_malloc 0 0% 85.58% 23ms 0.55% KSP_RemoveNullSpace (inline) 0 0% 85.58% 23ms 0.55% orte_init 5ms 0.12% 85.70% 22ms 0.53% PMPI_Comm_get_attr 0 0% 85.70% 21ms 0.51% PetscMemzero (inline) 0 0% 85.70% 21ms 0.51% PetscVecTools::Finalise 3ms 0.072% 85.78% 21ms 0.51% VecAssemblyBegin 2ms 0.048% 85.82% 21ms 0.51% VecStashCreate_Private 21ms 0.51% 86.33% 21ms 0.51% __memset_avx2_unaligned_erms 21ms 0.51% 86.84% 21ms 0.51% dasum_