File: Test3dBidomainProblemForEfficiencyWithFasterOdes Type: cpu Showing nodes accounting for 1918ms, 86.94% of 2206ms total Dropped 394 nodes (cum <= 11.03ms) flat flat% sum% cum cum% 0 0% 0% 2198ms 99.64% __libc_start_call_main 0 0% 0% 2198ms 99.64% __libc_start_main_impl 0 0% 0% 2198ms 99.64% _start 0 0% 0% 2196ms 99.55% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 2196ms 99.55% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 2196ms 99.55% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 2196ms 99.55% main 0 0% 0% 2167ms 98.23% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 2167ms 98.23% CxxTest::TestRunner::runTest (inline) 0 0% 0% 2167ms 98.23% Test3dBidomainProblemForEfficiencyWithFasterOdes::TestBidomain3d 0 0% 0% 2162ms 98.01% AbstractCardiacProblem::Solve 1ms 0.045% 0.045% 2157ms 97.78% AbstractDynamicLinearPdeSolver::Solve 12ms 0.54% 0.59% 1190ms 53.94% AbstractCardiacTissue::SolveCellSystems 23ms 1.04% 1.63% 823ms 37.31% AbstractBackwardEulerCardiacCell::ComputeExceptVoltage 0 0% 1.63% 774ms 35.09% LinearSystem::Solve 0 0% 1.63% 758ms 34.36% KSPSolve 2ms 0.091% 1.72% 758ms 34.36% KSPSolve_Private 168ms 7.62% 9.34% 730ms 33.09% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeOneStepExceptVoltage 1ms 0.045% 9.38% 729ms 33.05% KSPSolve_CG 1ms 0.045% 9.43% 429ms 19.45% PCApply 0 0% 9.43% 425ms 19.27% PCApply_BJacobi_Singleblock 55ms 2.49% 11.92% 375ms 17.00% CardiacNewtonSolver::Solve 0 0% 11.92% 367ms 16.64% KSPSolve_PREONLY (partial-inline) 1ms 0.045% 11.97% 345ms 15.64% PCApply_ICC 1ms 0.045% 12.01% 344ms 15.59% MatSolve 0 0% 12.01% 337ms 15.28% KSP_PCApply.lto_priv.7 337ms 15.28% 27.29% 337ms 15.28% MatSolve_SeqSBAIJ_1_NaturalOrdering 3ms 0.14% 27.43% 327ms 14.82% AbstractCardiacTissue::UpdateCaches (inline) 103ms 4.67% 32.09% 302ms 13.69% CellLuoRudy1991FromCellMLBackwardEulerOpt::GetIIonic 1ms 0.045% 32.14% 266ms 12.06% MatMult 4ms 0.18% 32.32% 263ms 11.92% MatMult_SeqAIJ (partial-inline) 259ms 11.74% 44.06% 262ms 11.88% MatMult_SeqAIJ_Inode (inline) 116ms 5.26% 49.32% 213ms 9.66% CellLuoRudy1991FromCellMLBackwardEulerOpt::ComputeResidual 17ms 0.77% 50.09% 165ms 7.48% BidomainSolver::SetupLinearSystem 18ms 0.82% 50.91% 152ms 6.89% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::Instance 1ms 0.045% 50.95% 137ms 6.21% KSPConvergedDefault 14ms 0.63% 51.59% 137ms 6.21% __pow 0 0% 51.59% 137ms 6.21% std::pow (inline) 0 0% 51.59% 132ms 5.98% KSP_PCApply (partial-inline) 0 0% 51.59% 131ms 5.94% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables (inline) 28ms 1.27% 52.86% 131ms 5.94% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::RegenerateTables 15ms 0.68% 53.54% 123ms 5.58% __ieee754_pow_fma 104ms 4.71% 58.25% 107ms 4.85% __ieee754_log_fma 0 0% 58.25% 96ms 4.35% boost::numeric::ublas::norm_inf (inline) 67ms 3.04% 61.29% 96ms 4.35% boost::numeric::ublas::vector_norm_inf::apply (inline) 0 0% 61.29% 96ms 4.35% boost::numeric::ublas::vector_scalar_unary::evaluate (inline) 0 0% 61.29% 96ms 4.35% boost::numeric::ublas::vector_scalar_unary::operator double (inline) 68ms 3.08% 64.37% 82ms 3.72% exp_inline (inline) 39ms 1.77% 66.14% 79ms 3.58% __GI___exp 1ms 0.045% 66.18% 72ms 3.26% MatNullSpaceRemove 35ms 1.59% 67.77% 64ms 2.90% CellLuoRudy1991FromCellMLBackwardEulerOpt::VerifyStateVariables 5ms 0.23% 68.00% 63ms 2.86% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::IndexTable0 (inline) 54ms 2.45% 70.44% 54ms 2.45% CellLuoRudy1991FromCellMLBackwardEulerOpt_LookupTables::_lookup_0_row (inline) 53ms 2.40% 72.85% 53ms 2.40% ddot_ 14ms 0.63% 73.48% 43ms 1.95% MPI_Wtime 0 0% 73.48% 42ms 1.90% VecMDot 3ms 0.14% 73.62% 42ms 1.90% VecMXDot_Private 0 0% 73.62% 36ms 1.63% VecNorm 0 0% 73.62% 35ms 1.59% VecTDot 0 0% 73.62% 32ms 1.45% VecDuplicate 6ms 0.27% 73.89% 31ms 1.41% PetscLogEventBeginDefault 29ms 1.31% 75.20% 30ms 1.36% VecMDot_Seq 0 0% 75.20% 30ms 1.36% VecTDot_Seq 1ms 0.045% 75.25% 30ms 1.36% VecXDot_Seq_Private.constprop.0 3ms 0.14% 75.39% 29ms 1.31% VecMAXPY 1ms 0.045% 75.43% 29ms 1.31% VecNorm_Seq 29ms 1.31% 76.75% 29ms 1.31% [[vdso]] 0 0% 76.75% 29ms 1.31% __GI___clock_gettime 5ms 0.23% 76.97% 28ms 1.27% PetscLogEventEndDefault 0 0% 76.97% 27ms 1.22% CxxTest::RealWorldDescription::setUp 0 0% 76.97% 27ms 1.22% PetscInitialize 0 0% 76.97% 27ms 1.22% PetscSetup::setUpWorld 0 0% 76.97% 27ms 1.22% PetscSetupUtils::CommonSetup 0 0% 76.97% 27ms 1.22% PetscSetupUtils::InitialisePetsc 0 0% 76.97% 27ms 1.22% boost::numeric::ublas::scalar_traits::norm_inf (inline) 0 0% 76.97% 27ms 1.22% boost::numeric::ublas::scalar_traits::type_abs (inline) 0 0% 76.97% 27ms 1.22% boost_numeric_ublas_abs (inline) 27ms 1.22% 78.20% 27ms 1.22% std::abs (inline) 0 0% 78.20% 26ms 1.18% PMPI_Init_thread 0 0% 78.20% 26ms 1.18% ompi_mpi_init 25ms 1.13% 79.33% 25ms 1.13% ReplicatableVector::operator[] 25ms 1.13% 80.46% 25ms 1.13% log_inline (inline) 1ms 0.045% 80.51% 24ms 1.09% 24ms 1.09% 81.60% 24ms 1.09% [libchaste_heart.so] 5ms 0.23% 81.82% 23ms 1.04% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 81.82% 23ms 1.04% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 81.82% 23ms 1.04% PetscTimeSubtract (inline) 20ms 0.91% 82.73% 23ms 1.04% __ieee754_exp_fma 21ms 0.95% 83.68% 21ms 0.95% DistributedVector::Iterator::operator!= 18ms 0.82% 84.50% 18ms 0.82% VecMAXPY_Seq 18ms 0.82% 85.31% 18ms 0.82% asuint64 (inline) 0 0% 85.31% 18ms 0.82% orte_init 1ms 0.045% 85.36% 17ms 0.77% VecDestroy 2ms 0.091% 85.45% 17ms 0.77% VecDuplicate_MPI 17ms 0.77% 86.22% 17ms 0.77% [libm.so.6] 3ms 0.14% 86.36% 17ms 0.77% top12 (inline) 7ms 0.32% 86.67% 15ms 0.68% AbstractCardiacCell::SetVoltage 4ms 0.18% 86.85% 15ms 0.68% VecCopy 0 0% 86.85% 15ms 0.68% VecDuplicate_Seq 0 0% 86.85% 15ms 0.68% VecNorm_MPI 2ms 0.091% 86.94% 15ms 0.68% VecNorm_MPI_Default.constprop.0 0 0% 86.94% 13ms 0.59% hwloc_linux_get_tid_last_cpu_location 0 0% 86.94% 13ms 0.59% hwloc_topology_load 0 0% 86.94% 12ms 0.54% AbstractFeVolumeIntegralAssembler::DoAssemble