File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3624ms, 87.45% of 4144ms total Dropped 473 nodes (cum <= 20.72ms) flat flat% sum% cum cum% 0 0% 0% 4136ms 99.81% __libc_start_call_main 0 0% 0% 4136ms 99.81% __libc_start_main_impl 0 0% 0% 4136ms 99.81% _start 0 0% 0% 4133ms 99.73% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4133ms 99.73% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4133ms 99.73% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4133ms 99.73% main 0 0% 0% 4099ms 98.91% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4099ms 98.91% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4099ms 98.91% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4091ms 98.72% AbstractCardiacProblem::Solve 2ms 0.048% 0.048% 4081ms 98.48% AbstractDynamicLinearPdeSolver::Solve 17ms 0.41% 0.46% 2500ms 60.33% AbstractCardiacTissue::SolveCellSystems 40ms 0.97% 1.42% 1473ms 35.55% AbstractCardiacCell::ComputeExceptVoltage 1ms 0.024% 1.45% 1316ms 31.76% LinearSystem::Solve 0 0% 1.45% 1272ms 30.69% KSPSolve 4ms 0.097% 1.54% 1272ms 30.69% KSPSolve_Private 40ms 0.97% 2.51% 1244ms 30.02% AbstractOneStepIvpOdeSolver::InternalSolve 2ms 0.048% 2.56% 1238ms 29.87% KSPSolve_SYMMLQ 65ms 1.57% 4.13% 1025ms 24.73% EulerIvpOdeSolver::CalculateNextYValue 266ms 6.42% 10.55% 947ms 22.85% CellLuoRudy1991FromCellML::EvaluateYDerivatives 435ms 10.50% 21.04% 889ms 21.45% __GI___exp 23ms 0.56% 21.60% 789ms 19.04% AbstractCardiacTissue::UpdateCaches (inline) 2ms 0.048% 21.65% 765ms 18.46% PCApply 2ms 0.048% 21.69% 753ms 18.17% PCApply_BJacobi_Singleblock 248ms 5.98% 27.68% 743ms 17.93% CellLuoRudy1991FromCellML::GetIIonic 0 0% 27.68% 632ms 15.25% KSPSolve_PREONLY (partial-inline) 0 0% 27.68% 596ms 14.38% MatSolve 0 0% 27.68% 596ms 14.38% PCApply_ICC 589ms 14.21% 41.89% 593ms 14.31% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 41.89% 572ms 13.80% KSP_PCApply.lto_priv.18 408ms 9.85% 51.74% 438ms 10.57% __ieee754_exp_fma 6ms 0.14% 51.88% 349ms 8.42% MatMult 2ms 0.048% 51.93% 337ms 8.13% MatMult_SeqAIJ 332ms 8.01% 59.94% 336ms 8.11% MatMult_SeqAIJ_Inode (inline) 1ms 0.024% 59.97% 259ms 6.25% KSPConvergedDefault 0 0% 59.97% 239ms 5.77% KSP_PCApply (partial-inline) 1ms 0.024% 59.99% 237ms 5.72% std::pow (inline) 13ms 0.31% 60.30% 236ms 5.69% __pow 53ms 1.28% 61.58% 230ms 5.55% BidomainSolver::SetupLinearSystem 26ms 0.63% 62.21% 223ms 5.38% __ieee754_pow_fma 74ms 1.79% 64.00% 167ms 4.03% CellLuoRudy1991FromCellML::VerifyStateVariables 112ms 2.70% 66.70% 112ms 2.70% log_inline (inline) 0 0% 66.70% 95ms 2.29% MatNullSpaceRemove 1ms 0.024% 66.72% 89ms 2.15% VecDuplicate 81ms 1.95% 68.68% 81ms 1.95% exp_inline (inline) 20ms 0.48% 69.16% 69ms 1.67% MPI_Wtime 36ms 0.87% 70.03% 66ms 1.59% TimeStepper::TimeStepper 11ms 0.27% 70.29% 63ms 1.52% PetscLogEventBeginDefault 60ms 1.45% 71.74% 60ms 1.45% ddot_ 14ms 0.34% 72.08% 57ms 1.38% AbstractCardiacCell::SetVoltage (partial-inline) 28ms 0.68% 72.76% 54ms 1.30% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 1ms 0.024% 72.78% 54ms 1.30% VecMDot 1ms 0.024% 72.80% 53ms 1.28% VecDuplicate_MPI 7ms 0.17% 72.97% 53ms 1.28% VecMXDot_Private 49ms 1.18% 74.16% 49ms 1.18% [[vdso]] 0 0% 74.16% 49ms 1.18% __GI___clock_gettime 1ms 0.024% 74.18% 47ms 1.13% VecDot 2ms 0.048% 74.23% 46ms 1.11% VecAXPY 35ms 0.84% 75.07% 45ms 1.09% AbstractOneStepIvpOdeSolver::Solve 6ms 0.14% 75.22% 45ms 1.09% VecCopy 9ms 0.22% 75.43% 45ms 1.09% std::__cxx11::basic_string::basic_string 1ms 0.024% 75.46% 43ms 1.04% VecDestroy 34ms 0.82% 76.28% 42ms 1.01% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 9ms 0.22% 76.50% 42ms 1.01% PetscLogEventEndDefault 4ms 0.097% 76.59% 41ms 0.99% VecMAXPY 0 0% 76.59% 40ms 0.97% VecDot_Seq 0 0% 76.59% 40ms 0.97% VecXDot_Seq_Private.constprop.0 38ms 0.92% 77.51% 38ms 0.92% TimeStepper::CalculateNextTime 2ms 0.048% 77.56% 38ms 0.92% VecNorm 38ms 0.92% 78.47% 38ms 0.92% __memcpy_avx_unaligned_erms 37ms 0.89% 79.37% 37ms 0.89% VecMDot_Seq 32ms 0.77% 80.14% 36ms 0.87% AbstractParameterisedSystem::SetAnyVariable 1ms 0.024% 80.16% 36ms 0.87% VecCreate 2ms 0.048% 80.21% 35ms 0.84% VecDuplicate_Seq 34ms 0.82% 81.03% 35ms 0.84% __ieee754_log_fma 27ms 0.65% 81.68% 34ms 0.82% AbstractParameterisedSystem::GetAnyVariable 33ms 0.8% 82.48% 33ms 0.8% __strlen_avx2 0 0% 82.48% 32ms 0.77% std::char_traits::length (inline) 5ms 0.12% 82.60% 31ms 0.75% PetscMallocA 0 0% 82.60% 30ms 0.72% CxxTest::RealWorldDescription::setUp 0 0% 82.60% 30ms 0.72% PMPI_Init_thread 0 0% 82.60% 30ms 0.72% PetscInitialize 0 0% 82.60% 30ms 0.72% PetscSetup::setUpWorld 0 0% 82.60% 30ms 0.72% PetscSetupUtils::CommonSetup 0 0% 82.60% 30ms 0.72% PetscSetupUtils::InitialisePetsc 0 0% 82.60% 30ms 0.72% VecAXPY_Seq 0 0% 82.60% 30ms 0.72% VecNorm_Seq 0 0% 82.60% 30ms 0.72% ompi_mpi_init 0 0% 82.60% 29ms 0.7% AbstractBidomainSolver::FinaliseLinearSystem 29ms 0.7% 83.30% 29ms 0.7% [libchaste_heart.so] 29ms 0.7% 84.00% 29ms 0.7% std::isinf (inline) 3ms 0.072% 84.07% 29ms 0.7% std::vector::_M_assign_aux (inline) 0 0% 84.07% 29ms 0.7% std::vector::assign (inline) 15ms 0.36% 84.44% 28ms 0.68% AbstractBidomainSolver::CheckCompatibilityCondition 14ms 0.34% 84.77% 28ms 0.68% TimeStepper::AdvanceOneTimeStep 28ms 0.68% 85.45% 28ms 0.68% daxpy_ 15ms 0.36% 85.81% 28ms 0.68% top12 (inline) 1ms 0.024% 85.83% 27ms 0.65% 1ms 0.024% 85.86% 27ms 0.65% VecCreate_MPI_Private 1ms 0.024% 85.88% 26ms 0.63% PetscMallocAlign 21ms 0.51% 86.39% 26ms 0.63% VecMAXPY_Seq 10ms 0.24% 86.63% 25ms 0.6% AbstractCardiacCell::GetVoltage (partial-inline) 2ms 0.048% 86.68% 22ms 0.53% PetscHeaderDestroy_Private 22ms 0.53% 87.21% 22ms 0.53% TimeStepper::GetNextTimeStep 10ms 0.24% 87.45% 22ms 0.53% __GI___libc_free 0 0% 87.45% 21ms 0.51% PetscMemcpy (inline) 0 0% 87.45% 21ms 0.51% orte_init