Uploaded image for project: 'Core Server'
  1. Core Server
  2. SERVER-55548

resmoke.py reports stale "Fixture status" message during fixture teardown

    • Fully Compatible
    • ALL
    • v5.0
    • STM 2021-06-14
    • 2

      The "Fixture status" prefix is cached before the test is run. However, hooks such as CleanEveryN and ContinuousStepdown may restart the MongoDB processes. This leads the teardown fixture test case to log the former pids of the MongoDB processes and can be confusing for Server engineers.

      [j2:rs0:n0] | 2021-03-24T17:14:08.089+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":27107,"port":20500,"dbPath":"/data/db/job2/rs0/node0","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [j2:rs0:n1] | 2021-03-24T17:14:09.516+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":27185,"port":20501,"dbPath":"/data/db/job2/rs0/node1","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [j2:rs0:n2] | 2021-03-24T17:14:09.656+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":27265,"port":20502,"dbPath":"/data/db/job2/rs0/node2","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [j2:rs1:n1] | 2021-03-24T17:14:30.891+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":31358,"port":20504,"dbPath":"/data/db/job2/rs1/node1","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [j2:rs1:n0] | 2021-03-24T17:14:30.465+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":31300,"port":20503,"dbPath":"/data/db/job2/rs1/node0","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [j2:rs1:n2] | 2021-03-24T17:14:33.182+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":31498,"port":20505,"dbPath":"/data/db/job2/rs1/node2","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [js_test:explain5] Fixture status:
      |ReplicaSetFixture:job2:rs0:node0|j2:rs0:n0|20500|27107|
      |ReplicaSetFixture:job2:rs0:node1|j2:rs0:n1|20501|27185|
      |ReplicaSetFixture:job2:rs0:node2|j2:rs0:n2|20502|27265|
      |ReplicaSetFixture:job2:rs1:node0|j2:rs1:n0|20503|31300|
      |ReplicaSetFixture:job2:rs1:node1|j2:rs1:n1|20504|31358|
      |ReplicaSetFixture:job2:rs1:node2|j2:rs1:n2|20505|31498|
      [ContinuousStepdown:job2] Fixture status:
      |ReplicaSetFixture:job2:rs0:node0|j2:rs0:n0|20500|2479 |
      |ReplicaSetFixture:job2:rs0:node1|j2:rs0:n1|20501|27185|
      |ReplicaSetFixture:job2:rs0:node2|j2:rs0:n2|20502|27265|
      |ReplicaSetFixture:job2:rs1:node0|j2:rs1:n0|20503|31300|
      |ReplicaSetFixture:job2:rs1:node1|j2:rs1:n1|20504|31358|
      |ReplicaSetFixture:job2:rs1:node2|j2:rs1:n2|20505|31498|
      [j2:rs0:n0] | 2021-03-24T17:14:47.600+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":2479,"port":20500,"dbPath":"/data/db/job2/rs0/node0","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [ContinuousStepdown:job2] Fixture status:
      |ReplicaSetFixture:job2:rs0:node0|j2:rs0:n0|20500|2479 |
      |ReplicaSetFixture:job2:rs0:node1|j2:rs0:n1|20501|27185|
      |ReplicaSetFixture:job2:rs0:node2|j2:rs0:n2|20502|6812 |
      |ReplicaSetFixture:job2:rs1:node0|j2:rs1:n0|20503|31300|
      |ReplicaSetFixture:job2:rs1:node1|j2:rs1:n1|20504|31358|
      |ReplicaSetFixture:job2:rs1:node2|j2:rs1:n2|20505|31498|
      [j2:rs0:n2] | 2021-03-24T17:15:18.748+00:00 I  CONTROL  4615611 [initandlisten] "MongoDB starting","attr":{"pid":6812,"port":20502,"dbPath":"/data/db/job2/rs0/node2","architecture":"64-bit","host":"ip-10-122-66-208.ec2.internal"}
      [js_test:elemmatch_object] Fixture status:
      |ReplicaSetFixture:job2:rs0:node0|j2:rs0:n0|20500|27107|
      |ReplicaSetFixture:job2:rs0:node1|j2:rs0:n1|20501|27185|
      |ReplicaSetFixture:job2:rs0:node2|j2:rs0:n2|20502|27265|
      |ReplicaSetFixture:job2:rs1:node0|j2:rs1:n0|20503|31300|
      |ReplicaSetFixture:job2:rs1:node1|j2:rs1:n1|20504|31358|
      |ReplicaSetFixture:job2:rs1:node2|j2:rs1:n2|20505|31498|
      [js_test:job2_fixture_teardown] Fixture status:
      |ReplicaSetFixture:job2:rs0:node0|j2:rs0:n0|20500|27107|
      |ReplicaSetFixture:job2:rs0:node1|j2:rs0:n1|20501|27185|
      |ReplicaSetFixture:job2:rs0:node2|j2:rs0:n2|20502|27265|
      |ReplicaSetFixture:job2:rs1:node0|j2:rs1:n0|20503|31300|
      |ReplicaSetFixture:job2:rs1:node1|j2:rs1:n1|20504|31358|
      |ReplicaSetFixture:job2:rs1:node2|j2:rs1:n2|20505|31498|
      

      https://logkeeper.mongodb.org/lobster/build/dd2650c233841c284457e4a5df2d76d1/all#bookmarks=0%2C47851%2C47852%2C47853%2C48185%2C48186%2C48187%2C54129%2C54130%2C54131%2C65990%2C65991%2C65992%2C78604%2C78605%2C78606%2C79341&f~=100~%28Fixture%20status%7C%5C%7CReplicaSetFixture%7CMongoDB%20starting%29&l=1

            Assignee:
            robert.guo@mongodb.com Robert Guo (Inactive)
            Reporter:
            max.hirschhorn@mongodb.com Max Hirschhorn
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

              Created:
              Updated:
              Resolved: