-
Type: Bug
-
Resolution: Done
-
Priority: Minor - P4
-
Affects Version/s: 1.8.0-rc1
-
Component/s: None
-
None
-
ALL
Didn't cause a crash and doesn't seem to have affected anything.
Mon Mar 7 10:57:46 [initandlisten] MongoDB starting : pid=1062 port=27018 dbpath=/mongodbdata/ 64-bit
Mon Mar 7 10:57:46 [initandlisten] db version v1.8.0-rc1, pdfile version 4.5
Mon Mar 7 10:57:46 [initandlisten] git version: 87dd5720e48e875487d5fbd78cbe120d5a610973
Mon Mar 7 10:57:46 [initandlisten] build sys info: Linux bs-linux64.10gen.cc 2.6.21.7-2.ec2.v1.2.fc8xen #1 SMP Fri Nov 20 17:48:28 EST 2009 x86_64 BOOST_LIB_VERSION=1_41
Mon Mar 7 10:57:46 [initandlisten] waiting for connections on port 27018
Mon Mar 7 10:57:46 [websvr] web admin interface listening on port 28018
Mon Mar 7 10:57:46 [startReplSets] replSet can't get local.system.replset config from self or any seed (EMPTYCONFIG)
Mon Mar 7 10:57:46 [startReplSets] replSet info you may need to run replSetInitiate – rs.initiate() in the shell – if that is not already done
Mon Mar 7 10:57:56 [startReplSets] trying to contact rs2a:27018
Mon Mar 7 10:57:57 [startReplSets] replSet got config version 7 from a remote, saving locally
Mon Mar 7 10:57:57 [startReplSets] replSet info saving a newer config version to local.system.replset
Mon Mar 7 10:57:57 [FileAllocator] allocating new datafile /mongodbdata/local.ns, filling with zeroes...
Mon Mar 7 10:57:57 [FileAllocator] done allocating datafile /mongodbdata/local.ns, size: 16MB, took 0.017 secs
Mon Mar 7 10:57:57 [FileAllocator] allocating new datafile /mongodbdata/local.0, filling with zeroes...
Mon Mar 7 10:57:57 [FileAllocator] done allocating datafile /mongodbdata/local.0, size: 64MB, took 0.072 secs
Mon Mar 7 10:57:57 [FileAllocator] allocating new datafile /mongodbdata/local.1, filling with zeroes...
Mon Mar 7 10:57:57 [FileAllocator] done allocating datafile /mongodbdata/local.1, size: 128MB, took 0.153 secs
Mon Mar 7 10:57:57 [startReplSets] replSet STARTUP2
Mon Mar 7 10:57:57 [replica set sync] ******
Mon Mar 7 10:57:57 [replica set sync] creating replication oplog of size: 25582MB...
Mon Mar 7 10:57:57 [FileAllocator] allocating new datafile /mongodbdata/local.2, filling with zeroes...
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet info rs2d:27018 is up
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet member rs2d:27018 SECONDARY
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet info rs2a:27018 is up
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet member rs2a:27018 PRIMARY
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet info rs2arbiter:27018 is up
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet member rs2arbiter:27018 ARBITER
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet info rs2b:27018 is up
Mon Mar 7 10:57:59 [ReplSetHealthPollTask] replSet member rs2b:27018 SECONDARY
Mon Mar 7 10:57:59 [FileAllocator] done allocating datafile /mongodbdata/local.2, size: 2047MB, took 2.247 secs
Mon Mar 7 10:57:59 [FileAllocator] allocating new datafile /mongodbdata/local.3, filling with zeroes...
Mon Mar 7 10:58:04 [FileAllocator] done allocating datafile /mongodbdata/local.3, size: 2047MB, took 4.954 secs
Mon Mar 7 10:58:04 [FileAllocator] allocating new datafile /mongodbdata/local.4, filling with zeroes...
Mon Mar 7 10:58:10 [FileAllocator] done allocating datafile /mongodbdata/local.4, size: 2047MB, took 5.49 secs
Mon Mar 7 10:58:10 [FileAllocator] allocating new datafile /mongodbdata/local.5, filling with zeroes...
Mon Mar 7 10:58:15 [FileAllocator] done allocating datafile /mongodbdata/local.5, size: 2047MB, took 5.387 secs
Mon Mar 7 10:58:15 [FileAllocator] allocating new datafile /mongodbdata/local.6, filling with zeroes...
Mon Mar 7 10:58:21 [FileAllocator] done allocating datafile /mongodbdata/local.6, size: 2047MB, took 5.501 secs
Mon Mar 7 10:58:21 [FileAllocator] allocating new datafile /mongodbdata/local.7, filling with zeroes...
Mon Mar 7 10:58:26 [FileAllocator] done allocating datafile /mongodbdata/local.7, size: 2047MB, took 5.738 secs
Mon Mar 7 10:58:26 [FileAllocator] allocating new datafile /mongodbdata/local.8, filling with zeroes...
Mon Mar 7 10:58:32 [FileAllocator] done allocating datafile /mongodbdata/local.8, size: 2047MB, took 5.737 secs
Mon Mar 7 10:58:32 [FileAllocator] allocating new datafile /mongodbdata/local.9, filling with zeroes...
Mon Mar 7 10:58:38 [FileAllocator] done allocating datafile /mongodbdata/local.9, size: 2047MB, took 5.952 secs
Mon Mar 7 10:58:38 [FileAllocator] allocating new datafile /mongodbdata/local.10, filling with zeroes...
Mon Mar 7 10:58:44 [FileAllocator] done allocating datafile /mongodbdata/local.10, size: 2047MB, took 5.913 secs
Mon Mar 7 10:58:44 [FileAllocator] allocating new datafile /mongodbdata/local.11, filling with zeroes...
Mon Mar 7 10:58:50 [FileAllocator] done allocating datafile /mongodbdata/local.11, size: 2047MB, took 5.824 secs
Mon Mar 7 10:58:50 [FileAllocator] allocating new datafile /mongodbdata/local.12, filling with zeroes...
Mon Mar 7 10:58:55 [FileAllocator] done allocating datafile /mongodbdata/local.12, size: 2047MB, took 5.55 secs
Mon Mar 7 10:58:55 [FileAllocator] allocating new datafile /mongodbdata/local.13, filling with zeroes...
Mon Mar 7 10:59:01 [FileAllocator] done allocating datafile /mongodbdata/local.13, size: 2047MB, took 5.503 secs
Mon Mar 7 10:59:01 [FileAllocator] allocating new datafile /mongodbdata/local.14, filling with zeroes...
Mon Mar 7 10:59:07 [FileAllocator] done allocating datafile /mongodbdata/local.14, size: 2047MB, took 5.732 secs
Mon Mar 7 10:59:11 [replica set sync] ******
Mon Mar 7 10:59:11 [replica set sync] replSet initial sync pending
Mon Mar 7 10:59:11 [replica set sync] replSet syncing to: rs2d:27018
Mon Mar 7 10:59:11 [conn8] query admin.$cmd ntoreturn:1 command:
reslen:192 18187ms
Mon Mar 7 10:59:11 [replica set sync] building new index on
for local.me
Mon Mar 7 10:59:11 [replica set sync] done for 0 records 0.013secs
Mon Mar 7 10:59:11 [replica set sync] replSet initial sync drop all databases
Mon Mar 7 10:59:11 [replica set sync] dropAllDatabasesExceptLocal 1
Mon Mar 7 10:59:11 [replica set sync] replSet initial sync clone all databases
Mon Mar 7 10:59:11 [replica set sync] replSet initial sync cloning db: accounts
Mon Mar 7 10:59:11 [FileAllocator] allocating new datafile /mongodbdata/accounts.ns, filling with zeroes...
Mon Mar 7 10:59:11 [FileAllocator] done allocating datafile /mongodbdata/accounts.ns, size: 16MB, took 0.016 secs
Mon Mar 7 10:59:11 [FileAllocator] allocating new datafile /mongodbdata/accounts.0, filling with zeroes...
Mon Mar 7 10:59:11 [FileAllocator] done allocating datafile /mongodbdata/accounts.0, size: 64MB, took 0.067 secs
Mon Mar 7 10:59:11 [FileAllocator] allocating new datafile /mongodbdata/accounts.1, filling with zeroes...
Mon Mar 7 10:59:12 [FileAllocator] done allocating datafile /mongodbdata/accounts.1, size: 128MB, took 0.14 secs
Mon Mar 7 10:59:12 [replica set sync] replauthenticate: no user in local.system.users to use for authentication
building new index on
for accounts.accounts
Mon Mar 7 10:59:12 [replica set sync] done for 4275 records 0.022secs
Mon Mar 7 10:59:12 [replica set sync] building new index on
for accounts.accounts
Mon Mar 7 10:59:12 [replica set sync] accounts Btree::insert: key too large to index, skipping accounts.accounts.$hostname_1 2155 { : "dddddddddddddddddddddddddddddddddddddddddddddddddddddddddddddddddddsas..." }
Mon Mar 7 10:59:12 [replica set sync] accounts Assertion failure btBuilder.getn() == nkeys || dropDups db/pdfile.cpp 1194
0x55127e 0x5628cf 0x7775ae 0x777a78 0x7794d0 0x77a91f 0x7251b8 0x726b2d 0x727b6d 0x70e002 0x70fa78 0x70775c 0x70784c 0x70a662 0x8b84f0 0x35e700673d 0x35e68d3f6d
/home/david/mongodb/latest/bin/mongod(_ZN5mongo12sayDbContextEPKc+0xae) [0x55127e]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo9wassertedEPKcS1_j+0x10f) [0x5628cf]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo14fastBuildIndexEPKcPNS_16NamespaceDetailsERNS_12IndexDetailsEi+0x184e) [0x7775ae]
/home/david/mongodb/latest/bin/mongod [0x777a78]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo11DataFileMgr6insertEPKcPKvibRKNS_11BSONElementEb+0xf60) [0x7794d0]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo11DataFileMgr16insertWithObjModEPKcRNS_7BSONObjEb+0x5f) [0x77a91f]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo6Cloner4copyEPKcS2_bbbbNS_5QueryE+0x3a8) [0x7251b8]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo6Cloner2goEPKcRSsRKSsbbbb+0x10cd) [0x726b2d]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo9cloneFromEPKcRSsRKSsbbbb+0x3d) [0x727b6d]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo11ReplSetImpl18_syncDoInitialSyncEv+0xf12) [0x70e002]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo11ReplSetImpl17syncDoInitialSyncEv+0x28) [0x70fa78]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo11ReplSetImpl11_syncThreadEv+0x5c) [0x70775c]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo11ReplSetImpl10syncThreadEv+0x3c) [0x70784c]
/home/david/mongodb/latest/bin/mongod(_ZN5mongo15startSyncThreadEv+0x252) [0x70a662]
/home/david/mongodb/latest/bin/mongod(thread_proxy+0x80) [0x8b84f0]
/lib64/libpthread.so.0 [0x35e700673d]
/lib64/libc.so.6(clone+0x6d) [0x35e68d3f6d]
Mon Mar 7 10:59:12 [replica set sync] done for 4275 records 0.206secs
Mon Mar 7 10:59:12 [replica set sync] replSet initial sync cloning db: sd