File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3658ms, 86.89% of 4210ms total Dropped 472 nodes (cum <= 21.05ms) flat flat% sum% cum cum% 0 0% 0% 4199ms 99.74% __libc_start_call_main 0 0% 0% 4199ms 99.74% __libc_start_main_impl 0 0% 0% 4199ms 99.74% _start 0 0% 0% 4196ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4196ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4196ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4196ms 99.67% main 0 0% 0% 4159ms 98.79% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4159ms 98.79% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4159ms 98.79% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 2ms 0.048% 0.048% 4150ms 98.57% AbstractCardiacProblem::Solve 2ms 0.048% 0.095% 4140ms 98.34% AbstractDynamicLinearPdeSolver::Solve 1ms 0.024% 0.12% 2392ms 56.82% LinearSystem::Solve 1ms 0.024% 0.14% 2327ms 55.27% KSPSolve 4ms 0.095% 0.24% 2327ms 55.27% KSPSolve_Private 1ms 0.024% 0.26% 2277ms 54.09% KSPSolve_CG 7ms 0.17% 0.43% 1528ms 36.29% PCApply 0 0% 0.43% 1508ms 35.82% PCApply_BJacobi_Singleblock 13ms 0.31% 0.74% 1370ms 32.54% AbstractCardiacTissue::SolveCellSystems 0 0% 0.74% 1303ms 30.95% KSP_PCApply.lto_priv.7 0 0% 0.74% 1268ms 30.12% KSPSolve_PREONLY (partial-inline) 1ms 0.024% 0.76% 1188ms 28.22% MatSolve 0 0% 0.76% 1188ms 28.22% PCApply_ICC 1168ms 27.74% 28.50% 1175ms 27.91% MatSolve_SeqSBAIJ_1_NaturalOrdering 26ms 0.62% 29.12% 944ms 22.42% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 180ms 4.28% 33.40% 852ms 20.24% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 5ms 0.12% 33.52% 607ms 14.42% MatMult 19ms 0.45% 33.97% 592ms 14.06% MatMult_SeqAIJ (partial-inline) 570ms 13.54% 47.51% 592ms 14.06% MatMult_SeqAIJ_Inode (inline) 15ms 0.36% 47.86% 376ms 8.93% AbstractCardiacTissue::UpdateCaches (inline) 50ms 1.19% 49.05% 362ms 8.60% CardiacNewtonSolver::Solve 124ms 2.95% 52.00% 346ms 8.22% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 0 0% 52.00% 333ms 7.91% KSP_PCApply (partial-inline) 61ms 1.45% 53.44% 323ms 7.67% BidomainSolver::SetupLinearSystem 0 0% 53.44% 313ms 7.43% KSPConvergedDefault 110ms 2.61% 56.06% 217ms 5.15% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 17ms 0.4% 56.46% 211ms 5.01% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 3ms 0.071% 56.53% 192ms 4.56% MatNullSpaceRemove 0 0% 56.53% 191ms 4.54% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 38ms 0.9% 57.43% 191ms 4.54% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 38ms 0.9% 58.34% 179ms 4.25% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 142ms 3.37% 61.71% 142ms 3.37% ddot_ 133ms 3.16% 64.87% 133ms 3.16% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 0 0% 64.87% 121ms 2.87% VecDuplicate 0 0% 64.87% 121ms 2.87% VecMDot 5ms 0.12% 64.99% 121ms 2.87% VecMXDot_Private 50ms 1.19% 66.18% 118ms 2.80% __GI___exp 114ms 2.71% 68.88% 115ms 2.73% __ieee754_log_fma 4ms 0.095% 68.98% 111ms 2.64% VecTDot 38ms 0.9% 69.88% 109ms 2.59% MPI_Wtime 1ms 0.024% 69.90% 98ms 2.33% std::pow (inline) 11ms 0.26% 70.17% 97ms 2.30% __pow 2ms 0.048% 70.21% 94ms 2.23% VecNorm 0 0% 70.21% 89ms 2.11% VecTDot_Seq 0 0% 70.21% 89ms 2.11% VecXDot_Seq_Private.constprop.0 26ms 0.62% 70.83% 88ms 2.09% PetscLogEventEndDefault 0 0% 70.83% 88ms 2.09% boost::numeric::ublas::norm_inf (inline) 63ms 1.50% 72.33% 88ms 2.09% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 72.33% 88ms 2.09% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 72.33% 88ms 2.09% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 15ms 0.36% 72.68% 86ms 2.04% __ieee754_pow_fma 83ms 1.97% 74.66% 85ms 2.02% VecMDot_Seq 16ms 0.38% 75.04% 81ms 1.92% PetscLogEventBeginDefault 1ms 0.024% 75.06% 80ms 1.90% VecNorm_Seq 2ms 0.048% 75.11% 71ms 1.69% __GI___clock_gettime 69ms 1.64% 76.75% 69ms 1.64% [[vdso]] 3ms 0.071% 76.82% 68ms 1.62% VecMAXPY 1ms 0.024% 76.84% 67ms 1.59% VecDuplicate_Seq 3ms 0.071% 76.91% 62ms 1.47% VecCreate 44ms 1.05% 77.96% 61ms 1.45% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 9ms 0.21% 78.17% 58ms 1.38% PetscMallocA 2ms 0.048% 78.22% 55ms 1.31% VecDestroy 2ms 0.048% 78.27% 54ms 1.28% VecDuplicate_MPI 52ms 1.24% 79.50% 52ms 1.24% exp_inline (inline) 40ms 0.95% 80.45% 51ms 1.21% __ieee754_exp_fma 7ms 0.17% 80.62% 49ms 1.16% PetscMallocAlign (partial-inline) 7ms 0.17% 80.78% 48ms 1.14% VecCopy 1ms 0.024% 80.81% 46ms 1.09% AbstractBidomainSolver::FinaliseLinearSystem 12ms 0.29% 81.09% 44ms 1.05% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.09% 43ms 1.02% VecNorm_MPI 1ms 0.024% 81.12% 43ms 1.02% VecNorm_MPI_Default.constprop.0 38ms 0.9% 82.02% 38ms 0.9% VecMAXPY_Seq 0 0% 82.02% 33ms 0.78% CxxTest::RealWorldDescription::setUp 0 0% 82.02% 33ms 0.78% PMPI_Init_thread 0 0% 82.02% 33ms 0.78% PetscInitialize 0 0% 82.02% 33ms 0.78% PetscSetup::setUpWorld 0 0% 82.02% 33ms 0.78% PetscSetupUtils::CommonSetup 0 0% 82.02% 33ms 0.78% PetscSetupUtils::InitialisePetsc 0 0% 82.02% 33ms 0.78% ompi_mpi_init 2ms 0.048% 82.07% 29ms 0.69% 1ms 0.024% 82.09% 28ms 0.67% VecCreate_MPI_Private 28ms 0.67% 82.76% 28ms 0.67% [libchaste_heart.so] 5ms 0.12% 82.87% 28ms 0.67% __GI___libc_malloc 27ms 0.64% 83.52% 27ms 0.64% DistributedVector::Iterator::operator!= 3ms 0.071% 83.59% 27ms 0.64% PetscHeaderCreate_Private 6ms 0.14% 83.73% 27ms 0.64% PetscHeaderDestroy_Private 0 0% 83.73% 27ms 0.64% PetscMemcpy (inline) 26ms 0.62% 84.35% 26ms 0.62% dasum_ 0 0% 84.35% 25ms 0.59% VecSetType 1ms 0.024% 84.37% 25ms 0.59% __posix_memalign 4ms 0.095% 84.47% 24ms 0.57% VecSet 24ms 0.57% 85.04% 24ms 0.57% __memcpy_avx_unaligned_erms 9ms 0.21% 85.25% 23ms 0.55% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 0 0% 85.25% 23ms 0.55% PetscMemzero (inline) 1ms 0.024% 85.27% 23ms 0.55% VecAXPY 0 0% 85.27% 23ms 0.55% VecCopy_Seq (partial-inline) 23ms 0.55% 85.82% 23ms 0.55% __memset_avx2_unaligned_erms 0 0% 85.82% 23ms 0.55% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 85.82% 23ms 0.55% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 85.82% 23ms 0.55% boost_numeric_ublas_abs (inline) 23ms 0.55% 86.37% 23ms 0.55% std::abs (inline) 0 0% 86.37% 22ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble 22ms 0.52% 86.89% 22ms 0.52% DistributedVector::Stripe::operator[] (inline) 0 0% 86.89% 22ms 0.52% orte_init