File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 4134ms, 88.35% of 4679ms total Dropped 446 nodes (cum <= 23.39ms) flat flat% sum% cum cum% 0 0% 0% 4671ms 99.83% __libc_start_call_main 0 0% 0% 4671ms 99.83% __libc_start_main_impl 0 0% 0% 4671ms 99.83% _start 0 0% 0% 4669ms 99.79% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4669ms 99.79% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4669ms 99.79% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4669ms 99.79% main 0 0% 0% 4638ms 99.12% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4638ms 99.12% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4638ms 99.12% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 2ms 0.043% 0.043% 4630ms 98.95% AbstractCardiacProblem::Solve 1ms 0.021% 0.064% 4615ms 98.63% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.064% 2415ms 51.61% LinearSystem::Solve 1ms 0.021% 0.085% 2377ms 50.80% KSPSolve 3ms 0.064% 0.15% 2376ms 50.78% KSPSolve_Private 3ms 0.064% 0.21% 2329ms 49.78% KSPSolve_CG 8ms 0.17% 0.38% 1633ms 34.90% AbstractCardiacTissue::SolveCellSystems 5ms 0.11% 0.49% 1320ms 28.21% MatMult 15ms 0.32% 0.81% 1305ms 27.89% MatMult_SeqAIJ (partial-inline) 1285ms 27.46% 28.28% 1305ms 27.89% MatMult_SeqAIJ_Inode (inline) 1ms 0.021% 28.30% 1115ms 23.83% PCApply 1ms 0.021% 28.32% 1109ms 23.70% PCApply_BJacobi_Singleblock 49ms 1.05% 29.37% 1099ms 23.49% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 168ms 3.59% 32.96% 986ms 21.07% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 0 0% 32.96% 939ms 20.07% KSPSolve_PREONLY (partial-inline) 5ms 0.11% 33.06% 888ms 18.98% MatSolve 0 0% 33.06% 888ms 18.98% PCApply_ICC 869ms 18.57% 51.63% 874ms 18.68% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 51.63% 865ms 18.49% KSP_PCApply.lto_priv.7 46ms 0.98% 52.62% 535ms 11.43% BidomainSolver::SetupLinearSystem 1ms 0.021% 52.64% 485ms 10.37% AbstractCardiacTissue::UpdateCaches (inline) 188ms 4.02% 56.66% 462ms 9.87% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 24ms 0.51% 57.17% 398ms 8.51% CardiacNewtonSolver::Solve 14ms 0.3% 57.47% 342ms 7.31% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 0 0% 57.47% 328ms 7.01% KSPConvergedDefault 0 0% 57.47% 326ms 6.97% KSP_PCApply (partial-inline) 0 0% 57.47% 316ms 6.75% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 45ms 0.96% 58.43% 316ms 6.75% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 153ms 3.27% 61.70% 280ms 5.98% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 96ms 2.05% 63.75% 191ms 4.08% __GI___exp 24ms 0.51% 64.27% 181ms 3.87% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 165ms 3.53% 67.79% 165ms 3.53% ddot_ 143ms 3.06% 70.85% 143ms 3.06% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 136ms 2.91% 73.76% 137ms 2.93% __ieee754_log_fma 1ms 0.021% 73.78% 134ms 2.86% MatNullSpaceRemove 2ms 0.043% 73.82% 131ms 2.80% std::pow (inline) 17ms 0.36% 74.18% 128ms 2.74% __pow 2ms 0.043% 74.23% 117ms 2.50% VecTDot 0 0% 74.23% 107ms 2.29% VecDuplicate 11ms 0.24% 74.46% 107ms 2.29% __ieee754_pow_fma 0 0% 74.46% 103ms 2.20% VecTDot_Seq 0 0% 74.46% 103ms 2.20% VecXDot_Seq_Private.constprop.0 101ms 2.16% 76.62% 101ms 2.16% [libchaste_heart.so] 1ms 0.021% 76.64% 92ms 1.97% VecNorm 82ms 1.75% 78.39% 83ms 1.77% __ieee754_exp_fma 31ms 0.66% 79.06% 82ms 1.75% MPI_Wtime 0 0% 79.06% 82ms 1.75% boost::numeric::ublas::norm_inf (inline) 71ms 1.52% 80.57% 82ms 1.75% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 80.57% 82ms 1.75% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 80.57% 82ms 1.75% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 0 0% 80.57% 81ms 1.73% VecNorm_Seq 0 0% 80.57% 70ms 1.50% VecDuplicate_Seq 0 0% 80.57% 70ms 1.50% VecMDot 4ms 0.085% 80.66% 70ms 1.50% VecMXDot_Private 47ms 1.00% 81.66% 63ms 1.35% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 4ms 0.085% 81.75% 63ms 1.35% VecMAXPY 12ms 0.26% 82.00% 61ms 1.30% PetscMallocA 11ms 0.24% 82.24% 58ms 1.24% PetscLogEventBeginDefault 12ms 0.26% 82.50% 58ms 1.24% PetscLogEventEndDefault 55ms 1.18% 83.67% 57ms 1.22% exp_inline (inline) 2ms 0.043% 83.71% 49ms 1.05% PetscMallocAlign 3ms 0.064% 83.78% 49ms 1.05% VecDestroy 2ms 0.043% 83.82% 49ms 1.05% __GI___clock_gettime 3ms 0.064% 83.89% 47ms 1.00% VecCreate 47ms 1.00% 84.89% 47ms 1.00% [[vdso]] 40ms 0.85% 85.74% 42ms 0.9% VecMDot_Seq 40ms 0.85% 86.60% 40ms 0.85% VecMAXPY_Seq 3ms 0.064% 86.66% 39ms 0.83% VecSetType 38ms 0.81% 87.48% 38ms 0.81% log_inline (inline) 2ms 0.043% 87.52% 37ms 0.79% VecDuplicate_MPI 1ms 0.021% 87.54% 37ms 0.79% __posix_memalign 11ms 0.24% 87.78% 35ms 0.75% __GI___libc_malloc 0 0% 87.78% 33ms 0.71% VecNorm_MPI 0 0% 87.78% 33ms 0.71% VecNorm_MPI_Default.constprop.0 7ms 0.15% 87.92% 31ms 0.66% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 0 0% 87.92% 28ms 0.6% CxxTest::RealWorldDescription::setUp 0 0% 87.92% 28ms 0.6% PMPI_Init_thread 0 0% 87.92% 28ms 0.6% PetscInitialize 0 0% 87.92% 28ms 0.6% PetscSetup::setUpWorld 0 0% 87.92% 28ms 0.6% PetscSetupUtils::CommonSetup 0 0% 87.92% 28ms 0.6% PetscSetupUtils::InitialisePetsc 1ms 0.021% 87.95% 28ms 0.6% VecCreate_Seq 0 0% 87.95% 28ms 0.6% ompi_mpi_init 10ms 0.21% 88.16% 26ms 0.56% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 88.16% 26ms 0.56% AbstractBidomainSolver::FinaliseLinearSystem 4ms 0.085% 88.25% 25ms 0.53% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 1ms 0.021% 88.27% 24ms 0.51% 4ms 0.085% 88.35% 24ms 0.51% VecCopy