File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3685ms, 86.99% of 4236ms total Dropped 508 nodes (cum <= 21.18ms) flat flat% sum% cum cum% 0 0% 0% 4226ms 99.76% __libc_start_call_main 0 0% 0% 4226ms 99.76% __libc_start_main_impl 0 0% 0% 4226ms 99.76% _start 0 0% 0% 4223ms 99.69% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4223ms 99.69% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4223ms 99.69% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4223ms 99.69% main 0 0% 0% 4183ms 98.75% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4183ms 98.75% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4183ms 98.75% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 4174ms 98.54% AbstractCardiacProblem::Solve 0 0% 0% 4163ms 98.28% AbstractDynamicLinearPdeSolver::Solve 16ms 0.38% 0.38% 1953ms 46.10% AbstractCardiacTissue::SolveCellSystems 0 0% 0.38% 1630ms 38.48% LinearSystem::Solve 0 0% 0.38% 1547ms 36.52% KSPSolve 5ms 0.12% 0.5% 1547ms 36.52% KSPSolve_Private 2ms 0.047% 0.54% 1484ms 35.03% KSPSolve_CG 49ms 1.16% 1.70% 1335ms 31.52% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 275ms 6.49% 8.19% 1197ms 28.26% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 4ms 0.094% 8.29% 862ms 20.35% PCApply 1ms 0.024% 8.31% 852ms 20.11% PCApply_BJacobi_Singleblock 0 0% 8.31% 709ms 16.74% KSPSolve_PREONLY (partial-inline) 0 0% 8.31% 667ms 15.75% KSP_PCApply.lto_priv.7 4ms 0.094% 8.40% 658ms 15.53% MatMult 3ms 0.071% 8.47% 658ms 15.53% MatSolve 0 0% 8.47% 658ms 15.53% PCApply_ICC 645ms 15.23% 23.70% 650ms 15.34% MatSolve_SeqSBAIJ_1_NaturalOrdering 16ms 0.38% 24.08% 643ms 15.18% MatMult_SeqAIJ (partial-inline) 623ms 14.71% 38.79% 643ms 15.18% MatMult_SeqAIJ_Inode (inline) 66ms 1.56% 40.34% 551ms 13.01% CardiacNewtonSolver::Solve 11ms 0.26% 40.60% 543ms 12.82% AbstractCardiacTissue::UpdateCaches (inline) 136ms 3.21% 43.81% 508ms 11.99% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 107ms 2.53% 46.34% 498ms 11.76% BidomainSolver::SetupLinearSystem 194ms 4.58% 50.92% 342ms 8.07% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 69ms 1.63% 52.55% 299ms 7.06% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 1ms 0.024% 52.57% 268ms 6.33% KSPConvergedDefault 1ms 0.024% 52.60% 264ms 6.23% KSP_PCApply (partial-inline) 26ms 0.61% 53.21% 221ms 5.22% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 217ms 5.12% 58.33% 217ms 5.12% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 0 0% 58.33% 190ms 4.49% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 36ms 0.85% 59.18% 190ms 4.49% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 0 0% 59.18% 182ms 4.30% std::pow (inline) 29ms 0.68% 59.87% 180ms 4.25% __pow 152ms 3.59% 63.46% 153ms 3.61% __ieee754_log_fma 21ms 0.5% 63.95% 147ms 3.47% __ieee754_pow_fma 1ms 0.024% 63.98% 131ms 3.09% MatNullSpaceRemove 0 0% 63.98% 130ms 3.07% boost::numeric::ublas::norm_inf (inline) 94ms 2.22% 66.19% 130ms 3.07% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 66.19% 130ms 3.07% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 66.19% 130ms 3.07% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 120ms 2.83% 69.03% 120ms 2.83% ddot_ 0 0% 69.03% 118ms 2.79% VecDuplicate 53ms 1.25% 70.28% 116ms 2.74% __GI___exp 31ms 0.73% 71.01% 106ms 2.50% MPI_Wtime 86ms 2.03% 73.04% 89ms 2.10% exp_inline (inline) 0 0% 73.04% 88ms 2.08% VecTDot 53ms 1.25% 74.29% 85ms 2.01% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 1ms 0.024% 74.32% 85ms 2.01% VecMDot 7ms 0.17% 74.48% 84ms 1.98% VecMXDot_Private 0 0% 74.48% 80ms 1.89% VecTDot_Seq 0 0% 74.48% 80ms 1.89% VecXDot_Seq_Private.constprop.0 30ms 0.71% 75.19% 77ms 1.82% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 75.19% 77ms 1.82% AbstractBidomainSolver::FinaliseLinearSystem 1ms 0.024% 75.21% 77ms 1.82% VecNorm 2ms 0.047% 75.26% 75ms 1.77% __GI___clock_gettime 73ms 1.72% 76.98% 73ms 1.72% [[vdso]] 2ms 0.047% 77.03% 72ms 1.70% VecDuplicate_MPI 1ms 0.024% 77.05% 68ms 1.61% VecNorm_Seq 9ms 0.21% 77.27% 67ms 1.58% PetscLogEventEndDefault 5ms 0.12% 77.38% 58ms 1.37% PetscLogEventBeginDefault 3ms 0.071% 77.46% 56ms 1.32% VecCreate 50ms 1.18% 78.64% 51ms 1.20% VecMDot_Seq 38ms 0.9% 79.53% 50ms 1.18% __ieee754_exp_fma 10ms 0.24% 79.77% 49ms 1.16% PetscMallocA 47ms 1.11% 80.88% 47ms 1.11% [libchaste_heart.so] 0 0% 80.88% 46ms 1.09% VecDuplicate_Seq 3ms 0.071% 80.95% 45ms 1.06% VecMAXPY 0 0% 80.95% 41ms 0.97% VecNorm_MPI 0 0% 80.95% 41ms 0.97% VecNorm_MPI_Default.constprop.0 4ms 0.094% 81.04% 40ms 0.94% VecCreate_MPI_Private 1ms 0.024% 81.07% 39ms 0.92% KSP_RemoveNullSpace (inline) 4ms 0.094% 81.16% 39ms 0.92% PetscMallocAlign 38ms 0.9% 82.06% 38ms 0.9% DistributedVector::Iterator::operator!= 0 0% 82.06% 36ms 0.85% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 82.06% 36ms 0.85% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 82.06% 36ms 0.85% boost_numeric_ublas_abs (inline) 36ms 0.85% 82.91% 36ms 0.85% std::abs (inline) 0 0% 82.91% 35ms 0.83% CxxTest::RealWorldDescription::setUp 0 0% 82.91% 35ms 0.83% PMPI_Init_thread 0 0% 82.91% 35ms 0.83% PetscInitialize 0 0% 82.91% 35ms 0.83% PetscSetup::setUpWorld 0 0% 82.91% 35ms 0.83% PetscSetupUtils::CommonSetup 0 0% 82.91% 35ms 0.83% PetscSetupUtils::InitialisePetsc 0 0% 82.91% 35ms 0.83% ompi_mpi_init 3ms 0.071% 82.98% 33ms 0.78% 1ms 0.024% 83.00% 32ms 0.76% VecDestroy 32ms 0.76% 83.76% 32ms 0.76% log_inline (inline) 3ms 0.071% 83.83% 31ms 0.73% VecCopy 28ms 0.66% 84.49% 28ms 0.66% DistributedVector::End 4ms 0.094% 84.58% 26ms 0.61% PetscHeaderCreate_Private 26ms 0.61% 85.20% 26ms 0.61% dasum_ 25ms 0.59% 85.79% 25ms 0.59% [libm.so.6] 5ms 0.12% 85.91% 24ms 0.57% __GI___libc_malloc 8ms 0.19% 86.10% 23ms 0.54% AbstractCardiacCell::SetVoltage 23ms 0.54% 86.64% 23ms 0.54% DistributedVector::Stripe::operator[] (inline) 3ms 0.071% 86.71% 23ms 0.54% VecAXPY 0 0% 86.71% 23ms 0.54% orte_init 0 0% 86.71% 22ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble 4ms 0.094% 86.80% 22ms 0.52% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 6ms 0.14% 86.95% 22ms 0.52% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 2ms 0.047% 86.99% 22ms 0.52% __posix_memalign