I noticed this fassert while running a longevity test against WT. I don't have repro steps yet, but I'm hoping the logs and backtrace can provide clues to someone more familiar with the WT code.
Backtrace:
2014-11-12T22:56:59.477-0500 I - [conn1622] Fatal assertion 28519 UnknownError -31802: WT_NOTFOUND: item not found #0 0x00007ffff7bcc20b in raise (sig=5) at ../nptl/sysdeps/unix/sysv/linux/pt-raise.c:37 #1 0x00000000018f1be3 in mongo::mongo_breakpoint () at src/mongo/util/debug_util.cpp:58 #2 0x00000000018e850c in mongo::breakpoint () at src/mongo/util/debug_util.h:73 #3 0x00000000018e763e in mongo::fassertFailedWithStatus (msgid=28519, status=...) at src/mongo/util/assert_util.cpp:168 #4 0x0000000001773888 in mongo::invariantWTOK (retCode=-31802) at src/mongo/db/storage/wiredtiger/wiredtiger_util.h:78 #5 0x000000000177872c in mongo::WiredTigerRecordStore::deleteRecord (this=0x380c2a0, txn=0x134216400, loc=...) at src/mongo/db/storage/wiredtiger/wiredtiger_record_store.cpp:341 #6 0x00000000016f6cee in mongo::KVCatalog::dropCollection (this=0x37da480, opCtx=0x134216400, ns=...) at src/mongo/db/storage/kv/kv_catalog.cpp:352 #7 0x00000000016fd947 in mongo::KVDatabaseCatalogEntry::dropCollection (this=0x1588cd8e0, opCtx=0x134216400, ns=...) at src/mongo/db/storage/kv/kv_database_catalog_entry.cpp:368 #8 0x0000000001701631 in mongo::KVStorageEngine::dropDatabase (this=0x37da400, txn=0x134216400, db=...) at src/mongo/db/storage/kv/kv_storage_engine.cpp:193 #9 0x0000000001286131 in mongo::dropDatabase (txn=0x134216400, db=0x0) at src/mongo/db/catalog/database.cpp:569 #10 0x00000000013468f3 in mongo::CmdDropDatabase::run (this=0x288dc20 <mongo::cmdDropDatabase>, txn=0x134216400, dbname=..., cmdObj=..., errmsg=..., result=..., fromRepl=false) at src/mongo/db/dbcommands.cpp:213 #11 0x00000000013441e5 in mongo::_execCommand (txn=0x134216400, c=0x288dc20 <mongo::cmdDropDatabase>, dbname=..., cmdObj=..., queryOptions=0, errmsg=..., result=..., fromRepl=false) at src/mongo/db/dbcommands.cpp:1174 #12 0x000000000134519a in mongo::Command::execCommand (txn=0x134216400, c=0x288dc20 <mongo::cmdDropDatabase>, queryOptions=0, cmdns=0x10355a814 "test.$cmd", cmdObj=..., result=..., fromRepl=false) at src/mongo/db/dbcommands.cpp:1388 #13 0x0000000001345aa7 in mongo::_runCommands (txn=0x134216400, ns=0x10355a814 "test.$cmd", _cmdobj=..., b=..., anObjBuilder=..., fromRepl=false, queryOptions=0) at src/mongo/db/dbcommands.cpp:1464 #14 0x0000000001563005 in mongo::runCommands (txn=0x134216400, ns=0x10355a814 "test.$cmd", jsobj=..., curop=..., b=..., anObjBuilder=..., fromRepl=false, queryOptions=0) at src/mongo/db/query/new_find.cpp:131 #15 0x0000000001564c92 in mongo::newRunQuery (txn=0x134216400, m=..., q=..., curop=..., result=..., fromDBDirectClient=false) at src/mongo/db/query/new_find.cpp:552 #16 0x0000000001450a47 in mongo::receivedQuery (txn=0x134216400, c=..., dbresponse=..., m=..., fromDBDirectClient=false) at src/mongo/db/instance.cpp:220 #17 0x0000000001451b6a in mongo::assembleResponse (txn=0x134216400, m=..., dbresponse=..., remote=..., fromDBDirectClient=false) at src/mongo/db/instance.cpp:393 #18 0x000000000115870e in mongo::MyMessageHandler::process (this=0x30e00f8, m=..., port=0x18a6a03f0, le=0x103176910) at src/mongo/db/db.cpp:185 #19 0x000000000190ddbd in mongo::PortMessageServer::handleIncomingMsg (arg=0x595fa630) at src/mongo/util/net/message_server_port.cpp:234 #20 0x00007ffff7bc4182 in start_thread (arg=0x7ffff0be9700) at pthread_create.c:312 #21 0x00007ffff6cc4fbd in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111
Preliminary analysis:
- The fassert fails when trying to drop the 'test.jstests_cursorb' collection as part of a dropDatabase command
- The log reports empty CollectionCatalogEntry metadata for the collection prior to the drop: "fetched CCE metadata: {}"
- The dropDatabase command for 'test' is processed from one connection at the same time as an insert on the 'test.jstests_cursorb collection' is processed from another connection:
2014-11-12T22:56:59.474-0500 I WRITES [conn1626] insert test.jstests_cursorb query: { returned_date: 5.0, _id: ObjectId('54642c0b5966eca41a8b1ab1') } ninserted:1 keyUpdates:0 numYields:0 118ms 2014-11-12T22:56:59.474-0500 I QUERY [conn1626] command test.$cmd command: insert { insert: "jstests_cursorb", documents: [ { returned_date: 5.0, _id: ObjectId('54642c0b5966eca41a8b1ab1') } ], ordered: true } keyUpdates:0 numYields:0 reslen:40 118ms 2014-11-12T22:56:59.474-0500 I COMMANDS [conn1622] dropDatabase test starting 2014-11-12T22:56:59.474-0500 D STORAGE [conn1622] dropDatabase test
More log context:
2014-11-12T22:56:59.369-0500 D STORAGE [conn1626] WT begin_transaction 2014-11-12T22:56:59.369-0500 D STORAGE [conn1626] stored meta data for test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.369-0500 D STORAGE [conn1626] WiredTigerKVEngine::createRecordStore uri: table:collection-203379--8676020821870714531 config: type=file,memory_page_max=100m,block_compressor=snappy,,app_metadata=(),key_format=q,value_format=u 2014-11-12T22:56:59.371-0500 D STORAGE [conn1622] WT begin_transaction 2014-11-12T22:56:59.371-0500 W ACCESS [conn1622] Could not fetch updated user privilege information for jstests_evalb_user@test; continuing to use old information. Reason is AuthSchemaIncompatible Authorization data schema version 1 not supported after MongoDB version 2.6. 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] fetched CCE metadata: { ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531", md: { ns: "test.jstests_cursorb", options: {}, indexes: [] } } 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] fetched CCE metadata: { ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531", md: { ns: "test.jstests_cursorb", options: {}, indexes: [] } } 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] fetched CCE metadata: { ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531", md: { ns: "test.jstests_cursorb", options: {}, indexes: [] } } 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.466-0500 D STORAGE [conn1626] create uri: table:index-203380--8676020821870714531 config: type=file,leaf_page_max=16k,,key_format=u,value_format=u,collator=mongo_index,app_metadata={ "v" : 1, "key" : { "_id" : 1 }, "name" : "_id_", "ns" : "test.jstests_cursorb" } 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] fetched CCE metadata: { md: { ns: "test.jstests_cursorb", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.jstests_cursorb" }, ready: false, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203380--8676020821870714531" }, ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531" } 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] fetched CCE metadata: { md: { ns: "test.jstests_cursorb", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.jstests_cursorb" }, ready: false, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203380--8676020821870714531" }, ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531" } 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] fetched CCE metadata: { md: { ns: "test.jstests_cursorb", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.jstests_cursorb" }, ready: false, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203380--8676020821870714531" }, ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531" } 2014-11-12T22:56:59.473-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] fetched CCE metadata: { md: { ns: "test.jstests_cursorb", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.jstests_cursorb" }, ready: false, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203380--8676020821870714531" }, ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531" } 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] test.jstests_cursorb: clearing plan cache - collection info cache reset 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] fetched CCE metadata: { md: { ns: "test.jstests_cursorb", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.jstests_cursorb" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203380--8676020821870714531" }, ns: "test.jstests_cursorb", ident: "collection-203379--8676020821870714531" } 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] WT commit_transaction 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] WT begin_transaction 2014-11-12T22:56:59.474-0500 D STORAGE [conn1626] WT commit_transaction 2014-11-12T22:56:59.474-0500 I WRITES [conn1626] insert test.jstests_cursorb query: { returned_date: 5.0, _id: ObjectId('54642c0b5966eca41a8b1ab1') } ninserted:1 keyUpdates:0 numYields:0 118ms 2014-11-12T22:56:59.474-0500 I QUERY [conn1626] command test.$cmd command: insert { insert: "jstests_cursorb", documents: [ { returned_date: 5.0, _id: ObjectId('54642c0b5966eca41a8b1ab1') } ], ordered: true } keyUpdates:0 numYields:0 reslen:40 118ms 2014-11-12T22:56:59.474-0500 I COMMANDS [conn1622] dropDatabase test starting 2014-11-12T22:56:59.474-0500 D STORAGE [conn1622] dropDatabase test 2014-11-12T22:56:59.474-0500 D STORAGE [conn1622] looking up metadata for: test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.474-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.covered_simple_id", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.covered_simple_id" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203378--8676020821870714531" }, ns: "test.covered_simple_id", ident: "collection-203377--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.covered_simple_id", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.covered_simple_id" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203378--8676020821870714531" }, ns: "test.covered_simple_id", ident: "collection-203377--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.covered_simple_id", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.covered_simple_id" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203378--8676020821870714531" }, ns: "test.covered_simple_id", ident: "collection-203377--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.covered_simple_id", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.covered_simple_id" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203378--8676020821870714531" }, ns: "test.covered_simple_id", ident: "collection-203377--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.covered_simple_id", options: {}, indexes: [] }, idxIdent: {}, ns: "test.covered_simple_id", ident: "collection-203377--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] deleting metadata for test.covered_simple_id @ 0:18b44 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.find4", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.find4" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203374--8676020821870714531" }, ns: "test.find4", ident: "collection-203373--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.find4", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.find4" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203374--8676020821870714531" }, ns: "test.find4", ident: "collection-203373--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.find4", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.find4" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203374--8676020821870714531" }, ns: "test.find4", ident: "collection-203373--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.find4", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.find4" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203374--8676020821870714531" }, ns: "test.find4", ident: "collection-203373--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.find4", options: {}, indexes: [] }, idxIdent: {}, ns: "test.find4", ident: "collection-203373--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] deleting metadata for test.find4 @ 0:18b42 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.foo @ 0:18b43 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.foo", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.foo" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203376--8676020821870714531" }, ns: "test.foo", ident: "collection-203375--8676020821870714531" } 2014-11-12T22:56:59.475-0500 D STORAGE [conn1622] looking up metadata for: test.foo @ 0:18b43 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.foo", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.foo" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203376--8676020821870714531" }, ns: "test.foo", ident: "collection-203375--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.foo @ 0:18b43 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.foo", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.foo" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203376--8676020821870714531" }, ns: "test.foo", ident: "collection-203375--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.foo @ 0:18b43 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.foo @ 0:18b43 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.foo", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.foo" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203376--8676020821870714531" }, ns: "test.foo", ident: "collection-203375--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.foo @ 0:18b43 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.foo @ 0:18b43 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.foo", options: {}, indexes: [] }, idxIdent: {}, ns: "test.foo", ident: "collection-203375--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] deleting metadata for test.foo @ 0:18b43 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.geo_polygon1", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.geo_polygon1" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203372--8676020821870714531" }, ns: "test.geo_polygon1", ident: "collection-203371--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.geo_polygon1", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.geo_polygon1" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203372--8676020821870714531" }, ns: "test.geo_polygon1", ident: "collection-203371--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.geo_polygon1", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.geo_polygon1" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203372--8676020821870714531" }, ns: "test.geo_polygon1", ident: "collection-203371--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.geo_polygon1", options: {}, indexes: [ { spec: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.geo_polygon1" }, ready: true, multikey: false, head_a: -1, head_b: 0 } ] }, idxIdent: { _id_: "index-203372--8676020821870714531" }, ns: "test.geo_polygon1", ident: "collection-203371--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: { md: { ns: "test.geo_polygon1", options: {}, indexes: [] }, idxIdent: {}, ns: "test.geo_polygon1", ident: "collection-203371--8676020821870714531" } 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] deleting metadata for test.geo_polygon1 @ 0:18b41 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.476-0500 D STORAGE [conn1622] fetched CCE metadata: {} 2014-11-12T22:56:59.477-0500 D STORAGE [conn1622] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.477-0500 D STORAGE [conn1622] fetched CCE metadata: {} 2014-11-12T22:56:59.477-0500 D STORAGE [conn1622] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.477-0500 D STORAGE [conn1622] fetched CCE metadata: {} 2014-11-12T22:56:59.477-0500 D STORAGE [conn1622] looking up metadata for: test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.477-0500 D STORAGE [conn1622] fetched CCE metadata: {} 2014-11-12T22:56:59.477-0500 D STORAGE [conn1622] deleting metadata for test.jstests_cursorb @ 0:18b45 2014-11-12T22:56:59.477-0500 I - [conn1622] Fatal assertion 28519 UnknownError -31802: WT_NOTFOUND: item not found
Version: b6c4e2491c1442b
- duplicates
-
SERVER-16794 Invariant failure: WT_NOTFOUND error with concurrent removes and updates
- Closed