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

Iterative task information:
  Successfully processed:   2000 in     234201 ms =    117.1 ms per object, last: ShadowType:u-00001999 (u-00001999 (ACCOUNT - default - AccountObjectClass), 42ef3a32-35a6-4059-9e85-701b479b7fed) on Tue May 04 01:39:22 CEST 2021 in 63 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:   4000 time(s), last: u-00001999 (Shadow u-00001999 (ACCOUNT - default - AccountObjectClass), 42ef3a32-35a6-4059-9e85-701b479b7fed) on Tue May 04 01:39:21 CEST 2021
    ADD        UserType                       http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001999 (User null (u-00001999), 6dd70e1f-728c-4434-a434-78380680bc63) on Tue May 04 01:39:21 CEST 2021
    MODIFY     UserType                       http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001999 (User null (u-00001999), 6dd70e1f-728c-4434-a434-78380680bc63) on Tue May 04 01:39:21 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), 42ef3a32-35a6-4059-9e85-701b479b7fed) on Tue May 04 01:39:21 CEST 2021
    ADD        UserType                       http://midpoint.evolveum.com/xml/ns/public/common/channels-3#import
      success:   2000 time(s), last: u-00001999 (User null (u-00001999), 6dd70e1f-728c-4434-a434-78380680bc63) on Tue May 04 01:39:21 CEST 2021

