-
Type: Bug
-
Resolution: Gone away
-
Priority: Minor - P4
-
None
-
Affects Version/s: None
-
Component/s: None
-
Storage Engines
Evergreen link to failing test: https://evergreen.mongodb.com/task/wiredtiger_feature_ubuntu1804_format_stress_sanitizer_test_7e595e4a3a9c30c9db0eb33f7da72c97526a2b99_20_03_01_23_26_06
The format-stress-sanitizer-test is failing with following signature:
[2020/03/01 21:11:48.823] format.sh: job in /data/mci/b6259b5d082af46a3e88aa64ee22ab1c/wiredtiger/test/format/RUNDIR.61 failed [2020/03/01 21:11:48.823] format.sh: /data/mci/b6259b5d082af46a3e88aa64ee22ab1c/wiredtiger/test/format/RUNDIR.61 log: [2020/03/01 21:11:48.839] t: process 18817 running [2020/03/01 21:11:48.839] format run more than 15 minutes past the maximum time [2020/03/01 21:11:48.839] format run dumping cache and transaction state, then aborting the process [2020/03/01 21:11:48.839] 0x7f5af6c98800:========================= [2020/03/01 21:11:48.839] 0x7f5af6c98800:transaction state dump [2020/03/01 21:11:48.839] 0x7f5af6c98800:current ID: 14975 [2020/03/01 21:11:48.839] 0x7f5af6c98800:last running ID: 14975 [2020/03/01 21:11:48.839] 0x7f5af6c98800:metadata_pinned ID: 6931 [2020/03/01 21:11:48.839] 0x7f5af6c98800:oldest ID: 6931 [2020/03/01 21:11:48.839] 0x7f5af6c98800:durable timestamp: (0, 29838) [2020/03/01 21:11:48.839] 0x7f5af6c98800:oldest timestamp: (0, 29838) [2020/03/01 21:11:48.839] 0x7f5af6c98800:pinned timestamp: (0, 29838) [2020/03/01 21:11:48.839] 0x7f5af6c98800:stable timestamp: (0, 0) [2020/03/01 21:11:48.839] 0x7f5af6c98800:has_durable_timestamp: yes [2020/03/01 21:11:48.839] 0x7f5af6c98800:has_oldest_timestamp: yes [2020/03/01 21:11:48.839] 0x7f5af6c98800:has_pinned_timestamp: yes [2020/03/01 21:11:48.839] 0x7f5af6c98800:has_stable_timestamp: no [2020/03/01 21:11:48.839] 0x7f5af6c98800:oldest_is_pinned: yes [2020/03/01 21:11:48.839] 0x7f5af6c98800:stable_is_pinned: no [2020/03/01 21:11:48.839] 0x7f5af6c98800:checkpoint running: no [2020/03/01 21:11:48.839] 0x7f5af6c98800:checkpoint generation: 1 [2020/03/01 21:11:48.839] 0x7f5af6c98800:checkpoint pinned ID: 0 [2020/03/01 21:11:48.839] 0x7f5af6c98800:checkpoint txn ID: 0 [2020/03/01 21:11:48.839] 0x7f5af6c98800:oldest named snapshot ID: 0 [2020/03/01 21:11:48.839] 0x7f5af6c98800:session count: 26 [2020/03/01 21:11:48.839] 0x7f5af6c98800:Transaction state of active sessions: [2020/03/01 21:11:48.839] 0x7f5af6c98800:ID: 0, pinned ID: 6931, metadata pinned ID: 0, name: WT_CURSOR.next [2020/03/01 21:11:48.839] 0x7f5af6c98800:transaction id: 0, mod count: 0, snap min: 6931, snap max: 6953, snapshot count: 6, commit_timestamp: (0, 0), durable_timestamp: (0, 0), first_commit_timestamp: (0, 0), prepare_timestamp: (0, 0), read_timestamp: (0, 0), checkpoint LSN: [0][0], full checkpoint: false, rollback reason: , flags: 0x00000008, isolation: WT_ISO_READ_COMMITTED [2020/03/01 21:11:48.839] 0x7f5af6c98800:========================= [2020/03/01 21:11:48.839] 0x7f5af6c98800:cache dump [2020/03/01 21:11:48.839] 0x7f5af6c98800:cache full: no [2020/03/01 21:11:48.839] 0x7f5af6c98800:cache clean check: no (79.532%) [2020/03/01 21:11:48.839] 0x7f5af6c98800:cache dirty check: yes (24.289%) [2020/03/01 21:11:48.839] 0x7f5af6c98800:file:wt.wt(checkpoint=WiredTigerCheckpoint.1): [2020/03/01 21:11:48.839] 0x7f5af6c98800:internal: 1 pages, 0MB, 1/0 clean/dirty pages, 0/0 clean/dirty MB, 0MB max page, 0MB max dirty page [2020/03/01 21:11:48.839] 0x7f5af6c98800:leaf: 0 pages [2020/03/01 21:11:48.839] 0x7f5af6c98800:file:wt.wt(<live>): [2020/03/01 21:11:48.839] 0x7f5af6c98800:internal: 12984 pages, 48MB, 5948/7036 clean/dirty pages, 18/29 clean/dirty MB, 0MB max page, 0MB max dirty page [2020/03/01 21:11:48.839] 0x7f5af6c98800:leaf: 17184 pages, 21MB, 1229/15955 clean/dirty pages, 0/21 clean/dirty MB, 0MB max page, 0MB max dirty page [2020/03/01 21:11:48.839] 0x7f5af6c98800:file:WiredTigerLAS.wt(<live>): [2020/03/01 21:11:48.839] 0x7f5af6c98800:internal: 1 pages, 0MB, 0/1 clean/dirty pages, 0/0 clean/dirty MB, 0MB max page, 0MB max dirty page [2020/03/01 21:11:48.839] 0x7f5af6c98800:leaf: 0 pages [2020/03/01 21:11:48.839] 0x7f5af6c98800:file:WiredTiger.wt(<live>): [2020/03/01 21:11:48.839] 0x7f5af6c98800:internal: 1 pages, 0MB, 0/1 clean/dirty pages, 0/0 clean/dirty MB, 0MB max page, 0MB max dirty page [2020/03/01 21:11:48.839] 0x7f5af6c98800:leaf: 1 pages, 0MB, 1/0 clean/dirty pages, 0/0 clean/dirty MB, 0MB max page, 0MB max dirty page [2020/03/01 21:11:48.839] 0x7f5af6c98800:cache dump: total found: 75MB vs tracked inuse 75MB [2020/03/01 21:11:48.839] 0x7f5af6c98800:total dirty bytes: 50MB [2020/03/01 21:11:48.839] WiredTiger Error: aborting WiredTiger library