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

fassert failure: WT_NOTFOUND return value in WiredTigerRecordStore::deleteRecord

    • Type: Icon: Bug Bug
    • Resolution: Duplicate
    • Priority: Icon: Major - P3 Major - P3
    • None
    • Affects Version/s: 2.8.0-rc0
    • Component/s: Storage
    • Fully Compatible
    • ALL

      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

            Assignee:
            geert.bosch@mongodb.com Geert Bosch
            Reporter:
            kamran.khan Kamran K.
            Votes:
            0 Vote for this issue
            Watchers:
            12 Start watching this issue

              Created:
              Updated:
              Resolved: