********** initial-run-of-task-import-000 FINISHED **********

Iterative task information:
  Successfully processed:   2000 in     352568 ms =    176.3 ms per object, last: ShadowType:u-00001998 (u-00001998 (ACCOUNT - default - AccountObjectClass), 84932a96-d299-41c0-82e8-d3cb0b382b6c) on Tue May 04 01:41:07 CEST 2021 in 125 ms
  Failed:                      0 in          0 ms =      0.0 ms per object

Actions executed:
  All object actions:
    MODIFY     UserType                       http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001998 (User null (u-00001998), 953683cc-83a4-48dd-a226-db1bee4dddea) on Tue May 04 01:41:07 CEST 2021
    MODIFY     ShadowType                     http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   4000 time(s), last: u-00001998 (Shadow u-00001998 (ACCOUNT - default - AccountObjectClass), 84932a96-d299-41c0-82e8-d3cb0b382b6c) on Tue May 04 01:41:07 CEST 2021
    ADD        UserType                       http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001998 (User null (u-00001998), 953683cc-83a4-48dd-a226-db1bee4dddea) on Tue May 04 01:41:07 CEST 2021
  Resulting object actions:
    MODIFY     ShadowType                     http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001998 (Shadow u-00001998 (ACCOUNT - default - AccountObjectClass), 84932a96-d299-41c0-82e8-d3cb0b382b6c) on Tue May 04 01:41:07 CEST 2021
    ADD        UserType                       http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001998 (User null (u-00001998), 953683cc-83a4-48dd-a226-db1bee4dddea) on Tue May 04 01:41:07 CEST 2021

Environmental performance information:
  Provisioning:
    source-000 (AccountObjectClass)                              count:        1, total time:      309 ms [min:      0, max:     13, avg:   309.0] GET:     0:  0 SEARCH:     1:  0 CREATE:     0:  0 UPDATE:     0:  0 DELETE:     0:  0 SYNC:     0:  0 SCRIPT:     0:  0 OTHER:     0:  0
  Mappings:
    source-000                               count:  92000, total time:  71463 ms [min:     0, max:   345, avg:     0.8]
  Last message: Successfully finished evaluation of mapping mapping in inbound expression for a-single-0008 in resource:5d1a7083-395a-4a03-aff7-c11e62618e2a(source-000) in 0 ms.
  On:           2021-05-04T01:41:07.765+02:00

Repository performance information:
  addObject.ShadowType:               count:   2000, total time:     8330 ms [min:     2, max:    51, avg:     4.2], wasted time for    4 retry/retries:       99 ms [min:     0, max:    48, avg:     0.0] (  1.19%)
  addObject.UserType:                 count:   2000, total time:    13365 ms [min:     4, max:    72, avg:     6.7], wasted time for    5 retry/retries:      162 ms [min:     0, max:    47, avg:     0.1] (  1.21%)
  fetchExtItems.RExtItem:             count:      5, total time:        5 ms [min:     1, max:     1, avg:     1.0]
  getObject.ArchetypeType:            count:      2, total time:        4 ms [min:     2, max:     2, avg:     2.0]
  getObject.ObjectTemplateType:       count:      2, total time:        4 ms [min:     2, max:     2, avg:     2.0]
  getObject.RoleType:                 count:      6, total time:       26 ms [min:     1, max:     9, avg:     4.3]
  getObject.ShadowType:               count:   6000, total time:     4747 ms [min:     0, max:    63, avg:     0.8]
  getObject.SystemConfigurationType:  count:      1, total time:        2 ms [min:     2, max:     2, avg:     2.0]
  getObject.TaskType:                 count:      4, total time:       12 ms [min:     2, max:     4, avg:     3.0]
  getObject.UserType:                 count:  10004, total time:    27695 ms [min:     0, max:    35, avg:     2.8]
  modifyObject.ShadowType:            count:   8000, total time:    57535 ms [min:     3, max:  1178, avg:     7.2], wasted time for  468 retry/retries:    18618 ms [min:     0, max:  1170, avg:     2.3] ( 32.36%)
  modifyObject.TaskType:              count:     26, total time:      629 ms [min:     9, max:    89, avg:    24.2], wasted time for    2 retry/retries:       95 ms [min:     0, max:    65, avg:     3.7] ( 15.10%)
  modifyObject.UserType:              count:   2000, total time:    26513 ms [min:     8, max:   305, avg:    13.3], wasted time for   35 retry/retries:     1748 ms [min:     0, max:   288, avg:     0.9] (  6.59%)
  searchObjects.FunctionLibraryType:  count:      1, total time:        8 ms [min:     8, max:     8, avg:     8.0]
  searchObjects.ShadowType:           count:   2000, total time:     1881 ms [min:     0, max:    18, avg:     0.9]
  searchObjects.TaskType:             count:   6000, total time:    19688 ms [min:     1, max:    41, avg:     3.3]
  searchObjects.UserType:             count:   2000, total time:     1270 ms [min:     0, max:    17, avg:     0.6]
  searchShadowOwner.FocusType:        count:   2000, total time:     1437 ms [min:     0, max:    18, avg:     0.7]

