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

Test logs consist of 3 lines (starting/pid/finished) on enterprise-rhel-80-64-bit* build variant

    • Type: Icon: Bug Bug
    • Resolution: Fixed
    • Priority: Icon: Major - P3 Major - P3
    • 5.2.0
    • Affects Version/s: None
    • Component/s: None
    • Labels:
      None
    • Fully Compatible
    • v5.1

      Failed execution task
      Successful test consists of 3 lines:

      [2021/10/06 10:49:18.931] [js_test:3_upgrade_replset] Starting JSTest jstests/multiVersion/genericSetFCVUsage/3_upgrade_replset.js...
      [2021/10/06 10:49:18.931] PATH=/data/mci/2e566072cd8ee4ec281b7cf062a3582c/src:/data/multiversion:/data/mci/2e566072cd8ee4ec281b7cf062a3582c/src/dist-test/bin:/data/mci/2e566072cd8ee4ec281b7cf062a3582c/venv/bin:/home/ec2-user/.local/bin:/home/ec2-user/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/opt/node/bin:/opt/node/bin:/data/multiversion INSTALL_DIR=/data/mci/2e566072cd8ee4ec281b7cf062a3582c/src/dist-test/bin /data/mci/2e566072cd8ee4ec281b7cf062a3582c/src/dist-test/bin/mongo --eval 'TestData = new Object(); TestData["auth"] = true; TestData["authMechanism"] = "SCRAM-SHA-1"; TestData["keyFile"] = "jstests/libs/authTestsKey"; TestData["keyFileData"] = "Thiskeyisonlyforrunningthesuitewithauthenticationdontuseitinanytestsdirectly"; TestData["minPort"] = 20270; TestData["maxPort"] = 20499; TestData["peerPids"] = []; TestData["alwaysUseLogFiles"] = false; TestData["failIfUnterminatedProcesses"] = true; TestData["implicitlyShardOnCreateCollectionOnly"] = false; TestData["isMainTest"] = true; TestData["numTestClients"] = 1; TestData["backupOnRestartDir"] = null; TestData["enableMajorityReadConcern"] = true; TestData["mixedBinVersions"] = ""; TestData["noJournal"] = false; TestData["storageEngine"] = "wiredTiger"; TestData["storageEngineCacheSizeGB"] = "1"; TestData["testName"] = "3_upgrade_replset"; TestData["transportLayer"] = ""; TestData["wiredTigerCollectionConfigString"] = ""; TestData["wiredTigerEngineConfigString"] = ""; TestData["wiredTigerIndexConfigString"] = ""; TestData["inEvergreen"] = true; TestData["evergreenTaskId"] = "mongodb_mongo_master_enterprise_rhel_80_64_bit_single_task_baseline_multiversion_auth_0_enterprise_rhel_80_64_bit_single_task_baseline_e4ebcccefb481fac9109417610828c2360149191_21_10_06_07_30_20"; TestData["setParameters"] = new Object(); TestData["setParameters"]["logComponentVerbosity"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["replication"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["replication"]["election"] = 4; TestData["setParameters"]["logComponentVerbosity"]["replication"]["heartbeats"] = 2; TestData["setParameters"]["logComponentVerbosity"]["replication"]["initialSync"] = 2; TestData["setParameters"]["logComponentVerbosity"]["replication"]["rollback"] = 2; TestData["setParameters"]["logComponentVerbosity"]["sharding"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["sharding"]["migration"] = 2; TestData["setParameters"]["logComponentVerbosity"]["storage"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["storage"]["recovery"] = 2; TestData["setParameters"]["logComponentVerbosity"]["transaction"] = 4; TestData["setParameters"]["logComponentVerbosity"]["tenantMigration"] = 4; TestData["setParameters"]["reshardingMinimumOperationDurationMillis"] = 5000; TestData["setParametersMongos"] = new Object(); TestData["setParametersMongos"]["logComponentVerbosity"] = new Object(); TestData["setParametersMongos"]["logComponentVerbosity"]["transaction"] = 3; TestData["setParametersMongocryptd"] = new Object(); TestData["undoRecorderPath"] = null; TestData["transactionLifetimeLimitSeconds"] = 86400; MongoRunner.dataDir = "/data/db/job1/mongorunner"; MongoRunner.dataPath = "/data/db/job1/mongorunner/"; load('"'"'jstests/libs/override_methods/validate_collections_on_shutdown.js'"'"');; load('"'"'jstests/libs/override_methods/check_uuids_consistent_across_cluster.js'"'"');; load('"'"'jstests/libs/override_methods/check_indexes_consistent_across_cluster.js'"'"');; load('"'"'jstests/libs/override_methods/check_orphans_are_deleted.js'"'"');; load('"'"'jstests/libs/override_methods/implicitly_retry_on_background_op_in_progress.js'"'"');; (function() { Timestamp.prototype.toString = function() { throw new Error("Cannot toString timestamps. Consider using timestampCmp() for comparison or tojson(<variable>) for output."); } })();' --authenticationDatabase=local --authenticationMechanism=SCRAM-SHA-1 --nodb --password=Thiskeyisonlyforrunningthesuitewithauthenticationdontuseitinanytestsdirectly --username=__system jstests/multiVersion/genericSetFCVUsage/3_upgrade_replset.js
      [2021/10/06 10:49:18.949] [js_test:3_upgrade_replset] JSTest jstests/multiVersion/genericSetFCVUsage/3_upgrade_replset.js started with pid 28412.
      [2021/10/06 10:51:13.425] [js_test:3_upgrade_replset] JSTest jstests/multiVersion/genericSetFCVUsage/3_upgrade_replset.js finished.
      

      Luckily, 3_upgrade_replset.js test logs are present in all job logs.

      Same is true for failed test - it consists of 2 lines (Starting/pid):

      [2021/10/06 10:51:13.489] [js_test:remove_invalid_index_options] Starting JSTest jstests/multiVersion/remove_invalid_index_options.js...
      [2021/10/06 10:51:13.489] PATH=/data/mci/2e566072cd8ee4ec281b7cf062a3582c/src:/data/multiversion:/data/mci/2e566072cd8ee4ec281b7cf062a3582c/src/dist-test/bin:/data/mci/2e566072cd8ee4ec281b7cf062a3582c/venv/bin:/home/ec2-user/.local/bin:/home/ec2-user/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/opt/node/bin:/opt/node/bin:/data/multiversion INSTALL_DIR=/data/mci/2e566072cd8ee4ec281b7cf062a3582c/src/dist-test/bin /data/mci/2e566072cd8ee4ec281b7cf062a3582c/src/dist-test/bin/mongo --eval 'TestData = new Object(); TestData["auth"] = true; TestData["authMechanism"] = "SCRAM-SHA-1"; TestData["keyFile"] = "jstests/libs/authTestsKey"; TestData["keyFileData"] = "Thiskeyisonlyforrunningthesuitewithauthenticationdontuseitinanytestsdirectly"; TestData["minPort"] = 20270; TestData["maxPort"] = 20499; TestData["peerPids"] = []; TestData["alwaysUseLogFiles"] = false; TestData["failIfUnterminatedProcesses"] = true; TestData["implicitlyShardOnCreateCollectionOnly"] = false; TestData["isMainTest"] = true; TestData["numTestClients"] = 1; TestData["backupOnRestartDir"] = null; TestData["enableMajorityReadConcern"] = true; TestData["mixedBinVersions"] = ""; TestData["noJournal"] = false; TestData["storageEngine"] = "wiredTiger"; TestData["storageEngineCacheSizeGB"] = "1"; TestData["testName"] = "remove_invalid_index_options"; TestData["transportLayer"] = ""; TestData["wiredTigerCollectionConfigString"] = ""; TestData["wiredTigerEngineConfigString"] = ""; TestData["wiredTigerIndexConfigString"] = ""; TestData["inEvergreen"] = true; TestData["evergreenTaskId"] = "mongodb_mongo_master_enterprise_rhel_80_64_bit_single_task_baseline_multiversion_auth_0_enterprise_rhel_80_64_bit_single_task_baseline_e4ebcccefb481fac9109417610828c2360149191_21_10_06_07_30_20"; TestData["setParameters"] = new Object(); TestData["setParameters"]["logComponentVerbosity"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["replication"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["replication"]["election"] = 4; TestData["setParameters"]["logComponentVerbosity"]["replication"]["heartbeats"] = 2; TestData["setParameters"]["logComponentVerbosity"]["replication"]["initialSync"] = 2; TestData["setParameters"]["logComponentVerbosity"]["replication"]["rollback"] = 2; TestData["setParameters"]["logComponentVerbosity"]["sharding"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["sharding"]["migration"] = 2; TestData["setParameters"]["logComponentVerbosity"]["storage"] = new Object(); TestData["setParameters"]["logComponentVerbosity"]["storage"]["recovery"] = 2; TestData["setParameters"]["logComponentVerbosity"]["transaction"] = 4; TestData["setParameters"]["logComponentVerbosity"]["tenantMigration"] = 4; TestData["setParameters"]["reshardingMinimumOperationDurationMillis"] = 5000; TestData["setParametersMongos"] = new Object(); TestData["setParametersMongos"]["logComponentVerbosity"] = new Object(); TestData["setParametersMongos"]["logComponentVerbosity"]["transaction"] = 3; TestData["setParametersMongocryptd"] = new Object(); TestData["undoRecorderPath"] = null; TestData["transactionLifetimeLimitSeconds"] = 86400; MongoRunner.dataDir = "/data/db/job1/mongorunner"; MongoRunner.dataPath = "/data/db/job1/mongorunner/"; load('"'"'jstests/libs/override_methods/validate_collections_on_shutdown.js'"'"');; load('"'"'jstests/libs/override_methods/check_uuids_consistent_across_cluster.js'"'"');; load('"'"'jstests/libs/override_methods/check_indexes_consistent_across_cluster.js'"'"');; load('"'"'jstests/libs/override_methods/check_orphans_are_deleted.js'"'"');; load('"'"'jstests/libs/override_methods/implicitly_retry_on_background_op_in_progress.js'"'"');; (function() { Timestamp.prototype.toString = function() { throw new Error("Cannot toString timestamps. Consider using timestampCmp() for comparison or tojson(<variable>) for output."); } })();' --authenticationDatabase=local --authenticationMechanism=SCRAM-SHA-1 --nodb --password=Thiskeyisonlyforrunningthesuitewithauthenticationdontuseitinanytestsdirectly --username=__system jstests/multiVersion/remove_invalid_index_options.js
      [2021/10/06 10:51:13.507] [js_test:remove_invalid_index_options] JSTest jstests/multiVersion/remove_invalid_index_options.js started with pid 7501.
      

      Luckily, there's a workaround - failed test logs could be found in all job logs.

            Assignee:
            robert.guo@mongodb.com Robert Guo (Inactive)
            Reporter:
            sviatlana.zuiko@mongodb.com Sviatlana Zuiko
            Votes:
            0 Vote for this issue
            Watchers:
            6 Start watching this issue

              Created:
              Updated:
              Resolved: