File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3683ms, 86.25% of 4270ms total Dropped 558 nodes (cum <= 21.35ms) flat flat% sum% cum cum% 0 0% 0% 4260ms 99.77% __libc_start_call_main 0 0% 0% 4260ms 99.77% __libc_start_main_impl 0 0% 0% 4260ms 99.77% _start 0 0% 0% 4256ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4256ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4256ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4256ms 99.67% main 0 0% 0% 4205ms 98.48% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4205ms 98.48% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4205ms 98.48% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.023% 0.023% 4190ms 98.13% AbstractCardiacProblem::Solve 3ms 0.07% 0.094% 4170ms 97.66% AbstractDynamicLinearPdeSolver::Solve 17ms 0.4% 0.49% 2236ms 52.37% AbstractCardiacTissue::SolveCellSystems 1ms 0.023% 0.52% 1581ms 37.03% LinearSystem::Solve 0 0% 0.52% 1522ms 35.64% KSPSolve 6ms 0.14% 0.66% 1522ms 35.64% KSPSolve_Private 5ms 0.12% 0.77% 1472ms 34.47% KSPSolve_SYMMLQ 26ms 0.61% 1.38% 1282ms 30.02% AbstractCardiacCell::ComputeExceptVoltage 33ms 0.77% 2.15% 1099ms 25.74% AbstractOneStepIvpOdeSolver::InternalSolve 62ms 1.45% 3.61% 912ms 21.36% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.023% 3.63% 885ms 20.73% PCApply 2ms 0.047% 3.68% 875ms 20.49% PCApply_BJacobi_Singleblock 217ms 5.08% 8.76% 841ms 19.70% CellLuoRudy1991FromCellML::EvaluateYDerivatives 24ms 0.56% 9.32% 788ms 18.45% AbstractCardiacTissue::UpdateCaches (inline) 381ms 8.92% 18.24% 771ms 18.06% __GI___exp 0 0% 18.24% 757ms 17.73% KSPSolve_PREONLY (partial-inline) 247ms 5.78% 24.03% 708ms 16.58% CellLuoRudy1991FromCellML::GetIIonic 4ms 0.094% 24.12% 707ms 16.56% MatSolve 0 0% 24.12% 707ms 16.56% PCApply_ICC 693ms 16.23% 40.35% 699ms 16.37% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 40.35% 643ms 15.06% KSP_PCApply.lto_priv.18 2ms 0.047% 40.40% 449ms 10.52% MatMult 16ms 0.37% 40.77% 441ms 10.33% MatMult_SeqAIJ (partial-inline) 424ms 9.93% 50.70% 440ms 10.30% MatMult_SeqAIJ_Inode (inline) 299ms 7.00% 57.70% 365ms 8.55% __ieee754_exp_fma 1ms 0.023% 57.73% 349ms 8.17% KSPConvergedDefault 0 0% 57.73% 319ms 7.47% KSP_PCApply (partial-inline) 68ms 1.59% 59.32% 291ms 6.81% BidomainSolver::SetupLinearSystem 1ms 0.023% 59.34% 253ms 5.93% std::pow (inline) 24ms 0.56% 59.91% 252ms 5.90% __pow 23ms 0.54% 60.44% 227ms 5.32% __ieee754_pow_fma 1ms 0.023% 60.47% 121ms 2.83% MatNullSpaceRemove 104ms 2.44% 62.90% 104ms 2.44% log_inline (inline) 53ms 1.24% 64.15% 103ms 2.41% CellLuoRudy1991FromCellML::VerifyStateVariables 0 0% 64.15% 90ms 2.11% VecDuplicate 85ms 1.99% 66.14% 85ms 1.99% exp_inline (inline) 77ms 1.80% 67.94% 77ms 1.80% ddot_ 21ms 0.49% 68.43% 76ms 1.78% MPI_Wtime 0 0% 68.43% 76ms 1.78% VecMDot 4ms 0.094% 68.52% 76ms 1.78% VecMXDot_Private 32ms 0.75% 69.27% 67ms 1.57% TimeStepper::TimeStepper 46ms 1.08% 70.35% 61ms 1.43% top12 (inline) 12ms 0.28% 70.63% 60ms 1.41% PetscLogEventEndDefault 5ms 0.12% 70.75% 57ms 1.33% VecCopy 0 0% 70.75% 56ms 1.31% VecNorm 2ms 0.047% 70.80% 55ms 1.29% VecDestroy 0 0% 70.80% 55ms 1.29% VecNorm_Seq 1ms 0.023% 70.82% 55ms 1.29% __GI___clock_gettime 54ms 1.26% 72.08% 54ms 1.26% VecMDot_Seq 54ms 1.26% 73.35% 54ms 1.26% [[vdso]] 2ms 0.047% 73.40% 53ms 1.24% VecDuplicate_MPI 0 0% 73.40% 52ms 1.22% VecDot 1ms 0.023% 73.42% 51ms 1.19% AbstractBidomainSolver::FinaliseLinearSystem 15ms 0.35% 73.77% 50ms 1.17% AbstractBidomainSolver::CheckCompatibilityCondition 47ms 1.10% 74.87% 47ms 1.10% [libchaste_heart.so] 12ms 0.28% 75.15% 46ms 1.08% AbstractCardiacCell::SetVoltage (partial-inline) 0 0% 75.15% 46ms 1.08% CxxTest::RealWorldDescription::setUp 0 0% 75.15% 46ms 1.08% PetscInitialize 0 0% 75.15% 46ms 1.08% PetscSetup::setUpWorld 0 0% 75.15% 46ms 1.08% PetscSetupUtils::CommonSetup 0 0% 75.15% 46ms 1.08% PetscSetupUtils::InitialisePetsc 3ms 0.07% 75.22% 46ms 1.08% VecAXPY 0 0% 75.22% 46ms 1.08% VecDot_Seq 0 0% 75.22% 46ms 1.08% VecXDot_Seq_Private.constprop.0 46ms 1.08% 76.30% 46ms 1.08% __memcpy_avx_unaligned_erms 27ms 0.63% 76.93% 45ms 1.05% AbstractOneStepIvpOdeSolver::Solve 0 0% 76.93% 45ms 1.05% PMPI_Init_thread 0 0% 76.93% 45ms 1.05% ompi_mpi_init 6ms 0.14% 77.07% 44ms 1.03% PetscLogEventBeginDefault 1ms 0.023% 77.10% 44ms 1.03% VecMAXPY 0 0% 77.10% 44ms 1.03% VecNorm_MPI 0 0% 77.10% 44ms 1.03% VecNorm_MPI_Default.constprop.0 9ms 0.21% 77.31% 42ms 0.98% PetscMallocA 21ms 0.49% 77.80% 38ms 0.89% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 38ms 0.89% 78.69% 38ms 0.89% TimeStepper::CalculateNextTime 2ms 0.047% 78.74% 38ms 0.89% VecCreate 2ms 0.047% 78.78% 37ms 0.87% 0 0% 78.78% 37ms 0.87% PetscMemcpy (inline) 0 0% 78.78% 37ms 0.87% VecDuplicate_Seq 37ms 0.87% 79.65% 37ms 0.87% asuint64 (inline) 33ms 0.77% 80.42% 35ms 0.82% __ieee754_log_fma 28ms 0.66% 81.08% 33ms 0.77% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 1ms 0.023% 81.10% 33ms 0.77% PetscMallocAlign 0 0% 81.10% 33ms 0.77% VecCopy_Seq (partial-inline) 30ms 0.7% 81.80% 32ms 0.75% VecMAXPY_Seq 23ms 0.54% 82.34% 29ms 0.68% AbstractParameterisedSystem::SetAnyVariable 28ms 0.66% 83.00% 28ms 0.66% DistributedVector::Iterator::operator!= 1ms 0.023% 83.02% 28ms 0.66% VecCreate_MPI_Private 6ms 0.14% 83.16% 26ms 0.61% PetscHeaderDestroy_Private 26ms 0.61% 83.77% 26ms 0.61% [libm.so.6] 0 0% 83.77% 26ms 0.61% orte_init 13ms 0.3% 84.07% 25ms 0.59% TimeStepper::AdvanceOneTimeStep 18ms 0.42% 84.50% 23ms 0.54% AbstractParameterisedSystem::GetAnyVariable 7ms 0.16% 84.66% 23ms 0.54% __GI___libc_malloc 23ms 0.54% 85.20% 23ms 0.54% dasum_ 22ms 0.52% 85.71% 22ms 0.52% TimeStepper::GetNextTimeStep 1ms 0.023% 85.74% 22ms 0.52% VecAXPY_Seq 0 0% 85.74% 22ms 0.52% __GI__dl_catch_exception 0 0% 85.74% 22ms 0.52% _dl_catch_error 0 0% 85.74% 22ms 0.52% _dlerror_run 22ms 0.52% 86.25% 22ms 0.52% std::isinf (inline)