Cache performance information:
  com.evolveum.midpoint.provisioning.impl.ResourceCache:                               hits:   8004 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ArchetypeType:             hits:   1998 ( 99.9%), weak hits:      0 (0.0%), misses:      2, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ObjectTemplateType:        hits:   1998 ( 99.9%), weak hits:      0 (0.0%), misses:      2, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.RoleType:                  hits:   1994 ( 99.7%), weak hits:      0 (0.0%), misses:      6, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ShadowType:                hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   6000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.SystemConfigurationType:   hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      1, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.UserType:                  hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   4000, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalQueryCache.ShadowType:                 hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalQueryCache.UserType:                   hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.ResourceType:             hits:   2004 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.SystemConfigurationType:  hits:     59 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ArchetypeType:               hits:  12000 ( 85.7%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ObjectTemplateType:          hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.RoleType:                    hits:   2000 ( 50.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ShadowType:                  hits:   4000 ( 40.0%), weak hits:      0 (0.0%), misses:   6000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.SystemConfigurationType:     hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      1
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.UserType:                    hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   4000, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalQueryCache.ShadowType:                   hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalQueryCache.UserType:                     hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalVersionCache.ResourceType:               hits:   6000 ( 75.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      4
  com.evolveum.midpoint.repo.cache.local.LocalVersionCache.SystemConfigurationType:    hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:     59, passes:      0, not available:      0

Methods performance information:
  class com.evolveum.midpoint.model.common.stringpolicy.ObjectValuePolicyEvaluator.validateValue:                                  count:   6000, total time:         5.2 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.common.operation.import.accountsFromResource.statistics:                                                   count:      1, total time:         0.0 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.AbstractValueTransformationExpressionEvaluator.evaluate:  count: 190000, total time:     43865.3 ms [min:       0.0, max:     323.7, avg:       0.2]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.SingleShotEvaluation.evaluateExpression:                  count: 102000, total time:      1056.9 ms [min:       0.0, max:      42.2, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.ValueTupleTransformation.evaluate:                        count: 248000, total time:     22112.8 ms [min:       0.0, max:     314.7, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpression.evaluate:                                                  count: 342000, total time:      3855.7 ms [min:       0.0, max:     311.5, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpressionFactory.searchCustomFunctions:                              count:      1, total time:        13.5 ms [min:      13.5, max:      13.5, avg:      13.5]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluate:                                                                 count:  92000, total time:     70500.8 ms [min:       0.0, max:     345.0, avg:       0.8]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluatePrepared:                                                         count:  92000, total time:     47924.7 ms [min:       0.0, max:     344.7, avg:       0.5]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.prepare:                                                                  count:  92000, total time:     21530.1 ms [min:       0.0, max:      27.6, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute:                                                                    count:   4000, total time:     84271.9 ms [min:       0.1, max:     352.6, avg:      21.1]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.focus.UserType:                                                     count:   4000, total time:     17634.0 ms [min:       0.1, max:      74.8, avg:       4.4]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.projection.ShadowType:                                              count:   2000, total time:     17071.0 ms [min:       5.1, max:      95.3, avg:       8.5]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.executeDelta:                                                               count:   4000, total time:     30930.6 ms [min:       4.3, max:      95.2, avg:       7.7]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.linkShadow:                                                                 count:   2000, total time:     26695.4 ms [min:       7.8, max:     305.8, avg:      13.3]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.updateSituationInShadow:                                                    count:   2000, total time:     22450.2 ms [min:       5.3, max:     264.4, avg:      11.2]
  com.evolveum.midpoint.model.impl.lens.Clockwork.authorizeRequest:                                                                count:   2000, total time:        87.6 ms [min:       0.0, max:      12.9, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.Clockwork.click:                                                                           count:  10000, total time:    325033.7 ms [min:       2.5, max:     655.2, avg:      32.5]
  com.evolveum.midpoint.model.impl.lens.Clockwork.execution:                                                                       count:   4000, total time:     84296.4 ms [min:       0.1, max:     352.6, avg:      21.1]
  com.evolveum.midpoint.model.impl.lens.Clockwork.run:                                                                             count:   2000, total time:    325443.1 ms [min:     104.6, max:    1055.6, avg:     162.7]
  com.evolveum.midpoint.model.impl.lens.IvwoConsolidator.consolidateToDelta:                                                       count:  90000, total time:       863.9 ms [min:       0.0, max:      15.9, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.assignments.AssignmentEvaluator.evaluate:                                                  count:   4000, total time:      1181.3 ms [min:       0.1, max:      26.2, avg:       0.3]
  com.evolveum.midpoint.model.impl.lens.assignments.PathSegmentEvaluation.evaluate:                                                count:   8000, total time:      1288.8 ms [min:       0.0, max:      26.1, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.construction.EvaluatedResourceObjectConstructionImpl.evaluate:                             count:   2000, total time:        63.7 ms [min:       0.0, max:       2.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.construction.PlainResourceObjectConstruction.evaluate:                                     count:   2000, total time:       116.3 ms [min:       0.0, max:       3.6, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.ActivationProcessor.projectionActivation:                                        count:   4000, total time:        49.2 ms [min:       0.0, max:       1.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ConsolidationProcessor.consolidateValues:                                        count:   2000, total time:       404.1 ms [min:       0.1, max:      11.9, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.determineFocusContext:                                             count:  14000, total time:     24624.8 ms [min:       0.0, max:      35.2, avg:       1.8]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.load:                                                              count:   4000, total time:       403.8 ms [min:       0.0, max:      12.6, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.loadProjection:                                                    count:   4000, total time:        77.8 ms [min:       0.0, max:       5.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.DependencyProcessor.sortProjectionsToWaves:                                      count:   4000, total time:        18.4 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ProjectionValuesProcessor.iteration:                                             count:   2000, total time:      1392.3 ms [min:       0.4, max:      12.7, avg:       0.7]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.activation:                                                            count:   4000, total time:       356.7 ms [min:       0.0, max:      13.2, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignments:                                                           count:   4000, total time:     21217.9 ms [min:       2.9, max:      50.9, avg:       5.3]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsConflicts:                                                  count:   4000, total time:        37.7 ms [min:       0.0, max:       3.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsMembershipAndDelegate:                                      count:   4000, total time:       986.4 ms [min:       0.1, max:      10.5, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsOrg:                                                        count:   4000, total time:        67.5 ms [min:       0.0, max:      16.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focus:                                                                 count:   4000, total time:    162067.2 ms [min:      13.3, max:     616.3, avg:      40.5]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusActivation:                                                       count:  12000, total time:       750.5 ms [min:       0.0, max:      16.3, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusCredentials:                                                      count:   4000, total time:       146.8 ms [min:       0.0, max:       5.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusLifecycle:                                                        count:   4000, total time:         8.6 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusPolicyRules:                                                      count:   4000, total time:        80.6 ms [min:       0.0, max:       2.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.inbound:                                                               count:   4000, total time:    134608.3 ms [min:       9.7, max:     536.0, avg:      33.7]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.load:                                                                  count:   4000, total time:       433.4 ms [min:       0.0, max:      12.6, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterAssignments:                                        count:   4000, total time:       927.6 ms [min:       0.0, max:       8.7, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterProjections:                                        count:   4000, total time:       947.1 ms [min:       0.0, max:      13.3, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateBeforeAssignments:                                       count:   4000, total time:       837.4 ms [min:       0.0, max:      16.4, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.project:                                                               count:   4000, total time:    166336.1 ms [min:      13.4, max:     650.3, avg:      41.6]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectProjection:                                                     count:   2000, total time:      2253.0 ms [min:       0.6, max:      22.7, avg:       1.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projection:                                                            count:   4000, total time:      2281.4 ms [min:       0.0, max:      22.7, avg:       0.6]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionCredentials:                                                 count:   2000, total time:       142.0 ms [min:       0.0, max:       1.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionLifecycle:                                                   count:   2000, total time:        12.9 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionReconciliation:                                              count:   2000, total time:       259.0 ms [min:       0.1, max:      21.6, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValues:                                                      count:   2000, total time:      1605.7 ms [min:       0.4, max:      12.9, avg:       0.8]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValuesPostRecon:                                             count:   2000, total time:        93.0 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.distributeConstructions:                               count:   4000, total time:        49.6 ms [min:       0.0, max:       2.9, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.evaluateFocusMappings:                                 count:   4000, total time:       662.7 ms [min:       0.0, max:      14.8, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processAssignments:                                    count:   4000, total time:     21189.6 ms [min:       2.9, max:      50.9, avg:       5.3]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processProjections:                                    count:   4000, total time:       648.7 ms [min:       0.1, max:       7.0, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentTripleEvaluator.evaluateAssignment:                              count:   4000, total time:      1305.3 ms [min:       0.1, max:      26.2, avg:       0.3]
  com.evolveum.midpoint.model.impl.lens.projector.focus.PruningOperation.execute:                                                  count:   4000, total time:        16.3 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.consolidation.DeltaSetTripleMapConsolidation.consolidate:                  count:   4000, total time:      1679.1 ms [min:       0.2, max:      18.6, avg:       0.4]
  com.evolveum.midpoint.model.impl.lens.projector.policy.PolicyRuleEnforcer.execute:                                               count:   2000, total time:        27.9 ms [min:       0.0, max:       1.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.notifyChange:                                                   count:   4000, total time:    363666.6 ms [min:       3.1, max:    1502.0, avg:      90.9]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.setupSituation:                                                 count:   2000, total time:      3808.7 ms [min:       0.8, max:      27.2, avg:       1.9]
  com.evolveum.midpoint.model.impl.sync.SynchronizeAccountResultHandler.handle:                                                    count:   2000, total time:    352570.8 ms [min:     111.2, max:    1502.6, avg:     176.3]
  com.evolveum.midpoint.model.impl.util.AuditHelper.audit:                                                                         count:   4000, total time:     38589.8 ms [min:       1.5, max:      48.1, avg:       9.6]
  com.evolveum.midpoint.model.impl.util.AuditHelper.resolveName:                                                                   count:   4000, total time:       100.1 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.notifications.impl.NotificationHook.invoke:                                                                count:   8000, total time:         8.3 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.countObjects:                                                         count:      1, total time:         6.5 ms [min:       6.5, max:       6.5, avg:       6.5]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.getObject:                                                            count:   4002, total time:     10291.5 ms [min:       0.8, max:      40.0, avg:       2.6]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.modifyObject:                                                         count:   4000, total time:     28498.5 ms [min:       3.4, max:     252.1, avg:       7.1]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.searchObjectsIterative:                                               count:      1, total time:     58889.1 ms [min:   58889.1, max:   58889.1, avg:   58889.1]
  com.evolveum.midpoint.provisioning.impl.AccessChecker.accessCheck:                                                               count:   6000, total time:        62.2 ms [min:       0.0, max:       2.0, avg:       0.0]
  com.evolveum.midpoint.provisioning.impl.ProvisioningContext.getConnectorInstance:                                                count:      1, total time:         0.2 ms [min:       0.2, max:       0.2, avg:       0.2]
  com.evolveum.midpoint.provisioning.ucf.api.ConnectorInstance.search:                                                             count:      1, total time:     58886.0 ms [min:   58886.0, max:   58886.0, avg:   58886.0]
  com.evolveum.midpoint.provisioning.ucf.impl.connid.ConnIdConvertor.convertToResourceObject:                                      count:   2000, total time:       269.9 ms [min:       0.1, max:      13.3, avg:       0.1]
  com.evolveum.midpoint.repo.api.RepositoryService.addObject:                                                                      count:   4000, total time:     21358.6 ms [min:       2.6, max:      71.6, avg:       5.3]
  com.evolveum.midpoint.repo.api.RepositoryService.getObject:                                                                      count:  16019, total time:     32483.7 ms [min:       0.4, max:      62.9, avg:       2.0]
  com.evolveum.midpoint.repo.api.RepositoryService.modifyObject:                                                                   count:  10026, total time:     64858.4 ms [min:       2.7, max:      57.9, avg:       6.5]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjects:                                                                  count:  10001, total time:     22920.9 ms [min:       0.2, max:      41.3, avg:       2.3]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjectsIterative:                                                         count:      1, total time:        13.1 ms [min:      13.1, max:      13.1, avg:      13.1]
  com.evolveum.midpoint.repo.api.RepositoryService.searchShadowOwner:                                                              count:   2000, total time:      1421.6 ms [min:       0.2, max:      18.1, avg:       0.7]
  com.evolveum.midpoint.repo.cache.RepositoryCache.addObject:                                                                      count:   4000, total time:     22017.1 ms [min:       2.7, max:      71.8, avg:       5.5]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getObject:                                                                      count:  34001, total time:     38170.2 ms [min:       0.0, max:      64.3, avg:       1.1]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getVersion:                                                                     count:   8063, total time:        76.2 ms [min:       0.0, max:       0.5, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.invalidateCacheEntries:                                                         count:  14000, total time:       510.5 ms [min:       0.0, max:      15.6, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.modifyObject:                                                                   count:  10000, total time:     84740.2 ms [min:       3.0, max:    1178.2, avg:       8.5]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchObjects:                                                                  count:   4000, total time:      3414.2 ms [min:       0.3, max:      18.5, avg:       0.9]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchShadowOwner:                                                              count:   2000, total time:      1448.8 ms [min:       0.2, max:      18.1, avg:       0.7]
  com.evolveum.midpoint.schema.result.searchResult:                                                                                count:   2000, total time:     58181.1 ms [min:       8.7, max:     552.2, avg:      29.1]
  com.evolveum.midpoint.task.api.Task.getPathToRootTask:                                                                           count:   6000, total time:     25272.3 ms [min:       2.4, max:      42.7, avg:       4.2]
  com.evolveum.midpoint.task.api.TaskManager.createTaskInstance:                                                                   count:   6004, total time:      4494.5 ms [min:       0.4, max:      34.7, avg:       0.7]
  com.evolveum.midpoint.task.api.TaskManager.getTaskByIdentifier:                                                                  count:   6000, total time:     25220.1 ms [min:       2.4, max:      42.7, avg:       4.2]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskPlain:                                                        count:      4, total time:        19.1 ms [min:       4.3, max:       5.2, avg:       4.8]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskTypeByIdentifier:                                             count:   6000, total time:     20670.5 ms [min:       1.7, max:      41.4, avg:       3.4]
  com.evolveum.midpoint.wf.impl.hook.WfHook.invoke:                                                                                count:   8000, total time:       148.5 ms [min:       0.0, max:       1.1, avg:       0.0]
  com.evolveum.midpoint.wf.impl.processors.primary.PrimaryChangeProcessor.previewOrProcessModelInvocation:                         count:   2000, total time:        15.3 ms [min:       0.0, max:       0.5, avg:       0.0]
  interface com.evolveum.midpoint.notifications.api.NotificationManager.processEvent:                                              count:      1, total time:         6.2 ms [min:       6.2, max:       6.2, avg:       6.2]
  org.identityconnectors.framework.api.ConnectorFacade.search:                                                                     count:      1, total time:     58881.8 ms [min:   58881.8, max:   58881.8, avg:   58881.8]



********** no-op-run-1-of-task-import-000 FINISHED **********

Iterative task information:
  Successfully processed:   2000 in     185783 ms =     92.9 ms per object, last: ShadowType:u-00001999 (u-00001999 (ACCOUNT - default - AccountObjectClass), 3a504b63-83fc-478b-8ebb-965d849d8482) on Tue May 04 01:41:39 CEST 2021 in 82 ms
  Failed:                      0 in          0 ms =      0.0 ms per object

Actions executed:
  All object actions:
    MODIFY     ShadowType                     http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001999 (Shadow u-00001999 (ACCOUNT - default - AccountObjectClass), 3a504b63-83fc-478b-8ebb-965d849d8482) on Tue May 04 01:41:39 CEST 2021
  Resulting object actions:
    MODIFY     ShadowType                     http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001999 (Shadow u-00001999 (ACCOUNT - default - AccountObjectClass), 3a504b63-83fc-478b-8ebb-965d849d8482) on Tue May 04 01:41:39 CEST 2021

Environmental performance information:
  Provisioning:
    source-000 (AccountObjectClass)                              count:        1, total time:      135 ms [min:      0, max:      1, avg:   135.0] GET:     0:  0 SEARCH:     1:  0 CREATE:     0:  0 UPDATE:     0:  0 DELETE:     0:  0 SYNC:     0:  0 SCRIPT:     0:  0 OTHER:     0:  0
  Mappings:
    source-000                               count:  92000, total time:  64404 ms [min:     0, max:    27, avg:     0.7]
  Last message: Successfully finished evaluation of mapping mapping in inbound expression for a-single-0008 in resource:5d1a7083-395a-4a03-aff7-c11e62618e2a(source-000) in 0 ms.
  On:           2021-05-04T01:41:39.981+02:00

Repository performance information:
  getObject.ArchetypeType:       count:      1, total time:        1 ms [min:     1, max:     1, avg:     1.0]
  getObject.ObjectTemplateType:  count:      1, total time:        0 ms [min:     0, max:     0, avg:     0.0]
  getObject.RoleType:            count:      2, total time:        0 ms [min:     0, max:     0, avg:     0.0]
  getObject.ShadowType:          count:   2000, total time:     1027 ms [min:     0, max:    14, avg:     0.5]
  getObject.TaskType:            count:      4, total time:       13 ms [min:     1, max:     7, avg:     3.3]
  getObject.UserType:            count:   8004, total time:    13657 ms [min:     0, max:    23, avg:     1.7]
  getVersion.ResourceType:       count:      1, total time:        1 ms [min:     1, max:     1, avg:     1.0]
  modifyObject.ShadowType:       count:   2000, total time:     9519 ms [min:     3, max:    33, avg:     4.8]
  modifyObject.TaskType:         count:     17, total time:      280 ms [min:     5, max:    38, avg:    16.5]
  searchObjects.ShadowType:      count:   2000, total time:     1724 ms [min:     0, max:    24, avg:     0.9]
  searchObjects.TaskType:        count:   6000, total time:    14035 ms [min:     0, max:    27, avg:     2.3]
  searchShadowOwner.FocusType:   count:   2000, total time:    10647 ms [min:     4, max:    22, avg:     5.3]

Cache performance information:
  com.evolveum.midpoint.provisioning.impl.ResourceCache:                               hits:   2004 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ArchetypeType:             hits:   1999 ( 99.9%), weak hits:      0 (0.0%), misses:      1, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ObjectTemplateType:        hits:   1999 ( 99.9%), weak hits:      0 (0.0%), misses:      1, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.RoleType:                  hits:   1998 ( 99.9%), weak hits:      0 (0.0%), misses:      2, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ShadowType:                hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.SystemConfigurationType:   hits:      1 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.UserType:                  hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalQueryCache.ShadowType:                 hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.ResourceType:             hits:   2003 (100.0%), weak hits:      0 (0.0%), misses:      1, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.SystemConfigurationType:  hits:     31 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ArchetypeType:               hits:  12000 ( 85.7%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ObjectTemplateType:          hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.RoleType:                    hits:   2000 ( 50.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ShadowType:                  hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.SystemConfigurationType:     hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      1
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.UserType:                    hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalQueryCache.ShadowType:                   hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalVersionCache.ResourceType:               hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      4
  com.evolveum.midpoint.repo.cache.local.LocalVersionCache.SystemConfigurationType:    hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:     31, passes:      0, not available:      0

Methods performance information:
  com.evolveum.midpoint.common.operation.import.accountsFromResource.statistics:                                                   count:      1, total time:         0.0 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.AbstractValueTransformationExpressionEvaluator.evaluate:  count: 292000, total time:     39289.5 ms [min:       0.0, max:      22.6, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.SingleShotEvaluation.evaluateExpression:                  count: 204000, total time:      1401.7 ms [min:       0.0, max:       6.2, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.ValueTupleTransformation.evaluate:                        count: 248000, total time:     18541.5 ms [min:       0.0, max:      16.2, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpression.evaluate:                                                  count: 444000, total time:      1678.5 ms [min:       0.0, max:       4.9, avg:       0.0]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluate:                                                                 count:  92000, total time:     63690.9 ms [min:       0.0, max:      26.7, avg:       0.7]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluatePrepared:                                                         count:  92000, total time:     42691.0 ms [min:       0.0, max:      26.5, avg:       0.5]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.prepare:                                                                  count:  92000, total time:     20146.9 ms [min:       0.0, max:      20.4, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute:                                                                    count:   4000, total time:      4461.9 ms [min:       0.0, max:      16.7, avg:       1.1]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.projection.ShadowType:                                              count:   2000, total time:      4418.3 ms [min:       1.6, max:      16.7, avg:       2.2]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.updateSituationInShadow:                                                    count:   2000, total time:      4380.3 ms [min:       1.6, max:      16.6, avg:       2.2]
  com.evolveum.midpoint.model.impl.lens.Clockwork.authorizeRequest:                                                                count:   2000, total time:         3.2 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.Clockwork.click:                                                                           count:  10000, total time:    157132.8 ms [min:       0.0, max:     125.2, avg:      15.7]
  com.evolveum.midpoint.model.impl.lens.Clockwork.execution:                                                                       count:   4000, total time:      4478.8 ms [min:       0.0, max:      16.7, avg:       1.1]
  com.evolveum.midpoint.model.impl.lens.Clockwork.run:                                                                             count:   2000, total time:    157423.2 ms [min:      62.5, max:     169.6, avg:      78.7]
  com.evolveum.midpoint.model.impl.lens.IvwoConsolidator.consolidateToDelta:                                                       count:  90000, total time:       701.9 ms [min:       0.0, max:       5.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.assignments.AssignmentEvaluator.evaluate:                                                  count:   4000, total time:       716.3 ms [min:       0.1, max:      10.2, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.assignments.PathSegmentEvaluation.evaluate:                                                count:   8000, total time:       735.3 ms [min:       0.0, max:      10.2, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.construction.EvaluatedResourceObjectConstructionImpl.evaluate:                             count:   2000, total time:        30.4 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.construction.PlainResourceObjectConstruction.evaluate:                                     count:   2000, total time:        56.8 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ActivationProcessor.projectionActivation:                                        count:   4000, total time:        31.8 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ConsolidationProcessor.consolidateValues:                                        count:   2000, total time:        52.8 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.determineFocusContext:                                             count:  12000, total time:     10503.5 ms [min:       0.0, max:      22.5, avg:       0.9]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.load:                                                              count:   2000, total time:       196.9 ms [min:       0.1, max:       1.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.loadProjection:                                                    count:   2000, total time:        28.8 ms [min:       0.0, max:       0.6, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.DependencyProcessor.sortProjectionsToWaves:                                      count:   4000, total time:        12.5 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ProjectionValuesProcessor.iteration:                                             count:   2000, total time:       159.5 ms [min:       0.0, max:       0.3, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.activation:                                                            count:   4000, total time:       292.4 ms [min:       0.0, max:       0.7, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignments:                                                           count:   4000, total time:     13542.1 ms [min:       1.4, max:      28.8, avg:       3.4]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsConflicts:                                                  count:   4000, total time:        14.8 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsMembershipAndDelegate:                                      count:   4000, total time:        38.9 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsOrg:                                                        count:   4000, total time:        22.9 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focus:                                                                 count:   4000, total time:    134431.9 ms [min:      13.0, max:     116.7, avg:      33.6]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusActivation:                                                       count:  12000, total time:       182.5 ms [min:       0.0, max:       6.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusCredentials:                                                      count:   4000, total time:        19.9 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusLifecycle:                                                        count:   4000, total time:         6.6 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusPolicyRules:                                                      count:   4000, total time:        39.2 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.inbound:                                                               count:   4000, total time:    120114.1 ms [min:      10.3, max:     100.0, avg:      30.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.load:                                                                  count:   2000, total time:       208.4 ms [min:       0.1, max:       1.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterAssignments:                                        count:   4000, total time:        53.7 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterProjections:                                        count:   4000, total time:        45.9 ms [min:       0.0, max:       8.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateBeforeAssignments:                                       count:   4000, total time:        63.6 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.project:                                                               count:   4000, total time:    135521.9 ms [min:      13.0, max:     117.3, avg:      33.9]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectProjection:                                                     count:   2000, total time:       393.2 ms [min:       0.1, max:       5.8, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projection:                                                            count:   4000, total time:       415.6 ms [min:       0.0, max:       5.8, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionCredentials:                                                 count:   2000, total time:        27.7 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionLifecycle:                                                   count:   2000, total time:         7.0 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionReconciliation:                                              count:   2000, total time:        97.7 ms [min:       0.0, max:       0.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValues:                                                      count:   2000, total time:       183.1 ms [min:       0.0, max:       0.4, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValuesPostRecon:                                             count:   2000, total time:         6.1 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.distributeConstructions:                               count:   4000, total time:        14.0 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.evaluateFocusMappings:                                 count:   4000, total time:        43.6 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processAssignments:                                    count:   4000, total time:     13522.3 ms [min:       1.4, max:      28.7, avg:       3.4]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processProjections:                                    count:   4000, total time:        54.1 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentTripleEvaluator.evaluateAssignment:                              count:   4000, total time:       829.2 ms [min:       0.1, max:      10.3, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.focus.PruningOperation.execute:                                                  count:   4000, total time:         7.1 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.consolidation.DeltaSetTripleMapConsolidation.consolidate:                  count:   4000, total time:      1425.1 ms [min:       0.2, max:       8.2, avg:       0.4]
  com.evolveum.midpoint.model.impl.lens.projector.policy.PolicyRuleEnforcer.execute:                                               count:   2000, total time:        14.6 ms [min:       0.0, max:       4.5, avg:       0.0]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.notifyChange:                                                   count:   2000, total time:    184937.7 ms [min:      74.7, max:     194.1, avg:      92.5]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.setupSituation:                                                 count:   2000, total time:     16797.2 ms [min:       6.6, max:      25.4, avg:       8.4]
  com.evolveum.midpoint.model.impl.sync.SynchronizeAccountResultHandler.handle:                                                    count:   2000, total time:    185771.9 ms [min:      75.0, max:     195.3, avg:      92.9]
  com.evolveum.midpoint.notifications.impl.NotificationHook.invoke:                                                                count:   8000, total time:         5.7 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.countObjects:                                                         count:      1, total time:         0.2 ms [min:       0.2, max:       0.2, avg:       0.2]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.getObject:                                                            count:   2002, total time:      4330.5 ms [min:       0.3, max:      16.6, avg:       2.2]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.searchObjectsIterative:                                               count:      1, total time:     30877.0 ms [min:   30877.0, max:   30877.0, avg:   30877.0]
  com.evolveum.midpoint.provisioning.impl.AccessChecker.accessCheck:                                                               count:   2000, total time:        39.6 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.provisioning.impl.ProvisioningContext.getConnectorInstance:                                                count:      1, total time:         0.2 ms [min:       0.2, max:       0.2, avg:       0.2]
  com.evolveum.midpoint.provisioning.ucf.api.ConnectorInstance.search:                                                             count:      1, total time:     30876.5 ms [min:   30876.5, max:   30876.5, avg:   30876.5]
  com.evolveum.midpoint.provisioning.ucf.impl.connid.ConnIdConvertor.convertToResourceObject:                                      count:   2000, total time:       187.7 ms [min:       0.1, max:       0.7, avg:       0.1]
  com.evolveum.midpoint.repo.api.RepositoryService.getObject:                                                                      count:  10012, total time:     14664.5 ms [min:       0.3, max:      22.5, avg:       1.5]
  com.evolveum.midpoint.repo.api.RepositoryService.getVersion:                                                                     count:      1, total time:         0.5 ms [min:       0.5, max:       0.5, avg:       0.5]
  com.evolveum.midpoint.repo.api.RepositoryService.modifyObject:                                                                   count:   2017, total time:      9799.2 ms [min:       3.6, max:      38.1, avg:       4.9]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjects:                                                                  count:   8000, total time:     15773.3 ms [min:       0.5, max:      27.5, avg:       2.0]
  com.evolveum.midpoint.repo.api.RepositoryService.searchShadowOwner:                                                              count:   2000, total time:     10634.1 ms [min:       4.0, max:      22.2, avg:       5.3]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getObject:                                                                      count:  24001, total time:     14930.9 ms [min:       0.0, max:      22.5, avg:       0.6]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getVersion:                                                                     count:   2035, total time:        19.5 ms [min:       0.0, max:       1.0, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.invalidateCacheEntries:                                                         count:   2000, total time:        32.1 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.modifyObject:                                                                   count:   2000, total time:      9596.4 ms [min:       3.7, max:      32.3, avg:       4.8]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchObjects:                                                                  count:   2000, total time:      1845.9 ms [min:       0.6, max:      24.4, avg:       0.9]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchShadowOwner:                                                              count:   2000, total time:     16768.0 ms [min:       6.6, max:      25.4, avg:       8.4]
  com.evolveum.midpoint.schema.result.searchResult:                                                                                count:   2000, total time:     30425.5 ms [min:       1.2, max:      66.7, avg:      15.2]
  com.evolveum.midpoint.task.api.Task.getPathToRootTask:                                                                           count:   6000, total time:     18249.3 ms [min:       1.1, max:      28.3, avg:       3.0]
  com.evolveum.midpoint.task.api.TaskManager.createTaskInstance:                                                                   count:   6004, total time:      3329.6 ms [min:       0.4, max:      12.6, avg:       0.6]
  com.evolveum.midpoint.task.api.TaskManager.getTaskByIdentifier:                                                                  count:   6000, total time:     18217.8 ms [min:       1.1, max:      28.3, avg:       3.0]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskPlain:                                                        count:      4, total time:        16.0 ms [min:       1.4, max:       8.5, avg:       4.0]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskTypeByIdentifier:                                             count:   6000, total time:     14852.0 ms [min:       0.7, max:      27.7, avg:       2.5]
  com.evolveum.midpoint.wf.impl.hook.WfHook.invoke:                                                                                count:   8000, total time:        74.9 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.wf.impl.processors.primary.PrimaryChangeProcessor.previewOrProcessModelInvocation:                         count:   2000, total time:         3.7 ms [min:       0.0, max:       0.1, avg:       0.0]
  interface com.evolveum.midpoint.notifications.api.NotificationManager.processEvent:                                              count:      1, total time:         0.2 ms [min:       0.2, max:       0.2, avg:       0.2]
  org.identityconnectors.framework.api.ConnectorFacade.search:                                                                     count:      1, total time:     30876.1 ms [min:   30876.1, max:   30876.1, avg:   30876.1]



********** task-recomputation FINISHED **********

Iterative task information:
  Successfully processed:   2000 in     108568 ms =     54.3 ms per object, last: null:u-00001715 (User null (u-00001715), fffd5078-391e-4469-966e-512c14e3cbb5) on Tue May 04 01:42:02 CEST 2021 in 42 ms
  Failed:                      0 in          0 ms =      0.0 ms per object

Actions executed:
  All object actions:
  Resulting object actions:

Environmental performance information:
  Provisioning:
    source-000 (AccountObjectClass)                              count:     4000, total time:      968 ms [min:      0, max:      8, avg:     0.2] GET:  4000:  0 SEARCH:     0:  0 CREATE:     0:  0 UPDATE:     0:  0 DELETE:     0:  0 SYNC:     0:  0 SCRIPT:     0:  0 OTHER:     0:  0
  Mappings:
    source-000                               count:  92000, total time:  42546 ms [min:     0, max:    23, avg:     0.5]
  Last message: Successfully finished evaluation of mapping mapping in inbound expression for a-single-0008 in resource:5d1a7083-395a-4a03-aff7-c11e62618e2a(source-000) in 0 ms.
  On:           2021-05-04T01:42:02.082+02:00

Repository performance information:
  countObjects.UserType:   count:      1, total time:        9 ms [min:     9, max:     9, avg:     9.0]
  getObject.TaskType:      count:      4, total time:       12 ms [min:     0, max:     7, avg:     3.0]
  getObject.UserType:      count:   8004, total time:    14411 ms [min:     0, max:    35, avg:     1.8]
  modifyObject.TaskType:   count:     13, total time:      183 ms [min:     5, max:    32, avg:    14.1]
  searchObjects.TaskType:  count:   6000, total time:    12645 ms [min:     0, max:    29, avg:     2.1]
  searchObjects.UserType:  count:     41, total time:     8426 ms [min:     1, max:   259, avg:   205.5]

Cache performance information:
  all.UserType:                                                                        hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.provisioning.impl.ResourceCache:                               hits:  16000 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ArchetypeType:             hits:   2000 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ObjectTemplateType:        hits:   2000 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.RoleType:                  hits:   2000 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.ShadowType:                hits:   2000 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.SystemConfigurationType:   hits:      1 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalObjectCache.UserType:                  hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalQueryCache.UserType:                   hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:      1, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.ResourceType:             hits:   2000 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.SystemConfigurationType:  hits:     21 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ArchetypeType:               hits:  12000 ( 85.7%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ObjectTemplateType:          hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.RoleType:                    hits:   2000 ( 50.0%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.ShadowType:                  hits:   4000 ( 66.7%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.SystemConfigurationType:     hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      1
  com.evolveum.midpoint.repo.cache.local.LocalObjectCache.UserType:                    hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:   2000, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalQueryCache.UserType:                     hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      1
  com.evolveum.midpoint.repo.cache.local.LocalVersionCache.ResourceType:               hits:  14000 ( 87.5%), weak hits:      0 (0.0%), misses:   2000, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.local.LocalVersionCache.SystemConfigurationType:    hits:      0 (  0.0%), weak hits:      0 (0.0%), misses:     21, passes:      0, not available:      0

Methods performance information:
  com.evolveum.midpoint.common.operation.recompute.statistics:                                                                     count:      1, total time:         0.0 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.AbstractValueTransformationExpressionEvaluator.evaluate:  count: 292000, total time:     37745.0 ms [min:       0.0, max:      21.9, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.SingleShotEvaluation.evaluateExpression:                  count: 204000, total time:      1405.8 ms [min:       0.0, max:      12.5, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.ValueTupleTransformation.evaluate:                        count: 248000, total time:     18583.3 ms [min:       0.0, max:      20.7, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpression.evaluate:                                                  count: 444000, total time:      1616.4 ms [min:       0.0, max:       7.4, avg:       0.0]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluate:                                                                 count:  92000, total time:     41850.1 ms [min:       0.0, max:      23.1, avg:       0.5]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluatePrepared:                                                         count:  92000, total time:     40772.8 ms [min:       0.0, max:      23.1, avg:       0.4]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.prepare:                                                                  count:  92000, total time:       330.5 ms [min:       0.0, max:       6.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute:                                                                    count:   4000, total time:       365.2 ms [min:       0.0, max:      15.9, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.projection.ShadowType:                                              count:   2000, total time:       330.2 ms [min:       0.1, max:      15.8, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.updateSituationInShadow:                                                    count:   2000, total time:       295.4 ms [min:       0.1, max:      15.8, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.Clockwork.authorizeRequest:                                                                count:   2000, total time:         2.6 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.Clockwork.click:                                                                           count:  10000, total time:    108114.3 ms [min:       0.0, max:      92.3, avg:      10.8]
  com.evolveum.midpoint.model.impl.lens.Clockwork.execution:                                                                       count:   4000, total time:       376.3 ms [min:       0.0, max:      15.9, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.Clockwork.run:                                                                             count:   2000, total time:    108317.1 ms [min:      39.5, max:     131.0, avg:      54.2]
  com.evolveum.midpoint.model.impl.lens.IvwoConsolidator.consolidateToDelta:                                                       count:  90000, total time:       700.6 ms [min:       0.0, max:      17.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.assignments.AssignmentEvaluator.evaluate:                                                  count:   4000, total time:       575.6 ms [min:       0.1, max:       5.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.assignments.PathSegmentEvaluation.evaluate:                                                count:   8000, total time:       598.2 ms [min:       0.0, max:       5.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.construction.EvaluatedResourceObjectConstructionImpl.evaluate:                             count:   2000, total time:        26.2 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.construction.PlainResourceObjectConstruction.evaluate:                                     count:   2000, total time:        52.1 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ActivationProcessor.projectionActivation:                                        count:   4000, total time:        28.3 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ConsolidationProcessor.consolidateValues:                                        count:   2000, total time:        49.3 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.determineFocusContext:                                             count:  12000, total time:     11015.3 ms [min:       0.0, max:      34.6, avg:       0.9]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.load:                                                              count:   2000, total time:      6851.8 ms [min:       1.9, max:      31.3, avg:       3.4]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.loadProjection:                                                    count:   2000, total time:      3137.0 ms [min:       0.9, max:      19.8, avg:       1.6]
  com.evolveum.midpoint.model.impl.lens.projector.DependencyProcessor.sortProjectionsToWaves:                                      count:   4000, total time:         8.6 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ProjectionValuesProcessor.iteration:                                             count:   2000, total time:       152.5 ms [min:       0.0, max:       1.4, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.activation:                                                            count:   4000, total time:        53.6 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignments:                                                           count:   4000, total time:     12563.9 ms [min:       1.2, max:      31.1, avg:       3.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsConflicts:                                                  count:   4000, total time:         9.8 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsMembershipAndDelegate:                                      count:   4000, total time:        30.7 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsOrg:                                                        count:   4000, total time:        16.5 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focus:                                                                 count:   4000, total time:     83189.2 ms [min:      12.6, max:      64.3, avg:      20.8]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusActivation:                                                       count:  12000, total time:       148.5 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusCredentials:                                                      count:   4000, total time:        12.6 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusLifecycle:                                                        count:   4000, total time:         3.9 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusPolicyRules:                                                      count:   4000, total time:        32.2 ms [min:       0.0, max:       6.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.inbound:                                                               count:   4000, total time:     70002.4 ms [min:      10.5, max:      41.9, avg:      17.5]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.load:                                                                  count:   2000, total time:      6859.9 ms [min:       1.9, max:      31.3, avg:       3.4]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterAssignments:                                        count:   4000, total time:        48.7 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterProjections:                                        count:   4000, total time:        34.3 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateBeforeAssignments:                                       count:   4000, total time:        56.4 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.project:                                                               count:   4000, total time:     90641.5 ms [min:      12.6, max:      66.5, avg:      22.7]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectProjection:                                                     count:   2000, total time:       374.4 ms [min:       0.1, max:       1.5, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projection:                                                            count:   4000, total time:       391.4 ms [min:       0.0, max:       1.5, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionCredentials:                                                 count:   2000, total time:        26.5 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionLifecycle:                                                   count:   2000, total time:         6.6 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionReconciliation:                                              count:   2000, total time:        97.0 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValues:                                                      count:   2000, total time:       176.2 ms [min:       0.0, max:       1.4, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValuesPostRecon:                                             count:   2000, total time:         5.7 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.distributeConstructions:                               count:   4000, total time:         9.9 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.evaluateFocusMappings:                                 count:   4000, total time:        34.2 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processAssignments:                                    count:   4000, total time:     12546.6 ms [min:       1.2, max:      31.1, avg:       3.1]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processProjections:                                    count:   4000, total time:        40.4 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentTripleEvaluator.evaluateAssignment:                              count:   4000, total time:       662.8 ms [min:       0.1, max:       5.1, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.focus.PruningOperation.execute:                                                  count:   4000, total time:         6.2 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.consolidation.DeltaSetTripleMapConsolidation.consolidate:                  count:   4000, total time:      1414.5 ms [min:       0.2, max:      18.5, avg:       0.4]
  com.evolveum.midpoint.model.impl.lens.projector.policy.PolicyRuleEnforcer.execute:                                               count:   2000, total time:         7.2 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.sync.RecomputeTaskHandler.handle:                                                               count:   2000, total time:    108460.4 ms [min:      39.6, max:     131.1, avg:      54.2]
  com.evolveum.midpoint.notifications.impl.NotificationHook.invoke:                                                                count:   8000, total time:         3.9 ms [min:       0.0, max:       0.0, avg:       0.0]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.getObject:                                                            count:   8000, total time:      6103.2 ms [min:       0.0, max:      28.9, avg:       0.8]
  com.evolveum.midpoint.provisioning.impl.AccessChecker.accessCheck:                                                               count:   4000, total time:        68.2 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.provisioning.impl.ProvisioningContext.getConnectorInstance:                                                count:   4000, total time:       119.3 ms [min:       0.0, max:       0.9, avg:       0.0]
  com.evolveum.midpoint.provisioning.ucf.api.ConnectorInstance.fetchObject:                                                        count:   4000, total time:      2122.6 ms [min:       0.3, max:      10.0, avg:       0.5]
  com.evolveum.midpoint.provisioning.ucf.impl.connid.ConnIdConvertor.convertToResourceObject:                                      count:   4000, total time:       334.9 ms [min:       0.0, max:       4.9, avg:       0.1]
  com.evolveum.midpoint.repo.api.RepositoryService.countObjects:                                                                   count:      1, total time:         9.8 ms [min:       9.8, max:       9.8, avg:       9.8]
  com.evolveum.midpoint.repo.api.RepositoryService.getObject:                                                                      count:   8008, total time:     14353.7 ms [min:       0.3, max:      34.6, avg:       1.8]
  com.evolveum.midpoint.repo.api.RepositoryService.modifyObject:                                                                   count:     13, total time:       182.6 ms [min:       4.6, max:      32.4, avg:      14.0]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjects:                                                                  count:   6041, total time:     21158.9 ms [min:       0.5, max:     258.8, avg:       3.5]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjectsIterative:                                                         count:      1, total time:     21004.6 ms [min:   21004.6, max:   21004.6, avg:   21004.6]
  com.evolveum.midpoint.repo.cache.RepositoryCache.countObjects:                                                                   count:      1, total time:         9.9 ms [min:       9.9, max:       9.9, avg:       9.9]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getObject:                                                                      count:  28001, total time:     11464.0 ms [min:       0.0, max:      34.6, avg:       0.4]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getVersion:                                                                     count:  16021, total time:        62.5 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchObjectsIterative:                                                         count:      1, total time:     21005.3 ms [min:   21005.3, max:   21005.3, avg:   21005.3]
  com.evolveum.midpoint.task.api.Task.getPathToRootTask:                                                                           count:   6000, total time:     17111.6 ms [min:       1.0, max:      30.8, avg:       2.9]
  com.evolveum.midpoint.task.api.TaskManager.createTaskInstance:                                                                   count:   6004, total time:      3506.6 ms [min:       0.3, max:      28.3, avg:       0.6]
  com.evolveum.midpoint.task.api.TaskManager.getTaskByIdentifier:                                                                  count:   6000, total time:     17081.3 ms [min:       1.0, max:      30.8, avg:       2.8]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskPlain:                                                        count:      4, total time:        17.1 ms [min:       1.1, max:       8.4, avg:       4.3]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskTypeByIdentifier:                                             count:   6000, total time:     13526.0 ms [min:       0.6, max:      29.9, avg:       2.3]
  com.evolveum.midpoint.wf.impl.hook.WfHook.invoke:                                                                                count:   8000, total time:        58.1 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.wf.impl.processors.primary.PrimaryChangeProcessor.previewOrProcessModelInvocation:                         count:   2000, total time:         2.0 ms [min:       0.0, max:       0.0, avg:       0.0]
  interface com.evolveum.midpoint.notifications.api.NotificationManager.processEvent:                                              count:      1, total time:         0.2 ms [min:       0.2, max:       0.2, avg:       0.2]
  org.identityconnectors.framework.api.ConnectorFacade.getObject:                                                                  count:   4000, total time:      1028.5 ms [min:       0.1, max:       8.5, avg:       0.3]



