File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3672ms, 87.26% of 4208ms total Dropped 484 nodes (cum <= 21.04ms) flat flat% sum% cum cum% 0 0% 0% 4199ms 99.79% __libc_start_call_main 0 0% 0% 4199ms 99.79% __libc_start_main_impl 0 0% 0% 4199ms 99.79% _start 0 0% 0% 4196ms 99.71% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4196ms 99.71% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4196ms 99.71% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4196ms 99.71% main 0 0% 0% 4151ms 98.65% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4151ms 98.65% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4151ms 98.65% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 2ms 0.048% 0.048% 4142ms 98.43% AbstractCardiacProblem::Solve 1ms 0.024% 0.071% 4126ms 98.05% AbstractDynamicLinearPdeSolver::Solve 14ms 0.33% 0.4% 2328ms 55.32% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.43% 1300ms 30.89% LinearSystem::Solve 39ms 0.93% 1.35% 1281ms 30.44% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.35% 1255ms 29.82% KSPSolve 3ms 0.071% 1.43% 1255ms 29.82% KSPSolve_Private 1ms 0.024% 1.45% 1214ms 28.85% KSPSolve_SYMMLQ 33ms 0.78% 2.23% 1088ms 25.86% AbstractOneStepIvpOdeSolver::InternalSolve 57ms 1.35% 3.59% 921ms 21.89% EulerIvpOdeSolver::CalculateNextYValue 36ms 0.86% 4.44% 855ms 20.32% AbstractCardiacTissue::UpdateCaches (inline) 204ms 4.85% 9.29% 850ms 20.20% CellLuoRudy1991FromCellML::EvaluateYDerivatives 391ms 9.29% 18.58% 800ms 19.01% __GI___exp 275ms 6.54% 25.12% 775ms 18.42% CellLuoRudy1991FromCellML::GetIIonic 3ms 0.071% 25.19% 694ms 16.49% PCApply 0 0% 25.19% 686ms 16.30% PCApply_BJacobi_Singleblock 1ms 0.024% 25.21% 555ms 13.19% KSPSolve_PREONLY (partial-inline) 0 0% 25.21% 531ms 12.62% KSP_PCApply.lto_priv.18 4ms 0.095% 25.31% 529ms 12.57% MatMult 11ms 0.26% 25.57% 519ms 12.33% MatMult_SeqAIJ (partial-inline) 506ms 12.02% 37.60% 519ms 12.33% MatMult_SeqAIJ_Inode (inline) 3ms 0.071% 37.67% 513ms 12.19% MatSolve 0 0% 37.67% 513ms 12.19% PCApply_ICC 498ms 11.83% 49.50% 505ms 12.00% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 88ms 2.09% 51.59% 437ms 10.38% BidomainSolver::SetupLinearSystem 331ms 7.87% 59.46% 391ms 9.29% __ieee754_exp_fma 31ms 0.74% 60.19% 259ms 6.15% __pow 0 0% 60.19% 259ms 6.15% std::pow (inline) 25ms 0.59% 60.79% 228ms 5.42% __ieee754_pow_fma 0 0% 60.79% 223ms 5.30% KSP_PCApply (partial-inline) 0 0% 60.79% 220ms 5.23% KSPConvergedDefault 56ms 1.33% 62.12% 112ms 2.66% CellLuoRudy1991FromCellML::VerifyStateVariables 107ms 2.54% 64.66% 107ms 2.54% log_inline (inline) 1ms 0.024% 64.69% 101ms 2.40% MatNullSpaceRemove 0 0% 64.69% 90ms 2.14% VecDuplicate 80ms 1.90% 66.59% 84ms 2.00% exp_inline (inline) 19ms 0.45% 67.04% 77ms 1.83% MPI_Wtime 66ms 1.57% 68.61% 66ms 1.57% ddot_ 25ms 0.59% 69.20% 63ms 1.50% TimeStepper::TimeStepper 61ms 1.45% 70.65% 61ms 1.45% [libchaste_heart.so] 8ms 0.19% 70.84% 59ms 1.40% PetscLogEventEndDefault 0 0% 70.84% 58ms 1.38% VecMDot 2ms 0.048% 70.89% 58ms 1.38% VecMXDot_Private 2ms 0.048% 70.94% 57ms 1.35% __GI___clock_gettime 9ms 0.21% 71.15% 55ms 1.31% PetscLogEventBeginDefault 55ms 1.31% 72.46% 55ms 1.31% [[vdso]] 40ms 0.95% 73.41% 53ms 1.26% top12 (inline) 15ms 0.36% 73.76% 52ms 1.24% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 73.76% 52ms 1.24% AbstractBidomainSolver::FinaliseLinearSystem 12ms 0.29% 74.05% 52ms 1.24% AbstractCardiacCell::SetVoltage (partial-inline) 4ms 0.095% 74.14% 51ms 1.21% VecCopy 0 0% 74.14% 51ms 1.21% VecDot 37ms 0.88% 75.02% 49ms 1.16% AbstractOneStepIvpOdeSolver::Solve 0 0% 75.02% 48ms 1.14% VecDuplicate_Seq 1ms 0.024% 75.05% 46ms 1.09% VecAXPY 45ms 1.07% 76.12% 46ms 1.09% __ieee754_log_fma 6ms 0.14% 76.26% 45ms 1.07% PetscMallocA 45ms 1.07% 77.33% 45ms 1.07% VecMDot_Seq 43ms 1.02% 78.35% 43ms 1.02% TimeStepper::CalculateNextTime 0 0% 78.35% 43ms 1.02% VecDot_Seq 0 0% 78.35% 43ms 1.02% VecXDot_Seq_Private.constprop.0 3ms 0.071% 78.42% 42ms 1% VecDestroy 4ms 0.095% 78.52% 42ms 1% VecDuplicate_MPI 0 0% 78.52% 42ms 1% VecMAXPY 0 0% 78.52% 41ms 0.97% CxxTest::RealWorldDescription::setUp 0 0% 78.52% 41ms 0.97% PMPI_Init_thread 0 0% 78.52% 41ms 0.97% PetscInitialize 0 0% 78.52% 41ms 0.97% PetscSetup::setUpWorld 0 0% 78.52% 41ms 0.97% PetscSetupUtils::CommonSetup 0 0% 78.52% 41ms 0.97% PetscSetupUtils::InitialisePetsc 0 0% 78.52% 41ms 0.97% ompi_mpi_init 4ms 0.095% 78.61% 39ms 0.93% PetscMallocAlign 1ms 0.024% 78.64% 39ms 0.93% VecNorm 1ms 0.024% 78.66% 38ms 0.9% VecCreate 37ms 0.88% 79.54% 37ms 0.88% asuint64 (inline) 1ms 0.024% 79.56% 36ms 0.86% 32ms 0.76% 80.32% 35ms 0.83% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 27ms 0.64% 80.96% 35ms 0.83% AbstractParameterisedSystem::SetAnyVariable 0 0% 80.96% 35ms 0.83% VecNorm_Seq 16ms 0.38% 81.35% 33ms 0.78% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 31ms 0.74% 82.08% 31ms 0.74% __memcpy_avx_unaligned_erms 0 0% 82.08% 30ms 0.71% PetscMemcpy (inline) 0 0% 82.08% 30ms 0.71% VecAXPY_Seq 20ms 0.48% 82.56% 29ms 0.69% TimeStepper::AdvanceOneTimeStep 28ms 0.67% 83.22% 28ms 0.67% DistributedVector::End 27ms 0.64% 83.86% 28ms 0.67% VecMAXPY_Seq 2ms 0.048% 83.91% 28ms 0.67% VecSetType 28ms 0.67% 84.58% 28ms 0.67% daxpy_ 27ms 0.64% 85.22% 27ms 0.64% DistributedVector::Iterator::operator!= 26ms 0.62% 85.84% 26ms 0.62% ReplicatableVector::operator[] 3ms 0.071% 85.91% 26ms 0.62% __posix_memalign 20ms 0.48% 86.38% 25ms 0.59% AbstractParameterisedSystem::GetAnyVariable 3ms 0.071% 86.45% 25ms 0.59% __GI___libc_malloc 0 0% 86.45% 25ms 0.59% orte_init 0 0% 86.45% 22ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble 22ms 0.52% 86.98% 22ms 0.52% RegularStimulus::GetStimulus 3ms 0.071% 87.05% 22ms 0.52% VecCreate_MPI_Private 9ms 0.21% 87.26% 22ms 0.52% std::__cxx11::basic_string::basic_string