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

confusing protocol version 0 warning message while configuring a replica set for the first time

    • Type: Icon: Improvement Improvement
    • Resolution: Done
    • Priority: Icon: Minor - P4 Minor - P4
    • 3.2.0-rc2
    • Affects Version/s: 3.2.0-rc1
    • Component/s: Replication
    • None
    • Fully Compatible
    • Repl B (10/30/15)

      Example from nightly build:

      https://logkeeper.mongodb.org/build/562f6ea5be07c42d838f19cb/test/562f6ea59041304df68f3989

      	
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 [
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 	connection to build10.ny.cbi.10gen.cc:22760,
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 	connection to build10.ny.cbi.10gen.cc:22761,
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 	connection to build10.ny.cbi.10gen.cc:22762
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 ]
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 {
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 	"replSetInitiate" : {
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 		"_id" : "stepDownWithLongWait",
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.383-0400 		"members" : [
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.384-0400 			{
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.384-0400 				"_id" : 0,
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.384-0400 				"host" : "build10.ny.cbi.10gen.cc:22760",
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.384-0400 				"priority" : 3
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.384-0400 			},
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.384-0400 			{
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.384-0400 				"_id" : 1,
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 				"host" : "build10.ny.cbi.10gen.cc:22761"
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 			},
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 			{
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 				"_id" : 2,
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 				"host" : "build10.ny.cbi.10gen.cc:22762",
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 				"arbiterOnly" : true
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 			}
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.385-0400 		]
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.386-0400 	}
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.386-0400 }
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.386-0400 d22760| 2015-10-27T08:31:34.383-0400 I REPL     [conn1] replSetInitiate admin command received from client
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.386-0400 d22761| 2015-10-27T08:31:34.384-0400 I NETWORK  [initandlisten] connection accepted from 172.30.200.42:35217 #2 (2 connections now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.387-0400 d22761| 2015-10-27T08:31:34.384-0400 I NETWORK  [conn2] end connection 172.30.200.42:35217 (1 connection now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.387-0400 d22762| 2015-10-27T08:31:34.384-0400 I NETWORK  [initandlisten] connection accepted from 172.30.200.42:44001 #2 (2 connections now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.387-0400 d22760| 2015-10-27T08:31:34.384-0400 I REPL     [conn1] replSetInitiate config object with 3 members parses ok
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.387-0400 d22762| 2015-10-27T08:31:34.385-0400 I NETWORK  [conn2] end connection 172.30.200.42:44001 (1 connection now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.388-0400 d22761| 2015-10-27T08:31:34.385-0400 I NETWORK  [initandlisten] connection accepted from 172.30.200.42:35219 #3 (2 connections now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.388-0400 d22762| 2015-10-27T08:31:34.385-0400 I NETWORK  [initandlisten] connection accepted from 172.30.200.42:44003 #3 (2 connections now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.388-0400 d22760| 2015-10-27T08:31:34.385-0400 I ASIO     [NetworkInterfaceASIO] Successfully connected to build10.ny.cbi.10gen.cc:22761
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.389-0400 d22760| 2015-10-27T08:31:34.385-0400 I ASIO     [NetworkInterfaceASIO] Successfully connected to build10.ny.cbi.10gen.cc:22762
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.389-0400 d22760| 2015-10-27T08:31:34.386-0400 I NETWORK  [initandlisten] connection accepted from 172.30.200.42:36395 #2 (2 connections now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.389-0400 d22760| 2015-10-27T08:31:34.386-0400 I NETWORK  [initandlisten] connection accepted from 172.30.200.42:36396 #3 (3 connections now open)
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.390-0400 d22761| 2015-10-27T08:31:34.386-0400 I ASIO     [NetworkInterfaceASIO] Successfully connected to build10.ny.cbi.10gen.cc:22760
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.390-0400 d22762| 2015-10-27T08:31:34.386-0400 I ASIO     [NetworkInterfaceASIO] Successfully connected to build10.ny.cbi.10gen.cc:22760
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.390-0400 d22762| 2015-10-27T08:31:34.386-0400 W REPL     [ReplicationExecutor] Cannot update term in election protocol version 0
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.391-0400 d22762| 2015-10-27T08:31:34.386-0400 W REPL     [ReplicationExecutor] Cannot update term in election protocol version 0
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.391-0400 d22761| 2015-10-27T08:31:34.386-0400 W REPL     [ReplicationExecutor] Cannot update term in election protocol version 0
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.392-0400 d22761| 2015-10-27T08:31:34.386-0400 W REPL     [ReplicationExecutor] Cannot update term in election protocol version 0
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.401-0400 d22760| 2015-10-27T08:31:34.400-0400 I REPL     [ReplicationExecutor] New replica set config in use: { _id: "stepDownWithLongWait", version: 1, protocolVersion: 1, members: [ { _id: 0, host: "build10.ny.cbi.10gen.cc:22760", arbiterOnly: false, buildIndexes: true, hidden: false, priority: 3.0, tags: {}, slaveDelay: 0, votes: 1 }, { _id: 1, host: "build10.ny.cbi.10gen.cc:22761", arbiterOnly: false, buildIndexes: true, hidden: false, priority: 1.0, tags: {}, slaveDelay: 0, votes: 1 }, { _id: 2, host: "build10.ny.cbi.10gen.cc:22762", arbiterOnly: true, buildIndexes: true, hidden: false, priority: 1.0, tags: {}, slaveDelay: 0, votes: 1 } ], settings: { chainingAllowed: true, heartbeatIntervalMillis: 2000, heartbeatTimeoutSecs: 10, electionTimeoutMillis: 5000, getLastErrorModes: {}, getLastErrorDefaults: { w: 1, wtimeout: 0 } } }
      [js_test:stepdown_long_wait_time] 2015-10-27T08:31:34.401-0400 d22760| 2015-10-27T08:31:34.400-0400 I REPL     [ReplicationExecutor] This node is build10.ny.cbi.10gen.cc:22760 in the config
      

            Assignee:
            siyuan.zhou@mongodb.com Siyuan Zhou
            Reporter:
            benety.goh@mongodb.com Benety Goh
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

              Created:
              Updated:
              Resolved: