File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3592ms, 85.26% of 4213ms total Dropped 466 nodes (cum <= 21.07ms) flat flat% sum% cum cum% 0 0% 0% 4204ms 99.79% __libc_start_call_main 0 0% 0% 4204ms 99.79% __libc_start_main_impl 0 0% 0% 4204ms 99.79% _start 0 0% 0% 4201ms 99.72% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4201ms 99.72% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4201ms 99.72% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4201ms 99.72% main 0 0% 0% 4162ms 98.79% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4162ms 98.79% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4162ms 98.79% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4155ms 98.62% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4137ms 98.20% AbstractDynamicLinearPdeSolver::Solve 11ms 0.26% 0.28% 2227ms 52.86% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.31% 1594ms 37.84% LinearSystem::Solve 0 0% 0.31% 1553ms 36.86% KSPSolve 3ms 0.071% 0.38% 1553ms 36.86% KSPSolve_Private 1ms 0.024% 0.4% 1505ms 35.72% KSPSolve_SYMMLQ 38ms 0.9% 1.31% 1264ms 30.00% AbstractCardiacCell::ComputeExceptVoltage 21ms 0.5% 1.80% 1089ms 25.85% AbstractOneStepIvpOdeSolver::InternalSolve 2ms 0.047% 1.85% 991ms 23.52% PCApply 2ms 0.047% 1.90% 982ms 23.31% PCApply_BJacobi_Singleblock 53ms 1.26% 3.16% 922ms 21.88% EulerIvpOdeSolver::CalculateNextYValue 237ms 5.63% 8.78% 860ms 20.41% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 8.78% 828ms 19.65% KSPSolve_PREONLY (partial-inline) 3ms 0.071% 8.85% 786ms 18.66% MatSolve 0 0% 8.85% 786ms 18.66% PCApply_ICC 777ms 18.44% 27.30% 780ms 18.51% MatSolve_SeqSBAIJ_1_NaturalOrdering 336ms 7.98% 35.27% 768ms 18.23% __GI___exp 26ms 0.62% 35.89% 731ms 17.35% AbstractCardiacTissue::UpdateCaches (inline) 246ms 5.84% 41.73% 684ms 16.24% CellLuoRudy1991FromCellML::GetIIonic 0 0% 41.73% 683ms 16.21% KSP_PCApply.lto_priv.18 392ms 9.30% 51.03% 415ms 9.85% __ieee754_exp_fma 5ms 0.12% 51.15% 387ms 9.19% MatMult 0 0% 51.15% 383ms 9.09% KSPConvergedDefault 4ms 0.095% 51.25% 378ms 8.97% MatMult_SeqAIJ 371ms 8.81% 60.05% 378ms 8.97% MatMult_SeqAIJ_Inode (inline) 0 0% 60.05% 367ms 8.71% KSP_PCApply (partial-inline) 54ms 1.28% 61.33% 262ms 6.22% BidomainSolver::SetupLinearSystem 6ms 0.14% 61.48% 223ms 5.29% std::pow (inline) 16ms 0.38% 61.86% 217ms 5.15% __pow 27ms 0.64% 62.50% 201ms 4.77% __ieee754_pow_fma 92ms 2.18% 64.68% 177ms 4.20% CellLuoRudy1991FromCellML::VerifyStateVariables 1ms 0.024% 64.70% 116ms 2.75% VecDuplicate 0 0% 64.70% 105ms 2.49% MatNullSpaceRemove 100ms 2.37% 67.08% 100ms 2.37% log_inline (inline) 72ms 1.71% 68.79% 72ms 1.71% exp_inline (inline) 17ms 0.4% 69.19% 69ms 1.64% MPI_Wtime 6ms 0.14% 69.33% 67ms 1.59% VecDuplicate_MPI (partial-inline) 0 0% 69.33% 65ms 1.54% VecMDot 9ms 0.21% 69.55% 65ms 1.54% VecMXDot_Private 28ms 0.66% 70.21% 60ms 1.42% TimeStepper::TimeStepper 60ms 1.42% 71.64% 60ms 1.42% ddot_ 9ms 0.21% 71.85% 54ms 1.28% PetscMallocA 10ms 0.24% 72.09% 52ms 1.23% PetscLogEventEndDefault 3ms 0.071% 72.16% 52ms 1.23% __GI___clock_gettime 2ms 0.047% 72.21% 51ms 1.21% VecDestroy 2ms 0.047% 72.25% 51ms 1.21% VecDot 3ms 0.071% 72.32% 50ms 1.19% VecCopy 37ms 0.88% 73.20% 49ms 1.16% AbstractOneStepIvpOdeSolver::Solve 16ms 0.38% 73.58% 49ms 1.16% PetscLogEventBeginDefault 49ms 1.16% 74.74% 49ms 1.16% [[vdso]] 1ms 0.024% 74.77% 48ms 1.14% VecDuplicate_Seq 14ms 0.33% 75.10% 47ms 1.12% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 75.10% 47ms 1.12% AbstractBidomainSolver::FinaliseLinearSystem 6ms 0.14% 75.24% 45ms 1.07% PetscMallocAlign (partial-inline) 35ms 0.83% 76.07% 44ms 1.04% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 3ms 0.071% 76.15% 43ms 1.02% VecAXPY 4ms 0.095% 76.24% 43ms 1.02% VecCreate 42ms 1% 77.24% 43ms 1.02% __ieee754_log_fma 0 0% 77.24% 42ms 1% VecDot_Seq 0 0% 77.24% 42ms 1% VecXDot_Seq_Private.constprop.0 40ms 0.95% 78.19% 40ms 0.95% TimeStepper::CalculateNextTime 3ms 0.071% 78.26% 40ms 0.95% VecMAXPY 0 0% 78.26% 38ms 0.9% PetscMemcpy (inline) 24ms 0.57% 78.83% 37ms 0.88% TimeStepper::AdvanceOneTimeStep 35ms 0.83% 79.66% 37ms 0.88% VecMDot_Seq 13ms 0.31% 79.97% 37ms 0.88% std::__cxx11::basic_string::basic_string 0 0% 79.97% 36ms 0.85% VecNorm 0 0% 79.97% 35ms 0.83% VecCopy_Seq (partial-inline) 35ms 0.83% 80.80% 35ms 0.83% [libchaste_heart.so] 35ms 0.83% 81.63% 35ms 0.83% __memcpy_avx_unaligned_erms 0 0% 81.63% 34ms 0.81% CxxTest::RealWorldDescription::setUp 0 0% 81.63% 34ms 0.81% PMPI_Init_thread 0 0% 81.63% 34ms 0.81% PetscInitialize 0 0% 81.63% 34ms 0.81% PetscSetup::setUpWorld 0 0% 81.63% 34ms 0.81% PetscSetupUtils::CommonSetup 0 0% 81.63% 34ms 0.81% PetscSetupUtils::InitialisePetsc 0 0% 81.63% 34ms 0.81% ompi_mpi_init 32ms 0.76% 82.39% 32ms 0.76% std::isinf (inline) 0 0% 82.39% 31ms 0.74% KSP_RemoveNullSpace (inline) 2ms 0.047% 82.44% 29ms 0.69% 2ms 0.047% 82.48% 29ms 0.69% VecCreate_MPI_Private 1ms 0.024% 82.51% 29ms 0.69% VecSetType 28ms 0.66% 83.17% 28ms 0.66% DistributedVector::Iterator::operator!= 1ms 0.024% 83.19% 28ms 0.66% VecNorm_Seq 5ms 0.12% 83.31% 27ms 0.64% AbstractCardiacCell::SetVoltage (partial-inline) 15ms 0.36% 83.67% 27ms 0.64% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 25ms 0.59% 84.26% 25ms 0.59% __memset_avx2_unaligned_erms 0 0% 84.26% 24ms 0.57% PetscMemzero (inline) 5ms 0.12% 84.38% 24ms 0.57% __GI___libc_malloc 12ms 0.28% 84.67% 24ms 0.57% top12 (inline) 3ms 0.071% 84.74% 23ms 0.55% PetscHeaderDestroy_Private 0 0% 84.74% 23ms 0.55% VecAXPY_Seq 0 0% 84.74% 22ms 0.52% __posix_memalign 22ms 0.52% 85.26% 22ms 0.52% daxpy_ 0 0% 85.26% 22ms 0.52% orte_init