File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3710ms, 87.01% of 4264ms total Dropped 456 nodes (cum <= 21.32ms) flat flat% sum% cum cum% 0 0% 0% 4253ms 99.74% __libc_start_call_main 0 0% 0% 4253ms 99.74% __libc_start_main_impl 0 0% 0% 4253ms 99.74% _start 0 0% 0% 4250ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4250ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4250ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4250ms 99.67% main 0 0% 0% 4208ms 98.69% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4208ms 98.69% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4208ms 98.69% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4200ms 98.50% AbstractCardiacProblem::Solve 3ms 0.07% 0.07% 4190ms 98.26% AbstractDynamicLinearPdeSolver::Solve 20ms 0.47% 0.54% 2391ms 56.07% AbstractCardiacTissue::SolveCellSystems 63ms 1.48% 2.02% 1390ms 32.60% AbstractCardiacCell::ComputeExceptVoltage 2ms 0.047% 2.06% 1368ms 32.08% LinearSystem::Solve 0 0% 2.06% 1305ms 30.61% KSPSolve 0 0% 2.06% 1305ms 30.61% KSPSolve_Private 1ms 0.023% 2.09% 1262ms 29.60% KSPSolve_SYMMLQ 20ms 0.47% 2.56% 1163ms 27.27% AbstractOneStepIvpOdeSolver::InternalSolve 76ms 1.78% 4.34% 901ms 21.13% EulerIvpOdeSolver::CalculateNextYValue 24ms 0.56% 4.90% 813ms 19.07% AbstractCardiacTissue::UpdateCaches (inline) 259ms 6.07% 10.98% 805ms 18.88% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.023% 11.00% 754ms 17.68% PCApply 1ms 0.023% 11.02% 749ms 17.57% PCApply_BJacobi_Singleblock 265ms 6.21% 17.24% 746ms 17.50% CellLuoRudy1991FromCellML::GetIIonic 357ms 8.37% 25.61% 709ms 16.63% __GI___exp 0 0% 25.61% 636ms 14.92% KSPSolve_PREONLY (partial-inline) 3ms 0.07% 25.68% 586ms 13.74% PCApply_ICC 3ms 0.07% 25.75% 583ms 13.67% MatSolve 573ms 13.44% 39.19% 576ms 13.51% MatSolve_SeqSBAIJ_1_NaturalOrdering 0 0% 39.19% 575ms 13.48% KSP_PCApply.lto_priv.18 5ms 0.12% 39.31% 459ms 10.76% MatMult 6ms 0.14% 39.45% 445ms 10.44% MatMult_SeqAIJ (partial-inline) 436ms 10.23% 49.67% 445ms 10.44% MatMult_SeqAIJ_Inode (inline) 70ms 1.64% 51.31% 358ms 8.40% BidomainSolver::SetupLinearSystem 267ms 6.26% 57.58% 327ms 7.67% __ieee754_exp_fma 1ms 0.023% 57.60% 255ms 5.98% std::pow (inline) 27ms 0.63% 58.23% 254ms 5.96% __pow 1ms 0.023% 58.26% 250ms 5.86% KSPConvergedDefault 0 0% 58.26% 248ms 5.82% KSP_PCApply (partial-inline) 22ms 0.52% 58.77% 227ms 5.32% __ieee754_pow_fma 116ms 2.72% 61.49% 180ms 4.22% TimeStepper::TimeStepper 55ms 1.29% 62.78% 122ms 2.86% CellLuoRudy1991FromCellML::VerifyStateVariables 2ms 0.047% 62.83% 119ms 2.79% MatNullSpaceRemove 118ms 2.77% 65.60% 118ms 2.77% log_inline (inline) 0 0% 65.60% 81ms 1.90% VecDuplicate 22ms 0.52% 66.11% 77ms 1.81% MPI_Wtime 75ms 1.76% 67.87% 76ms 1.78% exp_inline (inline) 14ms 0.33% 68.20% 72ms 1.69% PetscLogEventBeginDefault 69ms 1.62% 69.82% 69ms 1.62% TimeStepper::CalculateNextTime 2ms 0.047% 69.86% 64ms 1.50% AbstractBidomainSolver::FinaliseLinearSystem 0 0% 69.86% 64ms 1.50% VecMDot 2ms 0.047% 69.91% 64ms 1.50% VecMXDot_Private 22ms 0.52% 70.43% 62ms 1.45% AbstractBidomainSolver::CheckCompatibilityCondition 58ms 1.36% 71.79% 58ms 1.36% ddot_ 49ms 1.15% 72.94% 58ms 1.36% top12 (inline) 55ms 1.29% 74.23% 55ms 1.29% [[vdso]] 0 0% 74.23% 55ms 1.29% __GI___clock_gettime 4ms 0.094% 74.32% 53ms 1.24% VecMAXPY 13ms 0.3% 74.62% 51ms 1.20% AbstractCardiacCell::SetVoltage (partial-inline) 18ms 0.42% 75.05% 50ms 1.17% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 11ms 0.26% 75.30% 49ms 1.15% PetscLogEventEndDefault 4ms 0.094% 75.40% 49ms 1.15% VecCopy 3ms 0.07% 75.47% 47ms 1.10% VecDuplicate_MPI 1ms 0.023% 75.49% 47ms 1.10% VecNorm 46ms 1.08% 76.57% 46ms 1.08% [libchaste_heart.so] 3ms 0.07% 76.64% 45ms 1.06% PetscTimeSubtract (inline) 0 0% 76.64% 45ms 1.06% VecDot 44ms 1.03% 77.67% 45ms 1.06% VecMDot_Seq 3ms 0.07% 77.74% 43ms 1.01% VecAXPY 1ms 0.023% 77.77% 43ms 1.01% VecNorm_Seq 0 0% 77.77% 41ms 0.96% VecDot_Seq 0 0% 77.77% 41ms 0.96% VecXDot_Seq_Private.constprop.0 34ms 0.8% 78.56% 38ms 0.89% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 25ms 0.59% 79.15% 38ms 0.89% AbstractOneStepIvpOdeSolver::Solve 0 0% 79.15% 38ms 0.89% CxxTest::RealWorldDescription::setUp 0 0% 79.15% 38ms 0.89% KSP_RemoveNullSpace (inline) 0 0% 79.15% 38ms 0.89% PetscInitialize 0 0% 79.15% 38ms 0.89% PetscSetup::setUpWorld 0 0% 79.15% 38ms 0.89% PetscSetupUtils::CommonSetup 0 0% 79.15% 38ms 0.89% PetscSetupUtils::InitialisePetsc 0 0% 79.15% 38ms 0.89% VecNorm_MPI 0 0% 79.15% 38ms 0.89% VecNorm_MPI_Default.constprop.0 38ms 0.89% 80.04% 38ms 0.89% __memcpy_avx_unaligned_erms 0 0% 80.04% 37ms 0.87% PMPI_Init_thread 0 0% 80.04% 37ms 0.87% ompi_mpi_init 0 0% 80.04% 34ms 0.8% 1ms 0.023% 80.07% 34ms 0.8% VecDuplicate_Seq 33ms 0.77% 80.84% 34ms 0.8% __ieee754_log_fma 7ms 0.16% 81.00% 32ms 0.75% PetscMallocA 2ms 0.047% 81.05% 32ms 0.75% VecDestroy 25ms 0.59% 81.64% 31ms 0.73% AbstractParameterisedSystem::SetAnyVariable 0 0% 81.64% 30ms 0.7% PetscMemcpy (inline) 2ms 0.047% 81.68% 30ms 0.7% VecCreate 28ms 0.66% 82.34% 28ms 0.66% DistributedVector::Iterator::operator!= 19ms 0.45% 82.79% 27ms 0.63% AbstractParameterisedSystem::GetAnyVariable 1ms 0.023% 82.81% 27ms 0.63% VecCreate_MPI_Private 26ms 0.61% 83.42% 27ms 0.63% VecMAXPY_Seq 2ms 0.047% 83.47% 25ms 0.59% PetscMallocAlign 1ms 0.023% 83.49% 25ms 0.59% VecCopy_Seq (partial-inline) 25ms 0.59% 84.08% 25ms 0.59% [libm.so.6] 15ms 0.35% 84.43% 24ms 0.56% AbstractCardiacCell::GetVoltage (partial-inline) 0 0% 84.43% 24ms 0.56% AbstractFeVolumeIntegralAssembler::DoAssemble 24ms 0.56% 84.99% 24ms 0.56% DistributedVector::Stripe::operator[] (inline) 24ms 0.56% 85.55% 24ms 0.56% asuint64 (inline) 24ms 0.56% 86.12% 24ms 0.56% dasum_ 23ms 0.54% 86.66% 23ms 0.54% RegularStimulus::GetStimulus 2ms 0.047% 86.70% 23ms 0.54% VecAXPY_Seq 13ms 0.3% 87.01% 22ms 0.52% TimeStepper::AdvanceOneTimeStep 0 0% 87.01% 22ms 0.52% orte_init