File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3751ms, 86.87% of 4318ms total Dropped 486 nodes (cum <= 21.59ms) flat flat% sum% cum cum% 0 0% 0% 4308ms 99.77% __libc_start_call_main 0 0% 0% 4308ms 99.77% __libc_start_main_impl 0 0% 0% 4308ms 99.77% _start 0 0% 0% 4304ms 99.68% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4304ms 99.68% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4304ms 99.68% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4304ms 99.68% main 0 0% 0% 4257ms 98.59% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4257ms 98.59% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4257ms 98.59% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4248ms 98.38% AbstractCardiacProblem::Solve 1ms 0.023% 0.023% 4235ms 98.08% AbstractDynamicLinearPdeSolver::Solve 27ms 0.63% 0.65% 2268ms 52.52% AbstractCardiacTissue::SolveCellSystems 3ms 0.069% 0.72% 1558ms 36.08% LinearSystem::Solve 0 0% 0.72% 1501ms 34.76% KSPSolve 3ms 0.069% 0.79% 1501ms 34.76% KSPSolve_Private 3ms 0.069% 0.86% 1456ms 33.72% KSPSolve_SYMMLQ 27ms 0.63% 1.48% 1263ms 29.25% AbstractCardiacCell::ComputeExceptVoltage 32ms 0.74% 2.22% 1064ms 24.64% AbstractOneStepIvpOdeSolver::InternalSolve 6ms 0.14% 2.36% 926ms 21.45% PCApply 3ms 0.069% 2.43% 912ms 21.12% PCApply_BJacobi_Singleblock 51ms 1.18% 3.61% 870ms 20.15% EulerIvpOdeSolver::CalculateNextYValue 19ms 0.44% 4.05% 836ms 19.36% AbstractCardiacTissue::UpdateCaches (inline) 214ms 4.96% 9.01% 808ms 18.71% CellLuoRudy1991FromCellML::EvaluateYDerivatives 268ms 6.21% 15.22% 776ms 17.97% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.023% 15.24% 775ms 17.95% KSPSolve_PREONLY (partial-inline) 375ms 8.68% 23.92% 766ms 17.74% __GI___exp 6ms 0.14% 24.06% 724ms 16.77% MatSolve 0 0% 24.06% 724ms 16.77% PCApply_ICC 711ms 16.47% 40.53% 717ms 16.60% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 0 0% 40.53% 689ms 15.96% KSP_PCApply.lto_priv.18 3ms 0.069% 40.60% 468ms 10.84% MatMult 8ms 0.19% 40.78% 463ms 10.72% MatMult_SeqAIJ (partial-inline) 447ms 10.35% 51.13% 463ms 10.72% MatMult_SeqAIJ_Inode (inline) 303ms 7.02% 58.15% 366ms 8.48% __ieee754_exp_fma 76ms 1.76% 59.91% 353ms 8.18% BidomainSolver::SetupLinearSystem 0 0% 59.91% 312ms 7.23% KSPConvergedDefault 0 0% 59.91% 306ms 7.09% KSP_PCApply (partial-inline) 1ms 0.023% 59.94% 255ms 5.91% std::pow (inline) 22ms 0.51% 60.44% 254ms 5.88% __pow 21ms 0.49% 60.93% 232ms 5.37% __ieee754_pow_fma 2ms 0.046% 60.98% 129ms 2.99% MatNullSpaceRemove 122ms 2.83% 63.80% 122ms 2.83% log_inline (inline) 54ms 1.25% 65.05% 107ms 2.48% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 65.05% 89ms 2.06% VecDuplicate 80ms 1.85% 66.91% 83ms 1.92% exp_inline (inline) 0 0% 66.91% 82ms 1.90% VecMDot 4ms 0.093% 67.00% 82ms 1.90% VecMXDot_Private 17ms 0.39% 67.39% 75ms 1.74% MPI_Wtime 12ms 0.28% 67.67% 69ms 1.60% PetscLogEventEndDefault 21ms 0.49% 68.16% 69ms 1.60% TimeStepper::TimeStepper 10ms 0.23% 68.39% 66ms 1.53% AbstractCardiacCell::SetVoltage (partial-inline) 62ms 1.44% 69.82% 62ms 1.44% ddot_ 58ms 1.34% 71.17% 58ms 1.34% [[vdso]] 0 0% 71.17% 58ms 1.34% __GI___clock_gettime 12ms 0.28% 71.45% 55ms 1.27% PetscLogEventBeginDefault 3ms 0.069% 71.51% 54ms 1.25% VecDuplicate_MPI 3ms 0.069% 71.58% 53ms 1.23% VecCopy 40ms 0.93% 72.51% 52ms 1.20% top12 (inline) 2ms 0.046% 72.56% 51ms 1.18% VecDot 49ms 1.13% 73.69% 50ms 1.16% VecMDot_Seq 37ms 0.86% 74.55% 49ms 1.13% AbstractParameterisedSystem::SetAnyVariable 49ms 1.13% 75.68% 49ms 1.13% TimeStepper::CalculateNextTime 49ms 1.13% 76.82% 49ms 1.13% __memcpy_avx_unaligned_erms 21ms 0.49% 77.30% 48ms 1.11% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 77.30% 48ms 1.11% AbstractBidomainSolver::FinaliseLinearSystem 3ms 0.069% 77.37% 47ms 1.09% VecAXPY 46ms 1.07% 78.44% 46ms 1.07% [libchaste_heart.so] 1ms 0.023% 78.46% 45ms 1.04% VecMAXPY 0 0% 78.46% 44ms 1.02% VecNorm 0 0% 78.46% 43ms 1% CxxTest::RealWorldDescription::setUp 0 0% 78.46% 43ms 1% PetscInitialize 0 0% 78.46% 43ms 1% PetscSetup::setUpWorld 0 0% 78.46% 43ms 1% PetscSetupUtils::CommonSetup 0 0% 78.46% 43ms 1% PetscSetupUtils::InitialisePetsc 0 0% 78.46% 43ms 1% VecDot_Seq 1ms 0.023% 78.49% 43ms 1% VecXDot_Seq_Private.constprop.0 25ms 0.58% 79.06% 42ms 0.97% AbstractOneStepIvpOdeSolver::Solve 0 0% 79.06% 42ms 0.97% PMPI_Init_thread 9ms 0.21% 79.27% 42ms 0.97% PetscMallocA 0 0% 79.27% 42ms 0.97% ompi_mpi_init 1ms 0.023% 79.30% 41ms 0.95% VecDestroy 17ms 0.39% 79.69% 40ms 0.93% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.023% 79.71% 39ms 0.9% VecCreate 0 0% 79.71% 37ms 0.86% PetscMemcpy (inline) 1ms 0.023% 79.74% 37ms 0.86% VecNorm_Seq 35ms 0.81% 80.55% 36ms 0.83% __ieee754_log_fma 1ms 0.023% 80.57% 35ms 0.81% VecDuplicate_Seq 1ms 0.023% 80.59% 34ms 0.79% 1ms 0.023% 80.62% 33ms 0.76% PetscMallocAlign 33ms 0.76% 81.38% 33ms 0.76% asuint64 (inline) 3ms 0.069% 81.45% 30ms 0.69% VecAXPY_Seq 0 0% 81.45% 30ms 0.69% VecNorm_MPI 1ms 0.023% 81.47% 30ms 0.69% VecNorm_MPI_Default.constprop.0 1ms 0.023% 81.50% 29ms 0.67% std::vector::_M_assign_aux (inline) 0 0% 81.50% 29ms 0.67% std::vector::assign (inline) 28ms 0.65% 82.14% 28ms 0.65% DistributedVector::Stripe::operator[] (inline) 20ms 0.46% 82.61% 27ms 0.63% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 17ms 0.39% 83.00% 27ms 0.63% AbstractParameterisedSystem::GetAnyVariable 0 0% 83.00% 27ms 0.63% VecCopy_Seq (partial-inline) 27ms 0.63% 83.63% 27ms 0.63% daxpy_ 16ms 0.37% 84.00% 26ms 0.6% TimeStepper::AdvanceOneTimeStep 25ms 0.58% 84.58% 26ms 0.6% VecMAXPY_Seq 12ms 0.28% 84.85% 25ms 0.58% AbstractCardiacCell::GetVoltage (partial-inline) 25ms 0.58% 85.43% 25ms 0.58% [libm.so.6] 0 0% 85.43% 25ms 0.58% orte_init 24ms 0.56% 85.99% 24ms 0.56% DistributedVector::Iterator::operator!= 24ms 0.56% 86.54% 24ms 0.56% RegularStimulus::GetStimulus 1ms 0.023% 86.57% 24ms 0.56% VecCreate_MPI_Private 7ms 0.16% 86.73% 23ms 0.53% __GI___libc_malloc 6ms 0.14% 86.87% 23ms 0.53% std::__copy_move::__copy_m (inline) 0 0% 86.87% 23ms 0.53% std::__copy_move_a (inline) 0 0% 86.87% 23ms 0.53% std::__copy_move_a1 (inline) 0 0% 86.87% 23ms 0.53% std::__copy_move_a2 (inline) 0 0% 86.87% 23ms 0.53% std::copy (inline) 0 0% 86.87% 22ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble