Uploaded image for project: 'WiredTiger'
  1. WiredTiger
  2. WT-3351

Recovery assertion failure: old_lognum < lognum

    • Type: Icon: Bug Bug
    • Resolution: Fixed
    • Priority: Icon: Major - P3 Major - P3
    • WT2.9.3, 3.4.10, 3.5.9
    • Affects Version/s: None
    • Component/s: None
    • Labels:
      None
    • Storage 2017-06-19
    • v3.4

      Hi sueloverso, this assertion caused some test failures when testing WiredTiger develop against MongoDB master in preparation for a new drop.

      Can you please investigate?

      https://logkeeper.mongodb.org/build/f1761761d0feae033dc77bc38e61ff55/test/5930b1edc2ab686cf5065397

      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.756+0000 d20265| 2017-06-02T00:32:21.757+0000 I CONTROL  [initandlisten] options: { net: { bindIp: "0.0.0.0", port: 20265 }, setParameter: { enableTestCommands: "1", logComponentVerbosity: "{tracking:0,replication:{heartbeats:2}}" }, storage: { dbPath: "\data\db\job1\mongorunner\wt_nojournal_toggle", engine: "wiredTiger", journal: { enabled: true }, mmapv1: { journal: { nopreallocj: true } }, wiredTiger: { engineConfig: { cacheSizeGB: 1.0 } } } }
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.759+0000 d20265| 2017-06-02T00:32:21.758+0000 I STORAGE  [initandlisten] wiredtiger_open config: create,cache_size=1024M,session_max=20000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,archive=true,path=journal,compressor=snappy),file_manager=(close_idle_time=100000),statistics_log=(wait=0),verbose=(recovery_progress),
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.786+0000 d20265| 2017-06-02T00:32:21.785+0000 E STORAGE  [initandlisten] WiredTiger error (0) [1496363541:785600][3748:1994273664], txn-recover: src\third_party\wiredtiger\src\log\log.c, 480: old_lognum < lognum
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.786+0000 d20265| 2017-06-02T00:32:21.786+0000 E STORAGE  [initandlisten] WiredTiger error (0) [1496363541:786600][3748:1994273664], txn-recover: aborting WiredTiger library
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.973+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\mongo\util\stacktrace_windows.cpp(239)                     mongo::printStackTrace+0x43
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.974+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\mongo\util\signal_handlers_synchronous.cpp(180)            mongo::`anonymous namespace'::printSignalAndBacktrace+0x73
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.974+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\mongo\util\signal_handlers_synchronous.cpp(236)            mongo::`anonymous namespace'::abruptQuit+0x83
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.974+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    d:\th\minkernel\crts\ucrt\src\appcrt\misc\signal.cpp(522)          raise+0x468
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.974+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    d:\th\minkernel\crts\ucrt\src\appcrt\startup\abort.cpp(71)         abort+0x39
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.974+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\third_party\wiredtiger\src\os_common\os_abort.c(25)        __wt_abort+0x22
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.976+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\third_party\wiredtiger\src\support\err.c(488)              __wt_assert+0x37
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.976+0000 d20265| 2017-06-02T00:32:21.974+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\third_party\wiredtiger\src\log\log.c(480)                  __wt_log_reset+0x21c
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.976+0000 d20265| 2017-06-02T00:32:21.975+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\third_party\wiredtiger\src\txn\txn_recover.c(466)          __wt_txn_recover+0x350
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.976+0000 d20265| 2017-06-02T00:32:21.975+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\third_party\wiredtiger\src\conn\conn_open.c(240)           __wt_connection_workers+0x30
      [js_test:wt_nojournal_toggle] 2017-06-02T00:32:21.976+0000 d20265| 2017-06-02T00:32:21.975+0000 I CONTROL  [initandlisten] mongod.exe    ...\src\third_party\wiredtiger\src\conn\conn_api.c(2457)           wiredtiger_open+0xb5a
      

            Assignee:
            sue.loverso@mongodb.com Susan LoVerso
            Reporter:
            michael.cahill@mongodb.com Michael Cahill (Inactive)
            Votes:
            0 Vote for this issue
            Watchers:
            4 Start watching this issue

              Created:
              Updated:
              Resolved: