[SERVER-7758] Error out "[rsStart] DBClientCursor::init call() failed" message when rs.initiate() but relpica set still successfully created Created: 26/Nov/12  Updated: 11/Jul/16  Resolved: 28/Nov/12

Status: Closed
Project: Core Server
Component/s: None
Affects Version/s: None
Fix Version/s: None

Type: Question Priority: Major - P3
Reporter: jameszhou Assignee: Unassigned
Resolution: Done Votes: 0
Labels: None
Remaining Estimate: Not Specified
Time Spent: Not Specified
Original Estimate: Not Specified
Environment:

CentOS 5.3(Final) 64bits
Mongo_V2.2.1


Participants:

 Description   

Backgrouds:
I installed below 2 rpm packages on CentOS 5.3(Final) 64bits
mongo-10gen-2.2.1-mongodb_1.x86_64.rpm
mongo-10gen-server-2.2.1-mongodb_1.x86_64.rpm

Total 2 Servers, server #1 - primary mongod, server #2 - secondary mongod and arbiter mongod

Symptom:
when rs.initiate() for primary on server #1, find "[rsStart] DBClientCursor::init call() failed" message in logs

Questions:
even if error out above message, still a 3-members relpica set still successfully created...above failed message can be ignored? it is normal case?

Thanks in advanced!



 Comments   
Comment by jameszhou [ 28/Nov/12 ]

Hi David

Thank you for your quick reply.
Mongodb in my lab has been working well since its startup. No error/fail occurs.

Thanks,
Jameszhou

Comment by David Hows [ 27/Nov/12 ]

Hi James,

Seems like that error came while it was doing the file allocation for the creation of the opLog.

If everything is working well and you have not seen any subsequent issues then you should be able to ignore the error.

Cheers,

David

Comment by jameszhou [ 27/Nov/12 ]

Any guy give me an explicit answer?

Thanks

Jameszhuo

Comment by jameszhou [ 26/Nov/12 ]

A snippet of logs:

Mon Nov 26 17:10:25 [rsStart] replSet can't get local.system.replset config from self or any seed (EMPTYCONFIG)
Mon Nov 26 17:10:32 [initandlisten] connection accepted from 10.50.16.225:54261 #4 (2 connections now open)
Mon Nov 26 17:10:35 [rsStart] replSet can't get local.system.replset config from self or any seed (EMPTYCONFIG)
Mon Nov 26 17:10:45 [rsStart] replSet can't get local.system.replset config from self or any seed (EMPTYCONFIG)
Mon Nov 26 17:10:55 [rsStart] replSet can't get local.system.replset config from self or any seed (EMPTYCONFIG)
Mon Nov 26 17:10:56 [conn4] replSet replSetInitiate admin command received from client
Mon Nov 26 17:10:56 [conn4] replSet info initiate : no configuration specified. Using a default configuration for the set
Mon Nov 26 17:10:56 [conn4] replSet created this configuration for initiation : { _id: "rs0", members: [

{ _id: 0, host: "10.50.16.225:27017" }

] }
Mon Nov 26 17:10:56 [conn4] replSet replSetInitiate config object parses ok, 1 members specified
Mon Nov 26 17:10:56 [conn4] replSet replSetInitiate all members seem up
Mon Nov 26 17:10:56 [conn4] ******
Mon Nov 26 17:10:56 [conn4] creating replication oplog of size: 1271MB...
Mon Nov 26 17:10:56 [FileAllocator] allocating new datafile /drbd0/mongo/data/local.ns, filling with zeroes...
Mon Nov 26 17:10:56 [FileAllocator] creating directory /drbd0/mongo/data/_tmp
Mon Nov 26 17:10:57 [FileAllocator] done allocating datafile /drbd0/mongo/data/local.ns, size: 16MB, took 1.095 secs
Mon Nov 26 17:10:57 [FileAllocator] allocating new datafile /drbd0/mongo/data/local.0, filling with zeroes...
Mon Nov 26 17:11:15 [rsStart] DBClientCursor::init call() failed
Mon Nov 26 17:11:47 [FileAllocator] done allocating datafile /drbd0/mongo/data/local.0, size: 2047MB, took 49.649 secs
Mon Nov 26 17:11:47 [conn4] ******
Mon Nov 26 17:11:47 [rsStart] replSet can't get local.system.replset config from self or any seed (EMPTYCONFIG)
Mon Nov 26 17:11:47 [conn4] replSet info saving a newer config version to local.system.replset
Mon Nov 26 17:11:47 [conn4] replSet saveConfigLocally done
Mon Nov 26 17:11:47 [conn4] replSet replSetInitiate config now saved locally. Should come online in about a minute.
Mon Nov 26 17:11:47 [conn4] command admin.$cmd command:

{ replSetInitiate: undefined }

ntoreturn:1 keyUpdates:0 locks(micros) W:51496039 reslen:202 51512ms
Mon Nov 26 17:11:57 [conn1] end connection 10.50.16.225:48123 (1 connection now open)
Mon Nov 26 17:11:57 [initandlisten] connection accepted from 10.50.16.225:54263 #5 (2 connections now open)
Mon Nov 26 17:11:57 [rsStart] replSet I am 10.50.16.225:27017
Mon Nov 26 17:11:57 [rsStart] replSet STARTUP2
Mon Nov 26 17:11:58 [rsSync] replSet SECONDARY
Mon Nov 26 17:11:58 [rsMgr] replSet info electSelf 0
Mon Nov 26 17:11:58 [rsMgr] replSet PRIMARY

Generated at Thu Feb 08 03:15:31 UTC 2024 using Jira 9.7.1#970001-sha1:2222b88b221c4928ef0de3161136cc90c8356a66.