File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 2797ms, 84.76% of 3300ms total Dropped 430 nodes (cum <= 16.50ms) flat flat% sum% cum cum% 0 0% 0% 3291ms 99.73% __libc_start_call_main 0 0% 0% 3291ms 99.73% __libc_start_main_impl 0 0% 0% 3291ms 99.73% _start 0 0% 0% 3289ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3289ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3289ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3289ms 99.67% main 0 0% 0% 3255ms 98.64% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3255ms 98.64% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3255ms 98.64% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 3249ms 98.45% AbstractCardiacProblem::Solve 0 0% 0% 3233ms 97.97% AbstractDynamicLinearPdeSolver::Solve 1ms 0.03% 0.03% 1582ms 47.94% LinearSystem::Solve 0 0% 0.03% 1538ms 46.61% KSPSolve 3ms 0.091% 0.12% 1538ms 46.61% KSPSolve_Private 5ms 0.15% 0.27% 1496ms 45.33% KSPSolve_SYMMLQ 14ms 0.42% 0.7% 1425ms 43.18% AbstractCardiacTissue::SolveCellSystems 3ms 0.091% 0.79% 939ms 28.45% PCApply 0 0% 0.79% 934ms 28.30% PCApply_BJacobi_Singleblock 0 0% 0.79% 796ms 24.12% KSPSolve_PREONLY (partial-inline) 19ms 0.58% 1.36% 783ms 23.73% AbstractCardiacCell::ComputeExceptVoltage 5ms 0.15% 1.52% 733ms 22.21% MatSolve 0 0% 1.52% 733ms 22.21% PCApply_ICC 720ms 21.82% 23.33% 723ms 21.91% MatSolve_SeqSBAIJ_1_NaturalOrdering 13ms 0.39% 23.73% 661ms 20.03% AbstractOneStepIvpOdeSolver::InternalSolve 0 0% 23.73% 651ms 19.73% KSP_PCApply.lto_priv.18 29ms 0.88% 24.61% 551ms 16.70% EulerIvpOdeSolver::CalculateNextYValue 125ms 3.79% 28.39% 515ms 15.61% CellLuoRudy1991FromCellML::EvaluateYDerivatives 8ms 0.24% 28.64% 514ms 15.58% AbstractCardiacTissue::UpdateCaches (inline) 242ms 7.33% 35.97% 491ms 14.88% __GI___exp 162ms 4.91% 40.88% 479ms 14.52% CellLuoRudy1991FromCellML::GetIIonic 2ms 0.061% 40.94% 382ms 11.58% MatMult 7ms 0.21% 41.15% 376ms 11.39% MatMult_SeqAIJ (partial-inline) 361ms 10.94% 52.09% 373ms 11.30% MatMult_SeqAIJ_Inode (inline) 0 0% 52.09% 372ms 11.27% KSP_PCApply (partial-inline) 2ms 0.061% 52.15% 368ms 11.15% KSPConvergedDefault 194ms 5.88% 58.03% 237ms 7.18% __ieee754_exp_fma 33ms 1.00% 59.03% 199ms 6.03% BidomainSolver::SetupLinearSystem 2ms 0.061% 59.09% 173ms 5.24% std::pow (inline) 11ms 0.33% 59.42% 170ms 5.15% __pow 13ms 0.39% 59.82% 159ms 4.82% __ieee754_pow_fma 0 0% 59.82% 136ms 4.12% MatNullSpaceRemove 89ms 2.70% 62.52% 89ms 2.70% log_inline (inline) 39ms 1.18% 63.70% 87ms 2.64% CellLuoRudy1991FromCellML::VerifyStateVariables 25ms 0.76% 64.45% 87ms 2.64% MPI_Wtime 0 0% 64.45% 84ms 2.55% VecMDot 5ms 0.15% 64.61% 84ms 2.55% VecMXDot_Private 83ms 2.52% 67.12% 83ms 2.52% ddot_ 17ms 0.52% 67.64% 77ms 2.33% PetscLogEventEndDefault 1ms 0.03% 67.67% 77ms 2.33% VecDuplicate 9ms 0.27% 67.94% 68ms 2.06% VecCopy 62ms 1.88% 69.82% 62ms 1.88% [[vdso]] 0 0% 69.82% 62ms 1.88% __GI___clock_gettime 61ms 1.85% 71.67% 61ms 1.85% VecMDot_Seq 9ms 0.27% 71.94% 60ms 1.82% PetscLogEventBeginDefault 2ms 0.061% 72.00% 59ms 1.79% VecDestroy 1ms 0.03% 72.03% 56ms 1.70% VecDot 1ms 0.03% 72.06% 52ms 1.58% VecMAXPY 0 0% 72.06% 50ms 1.52% VecDot_Seq 0 0% 72.06% 50ms 1.52% VecXDot_Seq_Private.constprop.0 48ms 1.45% 73.52% 50ms 1.52% exp_inline (inline) 2ms 0.061% 73.58% 48ms 1.45% VecNorm 5ms 0.15% 73.73% 46ms 1.39% VecDuplicate_MPI (partial-inline) 1ms 0.03% 73.76% 43ms 1.30% VecNorm_Seq 3ms 0.091% 73.85% 42ms 1.27% VecAXPY 41ms 1.24% 75.09% 41ms 1.24% __memcpy_avx512_unaligned_erms 15ms 0.45% 75.55% 40ms 1.21% TimeStepper::TimeStepper 1ms 0.03% 75.58% 39ms 1.18% PetscTimeSubtract (inline) 8ms 0.24% 75.82% 35ms 1.06% AbstractCardiacCell::SetVoltage (partial-inline) 30ms 0.91% 76.73% 35ms 1.06% top12 (inline) 0 0% 76.73% 34ms 1.03% PetscMemcpy (inline) 0 0% 76.73% 32ms 0.97% CxxTest::RealWorldDescription::setUp 0 0% 76.73% 32ms 0.97% PetscInitialize 0 0% 76.73% 32ms 0.97% PetscSetup::setUpWorld 0 0% 76.73% 32ms 0.97% PetscSetupUtils::CommonSetup 0 0% 76.73% 32ms 0.97% PetscSetupUtils::InitialisePetsc 20ms 0.61% 77.33% 31ms 0.94% AbstractOneStepIvpOdeSolver::Solve 0 0% 77.33% 31ms 0.94% PMPI_Init_thread 2ms 0.061% 77.39% 31ms 0.94% PetscMallocA 29ms 0.88% 78.27% 31ms 0.94% VecMAXPY_Seq 0 0% 78.27% 31ms 0.94% ompi_mpi_init 0 0% 78.27% 30ms 0.91% VecDuplicate_Seq 2ms 0.061% 78.33% 29ms 0.88% PetscMallocAlign 29ms 0.88% 79.21% 29ms 0.88% TimeStepper::CalculateNextTime 0 0% 79.21% 29ms 0.88% VecCreate 1ms 0.03% 79.24% 28ms 0.85% 1ms 0.03% 79.27% 28ms 0.85% PetscHeaderDestroy_Private 3ms 0.091% 79.36% 27ms 0.82% VecCopy_Seq (partial-inline) 20ms 0.61% 79.97% 26ms 0.79% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 20ms 0.61% 80.58% 24ms 0.73% AbstractParameterisedSystem::SetAnyVariable 24ms 0.73% 81.30% 24ms 0.73% [libchaste_heart.so] 9ms 0.27% 81.58% 23ms 0.7% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.58% 23ms 0.7% AbstractBidomainSolver::FinaliseLinearSystem 3ms 0.091% 81.67% 23ms 0.7% VecCreate_MPI_Private 23ms 0.7% 82.36% 23ms 0.7% __ieee754_log_fma 3ms 0.091% 82.45% 22ms 0.67% __posix_memalign 22ms 0.67% 83.12% 22ms 0.67% asuint64 (inline) 0 0% 83.12% 22ms 0.67% orte_init 8ms 0.24% 83.36% 21ms 0.64% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.03% 83.39% 21ms 0.64% VecAXPY_Seq 0 0% 83.39% 21ms 0.64% VecNorm_MPI 0 0% 83.39% 21ms 0.64% VecNorm_MPI_Default.constprop.0 8ms 0.24% 83.64% 20ms 0.61% __GI___libc_malloc 19ms 0.58% 84.21% 19ms 0.58% daxpy_ 9ms 0.27% 84.48% 19ms 0.58% std::__cxx11::basic_string::basic_string 9ms 0.27% 84.76% 18ms 0.55% PetscStageLogGetCurrent 0 0% 84.76% 18ms 0.55% VecScale 0 0% 84.76% 17ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble