Uploaded image for project: 'Nuxeo Platform'
  1. Nuxeo Platform
  2. NXP-25047

Fix caching of collections 'group2group' and 'user2group' in MongoDB

    XMLWordPrintable

    Details

    • Type: Bug
    • Status: Resolved
    • Priority: Critical
    • Resolution: Not A Bug
    • Affects Version/s: 9.10, 10.1
    • Fix Version/s: None
    • Component/s: Core MongoDB, Performance
    • Tags:
    • Backlog priority:
      600
    • Sprint:
      nxFG 10.2.6, nxFG 10.2.7, nxFG 10.3.1, nxFG 10.3.2, nxFG 10.3.3, nxFG 10.3.4, nxFG 10.3.5, nxFG 10.3.10
    • Story Points:
      5

      Description

      It seems there is no caching for collections 'group2group' and 'user2group' in MongoDB. This can be a big performance killer with the new Web UI and documents with a lot of users in dc:contributors.
      How to reproduce:

      • fire up a Nuxeo instance with a mongoDB DB with logging of slow queries set to -1ms (to see all commands)
      • execute page provider default_search (i.e. with curl) with HTTP header fetch.document:properties
      • in the MongoDB logs, accesses to collections 'group2group' and 'user2group' are shown
      • execute again page provider default_search with HTTP header fetch.document:properties
        in the MongoDB logs, accesses to collections 'group2group' and 'user2group' are again shown

      This is a problem with the new Web UI because most of the time, page providers are executed with HTTP header fetch.document:properties, which calls resolver for property dc:contributors, which retrieves the group(s) of users mentioned in property dc:contributors, which is actually never needed when lsiting documents.

      See logs below:

      2018-05-21T16:04:36.846-0700 I COMMAND  [conn3] command admin.$cmd command: isMaster { ismaster: 1 } numYields:0 reslen:189 locks:{} protocol:op_query 0ms
      2018-05-21T16:04:36.855-0700 I COMMAND  [conn9] command nuxeo.userDirectory command: find { find: "userDirectory", filter: { username: "Administrator" }, limit: 1, singleBatch: true } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:336 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.856-0700 I COMMAND  [conn9] command nuxeo.digestauth command: find { find: "digestauth", filter: { username: "Administrator" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:204 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.874-0700 I COMMAND  [conn9] command nuxeo.default command: find { find: "default", filter: { $and: [ { ecm:id: { $in: [ "470b7d43-d8cc-42d6-8760-edf648c48b3f", "c2e58bd8-5b7b-4ba1-8cea-53a0b5eb5683", "30fca324-5121-4f20-add2-2bd4c4d94185", "909e87a7-5f4b-4d53-aee6-e688683bd2ba", "9c1bdd84-e3d3-4103-830e-475c80b65c5f", "74fd0335-e42d-4bf8-a10a-5ab4e80ff96a", "aec66a78-7199-4653-8b47-adabc9ae5426" ] } }, { ecm:primaryType: { $in: [ "TemplateRoot", "DocumentRouteModelsRoot", "Build_pp", "SimpleTask", "CommentRoot", "Document", "RoutingTask", "Picture", "PublicationRelation", "Carousel_pp", "SubmissionProduct", "SubmissionPublishing", "Submission_pp", "StyleGuide", "Character_pp", "NXService", "Note", "AnnotationRelation", "ManagementRoot", "Contract", "Favorites", "WBCPAssetSearchAdmin_pp", "TaskRoot", "StyleGuide_pp", "NXDocumentation", "SavedSearch", "AdvancedContent", "PermissionsSearch", "UserInvitationContainer", "UserWorkspacesRoot", "Folder", "BasicAuditSearch", "Attraction_pp", "LicenseeCode", "Season", "WBCPPublishing_pp", "Property", "StepFolder", "NXDistribution", "PictureBook", "DocumentRouteInstancesRoot", "NXSeamComponent", "ProductDetail", "Submission", "Area_pp", "Season_pp", "NXExtensionPoint", "HiddenFolder", "Section", "ExpiredSearch", "Tagging", "RelationSearch", "user_open_tasks_cv", "Tag", "Audio", "Licensee_pp", "AssetsSearch", "HelpCategory", "Carousel", "WBCPAsset", "NXBundleGroup", "SubmissionPackaging", "SubmissionGTE", "ConditionalTask", "NXContribution", "Build", "WBCPAssetSearchPublic_pp", "UserInvitation", "Collections", "Licensee", "Territory", "DefaultRelation", "Character", "RouteNode", "DocumentRoute", "HelpObject_pp", "StoredRenditionSearch", "Area", "Video", "Collection", "AdvancedSearch", "Domain", "NXComponent", "File", "OrderedFolder", "TaskDoc", "UserProfile", "FollowLifeCycleTransitionTask", "CommentRelation", "HelpObject", "NXOperation", "DocumentRouteStep", "WBCPAsset_pp", "WorkspaceRoot", "Acknowledgement", "PublishTask", "Relation", "Feedback", "LicenseeCode_pp", "Property_pp", "Comment", "Attraction", "DefaultSearch", "NXBundle", "AdministrativeStatus", "SectionRoot", "AdministrativeStatusContainer", "ConditionalStepFolder", "WBCPPublishingSource_pp", "Contract_pp", "ProductDetail_pp", "SubmissionMarketing", "Workspace", "Location", "Location_pp" ] } } ] }, projection: { ecm:id: 1.0, ecm:parentId: 1.0, ecm:name: 1.0 } } planSummary: IXSCAN { ecm:id: 1 } keysExamined:14 docsExamined:7 cursorExhausted:1 numYields:0 nreturned:7 reslen:1157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.875-0700 I COMMAND  [conn9] command nuxeo.default command: find { find: "default", filter: { ecm:id: { $in: [ "30fca324-5121-4f20-add2-2bd4c4d94185", "470b7d43-d8cc-42d6-8760-edf648c48b3f", "74fd0335-e42d-4bf8-a10a-5ab4e80ff96a", "909e87a7-5f4b-4d53-aee6-e688683bd2ba", "9c1bdd84-e3d3-4103-830e-475c80b65c5f", "aec66a78-7199-4653-8b47-adabc9ae5426", "c2e58bd8-5b7b-4ba1-8cea-53a0b5eb5683" ] } } } planSummary: IXSCAN { ecm:id: 1 } keysExamined:14 docsExamined:7 cursorExhausted:1 numYields:0 nreturned:7 reslen:12744 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.877-0700 I COMMAND  [conn9] command nuxeo.default command: find { find: "default", filter: { ecm:id: "08d61e81-85c3-41c8-a73b-4129e0186b75" } } planSummary: IXSCAN { ecm:id: 1 } keysExamined:1 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:1110 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.878-0700 I COMMAND  [conn9] command nuxeo.default command: find { find: "default", filter: { ecm:id: "d9927ced-637c-4fd1-ad4a-83c9a18d1fbb" } } planSummary: IXSCAN { ecm:id: 1 } keysExamined:1 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:897 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.878-0700 I COMMAND  [conn9] command nuxeo.default command: find { find: "default", filter: { ecm:id: "721ed8a2-edf8-41d6-a73d-e20aabcab3f8" } } planSummary: IXSCAN { ecm:id: 1 } keysExamined:1 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:1194 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.885-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.886-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.886-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.887-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.888-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.889-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.890-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.891-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.892-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.893-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.894-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.895-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.896-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.897-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.898-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.898-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.899-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.899-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.900-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.900-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.901-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.901-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.901-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.902-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.903-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.903-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.903-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.904-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.904-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.904-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.905-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.906-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:1 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 4 } }, Database: { acquireCount: { r: 2 } }, Collection: { acquireCount: { r: 2 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.907-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.907-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.908-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.908-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.910-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.911-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.911-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.912-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.912-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.912-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.913-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.913-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.914-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.914-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.914-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.915-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.915-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.916-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.916-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.917-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.917-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.917-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.918-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.918-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.919-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.919-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.919-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.920-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.921-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.921-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.922-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.922-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.923-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.923-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.923-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.924-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.924-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.925-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.925-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.925-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.927-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.927-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.927-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.928-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.928-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.929-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.929-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.929-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.930-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.930-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.930-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.930-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.931-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.932-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.932-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.932-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.932-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.933-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.933-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.933-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.934-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.934-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.934-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.935-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.935-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.936-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.936-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.936-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.937-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.937-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.937-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.937-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.938-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.938-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.938-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.938-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.939-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.939-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.940-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.940-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.940-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.941-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.941-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.941-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.942-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.942-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.942-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.943-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.944-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.945-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.945-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.946-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.946-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.947-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.947-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.947-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.948-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.948-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.948-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.948-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.949-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.949-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.949-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.949-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.950-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.950-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.950-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.950-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.951-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.951-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.951-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.952-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.952-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.952-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.952-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.953-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.953-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.953-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.954-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.954-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.954-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.955-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.955-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.955-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.956-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.956-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.956-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.957-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.957-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.957-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.957-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.958-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.958-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.959-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.959-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.960-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.961-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.961-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.961-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.961-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.962-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.962-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.963-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.963-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.963-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.963-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.964-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.964-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.964-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.965-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.965-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.965-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.966-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.966-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.966-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.966-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.967-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.967-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.968-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.968-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.968-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.969-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.969-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.969-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.970-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.970-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.970-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.971-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.971-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.971-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.971-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.972-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.972-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.973-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.973-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.973-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.974-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.974-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.974-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.975-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.979-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.979-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.980-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.980-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.981-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.981-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.982-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.982-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.983-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.983-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.984-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.984-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.985-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.985-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.985-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.985-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.986-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.986-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.987-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.987-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.987-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.988-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.988-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.988-0700 I COMMAND  [conn5] command admin.$cmd command: isMaster { ismaster: 1 } numYields:0 reslen:189 locks:{} protocol:op_query 0ms
      2018-05-21T16:04:36.988-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.989-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.989-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.989-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.990-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.993-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.994-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.995-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.996-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.997-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.997-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.998-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.998-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.998-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.999-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.999-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.999-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:36.999-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.000-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.000-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.000-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.001-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.002-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.002-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.002-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.003-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.003-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.003-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.003-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.004-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.004-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.005-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.005-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.005-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.006-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.006-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.006-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.007-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:212 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.007-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.007-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:100 reslen:6686 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.008-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.008-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "members2" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:5 cursorExhausted:1 numYields:0 nreturned:1 reslen:157 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.008-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.008-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:0 reslen:104 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.009-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "members2" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:1 reslen:184 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.011-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.012-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.012-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.013-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.013-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.014-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.016-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.016-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.017-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.017-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.017-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.017-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.018-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.018-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.019-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.019-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.019-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.020-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.020-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.020-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.020-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.021-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.021-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.021-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.022-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_01" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:3 cursorExhausted:1 numYields:0 nreturned:1 reslen:231 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.022-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.022-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.023-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_01" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.023-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "TEST_Group_02" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:4 cursorExhausted:1 numYields:0 nreturned:1 reslen:228 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.023-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.023-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:182 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.023-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "TEST_Group_02" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.024-0700 I COMMAND  [conn9] command nuxeo.groupDirectory command: find { find: "groupDirectory", filter: { groupname: "administrators" }, limit: 1 } planSummary: COLLSCAN keysExamined:0 docsExamined:2 cursorExhausted:1 numYields:0 nreturned:1 reslen:221 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.024-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { childGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.024-0700 I COMMAND  [conn9] command nuxeo.user2group command: find { find: "user2group", filter: { groupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:103 cursorExhausted:1 numYields:0 nreturned:1 reslen:183 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      2018-05-21T16:04:37.025-0700 I COMMAND  [conn9] command nuxeo.group2group command: find { find: "group2group", filter: { parentGroupId: "administrators" } } planSummary: COLLSCAN keysExamined:0 docsExamined:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:105 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 0ms
      

        Attachments

          Activity

            People

            • Votes:
              0 Vote for this issue
              Watchers:
              6 Start watching this issue

              Dates

              • Created:
                Updated:
                Resolved:

                Time Tracking

                Estimated:
                Original Estimate - Not Specified
                Not Specified
                Remaining:
                Remaining Estimate - 0 minutes
                0m
                Logged:
                Time Spent - 3 hours
                3h