File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3700ms, 86.55% of 4275ms total Dropped 471 nodes (cum <= 21.38ms) flat flat% sum% cum cum% 0 0% 0% 4264ms 99.74% __libc_start_call_main 0 0% 0% 4264ms 99.74% __libc_start_main_impl 0 0% 0% 4264ms 99.74% _start 0 0% 0% 4260ms 99.65% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4260ms 99.65% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4260ms 99.65% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4260ms 99.65% main 0 0% 0% 4217ms 98.64% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4217ms 98.64% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4217ms 98.64% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4208ms 98.43% AbstractCardiacProblem::Solve 0 0% 0% 4191ms 98.04% AbstractDynamicLinearPdeSolver::Solve 14ms 0.33% 0.33% 2254ms 52.73% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.35% 1597ms 37.36% LinearSystem::Solve 0 0% 0.35% 1540ms 36.02% KSPSolve 4ms 0.094% 0.44% 1540ms 36.02% KSPSolve_Private 3ms 0.07% 0.51% 1486ms 34.76% KSPSolve_SYMMLQ 26ms 0.61% 1.12% 1283ms 30.01% AbstractCardiacCell::ComputeExceptVoltage 28ms 0.65% 1.78% 1102ms 25.78% AbstractOneStepIvpOdeSolver::InternalSolve 64ms 1.50% 3.27% 951ms 22.25% EulerIvpOdeSolver::CalculateNextYValue 4ms 0.094% 3.37% 934ms 21.85% PCApply 2ms 0.047% 3.42% 922ms 21.57% PCApply_BJacobi_Singleblock 224ms 5.24% 8.65% 871ms 20.37% CellLuoRudy1991FromCellML::EvaluateYDerivatives 359ms 8.40% 17.05% 825ms 19.30% __GI___exp 35ms 0.82% 17.87% 801ms 18.74% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 17.87% 792ms 18.53% KSPSolve_PREONLY (partial-inline) 1ms 0.023% 17.89% 745ms 17.43% MatSolve 0 0% 17.89% 745ms 17.43% PCApply_ICC 737ms 17.24% 35.13% 742ms 17.36% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 256ms 5.99% 41.12% 730ms 17.08% CellLuoRudy1991FromCellML::GetIIonic 0 0% 41.12% 706ms 16.51% KSP_PCApply.lto_priv.18 380ms 8.89% 50.01% 450ms 10.53% __ieee754_exp_fma 3ms 0.07% 50.08% 418ms 9.78% MatMult 8ms 0.19% 50.27% 407ms 9.52% MatMult_SeqAIJ (partial-inline) 397ms 9.29% 59.56% 407ms 9.52% MatMult_SeqAIJ_Inode (inline) 2ms 0.047% 59.60% 319ms 7.46% KSPConvergedDefault 0 0% 59.60% 309ms 7.23% KSP_PCApply (partial-inline) 52ms 1.22% 60.82% 279ms 6.53% BidomainSolver::SetupLinearSystem 1ms 0.023% 60.84% 229ms 5.36% std::pow (inline) 21ms 0.49% 61.33% 228ms 5.33% __pow 21ms 0.49% 61.82% 207ms 4.84% __ieee754_pow_fma 0 0% 61.82% 131ms 3.06% MatNullSpaceRemove 54ms 1.26% 63.09% 107ms 2.50% CellLuoRudy1991FromCellML::VerifyStateVariables 106ms 2.48% 65.57% 106ms 2.48% log_inline (inline) 1ms 0.023% 65.59% 92ms 2.15% VecDuplicate 25ms 0.58% 66.18% 83ms 1.94% MPI_Wtime 0 0% 66.18% 79ms 1.85% VecMDot 6ms 0.14% 66.32% 79ms 1.85% VecMXDot_Private 73ms 1.71% 68.02% 73ms 1.71% ddot_ 70ms 1.64% 69.66% 71ms 1.66% exp_inline (inline) 15ms 0.35% 70.01% 62ms 1.45% AbstractCardiacCell::SetVoltage (partial-inline) 7ms 0.16% 70.18% 62ms 1.45% PetscLogEventEndDefault 46ms 1.08% 71.25% 61ms 1.43% top12 (inline) 58ms 1.36% 72.61% 58ms 1.36% [[vdso]] 0 0% 72.61% 58ms 1.36% __GI___clock_gettime 1ms 0.023% 72.63% 57ms 1.33% VecNorm 19ms 0.44% 73.08% 56ms 1.31% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 73.08% 56ms 1.31% AbstractBidomainSolver::FinaliseLinearSystem 1ms 0.023% 73.10% 54ms 1.26% VecDuplicate_MPI 0 0% 73.10% 54ms 1.26% VecNorm_Seq 53ms 1.24% 74.34% 53ms 1.24% __memcpy_avx_unaligned_erms 3ms 0.07% 74.41% 52ms 1.22% VecMAXPY 7ms 0.16% 74.57% 51ms 1.19% VecCopy 1ms 0.023% 74.60% 49ms 1.15% VecDot 48ms 1.12% 75.72% 49ms 1.15% VecMDot_Seq 6ms 0.14% 75.86% 48ms 1.12% PetscLogEventBeginDefault 26ms 0.61% 76.47% 48ms 1.12% TimeStepper::TimeStepper 48ms 1.12% 77.59% 48ms 1.12% [libchaste_heart.so] 3ms 0.07% 77.66% 47ms 1.10% VecAXPY 6ms 0.14% 77.80% 44ms 1.03% PetscMallocA 0 0% 77.80% 44ms 1.03% VecDot_Seq 0 0% 77.80% 44ms 1.03% VecXDot_Seq_Private.constprop.0 4ms 0.094% 77.89% 43ms 1.01% VecDestroy 28ms 0.65% 78.55% 40ms 0.94% AbstractOneStepIvpOdeSolver::Solve 0 0% 78.55% 40ms 0.94% VecNorm_MPI 0 0% 78.55% 40ms 0.94% VecNorm_MPI_Default.constprop.0 0 0% 78.55% 39ms 0.91% CxxTest::RealWorldDescription::setUp 0 0% 78.55% 39ms 0.91% PMPI_Init_thread 0 0% 78.55% 39ms 0.91% PetscInitialize 0 0% 78.55% 39ms 0.91% PetscSetup::setUpWorld 0 0% 78.55% 39ms 0.91% PetscSetupUtils::CommonSetup 0 0% 78.55% 39ms 0.91% PetscSetupUtils::InitialisePetsc 0 0% 78.55% 39ms 0.91% ompi_mpi_init 25ms 0.58% 79.13% 38ms 0.89% AbstractParameterisedSystem::SetAnyVariable 38ms 0.89% 80.02% 38ms 0.89% DistributedVector::Iterator::operator!= 2ms 0.047% 80.07% 38ms 0.89% PetscMallocAlign 0 0% 80.07% 37ms 0.87% VecDuplicate_Seq 1ms 0.023% 80.09% 36ms 0.84% VecCreate 36ms 0.84% 80.94% 36ms 0.84% asuint64 (inline) 17ms 0.4% 81.33% 35ms 0.82% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.023% 81.36% 35ms 0.82% VecAXPY_Seq 1ms 0.023% 81.38% 34ms 0.8% 0 0% 81.38% 33ms 0.77% PetscMemcpy (inline) 30ms 0.7% 82.08% 32ms 0.75% __ieee754_log_fma 32ms 0.75% 82.83% 32ms 0.75% daxpy_ 26ms 0.61% 83.44% 31ms 0.73% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.023% 83.46% 30ms 0.7% VecCreate_MPI_Private 28ms 0.65% 84.12% 30ms 0.7% VecMAXPY_Seq 28ms 0.65% 84.77% 28ms 0.65% TimeStepper::CalculateNextTime 1ms 0.023% 84.80% 26ms 0.61% VecCopy_Seq (partial-inline) 7ms 0.16% 84.96% 26ms 0.61% __GI___libc_malloc 0 0% 84.96% 26ms 0.61% std::vector::_M_assign_aux (inline) 0 0% 84.96% 26ms 0.61% std::vector::assign (inline) 25ms 0.58% 85.54% 25ms 0.58% dasum_ 0 0% 85.54% 25ms 0.58% orte_init 0 0% 85.54% 25ms 0.58% std::__copy_move::__copy_m (inline) 0 0% 85.54% 25ms 0.58% std::__copy_move_a (inline) 0 0% 85.54% 25ms 0.58% std::__copy_move_a1 (inline) 0 0% 85.54% 25ms 0.58% std::__copy_move_a2 (inline) 0 0% 85.54% 25ms 0.58% std::copy (inline) 7ms 0.16% 85.71% 24ms 0.56% PetscOptionsFindPair 3ms 0.07% 85.78% 24ms 0.56% __posix_memalign 15ms 0.35% 86.13% 23ms 0.54% std::__cxx11::basic_string::basic_string 18ms 0.42% 86.55% 22ms 0.51% AbstractParameterisedSystem::GetAnyVariable 0 0% 86.55% 22ms 0.51% VecSetType