File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3670ms, 87.59% of 4190ms total Dropped 474 nodes (cum <= 20.95ms) flat flat% sum% cum cum% 0 0% 0% 4181ms 99.79% __libc_start_call_main 0 0% 0% 4181ms 99.79% __libc_start_main_impl 0 0% 0% 4181ms 99.79% _start 0 0% 0% 4178ms 99.71% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4178ms 99.71% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4178ms 99.71% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4178ms 99.71% main 0 0% 0% 4147ms 98.97% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4147ms 98.97% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4147ms 98.97% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 4139ms 98.78% AbstractCardiacProblem::Solve 1ms 0.024% 0.024% 4130ms 98.57% AbstractDynamicLinearPdeSolver::Solve 0 0% 0.024% 2099ms 50.10% LinearSystem::Solve 1ms 0.024% 0.048% 2065ms 49.28% KSPSolve 2ms 0.048% 0.095% 2065ms 49.28% KSPSolve_Private 0 0% 0.095% 2016ms 48.11% KSPSolve_CG 10ms 0.24% 0.33% 1555ms 37.11% AbstractCardiacTissue::SolveCellSystems 3ms 0.072% 0.41% 1173ms 28.00% PCApply 0 0% 0.41% 1160ms 27.68% PCApply_BJacobi_Singleblock 36ms 0.86% 1.26% 1097ms 26.18% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 0 0% 1.26% 995ms 23.75% KSPSolve_PREONLY (partial-inline) 169ms 4.03% 5.30% 971ms 23.17% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 2ms 0.048% 5.35% 937ms 22.36% MatSolve 0 0% 5.35% 937ms 22.36% PCApply_ICC 1ms 0.024% 5.37% 927ms 22.12% KSP_PCApply.lto_priv.7 4ms 0.095% 5.47% 927ms 22.12% MatMult 917ms 21.89% 27.35% 923ms 22.03% MatSolve_SeqSBAIJ_1_NaturalOrdering 2ms 0.048% 27.40% 916ms 21.86% MatMult_SeqAIJ 910ms 21.72% 49.12% 915ms 21.84% MatMult_SeqAIJ_Inode (inline) 52ms 1.24% 50.36% 446ms 10.64% BidomainSolver::SetupLinearSystem 2ms 0.048% 50.41% 414ms 9.88% AbstractCardiacTissue::UpdateCaches (inline) 169ms 4.03% 54.44% 394ms 9.40% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 10ms 0.24% 54.68% 381ms 9.09% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 26ms 0.62% 55.30% 362ms 8.64% CardiacNewtonSolver::Solve 0 0% 55.30% 361ms 8.62% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 54ms 1.29% 56.59% 361ms 8.62% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 0 0% 56.59% 337ms 8.04% KSP_PCApply (partial-inline) 0 0% 56.59% 334ms 7.97% KSPConvergedDefault 133ms 3.17% 59.76% 262ms 6.25% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 160ms 3.82% 63.58% 237ms 5.66% __GI___exp 1ms 0.024% 63.60% 161ms 3.84% MatNullSpaceRemove 135ms 3.22% 66.83% 138ms 3.29% __ieee754_log_fma 0 0% 66.83% 134ms 3.20% std::pow (inline) 19ms 0.45% 67.28% 132ms 3.15% __pow 16ms 0.38% 67.66% 110ms 2.63% __ieee754_pow_fma 0 0% 67.66% 102ms 2.43% VecDuplicate 11ms 0.26% 67.92% 98ms 2.34% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 97ms 2.32% 70.24% 97ms 2.32% [libchaste_heart.so] 0 0% 70.24% 92ms 2.20% VecMDot 6ms 0.14% 70.38% 92ms 2.20% VecMXDot_Private 66ms 1.58% 71.96% 89ms 2.12% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 17ms 0.41% 72.36% 84ms 2.00% MPI_Wtime 79ms 1.89% 74.25% 79ms 1.89% ddot_ 67ms 1.60% 75.85% 77ms 1.84% exp_inline (inline) 73ms 1.74% 77.59% 73ms 1.74% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 4ms 0.095% 77.68% 68ms 1.62% VecMAXPY 66ms 1.58% 79.26% 66ms 1.58% __ieee754_exp_fma 1ms 0.024% 79.28% 65ms 1.55% __GI___clock_gettime 0 0% 79.28% 65ms 1.55% boost::numeric::ublas::norm_inf (inline) 55ms 1.31% 80.60% 65ms 1.55% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 80.60% 65ms 1.55% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 80.60% 65ms 1.55% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 64ms 1.53% 82.12% 64ms 1.53% [[vdso]] 13ms 0.31% 82.43% 63ms 1.50% PetscLogEventBeginDefault 2ms 0.048% 82.48% 63ms 1.50% VecTDot 58ms 1.38% 83.87% 62ms 1.48% VecMDot_Seq 14ms 0.33% 84.20% 58ms 1.38% PetscLogEventEndDefault 0 0% 84.20% 56ms 1.34% VecDuplicate_Seq 0 0% 84.20% 56ms 1.34% VecNorm 47ms 1.12% 85.32% 48ms 1.15% VecMAXPY_Seq 0 0% 85.32% 47ms 1.12% VecTDot_Seq 1ms 0.024% 85.35% 47ms 1.12% VecXDot_Seq_Private.constprop.0 0 0% 85.35% 46ms 1.10% VecDestroy 0 0% 85.35% 46ms 1.10% VecDuplicate_MPI 1ms 0.024% 85.37% 41ms 0.98% VecCreate 0 0% 85.37% 41ms 0.98% VecNorm_Seq 2ms 0.048% 85.42% 40ms 0.95% PetscMallocA 3ms 0.072% 85.49% 38ms 0.91% PetscMallocAlign 2ms 0.048% 85.54% 36ms 0.86% PMPI_Comm_get_attr 4ms 0.095% 85.63% 34ms 0.81% ompi_attr_get_c 3ms 0.072% 85.70% 30ms 0.72% VecSetType 5ms 0.12% 85.82% 28ms 0.67% __posix_memalign 0 0% 85.82% 27ms 0.64% CxxTest::RealWorldDescription::setUp 0 0% 85.82% 27ms 0.64% PMPI_Init_thread 0 0% 85.82% 27ms 0.64% PetscInitialize 0 0% 85.82% 27ms 0.64% PetscSetup::setUpWorld 0 0% 85.82% 27ms 0.64% PetscSetupUtils::CommonSetup 0 0% 85.82% 27ms 0.64% PetscSetupUtils::InitialisePetsc 13ms 0.31% 86.13% 27ms 0.64% __GI___libc_malloc 0 0% 86.13% 27ms 0.64% ompi_mpi_init 6ms 0.14% 86.28% 26ms 0.62% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 1ms 0.024% 86.30% 26ms 0.62% PetscHeaderCreate_Private 2ms 0.048% 86.35% 26ms 0.62% VecCreate_MPI_Private 26ms 0.62% 86.97% 26ms 0.62% [libm.so.6] 0 0% 86.97% 25ms 0.6% KSP_RemoveNullSpace (inline) 0 0% 86.97% 24ms 0.57% 10ms 0.24% 87.21% 24ms 0.57% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 87.21% 24ms 0.57% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 87.21% 24ms 0.57% VecCreate_Seq 4ms 0.095% 87.30% 22ms 0.53% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 2ms 0.048% 87.35% 22ms 0.53% PetscHeaderDestroy_Private 5ms 0.12% 87.47% 22ms 0.53% ___pthread_mutex_lock 4ms 0.095% 87.57% 21ms 0.5% VecAXPY 1ms 0.024% 87.59% 21ms 0.5% VecCopy