File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3643ms, 86.47% of 4213ms total Dropped 496 nodes (cum <= 21.07ms) flat flat% sum% cum cum% 0 0% 0% 4206ms 99.83% __libc_start_call_main 0 0% 0% 4206ms 99.83% __libc_start_main_impl 0 0% 0% 4206ms 99.83% _start 0 0% 0% 4203ms 99.76% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4203ms 99.76% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4203ms 99.76% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4203ms 99.76% 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 3ms 0.071% 0.071% 4143ms 98.34% AbstractDynamicLinearPdeSolver::Solve 12ms 0.28% 0.36% 2240ms 53.17% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.38% 1574ms 37.36% LinearSystem::Solve 0 0% 0.38% 1533ms 36.39% KSPSolve 1ms 0.024% 0.4% 1533ms 36.39% KSPSolve_Private 4ms 0.095% 0.5% 1486ms 35.27% KSPSolve_SYMMLQ 29ms 0.69% 1.19% 1265ms 30.03% AbstractCardiacCell::ComputeExceptVoltage 25ms 0.59% 1.78% 1048ms 24.88% AbstractOneStepIvpOdeSolver::InternalSolve 1ms 0.024% 1.80% 941ms 22.34% PCApply 0 0% 1.80% 933ms 22.15% PCApply_BJacobi_Singleblock 59ms 1.40% 3.20% 902ms 21.41% EulerIvpOdeSolver::CalculateNextYValue 223ms 5.29% 8.50% 833ms 19.77% CellLuoRudy1991FromCellML::EvaluateYDerivatives 0 0% 8.50% 799ms 18.97% KSPSolve_PREONLY (partial-inline) 27ms 0.64% 9.14% 752ms 17.85% AbstractCardiacTissue::UpdateCaches (inline) 2ms 0.047% 9.19% 746ms 17.71% MatSolve 0 0% 9.19% 746ms 17.71% PCApply_ICC 329ms 7.81% 17.00% 744ms 17.66% __GI___exp 735ms 17.45% 34.44% 737ms 17.49% MatSolve_SeqSBAIJ_1_NaturalOrdering 264ms 6.27% 40.71% 701ms 16.64% CellLuoRudy1991FromCellML::GetIIonic 0 0% 40.71% 661ms 15.69% KSP_PCApply.lto_priv.18 2ms 0.047% 40.75% 437ms 10.37% MatMult 5ms 0.12% 40.87% 431ms 10.23% MatMult_SeqAIJ (partial-inline) 425ms 10.09% 50.96% 431ms 10.23% MatMult_SeqAIJ_Inode (inline) 365ms 8.66% 59.62% 393ms 9.33% __ieee754_exp_fma 1ms 0.024% 59.65% 351ms 8.33% KSPConvergedDefault 0 0% 59.65% 349ms 8.28% KSP_PCApply (partial-inline) 44ms 1.04% 60.69% 279ms 6.62% BidomainSolver::SetupLinearSystem 31ms 0.74% 61.43% 243ms 5.77% __pow 0 0% 61.43% 243ms 5.77% std::pow (inline) 29ms 0.69% 62.12% 212ms 5.03% __ieee754_pow_fma 87ms 2.07% 64.18% 168ms 3.99% CellLuoRudy1991FromCellML::VerifyStateVariables 3ms 0.071% 64.25% 117ms 2.78% MatNullSpaceRemove 99ms 2.35% 66.60% 99ms 2.35% log_inline (inline) 1ms 0.024% 66.63% 92ms 2.18% VecDuplicate 79ms 1.88% 68.50% 79ms 1.88% exp_inline (inline) 25ms 0.59% 69.10% 77ms 1.83% MPI_Wtime 0 0% 69.10% 77ms 1.83% VecMDot 7ms 0.17% 69.26% 77ms 1.83% VecMXDot_Private 16ms 0.38% 69.64% 72ms 1.71% PetscLogEventEndDefault 64ms 1.52% 71.16% 64ms 1.52% ddot_ 49ms 1.16% 72.32% 53ms 1.26% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 6ms 0.14% 72.47% 53ms 1.26% PetscLogEventBeginDefault 31ms 0.74% 73.20% 52ms 1.23% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 73.23% 52ms 1.23% __GI___clock_gettime 1ms 0.024% 73.25% 51ms 1.21% VecDot 49ms 1.16% 74.41% 51ms 1.21% VecMDot_Seq 51ms 1.21% 75.62% 51ms 1.21% [[vdso]] 23ms 0.55% 76.17% 50ms 1.19% TimeStepper::TimeStepper 0 0% 76.17% 49ms 1.16% VecAXPY 41ms 0.97% 77.14% 48ms 1.14% AbstractOneStepIvpOdeSolver::Solve 5ms 0.12% 77.26% 48ms 1.14% VecCopy 0 0% 77.26% 47ms 1.12% VecDuplicate_MPI 0 0% 77.26% 46ms 1.09% VecDot_Seq 0 0% 77.26% 46ms 1.09% VecXDot_Seq_Private.constprop.0 0 0% 77.26% 44ms 1.04% VecDuplicate_Seq 44ms 1.04% 78.31% 44ms 1.04% __ieee754_log_fma 10ms 0.24% 78.54% 43ms 1.02% AbstractCardiacCell::SetVoltage (partial-inline) 2ms 0.047% 78.59% 43ms 1.02% VecNorm 0 0% 78.59% 42ms 1% VecCreate 42ms 1% 79.59% 42ms 1% std::isinf (inline) 9ms 0.21% 79.80% 40ms 0.95% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 79.80% 40ms 0.95% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 79.80% 37ms 0.88% CxxTest::RealWorldDescription::setUp 0 0% 79.80% 37ms 0.88% PMPI_Init_thread 0 0% 79.80% 37ms 0.88% PetscInitialize 0 0% 79.80% 37ms 0.88% PetscSetup::setUpWorld 0 0% 79.80% 37ms 0.88% PetscSetupUtils::CommonSetup 0 0% 79.80% 37ms 0.88% PetscSetupUtils::InitialisePetsc 1ms 0.024% 79.82% 37ms 0.88% VecDestroy 5ms 0.12% 79.94% 37ms 0.88% VecMAXPY 37ms 0.88% 80.82% 37ms 0.88% [libchaste_heart.so] 0 0% 80.82% 37ms 0.88% ompi_mpi_init 5ms 0.12% 80.94% 35ms 0.83% PetscMallocA 35ms 0.83% 81.77% 35ms 0.83% TimeStepper::CalculateNextTime 0 0% 81.77% 32ms 0.76% VecAXPY_Seq 0 0% 81.77% 31ms 0.74% 1ms 0.024% 81.79% 31ms 0.74% VecNorm_Seq 2ms 0.047% 81.84% 30ms 0.71% PetscMallocAlign 30ms 0.71% 82.55% 30ms 0.71% daxpy_ 10ms 0.24% 82.79% 30ms 0.71% top12 (inline) 14ms 0.33% 83.12% 28ms 0.66% TimeStepper::AdvanceOneTimeStep 1ms 0.024% 83.15% 27ms 0.64% VecCreate_MPI_Private 25ms 0.59% 83.74% 25ms 0.59% DistributedVector::Iterator::operator!= 0 0% 83.74% 25ms 0.59% orte_init 16ms 0.38% 84.12% 23ms 0.55% AbstractParameterisedSystem::GetAnyVariable 19ms 0.45% 84.57% 23ms 0.55% AbstractParameterisedSystem::SetAnyVariable 0 0% 84.57% 23ms 0.55% VecNorm_MPI 1ms 0.024% 84.60% 23ms 0.55% VecNorm_MPI_Default.constprop.0 23ms 0.55% 85.14% 23ms 0.55% __memcpy_avx_unaligned_erms 23ms 0.55% 85.69% 23ms 0.55% asuint64 (inline) 22ms 0.52% 86.21% 22ms 0.52% [libm.so.6] 11ms 0.26% 86.47% 22ms 0.52% std::__cxx11::basic_string::basic_string