File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3659ms, 86.30% of 4240ms total Dropped 460 nodes (cum <= 21.20ms) flat flat% sum% cum cum% 0 0% 0% 4232ms 99.81% __libc_start_call_main 0 0% 0% 4232ms 99.81% __libc_start_main_impl 0 0% 0% 4232ms 99.81% _start 0 0% 0% 4230ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4230ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4230ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4230ms 99.76% main 0 0% 0% 4190ms 98.82% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4190ms 98.82% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4190ms 98.82% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4182ms 98.63% AbstractCardiacProblem::Solve 2ms 0.047% 0.047% 4176ms 98.49% AbstractDynamicLinearPdeSolver::Solve 13ms 0.31% 0.35% 2218ms 52.31% AbstractCardiacTissue::SolveCellSystems 0 0% 0.35% 1657ms 39.08% LinearSystem::Solve 0 0% 0.35% 1609ms 37.95% KSPSolve 5ms 0.12% 0.47% 1609ms 37.95% KSPSolve_Private 4ms 0.094% 0.57% 1559ms 36.77% KSPSolve_SYMMLQ 24ms 0.57% 1.13% 1307ms 30.83% AbstractCardiacCell::ComputeExceptVoltage 40ms 0.94% 2.08% 1115ms 26.30% AbstractOneStepIvpOdeSolver::InternalSolve 4ms 0.094% 2.17% 971ms 22.90% PCApply 2ms 0.047% 2.22% 959ms 22.62% PCApply_BJacobi_Singleblock 60ms 1.42% 3.63% 895ms 21.11% EulerIvpOdeSolver::CalculateNextYValue 238ms 5.61% 9.25% 820ms 19.34% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 9.25% 814ms 19.20% KSPSolve_PREONLY (partial-inline) 2ms 0.047% 9.29% 758ms 17.88% MatSolve 0 0% 9.29% 758ms 17.88% PCApply_ICC 385ms 9.08% 18.37% 753ms 17.76% __GI___exp 743ms 17.52% 35.90% 750ms 17.69% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 18ms 0.42% 36.32% 720ms 16.98% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 36.32% 718ms 16.93% KSP_PCApply.lto_priv.18 241ms 5.68% 42.00% 676ms 15.94% CellLuoRudy1991FromCellML::GetIIonic 3ms 0.071% 42.08% 438ms 10.33% MatMult 4ms 0.094% 42.17% 430ms 10.14% MatMult_SeqAIJ 420ms 9.91% 52.08% 430ms 10.14% MatMult_SeqAIJ_Inode (inline) 328ms 7.74% 59.81% 348ms 8.21% __ieee754_exp_fma 1ms 0.024% 59.83% 341ms 8.04% KSPConvergedDefault 0 0% 59.83% 327ms 7.71% KSP_PCApply (partial-inline) 43ms 1.01% 60.85% 249ms 5.87% BidomainSolver::SetupLinearSystem 3ms 0.071% 60.92% 210ms 4.95% std::pow (inline) 16ms 0.38% 61.30% 207ms 4.88% __pow 28ms 0.66% 61.96% 189ms 4.46% __ieee754_pow_fma 69ms 1.63% 63.58% 142ms 3.35% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 63.58% 123ms 2.90% MatNullSpaceRemove 2ms 0.047% 63.63% 102ms 2.41% VecDuplicate 45ms 1.06% 64.69% 95ms 2.24% TimeStepper::TimeStepper 19ms 0.45% 65.14% 93ms 2.19% MPI_Wtime 82ms 1.93% 67.08% 82ms 1.93% log_inline (inline) 78ms 1.84% 68.92% 78ms 1.84% ddot_ 74ms 1.75% 70.66% 74ms 1.75% [[vdso]] 0 0% 70.66% 74ms 1.75% __GI___clock_gettime 70ms 1.65% 72.31% 72ms 1.70% exp_inline (inline) 0 0% 72.31% 70ms 1.65% VecMDot 4ms 0.094% 72.41% 70ms 1.65% VecMXDot_Private 14ms 0.33% 72.74% 65ms 1.53% PetscLogEventEndDefault 7ms 0.17% 72.90% 59ms 1.39% VecCopy 2ms 0.047% 72.95% 55ms 1.30% VecDot 2ms 0.047% 73.00% 54ms 1.27% VecDestroy 1ms 0.024% 73.02% 53ms 1.25% VecDuplicate_MPI 6ms 0.14% 73.16% 53ms 1.25% VecMAXPY 6ms 0.14% 73.30% 51ms 1.20% PetscLogEventBeginDefault 0 0% 73.30% 50ms 1.18% VecDot_Seq 1ms 0.024% 73.33% 50ms 1.18% VecNorm 2ms 0.047% 73.37% 50ms 1.18% VecXDot_Seq_Private.constprop.0 37ms 0.87% 74.25% 49ms 1.16% AbstractOneStepIvpOdeSolver::Solve 48ms 1.13% 75.38% 49ms 1.16% VecMDot_Seq 25ms 0.59% 75.97% 48ms 1.13% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 4ms 0.094% 76.06% 48ms 1.13% VecAXPY 0 0% 76.06% 47ms 1.11% VecDuplicate_Seq 44ms 1.04% 77.10% 44ms 1.04% TimeStepper::CalculateNextTime 1ms 0.024% 77.12% 43ms 1.01% VecNorm_Seq 1ms 0.024% 77.15% 41ms 0.97% AbstractBidomainSolver::FinaliseLinearSystem 12ms 0.28% 77.43% 40ms 0.94% AbstractBidomainSolver::CheckCompatibilityCondition 40ms 0.94% 78.37% 40ms 0.94% __memcpy_avx_unaligned_erms 3ms 0.071% 78.44% 39ms 0.92% VecCreate 31ms 0.73% 79.17% 35ms 0.83% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 4ms 0.094% 79.27% 35ms 0.83% PetscMallocA 0 0% 79.27% 35ms 0.83% PetscMemcpy (inline) 35ms 0.83% 80.09% 35ms 0.83% std::isinf (inline) 0 0% 80.09% 34ms 0.8% CxxTest::RealWorldDescription::setUp 0 0% 80.09% 34ms 0.8% PMPI_Init_thread 0 0% 80.09% 34ms 0.8% PetscInitialize 0 0% 80.09% 34ms 0.8% PetscSetup::setUpWorld 0 0% 80.09% 34ms 0.8% PetscSetupUtils::CommonSetup 0 0% 80.09% 34ms 0.8% PetscSetupUtils::InitialisePetsc 32ms 0.75% 80.85% 34ms 0.8% __ieee754_log_fma 0 0% 80.85% 34ms 0.8% ompi_mpi_init 11ms 0.26% 81.11% 33ms 0.78% AbstractCardiacCell::SetVoltage (partial-inline) 2ms 0.047% 81.16% 33ms 0.78% VecCopy_Seq (partial-inline) 32ms 0.75% 81.91% 33ms 0.78% VecMAXPY_Seq 2ms 0.047% 81.96% 31ms 0.73% PetscMallocAlign 3ms 0.071% 82.03% 30ms 0.71% 25ms 0.59% 82.62% 29ms 0.68% AbstractParameterisedSystem::GetAnyVariable 29ms 0.68% 83.30% 29ms 0.68% DistributedVector::Iterator::operator!= 0 0% 83.30% 29ms 0.68% VecAXPY_Seq 2ms 0.047% 83.35% 29ms 0.68% VecCreate_MPI_Private 29ms 0.68% 84.03% 29ms 0.68% [libchaste_heart.so] 0 0% 84.03% 28ms 0.66% VecNorm_MPI 0 0% 84.03% 28ms 0.66% VecNorm_MPI_Default.constprop.0 3ms 0.071% 84.10% 28ms 0.66% VecSetType 28ms 0.66% 84.76% 28ms 0.66% daxpy_ 12ms 0.28% 85.05% 27ms 0.64% AbstractCardiacCell::GetVoltage (partial-inline) 14ms 0.33% 85.38% 27ms 0.64% top12 (inline) 0 0% 85.38% 26ms 0.61% PetscHeaderDestroy_Private 12ms 0.28% 85.66% 24ms 0.57% TimeStepper::AdvanceOneTimeStep 5ms 0.12% 85.78% 23ms 0.54% PetscHeaderCreate_Private 0 0% 85.78% 23ms 0.54% orte_init 22ms 0.52% 86.30% 22ms 0.52% [libm.so.6]