File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3653ms, 86.48% of 4224ms total Dropped 454 nodes (cum <= 21.12ms) flat flat% sum% cum cum% 0 0% 0% 4215ms 99.79% __libc_start_call_main 0 0% 0% 4215ms 99.79% __libc_start_main_impl 0 0% 0% 4215ms 99.79% _start 0 0% 0% 4212ms 99.72% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4212ms 99.72% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4212ms 99.72% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4212ms 99.72% main 0 0% 0% 4171ms 98.75% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4171ms 98.75% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4171ms 98.75% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4163ms 98.56% AbstractCardiacProblem::Solve 2ms 0.047% 0.047% 4154ms 98.34% AbstractDynamicLinearPdeSolver::Solve 13ms 0.31% 0.36% 2278ms 53.93% AbstractCardiacTissue::SolveCellSystems 0 0% 0.36% 1539ms 36.43% LinearSystem::Solve 0 0% 0.36% 1490ms 35.27% KSPSolve 6ms 0.14% 0.5% 1490ms 35.27% KSPSolve_Private 3ms 0.071% 0.57% 1446ms 34.23% KSPSolve_SYMMLQ 35ms 0.83% 1.40% 1304ms 30.87% AbstractCardiacCell::ComputeExceptVoltage 27ms 0.64% 2.04% 1090ms 25.80% AbstractOneStepIvpOdeSolver::InternalSolve 54ms 1.28% 3.31% 931ms 22.04% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.024% 3.34% 905ms 21.43% PCApply 0 0% 3.34% 902ms 21.35% PCApply_BJacobi_Singleblock 249ms 5.89% 9.23% 864ms 20.45% CellLuoRudy1991FromCellML::EvaluateYDerivatives 353ms 8.36% 17.59% 759ms 17.97% __GI___exp 0 0% 17.59% 748ms 17.71% KSPSolve_PREONLY (partial-inline) 26ms 0.62% 18.21% 747ms 17.68% AbstractCardiacTissue::UpdateCaches (inline) 1ms 0.024% 18.23% 713ms 16.88% PCApply_ICC 3ms 0.071% 18.30% 712ms 16.86% MatSolve 695ms 16.45% 34.75% 701ms 16.60% MatSolve_SeqSBAIJ_1_NaturalOrdering 258ms 6.11% 40.86% 694ms 16.43% CellLuoRudy1991FromCellML::GetIIonic 0 0% 40.86% 656ms 15.53% KSP_PCApply.lto_priv.18 2ms 0.047% 40.91% 436ms 10.32% MatMult 5ms 0.12% 41.03% 426ms 10.09% MatMult_SeqAIJ (partial-inline) 416ms 9.85% 50.88% 426ms 10.09% MatMult_SeqAIJ_Inode (inline) 349ms 8.26% 59.14% 386ms 9.14% __ieee754_exp_fma 0 0% 59.14% 325ms 7.69% KSPConvergedDefault 0 0% 59.14% 305ms 7.22% KSP_PCApply (partial-inline) 61ms 1.44% 60.58% 285ms 6.75% BidomainSolver::SetupLinearSystem 2ms 0.047% 60.63% 233ms 5.52% std::pow (inline) 17ms 0.4% 61.03% 231ms 5.47% __pow 26ms 0.62% 61.65% 214ms 5.07% __ieee754_pow_fma 86ms 2.04% 63.68% 179ms 4.24% CellLuoRudy1991FromCellML::VerifyStateVariables 111ms 2.63% 66.31% 111ms 2.63% log_inline (inline) 0 0% 66.31% 109ms 2.58% MatNullSpaceRemove 24ms 0.57% 66.88% 89ms 2.11% MPI_Wtime 0 0% 66.88% 85ms 2.01% VecDuplicate 9ms 0.21% 67.09% 71ms 1.68% PetscLogEventBeginDefault 71ms 1.68% 68.77% 71ms 1.68% ddot_ 67ms 1.59% 70.36% 70ms 1.66% exp_inline (inline) 0 0% 70.36% 65ms 1.54% VecMDot 3ms 0.071% 70.43% 65ms 1.54% VecMXDot_Private 4ms 0.095% 70.53% 65ms 1.54% __GI___clock_gettime 61ms 1.44% 71.97% 61ms 1.44% [[vdso]] 31ms 0.73% 72.70% 60ms 1.42% TimeStepper::TimeStepper 0 0% 72.70% 57ms 1.35% VecNorm 0 0% 72.70% 55ms 1.30% VecDot 14ms 0.33% 73.04% 54ms 1.28% PetscLogEventEndDefault 45ms 1.07% 74.10% 53ms 1.25% AbstractOneStepIvpOdeSolver::Solve 3ms 0.071% 74.17% 50ms 1.18% VecCopy 42ms 0.99% 75.17% 49ms 1.16% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 75.17% 44ms 1.04% AbstractBidomainSolver::FinaliseLinearSystem 6ms 0.14% 75.31% 44ms 1.04% VecMAXPY 20ms 0.47% 75.78% 44ms 1.04% top12 (inline) 10ms 0.24% 76.02% 43ms 1.02% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 76.02% 43ms 1.02% VecDot_Seq 0 0% 76.02% 43ms 1.02% VecDuplicate_Seq 42ms 0.99% 77.01% 43ms 1.02% VecMDot_Seq 0 0% 77.01% 43ms 1.02% VecNorm_Seq 0 0% 77.01% 43ms 1.02% VecXDot_Seq_Private.constprop.0 43ms 1.02% 78.03% 43ms 1.02% std::isinf (inline) 21ms 0.5% 78.53% 42ms 0.99% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 78.55% 42ms 0.99% VecDestroy 2ms 0.047% 78.60% 42ms 0.99% VecDuplicate_MPI 2ms 0.047% 78.65% 40ms 0.95% PetscMallocA 6ms 0.14% 78.79% 38ms 0.9% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 78.79% 38ms 0.9% PetscMallocAlign (partial-inline) 8ms 0.19% 78.98% 38ms 0.9% std::__cxx11::basic_string::basic_string 0 0% 78.98% 36ms 0.85% CxxTest::RealWorldDescription::setUp 0 0% 78.98% 36ms 0.85% PetscInitialize 0 0% 78.98% 36ms 0.85% PetscSetup::setUpWorld 0 0% 78.98% 36ms 0.85% PetscSetupUtils::CommonSetup 0 0% 78.98% 36ms 0.85% PetscSetupUtils::InitialisePetsc 0 0% 78.98% 35ms 0.83% PMPI_Init_thread 2ms 0.047% 79.02% 35ms 0.83% VecAXPY 34ms 0.8% 79.83% 35ms 0.83% __ieee754_log_fma 0 0% 79.83% 35ms 0.83% ompi_mpi_init 34ms 0.8% 80.63% 34ms 0.8% TimeStepper::CalculateNextTime 0 0% 80.63% 34ms 0.8% VecCreate 34ms 0.8% 81.44% 34ms 0.8% [libchaste_heart.so] 32ms 0.76% 82.20% 32ms 0.76% __memcpy_avx_unaligned_erms 0 0% 82.20% 30ms 0.71% VecNorm_MPI 1ms 0.024% 82.22% 30ms 0.71% VecNorm_MPI_Default.constprop.0 29ms 0.69% 82.91% 29ms 0.69% DistributedVector::Iterator::operator!= 0 0% 82.91% 28ms 0.66% PetscMemcpy (inline) 0 0% 82.91% 28ms 0.66% VecAXPY_Seq 28ms 0.66% 83.57% 28ms 0.66% asuint64 (inline) 27ms 0.64% 84.21% 27ms 0.64% daxpy_ 0 0% 84.21% 26ms 0.62% 24ms 0.57% 84.78% 26ms 0.62% AbstractParameterisedSystem::SetAnyVariable 17ms 0.4% 85.18% 25ms 0.59% AbstractParameterisedSystem::GetAnyVariable 0 0% 85.18% 24ms 0.57% PetscMemzero (inline) 1ms 0.024% 85.20% 24ms 0.57% VecCreate_MPI_Private 24ms 0.57% 85.77% 24ms 0.57% VecMAXPY_Seq 0 0% 85.77% 24ms 0.57% orte_init 23ms 0.54% 86.32% 23ms 0.54% __memset_avx2_unaligned_erms 2ms 0.047% 86.36% 23ms 0.54% __posix_memalign 0 0% 86.36% 22ms 0.52% VecCopy_Seq (partial-inline) 1ms 0.024% 86.39% 22ms 0.52% VecSetType 4ms 0.095% 86.48% 22ms 0.52% __GI___libc_malloc