Environmental performance information:
  Provisioning:
    source-000 (AccountObjectClass)                              count:        1, total time:      276 ms [min:      0, max:      9, avg:   276.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:  20000, total time:  12381 ms [min:     0, max:   410, avg:     0.6]
  Last message: Successfully finished evaluation of mapping mapping in inbound expression for role in resource:931c59e1-dfa8-467a-b000-8fe00719204f(source-000) in 0 ms.
  On:           2021-05-04T01:39:22.011+02:00

Repository performance information:
  addObject.ShadowType:               count:   2000, total time:     9712 ms [min:     2, max:    64, avg:     4.9], wasted time for    8 retry/retries:      322 ms [min:     0, max:    59, avg:     0.2] (  3.32%)
  addObject.UserType:                 count:   2000, total time:    14731 ms [min:     4, max:    57, avg:     7.4], wasted time for   13 retry/retries:      498 ms [min:     0, max:    53, avg:     0.2] (  3.38%)
  fetchExtItems.RExtItem:             count:      5, total time:        9 ms [min:     1, max:     3, avg:     1.8]
  getObject.ArchetypeType:            count:      3, total time:       13 ms [min:     2, max:     6, avg:     4.3]
  getObject.ObjectTemplateType:       count:      1, total time:        2 ms [min:     2, max:     2, avg:     2.0]
  getObject.RoleType:                 count:      6, total time:       12 ms [min:     2, max:     2, avg:     2.0]
  getObject.ShadowType:               count:   6000, total time:     5739 ms [min:     0, max:    21, avg:     1.0]
  getObject.TaskType:                 count:      4, total time:       16 ms [min:     2, max:     9, avg:     4.0]
  getObject.UserType:                 count:  10004, total time:    13200 ms [min:     0, max:    42, avg:     1.3]
  modifyObject.ShadowType:            count:   8000, total time:    79971 ms [min:     3, max:  3265, avg:    10.0], wasted time for  678 retry/retries:    35444 ms [min:     0, max:  3260, avg:     4.4] ( 44.32%)
  modifyObject.TaskType:              count:     20, total time:      441 ms [min:    11, max:    55, avg:    22.0], wasted time for    1 retry/retries:       26 ms [min:     0, max:    26, avg:     1.3] (  5.90%)
  modifyObject.UserType:              count:   2000, total time:    18613 ms [min:     5, max:   131, avg:     9.3], wasted time for   52 retry/retries:     2059 ms [min:     0, max:   121, avg:     1.0] ( 11.06%)
  searchObjects.FunctionLibraryType:  count:      1, total time:        5 ms [min:     5, max:     5, avg:     5.0]
  searchObjects.ShadowType:           count:   2000, total time:     2112 ms [min:     0, max:    19, avg:     1.1]
  searchObjects.TaskType:             count:   6000, total time:    23893 ms [min:     1, max:    51, avg:     4.0]
  searchObjects.UserType:             count:   2000, total time:     1420 ms [min:     0, max:    18, avg:     0.7]
  searchShadowOwner.FocusType:        count:   2000, total time:     1429 ms [min:     0, max:    19, 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:   1997 ( 99.8%), weak hits:      0 (0.0%), misses:      3, 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:   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:      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:   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:     39 (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:     39, passes:      0, not available:      0

Methods performance information:
  class com.evolveum.midpoint.model.common.stringpolicy.ObjectValuePolicyEvaluator.validateValue:                                  count:   6000, total time:         5.5 ms [min:       0.0, max:       0.0, 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:  28000, total time:      6770.9 ms [min:       0.0, max:     398.9, avg:       0.2]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.SingleShotEvaluation.evaluateExpression:                  count:  12000, total time:       309.2 ms [min:       0.0, max:      33.7, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.ValueTupleTransformation.evaluate:                        count:  32000, total time:      4006.0 ms [min:       0.0, max:     384.6, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpression.evaluate:                                                  count:  36000, total time:      2007.0 ms [min:       0.0, max:     381.2, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpressionFactory.searchCustomFunctions:                              count:      1, total time:         7.1 ms [min:       7.1, max:       7.1, avg:       7.1]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluate:                                                                 count:  20000, total time:     12077.4 ms [min:       0.0, max:     409.8, avg:       0.6]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluatePrepared:                                                         count:  20000, total time:      8804.8 ms [min:       0.0, max:     408.6, avg:       0.4]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.prepare:                                                                  count:  20000, total time:      2929.4 ms [min:       0.0, max:      15.4, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute:                                                                    count:   4000, total time:     93382.5 ms [min:       0.1, max:    3321.0, avg:      23.3]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.focus.UserType:                                                     count:   4000, total time:     16922.1 ms [min:       0.1, max:      57.7, avg:       4.2]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.projection.ShadowType:                                              count:   2000, total time:     19953.4 ms [min:       5.2, max:     144.6, avg:      10.0]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.executeDelta:                                                               count:   4000, total time:     35138.0 ms [min:       4.3, max:     144.5, avg:       8.8]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.linkShadow:                                                                 count:   2000, total time:     18805.8 ms [min:       5.0, max:     130.4, avg:       9.4]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.updateSituationInShadow:                                                    count:   2000, total time:     37422.5 ms [min:       5.7, max:    3269.6, avg:      18.7]
  com.evolveum.midpoint.model.impl.lens.Clockwork.authorizeRequest:                                                                count:   2000, total time:        65.5 ms [min:       0.0, max:       1.9, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.Clockwork.click:                                                                           count:  10000, total time:    202490.5 ms [min:       1.2, max:    3341.6, avg:      20.2]
  com.evolveum.midpoint.model.impl.lens.Clockwork.execution:                                                                       count:   4000, total time:     93409.7 ms [min:       0.1, max:    3321.0, avg:      23.4]
  com.evolveum.midpoint.model.impl.lens.Clockwork.run:                                                                             count:   2000, total time:    202920.1 ms [min:      55.7, max:    3382.8, avg:     101.5]
  com.evolveum.midpoint.model.impl.lens.IvwoConsolidator.consolidateToDelta:                                                       count:  18000, total time:       365.2 ms [min:       0.0, max:      10.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.assignments.AssignmentEvaluator.evaluate:                                                  count:   4000, total time:      1342.4 ms [min:       0.1, max:      15.2, avg:       0.3]
  com.evolveum.midpoint.model.impl.lens.assignments.PathSegmentEvaluation.evaluate:                                                count:   8000, total time:      1476.5 ms [min:       0.0, max:      15.2, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.construction.EvaluatedResourceObjectConstructionImpl.evaluate:                             count:   2000, total time:        67.7 ms [min:       0.0, max:       5.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.construction.PlainResourceObjectConstruction.evaluate:                                     count:   2000, total time:       127.4 ms [min:       0.0, max:       5.5, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.ActivationProcessor.projectionActivation:                                        count:   4000, total time:        44.1 ms [min:       0.0, max:       0.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ConsolidationProcessor.consolidateValues:                                        count:   2000, total time:       272.9 ms [min:       0.0, max:      23.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.determineFocusContext:                                             count:  14000, total time:      8830.9 ms [min:       0.0, max:      42.4, avg:       0.6]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.load:                                                              count:   4000, total time:       413.3 ms [min:       0.0, max:      11.2, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.loadProjection:                                                    count:   4000, total time:        82.1 ms [min:       0.0, max:       4.5, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.DependencyProcessor.sortProjectionsToWaves:                                      count:   4000, total time:        33.5 ms [min:       0.0, max:      12.5, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ProjectionValuesProcessor.iteration:                                             count:   2000, total time:       834.5 ms [min:       0.2, max:      23.4, avg:       0.4]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.activation:                                                            count:   4000, total time:       360.5 ms [min:       0.0, max:       4.8, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignments:                                                           count:   4000, total time:     23876.4 ms [min:       2.9, max:      53.7, avg:       6.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsConflicts:                                                  count:   4000, total time:        34.1 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsMembershipAndDelegate:                                      count:   4000, total time:       512.1 ms [min:       0.0, max:      10.0, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsOrg:                                                        count:   4000, total time:        42.3 ms [min:       0.0, max:       0.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focus:                                                                 count:   4000, total time:     51356.0 ms [min:       4.9, max:     543.6, avg:      12.8]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusActivation:                                                       count:  12000, total time:       464.7 ms [min:       0.0, max:       9.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusCredentials:                                                      count:   4000, total time:       156.4 ms [min:       0.0, max:       5.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusLifecycle:                                                        count:   4000, total time:        10.9 ms [min:       0.0, max:       1.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusPolicyRules:                                                      count:   4000, total time:        77.1 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.inbound:                                                               count:   4000, total time:     23920.9 ms [min:       1.6, max:     478.5, avg:       6.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.load:                                                                  count:   4000, total time:       445.3 ms [min:       0.0, max:      11.2, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterAssignments:                                        count:   4000, total time:       470.0 ms [min:       0.0, max:      11.3, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterProjections:                                        count:   4000, total time:       475.9 ms [min:       0.0, max:       3.4, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateBeforeAssignments:                                       count:   4000, total time:       392.0 ms [min:       0.0, max:      13.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.project:                                                               count:   4000, total time:     54582.3 ms [min:       5.0, max:     577.9, avg:      13.6]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectProjection:                                                     count:   2000, total time:      1638.4 ms [min:       0.3, max:      23.9, avg:       0.8]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projection:                                                            count:   4000, total time:      1671.3 ms [min:       0.0, max:      23.9, avg:       0.4]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionCredentials:                                                 count:   2000, total time:       127.6 ms [min:       0.0, max:       4.9, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionLifecycle:                                                   count:   2000, total time:        26.9 ms [min:       0.0, max:      11.6, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionReconciliation:                                              count:   2000, total time:       202.8 ms [min:       0.0, max:       2.9, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValues:                                                      count:   2000, total time:      1048.5 ms [min:       0.2, max:      23.6, avg:       0.5]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValuesPostRecon:                                             count:   2000, total time:        72.7 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.distributeConstructions:                               count:   4000, total time:        47.1 ms [min:       0.0, max:       2.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.evaluateFocusMappings:                                 count:   4000, total time:       305.6 ms [min:       0.0, max:       6.4, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processAssignments:                                    count:   4000, total time:     23849.4 ms [min:       2.9, max:      53.6, avg:       6.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processProjections:                                    count:   4000, total time:       339.9 ms [min:       0.0, max:       6.0, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentTripleEvaluator.evaluateAssignment:                              count:   4000, total time:      1473.8 ms [min:       0.1, max:      15.3, avg:       0.4]
  com.evolveum.midpoint.model.impl.lens.projector.focus.PruningOperation.execute:                                                  count:   4000, total time:        17.0 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:       599.4 ms [min:       0.0, max:      10.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.policy.PolicyRuleEnforcer.execute:                                               count:   2000, total time:        31.5 ms [min:       0.0, max:       2.5, avg:       0.0]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.notifyChange:                                                   count:   4000, total time:    247252.6 ms [min:       3.1, max:    3616.1, avg:      61.8]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.setupSituation:                                                 count:   2000, total time:      4088.1 ms [min:       0.9, max:      25.6, avg:       2.0]
  com.evolveum.midpoint.model.impl.sync.SynchronizeAccountResultHandler.handle:                                                    count:   2000, total time:    234207.7 ms [min:      61.5, max:    3616.5, avg:     117.1]
  com.evolveum.midpoint.model.impl.util.AuditHelper.audit:                                                                         count:   4000, total time:     33724.6 ms [min:       1.6, max:      48.4, avg:       8.4]
  com.evolveum.midpoint.model.impl.util.AuditHelper.resolveName:                                                                   count:   4000, total time:       107.4 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.notifications.impl.NotificationHook.invoke:                                                                count:   8000, total time:         9.9 ms [min:       0.0, max:       0.6, avg:       0.0]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.countObjects:                                                         count:      1, total time:         7.0 ms [min:       7.0, max:       7.0, avg:       7.0]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.getObject:                                                            count:   4002, total time:     11564.8 ms [min:       0.7, max:      25.4, avg:       2.9]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.modifyObject:                                                         count:   4000, total time:     45087.7 ms [min:       3.5, max:    3266.4, avg:      11.3]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.searchObjectsIterative:                                               count:      1, total time:     39293.9 ms [min:   39293.9, max:   39293.9, avg:   39293.9]
  com.evolveum.midpoint.provisioning.impl.AccessChecker.accessCheck:                                                               count:   6000, total time:        37.7 ms [min:       0.0, max:       0.1, 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:     39289.7 ms [min:   39289.7, max:   39289.7, avg:   39289.7]
  com.evolveum.midpoint.provisioning.ucf.impl.connid.ConnIdConvertor.convertToResourceObject:                                      count:   2000, total time:       150.4 ms [min:       0.0, max:       8.1, avg:       0.1]
  com.evolveum.midpoint.repo.api.RepositoryService.addObject:                                                                      count:   4000, total time:     23565.1 ms [min:       2.6, max:      45.9, avg:       5.9]
  com.evolveum.midpoint.repo.api.RepositoryService.getObject:                                                                      count:  16018, total time:     18974.1 ms [min:       0.4, max:      42.0, avg:       1.2]
  com.evolveum.midpoint.repo.api.RepositoryService.modifyObject:                                                                   count:  10020, total time:     61906.8 ms [min:       2.7, max:      46.5, avg:       6.2]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjects:                                                                  count:  10001, total time:     27513.5 ms [min:       0.3, max:      50.9, avg:       2.8]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjectsIterative:                                                         count:      1, total time:         6.7 ms [min:       6.7, max:       6.7, avg:       6.7]
  com.evolveum.midpoint.repo.api.RepositoryService.searchShadowOwner:                                                              count:   2000, total time:      1409.5 ms [min:       0.3, max:      18.4, avg:       0.7]
  com.evolveum.midpoint.repo.cache.RepositoryCache.addObject:                                                                      count:   4000, total time:     24795.1 ms [min:       2.7, max:      64.8, avg:       6.2]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getObject:                                                                      count:  34001, total time:     24782.6 ms [min:       0.0, max:      42.1, avg:       0.7]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getVersion:                                                                     count:   8043, total time:        84.6 ms [min:       0.0, max:       0.8, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.invalidateCacheEntries:                                                         count:  14000, total time:       562.3 ms [min:       0.0, max:       5.5, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.modifyObject:                                                                   count:  10000, total time:     99333.6 ms [min:       3.1, max:    3265.3, avg:       9.9]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchObjects:                                                                  count:   4000, total time:      3891.5 ms [min:       0.3, max:      18.8, avg:       1.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchShadowOwner:                                                              count:   2000, total time:      1440.6 ms [min:       0.3, max:      18.5, avg:       0.7]
  com.evolveum.midpoint.schema.result.searchResult:                                                                                count:   2000, total time:     38710.9 ms [min:       8.5, max:     410.9, avg:      19.4]
  com.evolveum.midpoint.task.api.Task.getPathToRootTask:                                                                           count:   6000, total time:     30357.3 ms [min:       2.5, max:      52.3, avg:       5.1]
  com.evolveum.midpoint.task.api.TaskManager.createTaskInstance:                                                                   count:   6004, total time:      5306.2 ms [min:       0.4, max:      22.8, avg:       0.9]
  com.evolveum.midpoint.task.api.TaskManager.getTaskByIdentifier:                                                                  count:   6000, total time:     30282.9 ms [min:       2.5, max:      52.3, avg:       5.0]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskPlain:                                                        count:      4, total time:        24.1 ms [min:       2.9, max:      11.7, avg:       6.0]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskTypeByIdentifier:                                             count:   6000, total time:     24912.6 ms [min:       1.6, max:      51.1, avg:       4.2]
  com.evolveum.midpoint.wf.impl.hook.WfHook.invoke:                                                                                count:   8000, total time:       170.1 ms [min:       0.0, max:       5.1, avg:       0.0]
  com.evolveum.midpoint.wf.impl.processors.primary.PrimaryChangeProcessor.previewOrProcessModelInvocation:                         count:   2000, total time:        16.9 ms [min:       0.0, max:       0.5, avg:       0.0]
  interface com.evolveum.midpoint.notifications.api.NotificationManager.processEvent:                                              count:      1, total time:         0.3 ms [min:       0.3, max:       0.3, avg:       0.3]
  org.identityconnectors.framework.api.ConnectorFacade.search:                                                                     count:      1, total time:     39285.1 ms [min:   39285.1, max:   39285.1, avg:   39285.1]



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

Iterative task information:
  Successfully processed:   2000 in      74597 ms =     37.3 ms per object, last: ShadowType:u-00001999 (u-00001999 (ACCOUNT - default - AccountObjectClass), 42ef3a32-35a6-4059-9e85-701b479b7fed) on Tue May 04 01:39:35 CEST 2021 in 25 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), 42ef3a32-35a6-4059-9e85-701b479b7fed) on Tue May 04 01:39:35 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), 42ef3a32-35a6-4059-9e85-701b479b7fed) on Tue May 04 01:39:35 CEST 2021

Environmental performance information:
  Provisioning:
    source-000 (AccountObjectClass)                              count:        1, total time:      128 ms [min:      0, max:      1, avg:   128.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:  20000, total time:   9137 ms [min:     0, max:    25, avg:     0.5]
  Last message: Successfully finished evaluation of mapping mapping in inbound expression for role in resource:931c59e1-dfa8-467a-b000-8fe00719204f(source-000) in 0 ms.
  On:           2021-05-04T01:39:35.695+02:00

Repository performance information:
  getObject.ShadowType:         count:   2000, total time:     1287 ms [min:     0, max:     9, avg:     0.6]
  getObject.TaskType:           count:      4, total time:       12 ms [min:     1, max:     8, avg:     3.0]
  getObject.UserType:           count:   8004, total time:     7562 ms [min:     0, max:    26, avg:     0.9]
  modifyObject.ShadowType:      count:   2000, total time:    11387 ms [min:     3, max:    71, avg:     5.7], wasted time for    4 retry/retries:      152 ms [min:     0, max:    65, avg:     0.1] (  1.33%)
  modifyObject.TaskType:        count:     11, total time:      151 ms [min:     5, max:    34, avg:    13.7]
  searchObjects.ShadowType:     count:   2000, total time:     1851 ms [min:     0, max:    24, avg:     0.9]
  searchObjects.TaskType:       count:   6000, total time:    15662 ms [min:     0, max:    31, avg:     2.6]
  searchShadowOwner.FocusType:  count:   2000, total time:     3440 ms [min:     1, max:    22, avg:     1.7]

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:   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:      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:   2004 (100.0%), weak hits:      0 (0.0%), misses:      0, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.SystemConfigurationType:  hits:     12 (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:     12, 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:  40000, total time:      4560.8 ms [min:       0.0, max:      16.5, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.SingleShotEvaluation.evaluateExpression:                  count:  24000, total time:       239.5 ms [min:       0.0, max:       6.8, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.ValueTupleTransformation.evaluate:                        count:  32000, total time:      2162.2 ms [min:       0.0, max:      15.7, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpression.evaluate:                                                  count:  48000, total time:       302.3 ms [min:       0.0, max:       8.4, avg:       0.0]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluate:                                                                 count:  20000, total time:      8910.3 ms [min:       0.0, max:      24.6, avg:       0.4]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluatePrepared:                                                         count:  20000, total time:      5966.3 ms [min:       0.0, max:      16.8, avg:       0.3]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.prepare:                                                                  count:  20000, total time:      2696.0 ms [min:       0.0, max:      24.4, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute:                                                                    count:   4000, total time:      4908.8 ms [min:       0.0, max:      19.5, avg:       1.2]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.projection.ShadowType:                                              count:   2000, total time:      4873.8 ms [min:       1.6, max:      19.5, avg:       2.4]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.updateSituationInShadow:                                                    count:   2000, total time:      4835.1 ms [min:       1.6, max:      19.5, avg:       2.4]
  com.evolveum.midpoint.model.impl.lens.Clockwork.authorizeRequest:                                                                count:   2000, total time:         5.4 ms [min:       0.0, max:       1.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.Clockwork.click:                                                                           count:  10000, total time:     52417.8 ms [min:       0.0, max:      46.3, avg:       5.2]
  com.evolveum.midpoint.model.impl.lens.Clockwork.execution:                                                                       count:   4000, total time:      4935.4 ms [min:       0.0, max:      19.5, avg:       1.2]
  com.evolveum.midpoint.model.impl.lens.Clockwork.run:                                                                             count:   2000, total time:     52709.0 ms [min:      16.7, max:      82.0, avg:      26.4]
  com.evolveum.midpoint.model.impl.lens.IvwoConsolidator.consolidateToDelta:                                                       count:  18000, total time:       245.6 ms [min:       0.0, max:       8.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.assignments.AssignmentEvaluator.evaluate:                                                  count:   4000, total time:       804.6 ms [min:       0.1, max:       9.2, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.assignments.PathSegmentEvaluation.evaluate:                                                count:   8000, total time:       814.2 ms [min:       0.0, max:       9.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.construction.EvaluatedResourceObjectConstructionImpl.evaluate:                             count:   2000, total time:        32.2 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.construction.PlainResourceObjectConstruction.evaluate:                                     count:   2000, total time:        62.2 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ActivationProcessor.projectionActivation:                                        count:   4000, total time:        40.1 ms [min:       0.0, max:       8.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ConsolidationProcessor.consolidateValues:                                        count:   2000, total time:        62.7 ms [min:       0.0, max:       1.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.determineFocusContext:                                             count:  12000, total time:      3713.3 ms [min:       0.0, max:      26.2, avg:       0.3]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.load:                                                              count:   2000, total time:       215.8 ms [min:       0.0, max:       2.3, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.loadProjection:                                                    count:   2000, total time:        26.8 ms [min:       0.0, max:       1.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.DependencyProcessor.sortProjectionsToWaves:                                      count:   4000, total time:        12.8 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ProjectionValuesProcessor.iteration:                                             count:   2000, total time:       180.8 ms [min:       0.0, max:       1.5, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.activation:                                                            count:   4000, total time:       292.0 ms [min:       0.0, max:       8.3, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignments:                                                           count:   4000, total time:     15463.1 ms [min:       1.4, max:      29.5, avg:       3.9]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsConflicts:                                                  count:   4000, total time:        16.3 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsMembershipAndDelegate:                                      count:   4000, total time:        50.7 ms [min:       0.0, max:       7.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsOrg:                                                        count:   4000, total time:        22.2 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focus:                                                                 count:   4000, total time:     35114.2 ms [min:       3.7, max:      44.0, avg:       8.8]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusActivation:                                                       count:  12000, total time:       177.1 ms [min:       0.0, max:       0.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusCredentials:                                                      count:   4000, total time:        21.1 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusLifecycle:                                                        count:   4000, total time:         6.3 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusPolicyRules:                                                      count:   4000, total time:        74.7 ms [min:       0.0, max:      26.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.inbound:                                                               count:   4000, total time:     18782.7 ms [min:       1.6, max:      36.4, avg:       4.7]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.load:                                                                  count:   2000, total time:       228.1 ms [min:       0.1, max:       2.3, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterAssignments:                                        count:   4000, total time:        63.4 ms [min:       0.0, max:       6.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterProjections:                                        count:   4000, total time:        44.6 ms [min:       0.0, max:       1.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateBeforeAssignments:                                       count:   4000, total time:        68.7 ms [min:       0.0, max:       1.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.project:                                                               count:   4000, total time:     36305.1 ms [min:       3.8, max:      44.5, avg:       9.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectProjection:                                                     count:   2000, total time:       438.4 ms [min:       0.1, max:      13.0, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projection:                                                            count:   4000, total time:       464.0 ms [min:       0.0, max:      13.0, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionCredentials:                                                 count:   2000, total time:        42.9 ms [min:       0.0, max:      12.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionLifecycle:                                                   count:   2000, total time:         8.3 ms [min:       0.0, max:       0.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionReconciliation:                                              count:   2000, total time:        70.5 ms [min:       0.0, max:       1.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValues:                                                      count:   2000, total time:       207.0 ms [min:       0.0, max:       1.5, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValuesPostRecon:                                             count:   2000, total time:        16.4 ms [min:       0.0, max:       8.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.distributeConstructions:                               count:   4000, total time:        19.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:        53.3 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processAssignments:                                    count:   4000, total time:     15439.5 ms [min:       1.4, max:      29.5, avg:       3.9]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processProjections:                                    count:   4000, total time:        67.3 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentTripleEvaluator.evaluateAssignment:                              count:   4000, total time:       926.8 ms [min:       0.1, max:       9.2, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.focus.PruningOperation.execute:                                                  count:   4000, total time:         7.5 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:       398.9 ms [min:       0.1, max:       8.1, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.policy.PolicyRuleEnforcer.execute:                                               count:   2000, total time:        17.4 ms [min:       0.0, max:       4.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.notifyChange:                                                   count:   2000, total time:     73983.5 ms [min:      24.7, max:     122.5, avg:      37.0]
  com.evolveum.midpoint.model.impl.sync.SynchronizationServiceImpl.setupSituation:                                                 count:   2000, total time:      8527.2 ms [min:       2.9, max:      25.1, avg:       4.3]
  com.evolveum.midpoint.model.impl.sync.SynchronizeAccountResultHandler.handle:                                                    count:   2000, total time:     74619.8 ms [min:      24.9, max:     122.6, avg:      37.3]
  com.evolveum.midpoint.notifications.impl.NotificationHook.invoke:                                                                count:   8000, total time:         7.1 ms [min:       0.0, max:       0.2, 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:      4776.0 ms [min:       0.2, max:      19.5, avg:       2.4]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.searchObjectsIterative:                                               count:      1, total time:     12582.6 ms [min:   12582.6, max:   12582.6, avg:   12582.6]
  com.evolveum.midpoint.provisioning.impl.AccessChecker.accessCheck:                                                               count:   2000, total time:        14.7 ms [min:       0.0, max:       0.1, 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:     12582.1 ms [min:   12582.1, max:   12582.1, avg:   12582.1]
  com.evolveum.midpoint.provisioning.ucf.impl.connid.ConnIdConvertor.convertToResourceObject:                                      count:   2000, total time:       120.3 ms [min:       0.0, max:      10.1, avg:       0.1]
  com.evolveum.midpoint.repo.api.RepositoryService.getObject:                                                                      count:  10008, total time:      8856.5 ms [min:       0.3, max:      26.1, avg:       0.9]
  com.evolveum.midpoint.repo.api.RepositoryService.modifyObject:                                                                   count:   2011, total time:     11398.1 ms [min:       3.1, max:      34.2, avg:       5.7]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjects:                                                                  count:   8000, total time:     17492.2 ms [min:       0.5, max:      31.2, avg:       2.2]
  com.evolveum.midpoint.repo.api.RepositoryService.searchShadowOwner:                                                              count:   2000, total time:      3475.8 ms [min:       1.0, max:      22.8, avg:       1.7]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getObject:                                                                      count:  24001, total time:      8583.8 ms [min:       0.0, max:      26.2, avg:       0.4]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getVersion:                                                                     count:   2016, total time:        20.1 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.invalidateCacheEntries:                                                         count:   2000, total time:        39.4 ms [min:       0.0, max:       1.0, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.modifyObject:                                                                   count:   2000, total time:     11479.8 ms [min:       3.8, max:      70.4, avg:       5.7]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchObjects:                                                                  count:   2000, total time:      1935.9 ms [min:       0.5, max:      23.8, avg:       1.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchShadowOwner:                                                              count:   2000, total time:      8489.5 ms [min:       2.9, max:      25.1, avg:       4.2]
  com.evolveum.midpoint.schema.result.searchResult:                                                                                count:   2000, total time:     12240.7 ms [min:       1.0, max:      47.0, avg:       6.1]
  com.evolveum.midpoint.task.api.Task.getPathToRootTask:                                                                           count:   6000, total time:     20714.8 ms [min:       1.1, max:      31.9, avg:       3.5]
  com.evolveum.midpoint.task.api.TaskManager.createTaskInstance:                                                                   count:   6004, total time:      4144.8 ms [min:       0.4, max:      20.2, avg:       0.7]
  com.evolveum.midpoint.task.api.TaskManager.getTaskByIdentifier:                                                                  count:   6000, total time:     20679.7 ms [min:       1.1, max:      31.9, avg:       3.4]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskPlain:                                                        count:      4, total time:        15.3 ms [min:       1.4, max:       9.6, avg:       3.8]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskTypeByIdentifier:                                             count:   6000, total time:     16490.5 ms [min:       0.7, max:      31.3, avg:       2.7]
  com.evolveum.midpoint.wf.impl.hook.WfHook.invoke:                                                                                count:   8000, total time:        88.3 ms [min:       0.0, max:       1.0, avg:       0.0]
  com.evolveum.midpoint.wf.impl.processors.primary.PrimaryChangeProcessor.previewOrProcessModelInvocation:                         count:   2000, total time:         3.0 ms [min:       0.0, max:       0.2, 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:     12581.7 ms [min:   12581.7, max:   12581.7, avg:   12581.7]



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

Iterative task information:
  Successfully processed:   2000 in      49076 ms =     24.5 ms per object, last: null:u-00001518 (User null (u-00001518), fff5a23e-79f7-4cc2-a40d-54264c780a15) on Tue May 04 01:39:45 CEST 2021 in 19 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:      945 ms [min:      0, max:     16, 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:  20000, total time:   6095 ms [min:     0, max:    24, avg:     0.3]
  Last message: Successfully finished evaluation of mapping mapping in inbound expression for role in resource:931c59e1-dfa8-467a-b000-8fe00719204f(source-000) in 1 ms.
  On:           2021-05-04T01:39:45.006+02:00

Repository performance information:
  countObjects.UserType:               count:      1, total time:       11 ms [min:    11, max:    11, avg:    11.0]
  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:      3, total time:        3 ms [min:     1, max:     1, avg:     1.0]
  getObject.SystemConfigurationType:   count:      1, total time:        2 ms [min:     2, max:     2, avg:     2.0]
  getObject.TaskType:                  count:      4, total time:       12 ms [min:     1, max:     8, avg:     3.0]
  getObject.UserType:                  count:   8004, total time:    10012 ms [min:     0, max:    43, avg:     1.3]
  getVersion.ArchetypeType:            count:      1, total time:        0 ms [min:     0, max:     0, avg:     0.0]
  getVersion.ResourceType:             count:      2, total time:        2 ms [min:     1, max:     1, avg:     1.0]
  getVersion.SystemConfigurationType:  count:      1, total time:        1 ms [min:     1, max:     1, avg:     1.0]
  modifyObject.TaskType:               count:      9, total time:      123 ms [min:     5, max:    35, avg:    13.7]
  searchObjects.TaskType:              count:   6000, total time:    14726 ms [min:     0, max:    33, avg:     2.5]
  searchObjects.UserType:              count:     41, total time:     2311 ms [min:     1, max:   105, avg:    56.4]

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:   1998 ( 99.9%), weak hits:      1 (0.1%), 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:   1997 ( 99.8%), weak hits:      0 (0.0%), misses:      3, 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:      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:   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:   1998 ( 99.9%), weak hits:      0 (0.0%), misses:      2, passes:      0, not available:      0
  com.evolveum.midpoint.repo.cache.global.GlobalVersionCache.SystemConfigurationType:  hits:      7 ( 87.5%), weak hits:      0 (0.0%), misses:      1, 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:      8, 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:  40000, total time:      4445.1 ms [min:       0.0, max:      24.4, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.SingleShotEvaluation.evaluateExpression:                  count:  24000, total time:       239.7 ms [min:       0.0, max:      10.9, avg:       0.0]
  com.evolveum.midpoint.model.common.expression.evaluator.transformation.ValueTupleTransformation.evaluate:                        count:  32000, total time:      2185.3 ms [min:       0.0, max:      23.6, avg:       0.1]
  com.evolveum.midpoint.model.common.expression.script.ScriptExpression.evaluate:                                                  count:  48000, total time:       284.0 ms [min:       0.0, max:      10.9, avg:       0.0]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluate:                                                                 count:  20000, total time:      5966.2 ms [min:       0.0, max:      24.6, avg:       0.3]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.evaluatePrepared:                                                         count:  20000, total time:      5633.3 ms [min:       0.0, max:      24.6, avg:       0.3]
  com.evolveum.midpoint.model.common.mapping.MappingImpl.prepare:                                                                  count:  20000, total time:        89.2 ms [min:       0.0, max:       1.6, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute:                                                                    count:   4000, total time:       494.8 ms [min:       0.0, max:      23.7, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.execute.projection.ShadowType:                                              count:   2000, total time:       454.2 ms [min:       0.1, max:      23.7, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.ChangeExecutor.updateSituationInShadow:                                                    count:   2000, total time:       416.6 ms [min:       0.1, max:      23.7, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.Clockwork.authorizeRequest:                                                                count:   2000, total time:         3.3 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.Clockwork.click:                                                                           count:  10000, total time:     48589.5 ms [min:       0.0, max:      54.1, avg:       4.9]
  com.evolveum.midpoint.model.impl.lens.Clockwork.execution:                                                                       count:   4000, total time:       512.6 ms [min:       0.0, max:      23.7, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.Clockwork.run:                                                                             count:   2000, total time:     48837.6 ms [min:      13.6, max:      73.9, avg:      24.4]
  com.evolveum.midpoint.model.impl.lens.IvwoConsolidator.consolidateToDelta:                                                       count:  18000, total time:       236.0 ms [min:       0.0, max:       2.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.assignments.AssignmentEvaluator.evaluate:                                                  count:   4000, total time:       776.8 ms [min:       0.1, max:      28.5, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.assignments.PathSegmentEvaluation.evaluate:                                                count:   8000, total time:       753.0 ms [min:       0.0, max:      26.9, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.construction.EvaluatedResourceObjectConstructionImpl.evaluate:                             count:   2000, total time:        28.6 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.construction.PlainResourceObjectConstruction.evaluate:                                     count:   2000, total time:        59.7 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ActivationProcessor.projectionActivation:                                        count:   4000, total time:        29.6 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ConsolidationProcessor.consolidateValues:                                        count:   2000, total time:        60.1 ms [min:       0.0, max:       3.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.determineFocusContext:                                             count:  12000, total time:      4445.8 ms [min:       0.0, max:      42.2, avg:       0.4]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.load:                                                              count:   2000, total time:      6624.5 ms [min:       1.6, max:      29.5, avg:       3.3]
  com.evolveum.midpoint.model.impl.lens.projector.ContextLoader.loadProjection:                                                    count:   2000, total time:      3047.7 ms [min:       0.7, max:      17.1, avg:       1.5]
  com.evolveum.midpoint.model.impl.lens.projector.DependencyProcessor.sortProjectionsToWaves:                                      count:   4000, total time:        10.8 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.ProjectionValuesProcessor.iteration:                                             count:   2000, total time:       174.7 ms [min:       0.0, max:       3.5, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.activation:                                                            count:   4000, total time:        65.0 ms [min:       0.0, max:       8.6, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignments:                                                           count:   4000, total time:     15732.9 ms [min:       1.4, max:      34.6, avg:       3.9]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsConflicts:                                                  count:   4000, total time:        11.8 ms [min:       0.0, max:       0.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsMembershipAndDelegate:                                      count:   4000, total time:        35.9 ms [min:       0.0, max:       3.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.assignmentsOrg:                                                        count:   4000, total time:        17.8 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focus:                                                                 count:   4000, total time:     28564.0 ms [min:       3.4, max:      43.3, avg:       7.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusActivation:                                                       count:  12000, total time:       162.5 ms [min:       0.0, max:       1.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusCredentials:                                                      count:   4000, total time:        15.8 ms [min:       0.0, max:       0.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusLifecycle:                                                        count:   4000, total time:         3.7 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.focusPolicyRules:                                                      count:   4000, total time:        28.2 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.inbound:                                                               count:   4000, total time:     12111.8 ms [min:       1.8, max:      29.7, avg:       3.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.load:                                                                  count:   2000, total time:      6640.1 ms [min:       1.6, max:      29.5, avg:       3.3]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterAssignments:                                        count:   4000, total time:        73.6 ms [min:       0.0, max:       9.0, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateAfterProjections:                                        count:   4000, total time:        41.2 ms [min:       0.0, max:       2.8, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.objectTemplateBeforeAssignments:                                       count:   4000, total time:        67.3 ms [min:       0.0, max:       4.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.project:                                                               count:   4000, total time:     35905.3 ms [min:       3.5, max:      51.4, avg:       9.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectProjection:                                                     count:   2000, total time:       385.4 ms [min:       0.1, max:       6.6, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projection:                                                            count:   4000, total time:       446.3 ms [min:       0.0, max:      41.2, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionCredentials:                                                 count:   2000, total time:        31.0 ms [min:       0.0, max:       0.7, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionLifecycle:                                                   count:   2000, total time:         7.5 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionReconciliation:                                              count:   2000, total time:        69.2 ms [min:       0.0, max:       6.4, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValues:                                                      count:   2000, total time:       201.8 ms [min:       0.0, max:       3.5, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.Projector.projectionValuesPostRecon:                                             count:   2000, total time:         6.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:        12.1 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.evaluateFocusMappings:                                 count:   4000, total time:        40.2 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processAssignments:                                    count:   4000, total time:     15714.5 ms [min:       1.4, max:      34.6, avg:       3.9]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentProcessor.processProjections:                                    count:   4000, total time:        45.8 ms [min:       0.0, max:       0.3, avg:       0.0]
  com.evolveum.midpoint.model.impl.lens.projector.focus.AssignmentTripleEvaluator.evaluateAssignment:                              count:   4000, total time:       879.3 ms [min:       0.1, max:      28.5, avg:       0.2]
  com.evolveum.midpoint.model.impl.lens.projector.focus.PruningOperation.execute:                                                  count:   4000, total time:         7.6 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:       393.6 ms [min:       0.1, max:       5.5, avg:       0.1]
  com.evolveum.midpoint.model.impl.lens.projector.policy.PolicyRuleEnforcer.execute:                                               count:   2000, total time:         9.6 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.model.impl.sync.RecomputeTaskHandler.handle:                                                               count:   2000, total time:     48969.7 ms [min:      13.7, max:      73.9, avg:      24.5]
  com.evolveum.midpoint.notifications.impl.NotificationHook.invoke:                                                                count:   8000, total time:         5.1 ms [min:       0.0, max:       0.1, avg:       0.0]
  com.evolveum.midpoint.provisioning.api.ProvisioningService.getObject:                                                            count:   8000, total time:      6008.5 ms [min:       0.0, max:      23.7, avg:       0.8]
  com.evolveum.midpoint.provisioning.impl.AccessChecker.accessCheck:                                                               count:   4000, total time:        22.3 ms [min:       0.0, max:       0.2, avg:       0.0]
  com.evolveum.midpoint.provisioning.impl.ProvisioningContext.getConnectorInstance:                                                count:   4000, total time:       168.8 ms [min:       0.0, max:       5.3, avg:       0.0]
  com.evolveum.midpoint.provisioning.ucf.api.ConnectorInstance.fetchObject:                                                        count:   4000, total time:      2066.8 ms [min:       0.2, max:      20.5, avg:       0.5]
  com.evolveum.midpoint.provisioning.ucf.impl.connid.ConnIdConvertor.convertToResourceObject:                                      count:   4000, total time:       190.9 ms [min:       0.0, max:       4.3, avg:       0.0]
  com.evolveum.midpoint.repo.api.RepositoryService.countObjects:                                                                   count:      1, total time:        11.2 ms [min:      11.2, max:      11.2, avg:      11.2]
  com.evolveum.midpoint.repo.api.RepositoryService.getObject:                                                                      count:   8014, total time:     10056.3 ms [min:       0.3, max:      42.1, avg:       1.3]
  com.evolveum.midpoint.repo.api.RepositoryService.getVersion:                                                                     count:      4, total time:         2.1 ms [min:       0.4, max:       0.8, avg:       0.5]
  com.evolveum.midpoint.repo.api.RepositoryService.modifyObject:                                                                   count:      9, total time:       122.0 ms [min:       5.0, max:      34.2, avg:      13.6]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjects:                                                                  count:   6041, total time:     17032.4 ms [min:       0.6, max:     105.5, avg:       2.8]
  com.evolveum.midpoint.repo.api.RepositoryService.searchObjectsIterative:                                                         count:      1, total time:      8339.2 ms [min:    8339.2, max:    8339.2, avg:    8339.2]
  com.evolveum.midpoint.repo.cache.RepositoryCache.countObjects:                                                                   count:      1, total time:        11.5 ms [min:      11.5, max:      11.5, avg:      11.5]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getObject:                                                                      count:  28001, total time:      5007.1 ms [min:       0.0, max:      42.1, avg:       0.2]
  com.evolveum.midpoint.repo.cache.RepositoryCache.getVersion:                                                                     count:  16008, total time:        86.8 ms [min:       0.0, max:       1.5, avg:       0.0]
  com.evolveum.midpoint.repo.cache.RepositoryCache.searchObjectsIterative:                                                         count:      1, total time:      8339.9 ms [min:    8339.9, max:    8339.9, avg:    8339.9]
  com.evolveum.midpoint.task.api.Task.getPathToRootTask:                                                                           count:   6000, total time:     21438.9 ms [min:       1.1, max:      34.3, avg:       3.6]
  com.evolveum.midpoint.task.api.TaskManager.createTaskInstance:                                                                   count:   6004, total time:      5815.9 ms [min:       0.4, max:      31.5, avg:       1.0]
  com.evolveum.midpoint.task.api.TaskManager.getTaskByIdentifier:                                                                  count:   6000, total time:     21407.2 ms [min:       1.1, max:      34.3, avg:       3.6]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskPlain:                                                        count:      4, total time:        16.2 ms [min:       1.6, max:       9.7, avg:       4.0]
  com.evolveum.midpoint.task.quartzimpl.TaskManagerQuartzImpl.getTaskTypeByIdentifier:                                             count:   6000, total time:     15547.9 ms [min:       0.6, max:      33.6, avg:       2.6]
  com.evolveum.midpoint.wf.impl.hook.WfHook.invoke:                                                                                count:   8000, total time:        67.6 ms [min:       0.0, max:       0.3, 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:         6.4 ms [min:       6.4, max:       6.4, avg:       6.4]
  org.identityconnectors.framework.api.ConnectorFacade.getObject:                                                                  count:   4000, total time:      1032.1 ms [min:       0.1, max:      16.1, avg:       0.3]



