File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3699ms, 86.36% of 4283ms total Dropped 496 nodes (cum <= 21.41ms) flat flat% sum% cum cum% 0 0% 0% 4272ms 99.74% __libc_start_call_main 0 0% 0% 4272ms 99.74% __libc_start_main_impl 0 0% 0% 4272ms 99.74% _start 0 0% 0% 4268ms 99.65% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4268ms 99.65% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4268ms 99.65% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4268ms 99.65% main 0 0% 0% 4218ms 98.48% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4218ms 98.48% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4218ms 98.48% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 1ms 0.023% 0.023% 4210ms 98.30% AbstractCardiacProblem::Solve 2ms 0.047% 0.07% 4199ms 98.04% AbstractDynamicLinearPdeSolver::Solve 13ms 0.3% 0.37% 2150ms 50.20% AbstractCardiacTissue::SolveCellSystems 3ms 0.07% 0.44% 1666ms 38.90% LinearSystem::Solve 0 0% 0.44% 1603ms 37.43% KSPSolve 7ms 0.16% 0.61% 1603ms 37.43% KSPSolve_Private 3ms 0.07% 0.68% 1542ms 36.00% KSPSolve_SYMMLQ 27ms 0.63% 1.31% 1235ms 28.83% AbstractCardiacCell::ComputeExceptVoltage 27ms 0.63% 1.94% 1055ms 24.63% AbstractOneStepIvpOdeSolver::InternalSolve 1ms 0.023% 1.96% 1021ms 23.84% PCApply 2ms 0.047% 2.01% 1012ms 23.63% PCApply_BJacobi_Singleblock 48ms 1.12% 3.13% 893ms 20.85% EulerIvpOdeSolver::CalculateNextYValue 0 0% 3.13% 872ms 20.36% KSPSolve_PREONLY (partial-inline) 213ms 4.97% 8.10% 831ms 19.40% CellLuoRudy1991FromCellML::EvaluateYDerivatives 2ms 0.047% 8.15% 824ms 19.24% MatSolve 0 0% 8.15% 824ms 19.24% PCApply_ICC 811ms 18.94% 27.08% 816ms 19.05% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 27.08% 747ms 17.44% KSP_PCApply.lto_priv.18 345ms 8.06% 35.14% 746ms 17.42% __GI___exp 27ms 0.63% 35.77% 743ms 17.35% AbstractCardiacTissue::UpdateCaches (inline) 261ms 6.09% 41.86% 683ms 15.95% CellLuoRudy1991FromCellML::GetIIonic 1ms 0.023% 41.89% 430ms 10.04% MatMult 9ms 0.21% 42.10% 423ms 9.88% MatMult_SeqAIJ (partial-inline) 410ms 9.57% 51.67% 423ms 9.88% MatMult_SeqAIJ_Inode (inline) 322ms 7.52% 59.19% 385ms 8.99% __ieee754_exp_fma 0 0% 59.19% 356ms 8.31% KSP_PCApply (partial-inline) 1ms 0.023% 59.21% 353ms 8.24% KSPConvergedDefault 66ms 1.54% 60.75% 323ms 7.54% BidomainSolver::SetupLinearSystem 0 0% 60.75% 234ms 5.46% std::pow (inline) 20ms 0.47% 61.22% 233ms 5.44% __pow 16ms 0.37% 61.59% 213ms 4.97% __ieee754_pow_fma 2ms 0.047% 61.64% 131ms 3.06% MatNullSpaceRemove 71ms 1.66% 63.30% 114ms 2.66% CellLuoRudy1991FromCellML::VerifyStateVariables 110ms 2.57% 65.87% 110ms 2.57% log_inline (inline) 31ms 0.72% 66.59% 92ms 2.15% MPI_Wtime 0 0% 66.59% 90ms 2.10% VecDuplicate 76ms 1.77% 68.36% 78ms 1.82% exp_inline (inline) 0 0% 68.36% 74ms 1.73% VecMDot 5ms 0.12% 68.48% 74ms 1.73% VecMXDot_Private 12ms 0.28% 68.76% 73ms 1.70% PetscLogEventBeginDefault 14ms 0.33% 69.09% 62ms 1.45% PetscLogEventEndDefault 61ms 1.42% 70.51% 61ms 1.42% [[vdso]] 0 0% 70.51% 61ms 1.42% __GI___clock_gettime 7ms 0.16% 70.67% 57ms 1.33% VecCopy 57ms 1.33% 72.01% 57ms 1.33% ddot_ 3ms 0.07% 72.08% 56ms 1.31% VecDuplicate_MPI 2ms 0.047% 72.12% 55ms 1.28% VecMAXPY 44ms 1.03% 73.15% 55ms 1.28% top12 (inline) 21ms 0.49% 73.64% 54ms 1.26% TimeStepper::TimeStepper 52ms 1.21% 74.85% 52ms 1.21% VecMDot_Seq 12ms 0.28% 75.13% 51ms 1.19% AbstractBidomainSolver::CheckCompatibilityCondition 0 0% 75.13% 51ms 1.19% AbstractBidomainSolver::FinaliseLinearSystem 7ms 0.16% 75.30% 50ms 1.17% AbstractCardiacCell::SetVoltage (partial-inline) 1ms 0.023% 75.32% 50ms 1.17% VecNorm 5ms 0.12% 75.44% 47ms 1.10% PetscMallocA 0 0% 75.44% 47ms 1.10% PetscTimeSubtract (inline) 1ms 0.023% 75.46% 47ms 1.10% VecDestroy 47ms 1.10% 76.56% 47ms 1.10% __memcpy_avx_unaligned_erms 0 0% 76.56% 45ms 1.05% CxxTest::RealWorldDescription::setUp 0 0% 76.56% 45ms 1.05% PetscInitialize 0 0% 76.56% 45ms 1.05% PetscSetup::setUpWorld 0 0% 76.56% 45ms 1.05% PetscSetupUtils::CommonSetup 0 0% 76.56% 45ms 1.05% PetscSetupUtils::InitialisePetsc 1ms 0.023% 76.58% 45ms 1.05% VecDot 0 0% 76.58% 44ms 1.03% PMPI_Init_thread 0 0% 76.58% 44ms 1.03% ompi_mpi_init 3ms 0.07% 76.65% 42ms 0.98% PetscMallocAlign (partial-inline) 1ms 0.023% 76.68% 42ms 0.98% VecAXPY 41ms 0.96% 77.63% 41ms 0.96% TimeStepper::CalculateNextTime 0 0% 77.63% 41ms 0.96% VecNorm_Seq 28ms 0.65% 78.29% 39ms 0.91% AbstractOneStepIvpOdeSolver::Solve 2ms 0.047% 78.33% 38ms 0.89% 17ms 0.4% 78.73% 38ms 0.89% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 0 0% 78.73% 38ms 0.89% VecDot_Seq 0 0% 78.73% 38ms 0.89% VecXDot_Seq_Private.constprop.0 33ms 0.77% 79.50% 36ms 0.84% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 36ms 0.84% 80.34% 36ms 0.84% [libchaste_heart.so] 36ms 0.84% 81.18% 36ms 0.84% __ieee754_log_fma 1ms 0.023% 81.20% 35ms 0.82% VecCreate 28ms 0.65% 81.86% 34ms 0.79% AbstractParameterisedSystem::SetAnyVariable 3ms 0.07% 81.93% 34ms 0.79% VecCreate_MPI_Private 0 0% 81.93% 34ms 0.79% VecDuplicate_Seq 33ms 0.77% 82.70% 33ms 0.77% VecMAXPY_Seq 32ms 0.75% 83.45% 32ms 0.75% DistributedVector::Iterator::operator!= 0 0% 83.45% 32ms 0.75% PetscMemcpy (inline) 0 0% 83.45% 31ms 0.72% orte_init 0 0% 83.45% 30ms 0.7% VecNorm_MPI 1ms 0.023% 83.47% 30ms 0.7% VecNorm_MPI_Default.constprop.0 30ms 0.7% 84.17% 30ms 0.7% asuint64 (inline) 0 0% 84.17% 29ms 0.68% PetscMemzero (inline) 3ms 0.07% 84.24% 28ms 0.65% VecCopy_Seq (partial-inline) 28ms 0.65% 84.89% 28ms 0.65% __memset_avx2_unaligned_erms 26ms 0.61% 85.50% 26ms 0.61% DistributedVector::Stripe::operator[] (inline) 0 0% 85.50% 26ms 0.61% VecAXPY_Seq 10ms 0.23% 85.73% 24ms 0.56% TimeStepper::AdvanceOneTimeStep 24ms 0.56% 86.29% 24ms 0.56% daxpy_ 0 0% 86.29% 23ms 0.54% std::vector::_M_assign_aux (inline) 0 0% 86.29% 23ms 0.54% std::vector::assign (inline) 0 0% 86.29% 22ms 0.51% AbstractFeVolumeIntegralAssembler::DoAssemble 2ms 0.047% 86.34% 22ms 0.51% VecSet 1ms 0.023% 86.36% 22ms 0.51% __posix_memalign