File: Test3dBidomainProblemWithPermForEfficiency Type: cpu Showing nodes accounting for 3741ms, 87.39% of 4281ms total Dropped 448 nodes (cum <= 21.41ms) flat flat% sum% cum cum% 0 0% 0% 4274ms 99.84% __libc_start_call_main 0 0% 0% 4274ms 99.84% __libc_start_main_impl 0 0% 0% 4274ms 99.84% _start 0 0% 0% 4271ms 99.77% CxxTest::ErrorFormatter::run (inline) 0 0% 0% 4271ms 99.77% CxxTest::TestRunner::runAllTests (inline) 0 0% 0% 4271ms 99.77% CxxTest::TestRunner::runWorld (inline) 0 0% 0% 4271ms 99.77% main 0 0% 0% 4234ms 98.90% CxxTest::TestRunner::runSuite (inline) 0 0% 0% 4234ms 98.90% CxxTest::TestRunner::runTest (inline) 0 0% 0% 4234ms 98.90% Test3dBidomainProblemWithPermForEfficiency::TestBidomain3d 1ms 0.023% 0.023% 4227ms 98.74% AbstractCardiacProblem::Solve 0 0% 0.023% 4213ms 98.41% AbstractDynamicLinearPdeSolver::Solve 11ms 0.26% 0.28% 2189ms 51.13% AbstractCardiacTissue::SolveCellSystems 2ms 0.047% 0.33% 1626ms 37.98% LinearSystem::Solve 0 0% 0.33% 1570ms 36.67% KSPSolve 7ms 0.16% 0.49% 1570ms 36.67% KSPSolve_Private 4ms 0.093% 0.58% 1532ms 35.79% KSPSolve_SYMMLQ 41ms 0.96% 1.54% 1245ms 29.08% AbstractCardiacCell::ComputeExceptVoltage 31ms 0.72% 2.27% 1047ms 24.46% AbstractOneStepIvpOdeSolver::InternalSolve 2ms 0.047% 2.31% 1000ms 23.36% PCApply 0 0% 2.31% 991ms 23.15% PCApply_BJacobi_Singleblock 64ms 1.49% 3.81% 877ms 20.49% EulerIvpOdeSolver::CalculateNextYValue 1ms 0.023% 3.83% 829ms 19.36% KSPSolve_PREONLY (partial-inline) 232ms 5.42% 9.25% 802ms 18.73% CellLuoRudy1991FromCellML::EvaluateYDerivatives 1ms 0.023% 9.27% 793ms 18.52% MatSolve 0 0% 9.27% 793ms 18.52% PCApply_ICC 783ms 18.29% 27.56% 788ms 18.41% MatSolve_SeqSBAIJ_1_NaturalOrdering (partial-inline) 342ms 7.99% 35.55% 747ms 17.45% __GI___exp 23ms 0.54% 36.09% 742ms 17.33% AbstractCardiacTissue::UpdateCaches (inline) 0 0% 36.09% 710ms 16.58% KSP_PCApply.lto_priv.18 261ms 6.10% 42.19% 700ms 16.35% CellLuoRudy1991FromCellML::GetIIonic 4ms 0.093% 42.28% 440ms 10.28% MatMult 5ms 0.12% 42.40% 431ms 10.07% MatMult_SeqAIJ 420ms 9.81% 52.21% 429ms 10.02% MatMult_SeqAIJ_Inode (inline) 358ms 8.36% 60.57% 383ms 8.95% __ieee754_exp_fma 1ms 0.023% 60.59% 377ms 8.81% KSPConvergedDefault 83ms 1.94% 62.53% 345ms 8.06% BidomainSolver::SetupLinearSystem 0 0% 62.53% 345ms 8.06% KSP_PCApply (partial-inline) 1ms 0.023% 62.56% 204ms 4.77% std::pow (inline) 25ms 0.58% 63.14% 203ms 4.74% __pow 25ms 0.58% 63.72% 178ms 4.16% __ieee754_pow_fma 70ms 1.64% 65.36% 151ms 3.53% CellLuoRudy1991FromCellML::VerifyStateVariables 2ms 0.047% 65.41% 111ms 2.59% MatNullSpaceRemove 0 0% 65.41% 103ms 2.41% VecDuplicate 12ms 0.28% 65.69% 75ms 1.75% MPI_Wtime 73ms 1.71% 67.39% 73ms 1.71% log_inline (inline) 69ms 1.61% 69.00% 71ms 1.66% exp_inline (inline) 14ms 0.33% 69.33% 67ms 1.57% PetscLogEventBeginDefault 5ms 0.12% 69.45% 67ms 1.57% VecCopy 66ms 1.54% 70.99% 66ms 1.54% ddot_ 37ms 0.86% 71.85% 64ms 1.49% TimeStepper::TimeStepper 0 0% 71.85% 64ms 1.49% VecMDot 2ms 0.047% 71.90% 64ms 1.49% VecMXDot_Private 63ms 1.47% 73.37% 63ms 1.47% [[vdso]] 0 0% 73.37% 63ms 1.47% __GI___clock_gettime 2ms 0.047% 73.42% 60ms 1.40% VecDuplicate_MPI 55ms 1.28% 74.70% 55ms 1.28% __memcpy_avx_unaligned_erms 0 0% 74.70% 50ms 1.17% AbstractBidomainSolver::FinaliseLinearSystem 1ms 0.023% 74.73% 50ms 1.17% VecDestroy 0 0% 74.73% 50ms 1.17% VecNorm 16ms 0.37% 75.10% 49ms 1.14% AbstractBidomainSolver::CheckCompatibilityCondition 4ms 0.093% 75.19% 49ms 1.14% PetscMallocA 0 0% 75.19% 49ms 1.14% VecDot 14ms 0.33% 75.52% 47ms 1.10% AbstractCardiacCell::SetVoltage (partial-inline) 46ms 1.07% 76.59% 47ms 1.10% VecMDot_Seq 3ms 0.07% 76.66% 45ms 1.05% PetscMallocAlign (partial-inline) 2ms 0.047% 76.71% 45ms 1.05% VecMAXPY 2ms 0.047% 76.76% 45ms 1.05% VecNorm_Seq 28ms 0.65% 77.41% 43ms 1.00% AbstractCardiacCellInterface::SetVoltageDerivativeToZero 6ms 0.14% 77.55% 43ms 1.00% PetscLogEventEndDefault 3ms 0.07% 77.62% 43ms 1.00% VecDuplicate_Seq 41ms 0.96% 78.58% 42ms 0.98% __ieee754_log_fma 33ms 0.77% 79.35% 41ms 0.96% AbstractOneStepIvpOdeSolver::Solve 4ms 0.093% 79.44% 40ms 0.93% VecCreate 0 0% 79.44% 39ms 0.91% PetscMemcpy (inline) 0 0% 79.44% 39ms 0.91% VecDot_Seq 1ms 0.023% 79.47% 39ms 0.91% VecXDot_Seq_Private.constprop.0 3ms 0.07% 79.54% 38ms 0.89% VecAXPY 16ms 0.37% 79.91% 35ms 0.82% top12 (inline) 2ms 0.047% 79.96% 34ms 0.79% VecCopy_Seq (partial-inline) 34ms 0.79% 80.75% 34ms 0.79% std::isinf (inline) 0 0% 80.75% 32ms 0.75% CxxTest::RealWorldDescription::setUp 0 0% 80.75% 32ms 0.75% PMPI_Init_thread 0 0% 80.75% 32ms 0.75% PetscInitialize 0 0% 80.75% 32ms 0.75% PetscSetup::setUpWorld 0 0% 80.75% 32ms 0.75% PetscSetupUtils::CommonSetup 0 0% 80.75% 32ms 0.75% PetscSetupUtils::InitialisePetsc 32ms 0.75% 81.50% 32ms 0.75% TimeStepper::CalculateNextTime 0 0% 81.50% 32ms 0.75% ompi_mpi_init 1ms 0.023% 81.52% 31ms 0.72% VecCreate_MPI_Private 0 0% 81.52% 31ms 0.72% VecNorm_MPI 0 0% 81.52% 31ms 0.72% VecNorm_MPI_Default.constprop.0 30ms 0.7% 82.22% 30ms 0.7% DistributedVector::Iterator::operator!= 27ms 0.63% 82.85% 29ms 0.68% AbstractIvpOdeSolver::SolveAndUpdateStateVariable 29ms 0.68% 83.53% 29ms 0.68% [libchaste_heart.so] 26ms 0.61% 84.14% 28ms 0.65% AbstractParameterisedSystem::SetAnyVariable 4ms 0.093% 84.23% 27ms 0.63% PetscHeaderDestroy_Private 0 0% 84.23% 27ms 0.63% PetscMemzero (inline) 26ms 0.61% 84.84% 27ms 0.63% VecMAXPY_Seq 26ms 0.61% 85.45% 26ms 0.61% __memset_avx2_unaligned_erms 1ms 0.023% 85.47% 25ms 0.58% 1ms 0.023% 85.49% 24ms 0.56% VecAXPY_Seq 3ms 0.07% 85.56% 24ms 0.56% __posix_memalign 23ms 0.54% 86.10% 23ms 0.54% DistributedVector::Stripe::operator[] (inline) 1ms 0.023% 86.12% 23ms 0.54% VecSetType 8ms 0.19% 86.31% 23ms 0.54% __GI___libc_malloc 0 0% 86.31% 23ms 0.54% orte_init 11ms 0.26% 86.57% 22ms 0.51% AbstractCardiacCell::GetVoltage (partial-inline) 22ms 0.51% 87.08% 22ms 0.51% [libm.so.6] 13ms 0.3% 87.39% 22ms 0.51% std::__cxx11::basic_string::basic_string