File: Test3dBidomainProblemWithMetisForEfficiency Type: cpu Showing nodes accounting for 3675ms, 87.65% of 4193ms total Dropped 479 nodes (cum <= 20.96ms) flat flat% sum% cum cum% 0 0% 0% 4182ms 99.74% __libc_start_call_main 0 0% 0% 4182ms 99.74% __libc_start_main_impl 0 0% 0% 4182ms 99.74% _start 0 0% 0% 4179ms 99.67% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4179ms 99.67% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4179ms 99.67% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4179ms 99.67% main 0 0% 0% 4137ms 98.66% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4137ms 98.66% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4137ms 98.66% Test3dBidomainProblemWithMetisForEfficiency::TestBidomain3d 0 0% 0% 4127ms 98.43% AbstractCardiacProblem::Solve 2ms 0.048% 0.048% 4112ms 98.07% AbstractDynamicLinearPdeSolver::Solve 17ms 0.41% 0.45% 2297ms 54.78% AbstractCardiacTissue::SolveCellSystems 1ms 0.024% 0.48% 1324ms 31.58% LinearSystem::Solve 33ms 0.79% 1.26% 1310ms 31.24% AbstractCardiacCell::ComputeExceptVoltage 0 0% 1.26% 1265ms 30.17% KSPSolve 5ms 0.12% 1.38% 1265ms 30.17% KSPSolve_Private 2ms 0.048% 1.43% 1196ms 28.52% KSPSolve_SYMMLQ 24ms 0.57% 2.00% 1130ms 26.95% AbstractOneStepIvpOdeSolver::InternalSolve 71ms 1.69% 3.70% 970ms 23.13% EulerIvpOdeSolver::CalculateNextYValue 249ms 5.94% 9.64% 889ms 21.20% CellLuoRudy1991FromCellML::EvaluateYDerivatives 22ms 0.52% 10.16% 816ms 19.46% AbstractCardiacTissue::UpdateCaches (inline) 379ms 9.04% 19.20% 799ms 19.06% __GI___exp 244ms 5.82% 25.02% 747ms 17.82% CellLuoRudy1991FromCellML::GetIIonic 4ms 0.095% 25.11% 674ms 16.07% PCApply 0 0% 25.11% 666ms 15.88% PCApply_BJacobi_Singleblock 1ms 0.024% 25.14% 596ms 14.21% MatMult 9ms 0.21% 25.35% 583ms 13.90% MatMult_SeqAIJ (partial-inline) 573ms 13.67% 39.02% 583ms 13.90% MatMult_SeqAIJ_Inode (inline) 0 0% 39.02% 554ms 13.21% KSPSolve_PREONLY (partial-inline) 3ms 0.072% 39.09% 523ms 12.47% MatSolve 0 0% 39.09% 523ms 12.47% PCApply_ICC 1ms 0.024% 39.11% 517ms 12.33% KSP_PCApply.lto_priv.18 507ms 12.09% 51.20% 514ms 12.26% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 69ms 1.65% 52.85% 424ms 10.11% BidomainSolver::SetupLinearSystem 340ms 8.11% 60.96% 401ms 9.56% __ieee754_exp_fma 1ms 0.024% 60.98% 266ms 6.34% std::pow (inline) 29ms 0.69% 61.67% 265ms 6.32% __pow 17ms 0.41% 62.08% 235ms 5.60% __ieee754_pow_fma 1ms 0.024% 62.10% 219ms 5.22% KSPConvergedDefault 0 0% 62.10% 201ms 4.79% KSP_PCApply (partial-inline) 117ms 2.79% 64.89% 117ms 2.79% log_inline (inline) 58ms 1.38% 66.28% 109ms 2.60% CellLuoRudy1991FromCellML::VerifyStateVariables 91ms 2.17% 68.45% 93ms 2.22% exp_inline (inline) 0 0% 68.45% 90ms 2.15% MatNullSpaceRemove 0 0% 68.45% 88ms 2.10% VecDuplicate 19ms 0.45% 68.90% 72ms 1.72% MPI_Wtime 8ms 0.19% 69.09% 66ms 1.57% VecCopy 23ms 0.55% 69.64% 61ms 1.45% TimeStepper::TimeStepper 0 0% 69.64% 57ms 1.36% AbstractBidomainSolver::FinaliseLinearSystem 4ms 0.095% 69.74% 57ms 1.36% VecDuplicate_MPI 20ms 0.48% 70.21% 56ms 1.34% AbstractBidomainSolver::CheckCompatibilityCondition 8ms 0.19% 70.40% 54ms 1.29% PetscLogEventBeginDefault 0 0% 70.40% 54ms 1.29% VecMDot 1ms 0.024% 70.43% 54ms 1.29% VecMXDot_Private 53ms 1.26% 71.69% 53ms 1.26% [[vdso]] 0 0% 71.69% 53ms 1.26% __GI___clock_gettime 53ms 1.26% 72.95% 53ms 1.26% ddot_ 37ms 0.88% 73.84% 49ms 1.17% top12 (inline) 48ms 1.14% 74.98% 48ms 1.14% [libchaste_heart.so] 10ms 0.24% 75.22% 47ms 1.12% AbstractCardiacCell::SetVoltage (partial-inline) 13ms 0.31% 75.53% 47ms 1.12% PetscLogEventEndDefault 36ms 0.86% 76.39% 45ms 1.07% AbstractOneStepIvpOdeSolver::Solve 44ms 1.05% 77.44% 45ms 1.07% __ieee754_log_fma 45ms 1.07% 78.51% 45ms 1.07% __memcpy_avx_unaligned_erms 39ms 0.93% 79.44% 42ms 1.00% VecMDot_Seq 0 0% 79.44% 42ms 1.00% VecNorm 8ms 0.19% 79.63% 40ms 0.95% PetscMallocA 0 0% 79.63% 39ms 0.93% PetscMemcpy (inline) 0 0% 79.63% 38ms 0.91% CxxTest::RealWorldDescription::setUp 0 0% 79.63% 38ms 0.91% PMPI_Init_thread 0 0% 79.63% 38ms 0.91% PetscInitialize 0 0% 79.63% 38ms 0.91% PetscSetup::setUpWorld 0 0% 79.63% 38ms 0.91% PetscSetupUtils::CommonSetup 0 0% 79.63% 38ms 0.91% PetscSetupUtils::InitialisePetsc 0 0% 79.63% 38ms 0.91% ompi_mpi_init 1ms 0.024% 79.66% 37ms 0.88% VecDot 1ms 0.024% 79.68% 36ms 0.86% 16ms 0.38% 80.06% 36ms 0.86% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 30ms 0.72% 80.78% 36ms 0.86% AbstractParameterisedSystem::SetAnyVariable 36ms 0.86% 81.64% 36ms 0.86% TimeStepper::CalculateNextTime 6ms 0.14% 81.78% 36ms 0.86% VecMAXPY 0 0% 81.78% 35ms 0.83% VecNorm_Seq 35ms 0.83% 82.61% 35ms 0.83% asuint64 (inline) 1ms 0.024% 82.64% 33ms 0.79% VecCreate 0 0% 82.64% 33ms 0.79% VecDot_Seq 0 0% 82.64% 33ms 0.79% VecXDot_Seq_Private.constprop.0 1ms 0.024% 82.66% 32ms 0.76% PetscMallocAlign 3ms 0.072% 82.73% 32ms 0.76% VecDestroy 0 0% 82.73% 31ms 0.74% VecDuplicate_Seq 26ms 0.62% 83.35% 30ms 0.72% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 0 0% 83.35% 30ms 0.72% PetscTimeSubtract (inline) 2ms 0.048% 83.40% 30ms 0.72% VecCopy_Seq (partial-inline) 0 0% 83.40% 29ms 0.69% VecNorm_MPI 1ms 0.024% 83.42% 29ms 0.69% VecNorm_MPI_Default.constprop.0 2ms 0.048% 83.47% 28ms 0.67% VecCreate_MPI_Private 27ms 0.64% 84.12% 27ms 0.64% DistributedVector::Iterator::operator!= 0 0% 84.12% 27ms 0.64% PetscTimeAdd (inline) 18ms 0.43% 84.55% 24ms 0.57% AbstractParameterisedSystem::GetAnyVariable 24ms 0.57% 85.12% 24ms 0.57% TimeStepper::GetNextTimeStep 6ms 0.14% 85.26% 24ms 0.57% __GI___libc_malloc 23ms 0.55% 85.81% 23ms 0.55% DistributedVector::Stripe::operator[] (inline) 23ms 0.55% 86.36% 23ms 0.55% RegularStimulus::GetStimulus 14ms 0.33% 86.69% 23ms 0.55% std::__cxx11::basic_string::basic_string 22ms 0.52% 87.22% 22ms 0.52% [libm.so.6] 0 0% 87.22% 22ms 0.52% __posix_memalign 0 0% 87.22% 22ms 0.52% orte_init 0 0% 87.22% 21ms 0.5% AbstractFeVolumeIntegralAssembler::DoAssemble 18ms 0.43% 87.65% 21ms 0.5% VecMAXPY_Seq