File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 3056ms, 88.68% of 3446ms total Dropped 442 nodes (cum <= 17.23ms) flat flat% sum% cum cum% 0 0% 0% 3437ms 99.74% __libc_start_call_main 0 0% 0% 3437ms 99.74% __libc_start_main_impl 0 0% 0% 3437ms 99.74% _start 0 0% 0% 3434ms 99.65% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 3434ms 99.65% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 3434ms 99.65% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 3434ms 99.65% main 0 0% 0% 3407ms 98.87% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 3407ms 98.87% CxxTest::TestRunner::runTest (inline) 0 0% 0% 3407ms 98.87% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 3400ms 98.67% AbstractCardiacProblem::Solve 0 0% 0% 3390ms 98.37% AbstractDynamicLinearPdeSolver::Solve 0 0% 0% 1635ms 47.45% LinearSystem::Solve 0 0% 0% 1607ms 46.63% KSPSolve 3ms 0.087% 0.087% 1607ms 46.63% KSPSolve_Private 0 0% 0.087% 1574ms 45.68% KSPSolve_CG 10ms 0.29% 0.38% 1317ms 38.22% AbstractCardiacTissue::SolveCellSystems 4ms 0.12% 0.49% 881ms 25.57% PCApply 0 0% 0.49% 872ms 25.30% PCApply_BJacobi_Singleblock 32ms 0.93% 1.42% 855ms 24.81% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 4ms 0.12% 1.54% 815ms 23.65% MatMult 5ms 0.15% 1.68% 806ms 23.39% MatMult_SeqAIJ (partial-inline) 799ms 23.19% 24.87% 805ms 23.36% MatMult_SeqAIJ_Inode (inline) 0 0% 24.87% 755ms 21.91% KSPSolve_PREONLY (partial-inline) 153ms 4.44% 29.31% 748ms 21.71% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 7ms 0.2% 29.51% 715ms 20.75% MatSolve 0 0% 29.51% 715ms 20.75% PCApply_ICC 0 0% 29.51% 705ms 20.46% KSP_PCApply.lto_priv.7 699ms 20.28% 49.80% 700ms 20.31% MatSolve_SeqSBAIJ_1_NaturalOrdering 1ms 0.029% 49.83% 419ms 12.16% AbstractCardiacTissue::UpdateCaches (inline) 40ms 1.16% 50.99% 405ms 11.75% BidomainSolver::SetupLinearSystem 180ms 5.22% 56.21% 403ms 11.69% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 22ms 0.64% 56.85% 350ms 10.16% CardiacNewtonSolver::Solve 0 0% 56.85% 241ms 6.99% KSP_PCApply (partial-inline) 0 0% 56.85% 240ms 6.96% KSPConvergedDefault 125ms 3.63% 60.48% 233ms 6.76% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 10ms 0.29% 60.77% 213ms 6.18% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 0 0% 60.77% 192ms 5.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 41ms 1.19% 61.96% 192ms 5.57% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 0 0% 61.96% 136ms 3.95% std::pow (inline) 12ms 0.35% 62.30% 134ms 3.89% __pow 71ms 2.06% 64.36% 122ms 3.54% __GI___exp 121ms 3.51% 67.88% 122ms 3.54% __ieee754_log_fma 13ms 0.38% 68.25% 120ms 3.48% __ieee754_pow_fma 1ms 0.029% 68.28% 109ms 3.16% MatNullSpaceRemove 88ms 2.55% 70.84% 88ms 2.55% [libchaste_heart.so] 0 0% 70.84% 88ms 2.55% boost::numeric::ublas::norm_inf (inline) 77ms 2.23% 73.07% 88ms 2.55% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 73.07% 88ms 2.55% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 73.07% 88ms 2.55% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 76ms 2.21% 75.28% 88ms 2.55% exp_inline (inline) 47ms 1.36% 76.64% 72ms 2.09% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 8ms 0.23% 76.87% 72ms 2.09% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 68ms 1.97% 78.85% 68ms 1.97% ddot_ 0 0% 78.85% 67ms 1.94% VecMDot 2ms 0.058% 78.90% 67ms 1.94% VecMXDot_Private 0 0% 78.90% 66ms 1.92% VecDuplicate 16ms 0.46% 79.37% 59ms 1.71% MPI_Wtime 53ms 1.54% 80.91% 53ms 1.54% VecMDot_Seq 51ms 1.48% 82.39% 51ms 1.48% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 2ms 0.058% 82.44% 49ms 1.42% VecTDot 2ms 0.058% 82.50% 43ms 1.25% VecNorm 43ms 1.25% 83.75% 43ms 1.25% __ieee754_exp_fma 42ms 1.22% 84.97% 42ms 1.22% [[vdso]] 0 0% 84.97% 42ms 1.22% __GI___clock_gettime 5ms 0.15% 85.11% 41ms 1.19% VecMAXPY 0 0% 85.11% 40ms 1.16% KSP_RemoveNullSpace (inline) 3ms 0.087% 85.20% 39ms 1.13% VecDestroy 7ms 0.2% 85.40% 38ms 1.10% PetscLogEventEndDefault 0 0% 85.40% 37ms 1.07% VecNorm_Seq 0 0% 85.40% 37ms 1.07% VecTDot_Seq 0 0% 85.40% 37ms 1.07% VecXDot_Seq_Private.constprop.0 1ms 0.029% 85.43% 35ms 1.02% VecDuplicate_MPI 5ms 0.15% 85.58% 33ms 0.96% PetscLogEventBeginDefault 0 0% 85.58% 31ms 0.9% VecDuplicate_Seq 2ms 0.058% 85.64% 28ms 0.81% VecCopy 6ms 0.17% 85.81% 27ms 0.78% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 85.81% 27ms 0.78% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 85.81% 27ms 0.78% VecCreate 0 0% 85.81% 26ms 0.75% CxxTest::RealWorldDescription::setUp 0 0% 85.81% 26ms 0.75% PMPI_Init_thread 0 0% 85.81% 26ms 0.75% PetscInitialize 0 0% 85.81% 26ms 0.75% PetscSetup::setUpWorld 0 0% 85.81% 26ms 0.75% PetscSetupUtils::CommonSetup 0 0% 85.81% 26ms 0.75% PetscSetupUtils::InitialisePetsc 25ms 0.73% 86.54% 26ms 0.75% VecMAXPY_Seq 0 0% 86.54% 26ms 0.75% ompi_mpi_init 2ms 0.058% 86.59% 25ms 0.73% 4ms 0.12% 86.71% 24ms 0.7% PetscMallocA 1ms 0.029% 86.74% 23ms 0.67% PMPI_Comm_get_attr 5ms 0.15% 86.88% 22ms 0.64% ompi_attr_get_c 6ms 0.17% 87.06% 20ms 0.58% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#3}::operator() (inline) 2ms 0.058% 87.12% 20ms 0.58% PetscMallocAlign 1ms 0.029% 87.14% 20ms 0.58% VecCreate_MPI_Private 2ms 0.058% 87.20% 19ms 0.55% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables()::{lambda(double)#23}::operator() (inline) 19ms 0.55% 87.75% 19ms 0.55% DistributedVector::Stripe::operator[] (inline) 2ms 0.058% 87.81% 19ms 0.55% VecAYPX 19ms 0.55% 88.36% 19ms 0.55% [libm.so.6] 11ms 0.32% 88.68% 19ms 0.55% __GI___libc_malloc 0 0% 88.68% 18ms 0.52% AbstractFeVolumeIntegralAssembler::DoAssemble 0 0% 88.68% 18ms 0.52% PetscMemcpy (inline)