File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 2925ms, 87.16% of 3356ms total Dropped 453 nodes (cum <= 16.78ms) flat flat% sum% cum cum% 0 0% 0% 3349ms 99.79% __libc_start_call_main 0 0% 0% 3349ms 99.79% __libc_start_main_impl 0 0% 0% 3349ms 99.79% _start 0 0% 0% 3347ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3347ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3347ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3347ms 99.73% main 0 0% 0% 3306ms 98.51% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3306ms 98.51% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3306ms 98.51% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 3299ms 98.30% AbstractCardiacProblem::Solve 0 0% 0% 3293ms 98.12% AbstractDynamicLinearPdeSolver::Solve 44ms 1.31% 1.31% 2101ms 62.60% AbstractCardiacTissue::SolveCellSystems 29ms 0.86% 2.18% 1201ms 35.79% AbstractCardiacCell::ComputeExceptVoltage 22ms 0.66% 2.83% 1024ms 30.51% AbstractOneStepIvpOdeSolver::InternalSolve 0 0% 2.83% 922ms 27.47% LinearSystem::Solve 0 0% 2.83% 892ms 26.58% KSPSolve 2ms 0.06% 2.89% 892ms 26.58% KSPSolve_Private 1ms 0.03% 2.92% 868ms 25.86% KSPSolve_SYMMLQ 43ms 1.28% 4.20% 840ms 25.03% EulerIvpOdeSolver::CalculateNextYValue 220ms 6.56% 10.76% 785ms 23.39% CellLuoRudy1991FromCellML::EvaluateYDerivatives 15ms 0.45% 11.20% 697ms 20.77% AbstractCardiacTissue::UpdateCaches (inline) 316ms 9.42% 20.62% 686ms 20.44% __GI___exp 236ms 7.03% 27.65% 647ms 19.28% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.03% 27.68% 545ms 16.24% PCApply 0 0% 27.68% 540ms 16.09% PCApply_BJacobi_Singleblock 0 0% 27.68% 449ms 13.38% KSPSolve_PREONLY (partial-inline) 0 0% 27.68% 428ms 12.75% KSP_PCApply.lto_priv.18 2ms 0.06% 27.74% 426ms 12.69% MatSolve 0 0% 27.74% 426ms 12.69% PCApply_ICC 420ms 12.51% 40.26% 421ms 12.54% MatSolve_SeqSBAIJ_1_NaturalOrdering 302ms 9.00% 49.26% 349ms 10.40% __ieee754_exp_fma 3ms 0.089% 49.34% 268ms 7.99% MatMult 13ms 0.39% 49.73% 260ms 7.75% MatMult_SeqAIJ (partial-inline) 245ms 7.30% 57.03% 260ms 7.75% MatMult_SeqAIJ_Inode (inline) 63ms 1.88% 58.91% 232ms 6.91% BidomainSolver::SetupLinearSystem 1ms 0.03% 58.94% 228ms 6.79% std::pow (inline) 22ms 0.66% 59.59% 227ms 6.76% __pow 17ms 0.51% 60.10% 205ms 6.11% __ieee754_pow_fma 2ms 0.06% 60.16% 168ms 5.01% KSPConvergedDefault 0 0% 60.16% 157ms 4.68% KSP_PCApply (partial-inline) 55ms 1.64% 61.80% 108ms 3.22% CellLuoRudy1991FromCellML::VerifyStateVariables 95ms 2.83% 64.63% 95ms 2.83% log_inline (inline) 85ms 2.53% 67.16% 86ms 2.56% exp_inline (inline) 9ms 0.27% 67.43% 73ms 2.18% MPI_Wtime 0 0% 67.43% 73ms 2.18% MatNullSpaceRemove 64ms 1.91% 69.34% 64ms 1.91% [[vdso]] 1ms 0.03% 69.37% 64ms 1.91% __GI___clock_gettime 31ms 0.92% 70.29% 62ms 1.85% TimeStepper::TimeStepper 8ms 0.24% 70.53% 58ms 1.73% PetscLogEventEndDefault 0 0% 70.53% 58ms 1.73% VecDuplicate 10ms 0.3% 70.83% 52ms 1.55% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.03% 70.86% 49ms 1.46% VecMDot 3ms 0.089% 70.95% 48ms 1.43% VecMXDot_Private 3ms 0.089% 71.04% 42ms 1.25% VecCopy 41ms 1.22% 72.26% 41ms 1.22% [libchaste_heart.so] 41ms 1.22% 73.48% 41ms 1.22% ddot_ 31ms 0.92% 74.40% 41ms 1.22% top12 (inline) 30ms 0.89% 75.30% 40ms 1.19% AbstractOneStepIvpOdeSolver::Solve 39ms 1.16% 76.46% 39ms 1.16% TimeStepper::CalculateNextTime 38ms 1.13% 77.59% 38ms 1.13% __memcpy_avx512_unaligned_erms 0 0% 77.59% 37ms 1.10% CxxTest::RealWorldDescription::setUp 0 0% 77.59% 37ms 1.10% PetscInitialize 4ms 0.12% 77.71% 37ms 1.10% PetscLogEventBeginDefault 0 0% 77.71% 37ms 1.10% PetscSetup::setUpWorld 0 0% 77.71% 37ms 1.10% PetscSetupUtils::CommonSetup 0 0% 77.71% 37ms 1.10% PetscSetupUtils::InitialisePetsc 3ms 0.089% 77.80% 37ms 1.10% VecNorm 0 0% 77.80% 36ms 1.07% PMPI_Init_thread 0 0% 77.80% 36ms 1.07% ompi_mpi_init 1ms 0.03% 77.83% 35ms 1.04% AbstractBidomainSolver::FinaliseLinearSystem 29ms 0.86% 78.69% 35ms 1.04% AbstractParameterisedSystem::SetAnyVariable 0 0% 78.69% 35ms 1.04% VecDuplicate_Seq 8ms 0.24% 78.93% 33ms 0.98% AbstractBidomainSolver::CheckCompatibilityCondition 28ms 0.83% 79.77% 33ms 0.98% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.03% 79.80% 32ms 0.95% VecNorm_Seq 30ms 0.89% 80.69% 31ms 0.92% VecMDot_Seq 1ms 0.03% 80.72% 30ms 0.89% 12ms 0.36% 81.08% 30ms 0.89% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 81.08% 29ms 0.86% std::vector::_M_assign_aux (inline) 0 0% 81.08% 29ms 0.86% std::vector::assign (inline) 28ms 0.83% 81.91% 28ms 0.83% DistributedVector::Iterator::operator!= 1ms 0.03% 81.94% 28ms 0.83% VecDot 27ms 0.8% 82.75% 28ms 0.83% __ieee754_log_fma 2ms 0.06% 82.81% 27ms 0.8% VecAXPY 2ms 0.06% 82.87% 27ms 0.8% std::__copy_move::__copy_m (inline) 0 0% 82.87% 27ms 0.8% std::__copy_move_a (inline) 0 0% 82.87% 27ms 0.8% std::__copy_move_a1 (inline) 0 0% 82.87% 27ms 0.8% std::__copy_move_a2 (inline) 0 0% 82.87% 27ms 0.8% std::copy (inline) 2ms 0.06% 82.93% 25ms 0.74% VecCreate 25ms 0.74% 83.67% 25ms 0.74% asuint64 (inline) 11ms 0.33% 84.00% 24ms 0.72% TimeStepper::AdvanceOneTimeStep 0 0% 84.00% 24ms 0.72% VecMAXPY 0 0% 84.00% 24ms 0.72% VecNorm_MPI 0 0% 84.00% 24ms 0.72% VecNorm_MPI_Default.constprop.0 0 0% 84.00% 24ms 0.72% orte_init 18ms 0.54% 84.54% 23ms 0.69% AbstractParameterisedSystem::GetAnyVariable 3ms 0.089% 84.62% 23ms 0.69% PetscMallocA 4ms 0.12% 84.74% 23ms 0.69% VecDuplicate_MPI 22ms 0.66% 85.40% 22ms 0.66% [libm.so.6] 8ms 0.24% 85.64% 22ms 0.66% std::__cxx11::basic_string::basic_string 21ms 0.63% 86.26% 21ms 0.63% RegularStimulus::GetStimulus 2ms 0.06% 86.32% 20ms 0.6% PetscMallocAlign 20ms 0.6% 86.92% 20ms 0.6% TimeStepper::GetNextTimeStep 0 0% 86.92% 20ms 0.6% VecDot_Seq 0 0% 86.92% 20ms 0.6% VecXDot_Seq_Private.constprop.0 7ms 0.21% 87.13% 18ms 0.54% AbstractCardiacCell::GetVoltage (partial-inline) 1ms 0.03% 87.16% 18ms 0.54% VecAXPY_Seq 0 0% 87.16% 17ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 0 0% 87.16% 17ms 0.51% PetscMemcpy (inline)