[INFO] crate rusty-leveldb 0.2.7 is already in cache [INFO] testing rusty-leveldb-0.2.7 against 1.38.0 for beta-1.39-1 [INFO] extracting crate rusty-leveldb 0.2.7 into work/builds/worker-2/source [INFO] validating manifest of crates.io crate rusty-leveldb 0.2.7 on toolchain 1.38.0 [INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started tweaking crates.io crate rusty-leveldb 0.2.7 [INFO] finished tweaking crates.io crate rusty-leveldb 0.2.7 [INFO] tweaked toml for crates.io crate rusty-leveldb 0.2.7 written to work/builds/worker-2/source/Cargo.toml [INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "build" "--frozen"` [INFO] [stdout] f9908646bd3b34f016246164615b9379635d16b984d0e34eb71d04e3c7c76d0c [INFO] running `"docker" "start" "-a" "f9908646bd3b34f016246164615b9379635d16b984d0e34eb71d04e3c7c76d0c"` [INFO] [stderr] Compiling rusty-leveldb v0.2.7 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4.88s [INFO] running `"docker" "inspect" "f9908646bd3b34f016246164615b9379635d16b984d0e34eb71d04e3c7c76d0c"` [INFO] running `"docker" "rm" "-f" "f9908646bd3b34f016246164615b9379635d16b984d0e34eb71d04e3c7c76d0c"` [INFO] [stdout] f9908646bd3b34f016246164615b9379635d16b984d0e34eb71d04e3c7c76d0c [INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen" "--no-run"` [INFO] [stdout] 4e60e7352262f996762088b4d64981710ee97ab7333787873a7b943d02340938 [INFO] running `"docker" "start" "-a" "4e60e7352262f996762088b4d64981710ee97ab7333787873a7b943d02340938"` [INFO] [stderr] Compiling bencher v0.1.5 [INFO] [stderr] Compiling time-test v0.2.1 [INFO] [stderr] Compiling rusty-leveldb v0.2.7 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 6.53s [INFO] running `"docker" "inspect" "4e60e7352262f996762088b4d64981710ee97ab7333787873a7b943d02340938"` [INFO] running `"docker" "rm" "-f" "4e60e7352262f996762088b4d64981710ee97ab7333787873a7b943d02340938"` [INFO] [stdout] 4e60e7352262f996762088b4d64981710ee97ab7333787873a7b943d02340938 [INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen"` [INFO] [stdout] 022fa36a857bb18461ad2edf14661feba19edcaa3f3691d1fa48517a088b7e7b [INFO] running `"docker" "start" "-a" "022fa36a857bb18461ad2edf14661feba19edcaa3f3691d1fa48517a088b7e7b"` [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.02s [INFO] [stderr] Running /opt/rustwide/target/debug/deps/rusty_leveldb-976ebce5d71e584d [INFO] [stdout] [INFO] [stdout] running 143 tests [INFO] [stdout] test block::tests::test_block_iterate_reverse ... ok [INFO] [stdout] test block::tests::test_block_seek ... ok [INFO] [stdout] test block::tests::test_block_empty ... ok [INFO] [stdout] test block::tests::test_block_build_iterate ... ok [INFO] [stdout] test blockhandle::tests::test_blockhandle ... ok [INFO] [stdout] test block::tests::test_block_seek_to_last ... ok [INFO] [stdout] test cache::tests::test_blockcache_cache_add_rm ... ok [INFO] [stdout] test cache::tests::test_blockcache_lru_reinsert ... ok [INFO] [stdout] test cache::tests::test_blockcache_cache_capacity ... ok [INFO] [stdout] test cache::tests::test_blockcache_lru_1 ... ok [INFO] [stdout] test cache::tests::test_blockcache_lru_reinsert_2 ... ok [INFO] [stdout] test block_builder::tests::test_block_builder_reset ... ok [INFO] [stdout] test block::tests::test_block_iterator_properties ... ok [INFO] [stdout] test cache::tests::test_blockcache_lru_remove ... ok [INFO] [stdout] test cache::tests::test_blockcache_lru_edge_cases ... ok [INFO] [stdout] test cmp::tests::test_cmp_defaultcmp_shortest_sep ... ok [INFO] [stdout] test cmp::tests::test_cmp_defaultcmp_short_succ ... ok [INFO] [stdout] test cmp::tests::test_cmp_internalkeycmp ... ok [INFO] [stdout] test cmp::tests::test_cmp_internalkeycmp_shortest_sep ... ok [INFO] [stdout] test db_impl::tests::test_db_impl_compaction_state_cleanup ... ok [INFO] [stderr] Recovered manifest with next_file=3 manifest_num=2 log_num=0 prev_log_num=0 last_seq=0 [INFO] [stderr] reusing manifest "db/MANIFEST-000001" [INFO] [stdout] test block_builder::tests::test_block_builder_sanity ... ok [INFO] [stderr] Start write of L0 table 000004 [INFO] [stderr] Recovered manifest with next_file=3 manifest_num=2 log_num=0 prev_log_num=0 last_seq=0 [INFO] [stderr] Deleting file type=Descriptor num=1 [INFO] [stdout] test db_impl::tests::test_db_impl_build_table ... ok [INFO] [stderr] Recovered manifest with next_file=3 manifest_num=2 log_num=0 prev_log_num=0 last_seq=0 [INFO] [stderr] reusing manifest "db/MANIFEST-000001" [INFO] [stdout] test db_impl::tests::test_db_impl_open_info_log ... ok [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Recovered manifest with next_file=3 manifest_num=2 log_num=0 prev_log_num=0 last_seq=0 [INFO] [stderr] reusing manifest "db/MANIFEST-000001" [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Compacting @2 [99, 97, 98, 1, 10, 0, 0, 0, 0, 0, 0] .. [102, 98, 97, 1, 12, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Start write of L0 table 000014 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Moved num=6 bytes=218 from L2 to L3 [INFO] [stderr] Summary: level 0: 2 files, 483 bytes ([(1, 232), (2, 251)]); level 1: 3 files, 651 bytes ([(3, 218), (4, 216), (5, 217)]); level 2: 1 files, 250 bytes ([(7, 250)]); level 3: 3 files, 618 bytes ([(6, 218), (8, 200), (9, 200)]); [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Expanding inputs@1 1+1 (216+218 bytes) to 3+1 (651+218 bytes) [INFO] [stderr] Compacting @1 [97, 97, 97, 1, 19, 0, 0, 0, 0, 0, 0] .. [102, 97, 98, 1, 15, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 3 files at L1 and 1 files at L2 [INFO] [stderr] Expanding inputs@1 1+1 (218+218 bytes) to 3+1 (651+218 bytes) [INFO] [stderr] Compacting @1 [97, 97, 97, 1, 19, 0, 0, 0, 0, 0, 0] .. [102, 97, 98, 1, 15, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 3 files at L1 and 1 files at L2 [INFO] [stdout] test db_impl::tests::test_db_impl_build_db_sanity ... ok [INFO] [stdout] test db_impl::tests::test_db_impl_compaction_trivial ... ok [INFO] [stderr] Recovered manifest with next_file=3 manifest_num=2 log_num=0 prev_log_num=0 last_seq=0 [INFO] [stderr] Recovering log file "db/000003.log" [INFO] [stdout] test db_impl::tests::test_db_impl_locking ... ok [INFO] [stderr] L0 table 000014 has 182 bytes [INFO] [stderr] Start write of L0 table 000003 [INFO] [stderr] L0 table 000004 has 227 bytes [INFO] [stderr] Start write of L0 table 000003 [INFO] [stderr] Deleting file type=Log num=12 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 2 files at L0 and 1 files at L1 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 2 files at L0 and 1 files at L1 [INFO] [stderr] Compacting @2 [97, 98, 48, 1, 3, 0, 0, 0, 0, 0, 0] .. [97, 98, 122, 1, 4, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Moved num=4 bytes=227 from L2 to L3 [INFO] [stderr] Summary: level 3: 1 files, 227 bytes ([(4, 227)]); [INFO] [stdout] test db_impl::tests::test_db_impl_compaction_trivial_move ... ok [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] L0 table 000003 has 351 bytes [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] New table num=13: keys=10 size=345 [INFO] [stderr] Compacted 3 L1 files + 1 L2 files => 345B [INFO] [stderr] Compaction finished: level 0: 2 files, 483 bytes ([(1, 232), (2, 251)]); level 2: 2 files, 595 bytes ([(13, 345), (7, 250)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stdout] test db_impl::tests::test_db_impl_compaction ... ok [INFO] [stderr] Deleting file type=Table num=5 [INFO] [stderr] Deleting file type=Table num=4 [INFO] [stderr] Deleting file type=Table num=3 [INFO] [stderr] Deleting file type=Table num=6 [INFO] [stderr] New table num=13: keys=10 size=345 [INFO] [stderr] Compacted 3 L1 files + 1 L2 files => 345B [INFO] [stdout] test db_impl::tests::test_db_impl_compact_single_file ... ok [INFO] [stderr] Compaction finished: level 0: 2 files, 483 bytes ([(1, 232), (2, 251)]); level 2: 2 files, 595 bytes ([(13, 345), (7, 250)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stdout] test db_impl::tests::test_db_impl_memtable_compaction ... ok [INFO] [stderr] Deleting file type=Table num=3 [INFO] [stderr] Deleting file type=Table num=5 [INFO] [stderr] Deleting file type=Table num=4 [INFO] [stderr] Deleting file type=Table num=6 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stdout] test db_impl::tests::test_db_impl_delete ... ok [INFO] [stderr] New table num=13: keys=8 size=306 [INFO] [stderr] Compacted 2 L0 files + 1 L1 files => 306B [INFO] [stderr] Compaction finished: level 1: 3 files, 739 bytes ([(13, 306), (4, 216), (5, 217)]); level 2: 2 files, 468 bytes ([(6, 218), (7, 250)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stderr] Deleting file type=Table num=1 [INFO] [stderr] Deleting file type=Table num=2 [INFO] [stderr] Deleting file type=Table num=3 [INFO] [stderr] Expanding inputs@1 2+1 (522+218 bytes) to 3+1 (739+218 bytes) [INFO] [stderr] Compacting @1 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [102, 97, 98, 1, 15, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 3 files at L1 and 1 files at L2 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] New table num=15: keys=8 size=306 [INFO] [stderr] Compacted 2 L0 files + 1 L1 files => 306B [INFO] [stderr] Compaction finished: level 1: 3 files, 739 bytes ([(15, 306), (4, 216), (5, 217)]); level 2: 3 files, 650 bytes ([(6, 218), (7, 250), (14, 182)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stderr] Deleting file type=Table num=3 [INFO] [stderr] Deleting file type=Table num=1 [INFO] [stderr] Deleting file type=Table num=2 [INFO] [stderr] Expanding inputs@1 2+1 (522+218 bytes) to 3+1 (739+218 bytes) [INFO] [stderr] Compacting @1 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [102, 97, 98, 1, 15, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 3 files at L1 and 1 files at L2 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] L0 table 000003 has 197 bytes [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Deleting file type=Log num=3 [INFO] [stderr] Deleting file type=Descriptor num=1 [INFO] [stderr] files: [[RefCell { value: FileMetaData { allowed_seeks: 100, num: 3, size: 197, smallest: [97, 98, 99, 1, 1, 0, 0, 0, 0, 0, 0], largest: [97, 98, 100, 1, 2, 0, 0, 0, 0, 0, 0] } }], [], [], [], [], [], []] [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Recovered manifest with next_file=6 manifest_num=5 log_num=4 prev_log_num=0 last_seq=2 [INFO] [stderr] reusing manifest "db/MANIFEST-000002" [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] Recovering log file "db/000004.log" [INFO] [stdout] test db_impl::tests::test_db_impl_init ... ok [INFO] [stderr] reusing log file "db/000004.log" [INFO] [stderr] New table num=14: keys=15 size=435 [INFO] [stderr] Compacted 3 L1 files + 1 L2 files => 435B [INFO] [stderr] Compaction finished: level 2: 2 files, 685 bytes ([(14, 435), (7, 250)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stderr] Deleting file type=Table num=6 [INFO] [stderr] Recovered manifest with next_file=14 manifest_num=13 log_num=12 prev_log_num=0 last_seq=30 [INFO] [stderr] Deleting file type=Table num=5 [INFO] [stderr] Recovering log file "db/000012.log" [INFO] [stderr] Deleting file type=Table num=4 [INFO] [stderr] Deleting file type=Table num=13 [INFO] [stderr] New table num=16: keys=15 size=435 [INFO] [stderr] Compacting @2 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [102, 98, 97, 1, 12, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacted 3 L1 files + 1 L2 files => 435B [INFO] [stderr] Compaction finished: level 2: 3 files, 867 bytes ([(16, 435), (7, 250), (14, 182)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stderr] Start write of L0 table 000014 [INFO] [stderr] Compacting 1 files at L2 and 0 files at L3 [INFO] [stderr] Deleting file type=Table num=6 [INFO] [stderr] Deleting file type=Table num=4 [INFO] [stderr] Deleting file type=Table num=15 [INFO] [stderr] Deleting file type=Table num=5 [INFO] [stderr] Compacting @2 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [102, 98, 97, 1, 12, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 1 files at L2 and 0 files at L3 [INFO] [stdout] test db_impl::tests::test_db_impl_get_from_table_with_snapshot ... ok [INFO] [stderr] New table num=15: keys=15 size=435 [INFO] [stderr] Compacted 1 L2 files + 0 L3 files => 435B [INFO] [stderr] Compaction finished: level 2: 1 files, 250 bytes ([(7, 250)]); level 3: 3 files, 835 bytes ([(15, 435), (8, 200), (9, 200)]); [INFO] [stdout] test filter::tests::test_filter_bloom ... ok [INFO] [stdout] test db_iter::tests::db_iter_deleted_entry_not_returned ... ok [INFO] [stdout] test filter::tests::test_filter_bloom_hash ... ok [INFO] [stdout] test db_iter::tests::db_iter_basic_test ... ok [INFO] [stderr] New table num=17: keys=15 size=435 [INFO] [stderr] Compacted 1 L2 files + 0 L3 files => 435B [INFO] [stderr] Compaction finished: level 2: 2 files, 432 bytes ([(7, 250), (14, 182)]); level 3: 3 files, 835 bytes ([(17, 435), (8, 200), (9, 200)]); [INFO] [stderr] Deleting file type=Table num=16 [INFO] [stderr] Deleting file type=Table num=14 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stderr] L0 table 000014 has 238 bytes [INFO] [stdout] test filter::tests::test_filter_internal_keys_identical ... ok [INFO] [stdout] test db_impl::tests::test_db_impl_compact_range ... ok [INFO] [stdout] test filter_block::tests::test_filter_block_build_read ... ok [INFO] [stdout] test db_impl::tests::test_db_impl_compact_range_memtable ... ok [INFO] [stdout] test filter_block::tests::test_filter_block_builder ... ok [INFO] [stdout] test filter_block::tests::test_filter_index ... ok [INFO] [stdout] test log::tests::test_crc_mask_crc ... ok [INFO] [stdout] test log::tests::test_crc_sanity ... ok [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stdout] test key_types::tests::test_memtable_lookupkey ... ok [INFO] [stdout] test key_types::tests::test_build_memtable_key ... ok [INFO] [stdout] test log::tests::test_reader ... ok [INFO] [stdout] test mem_env::tests::test_mem_fs_memfile_read ... ok [INFO] [stdout] test mem_env::tests::test_mem_fs_lock ... ok [INFO] [stdout] test log::tests::test_writer ... ok [INFO] [stderr] Deleting file type=Descriptor num=11 [INFO] [stderr] Deleting file type=Log num=12 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stdout] test mem_env::tests::test_mem_fs_memfile_write ... ok [INFO] [stdout] test mem_env::tests::test_mem_fs_memfile_readat ... ok [INFO] [stderr] Recovered manifest with next_file=17 manifest_num=16 log_num=15 prev_log_num=0 last_seq=35 [INFO] [stderr] Recovering log file "db/000015.log" [INFO] [stdout] test log::tests::test_writer_append ... ok [INFO] [stdout] test mem_env::tests::test_mem_fs_metadata_operations ... ok [INFO] [stderr] Start write of L0 table 000017 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] L0 table 000017 has 182 bytes [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stdout] test mem_env::tests::test_mem_fs_open_read_write_append_truncate ... ok [INFO] [stdout] test mem_env::tests::test_mem_fs_open_read_write ... ok [INFO] [stdout] test mem_env::tests::test_memenv_all ... ok [INFO] [stdout] test db_iter::tests::db_iter_deleted_entry_not_returned_memtable ... ok [INFO] [stdout] test mem_env::tests::test_mem_fs_children ... ok [INFO] [stdout] test db_iter::tests::db_iter_test_fwd_backwd ... ok [INFO] [stderr] Recovered manifest with next_file=14 manifest_num=13 log_num=12 prev_log_num=0 last_seq=30 [INFO] [stdout] test memtable::tests::test_memtable_add ... ok [INFO] [stderr] Recovering log file "db/000012.log" [INFO] [stderr] Deleting file type=Descriptor num=13 [INFO] [stderr] Deleting file type=Log num=15 [INFO] [stdout] test memtable::tests::test_memtable_iterator_behavior ... ok [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting 2 files at L0 and 1 files at L1 [INFO] [stderr] Recovered manifest with next_file=12 manifest_num=11 log_num=0 prev_log_num=0 last_seq=30 [INFO] [stderr] Deleting file type=Descriptor num=10 [INFO] [stdout] test memtable::tests::test_memtable_parse_tag ... ok [INFO] [stdout] test memtable::tests::test_memtable_add_get ... ok [INFO] [stderr] Start write of L0 table 000014 [INFO] [stdout] test memtable::tests::test_memtable_iterator_init ... ok [INFO] [stdout] test memtable::tests::test_memtable_iterator_reverse ... ok [INFO] [stdout] test memtable::tests::test_memtable_iterator_seek ... ok [INFO] [stdout] test merging_iter::tests::test_merging_forward_backward ... ok [INFO] [stdout] test memtable::tests::test_shift_left ... ok [INFO] [stdout] test merging_iter::tests::test_merging_seek_reset ... ok [INFO] [stdout] test merging_iter::tests::test_merging_real ... ok [INFO] [stdout] test merging_iter::tests::test_merging_behavior ... ok [INFO] [stdout] test memtable::tests::test_memtable_iterator_fwd ... ok [INFO] [stdout] test memtable::tests::test_memtable_parse_key ... ok [INFO] [stdout] test merging_iter::tests::test_merging_one ... ok [INFO] [stdout] test merging_iter::tests::test_merging_zero ... ok [INFO] [stdout] test skipmap::tests::test_empty_skipmap_find_memtable_cmp ... ok [INFO] [stderr] L0 table 000014 has 253 bytes [INFO] [stdout] test skipmap::tests::test_contains ... ok [INFO] [stdout] test skipmap::tests::test_skipmap_behavior ... ok [INFO] [stdout] test db_iter::tests::db_iter_test_seek ... ok [INFO] [stderr] Deleting file type=Descriptor num=11 [INFO] [stderr] Deleting file type=Log num=12 [INFO] [stdout] test merging_iter::tests::test_merging_two ... ok [INFO] [stdout] test skipmap::tests::test_skipmap_iterator_0 ... ok [INFO] [stdout] test skipmap::tests::test_find ... ok [INFO] [stdout] test snapshot::tests::test_snapshot_list ... ok [INFO] [stdout] test skipmap::tests::test_skipmap_iterator_init ... ok [INFO] [stdout] test skipmap::tests::test_skipmap_iterator ... ok [INFO] [stdout] test skipmap::tests::test_skipmap_iterator_concurrent_insert ... ok [INFO] [stdout] test table_builder::tests::test_footer ... ok [INFO] [stdout] test skipmap::tests::test_skipmap_iterator_seek_valid ... ok [INFO] [stdout] test table_cache::tests::test_filenum_to_key ... ok [INFO] [stdout] test skipmap::tests::test_skipmap_iterator_prev ... ok [INFO] [stderr] (took PT0.000559009S) Recovered manifest with next_file=17 manifest_num=16 log_num=15 prev_log_num=0 last_seq=36 [INFO] [stdout] test table_cache::tests::test_table_file_name ... ok [INFO] [stderr] Recovering log file "db/000015.log" [INFO] [stderr] Start write of L0 table 000017 [INFO] [stderr] New table num=19: keys=8 size=306 [INFO] [stderr] Compacted 2 L0 files + 1 L1 files => 306B [INFO] [stderr] Compaction finished: level 0: 2 files, 420 bytes ([(14, 238), (17, 182)]); level 1: 3 files, 739 bytes ([(19, 306), (4, 216), (5, 217)]); level 2: 2 files, 468 bytes ([(6, 218), (7, 250)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stderr] Deleting file type=Table num=1 [INFO] [stderr] Deleting file type=Table num=2 [INFO] [stderr] Deleting file type=Table num=3 [INFO] [stdout] test db_iter::tests::db_iter_reset ... ok [INFO] [stdout] test skipmap::tests::test_insert ... ok [INFO] [stderr] L0 table 000017 has 179 bytes [INFO] [stdout] test table_cache::tests::test_table_cache ... ok [INFO] [stdout] test table_reader::tests::test_table_block_cache_use ... ok [INFO] [stderr] Deleting file type=Log num=15 [INFO] [stdout] test table_reader::tests::test_table_iterator_behavior_standard ... ok [INFO] [stderr] Deleting file type=Descriptor num=13 [INFO] [stdout] test table_reader::tests::test_table_approximate_offset ... ok [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stdout] test table_reader::tests::test_table_get ... ok [INFO] [stderr] Compacting 2 files at L0 and 1 files at L1 [INFO] [stdout] test table_builder::tests::test_table_builder ... ok [INFO] [stdout] test table_reader::tests::test_table_iterator_filter ... ok [INFO] [stdout] test table_reader::tests::test_table_iterator_fwd_bwd ... ok [INFO] [stdout] test test_util::tests::test_test_util_basic ... ok [INFO] [stdout] test table_reader::tests::test_table_internal_keys ... ok [INFO] [stdout] test table_reader::tests::test_table_iterator_seek ... ok [INFO] [stderr] New table num=19: keys=8 size=306 [INFO] [stdout] test db_iter::tests::db_iter_repeated_open_close ... ok [INFO] [stderr] Compacted 2 L0 files + 1 L1 files => 306B [INFO] [stdout] test table_reader::tests::test_table_reader_checksum ... ok [INFO] [stderr] Compaction finished: level 0: 2 files, 432 bytes ([(14, 253), (17, 179)]); level 1: 3 files, 739 bytes ([(19, 306), (4, 216), (5, 217)]); level 2: 2 files, 468 bytes ([(6, 218), (7, 250)]); level 3: 2 files, 400 bytes ([(8, 200), (9, 200)]); [INFO] [stdout] test table_reader::tests::test_table_iterator_state_behavior ... ok [INFO] [stderr] Deleting file type=Table num=2 [INFO] [stderr] Deleting file type=Table num=1 [INFO] [stderr] Deleting file type=Table num=3 [INFO] [stdout] test types::tests::test_types_parse_file_name ... ok [INFO] [stdout] test test_util::tests::test_test_util_ldbiter_properties ... ok [INFO] [stdout] test version::tests::test_version_file_overlaps ... ok [INFO] [stdout] test table_reader::tests::test_table_iterator_values ... ok [INFO] [stderr] (init took PT0.000002600S) (took PT0.000059501S) (took PT0.000108002S) Recovered manifest with next_file=21 manifest_num=20 log_num=18 prev_log_num=0 last_seq=37 [INFO] [stderr] Recovering log file "db/000018.log" [INFO] [stderr] Start write of L0 table 000021 [INFO] [stdout] test version::tests::test_version_key_ordering ... ok [INFO] [stderr] (took PT0.000031600S) L0 table 000021 has 182 bytes [INFO] [stderr] Deleting file type=Log num=18 [INFO] [stderr] Deleting file type=Descriptor num=16 [INFO] [stdout] test db_impl::tests::test_db_impl_open_close_reopen ... ok [INFO] [stdout] test version::tests::test_version_max_next_level_overlapping ... ok [INFO] [stdout] test version::tests::test_version_overlap_in_level ... ok [INFO] [stdout] test version::tests::test_version_concat_iter ... ok [INFO] [stdout] test version::tests::test_version_all_iters ... ok [INFO] [stdout] test version::tests::test_version_concat_iter_properties ... ok [INFO] [stdout] test version::tests::test_version_overlapping_inputs ... ok [INFO] [stdout] test version_set::tests::test_version_set_get_range ... ok [INFO] [stdout] test version::tests::test_version_record_read_sample ... ok [INFO] [stdout] test version_set::tests::test_version_set_merge_iters ... ok [INFO] [stdout] test version::tests::test_version_get_overlapping_basic ... ok [INFO] [stdout] test version_set::tests::test_version_set_total_size ... ok [INFO] [stdout] test version::tests::test_version_summary ... ok [INFO] [stdout] test version_edit::tests::test_version_edit_encode_decode ... ok [INFO] [stdout] test version::tests::test_version_get_simple ... ok [INFO] [stdout] test version::tests::test_version_pick_memtable_output_level ... ok [INFO] [stderr] (overlapping-inputs took PT0.000080702S) Recovered manifest with next_file=21 manifest_num=20 log_num=10 prev_log_num=0 last_seq=30 [INFO] [stderr] reusing manifest "db/MANIFEST-000019" [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Expanding inputs@1 1+1 (218+218 bytes) to 3+1 (651+218 bytes) [INFO] [stdout] test version_set::tests::test_version_set_log_and_apply ... ok [INFO] [stderr] Compacting @1 [97, 97, 97, 1, 19, 0, 0, 0, 0, 0, 0] .. [102, 97, 98, 1, 15, 0, 0, 0, 0, 0, 0] [INFO] [stdout] test version_set::tests::test_version_set_pick_compaction ... ok [INFO] [stdout] test version_set::tests::test_version_set_builder ... ok [INFO] [stdout] test write_batch::tests::test_write_batch ... ok [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stdout] test version_set::tests::test_version_set_utils ... ok [INFO] [stderr] Expanding inputs@1 2+1 (433+218 bytes) to 3+1 (651+218 bytes) [INFO] [stderr] Compacting @1 [97, 97, 97, 1, 19, 0, 0, 0, 0, 0, 0] .. [102, 97, 98, 1, 15, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting @2 [99, 97, 98, 1, 10, 0, 0, 0, 0, 0, 0] .. [102, 98, 97, 1, 12, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stderr] Compacting @0 [97, 97, 97, 1, 22, 0, 0, 0, 0, 0, 0] .. [98, 98, 97, 1, 30, 0, 0, 0, 0, 0, 0] [INFO] [stdout] test version_set::tests::test_version_set_compaction ... ok [INFO] [stdout] test block_builder::tests::test_block_builder_panics ... ok [INFO] [stdout] test cmp::tests::test_cmp_memtablekeycmp_panics ... ok [INFO] [stdout] test disk_env::tests::test_files ... FAILED [INFO] [stdout] test disk_env::tests::test_dirs ... FAILED [INFO] [stdout] test disk_env::tests::test_locking ... FAILED [INFO] [stdout] test skipmap::tests::test_no_dupes ... ok [INFO] [stdout] test table_builder::tests::test_bad_input ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- disk_env::tests::test_files stdout ---- [INFO] [stdout] thread 'disk_env::tests::test_files' panicked at 'assertion failed: env.open_appendable_file(name).is_ok()', src/disk_env.rs:206:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5603d00f233b - backtrace::backtrace::libunwind::trace::h89fcc71e59e3bc5b [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x5603d00f233b - backtrace::backtrace::trace_unsynchronized::h0bad9be1379e729a [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x5603d00f233b - std::sys_common::backtrace::_print::hd3382a1f33c473da [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x5603d00f233b - std::sys_common::backtrace::print::h0ec6f03cfb8e76a6 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x5603d00f233b - std::panicking::default_hook::{{closure}}::h96cbf7b454e3f557 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x5603d00f1fac - std::panicking::default_hook::h95a8f00337383d83 [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x5603d00f2aad - std::panicking::rust_panic_with_hook::h92f98b46e22f14ed [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x5603d00d6a55 - std::panicking::begin_panic::h6c846a4ba10071bb [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:411 [INFO] [stdout] 8: 0x5603cff67e0f - rusty_leveldb::disk_env::tests::test_files::h15be6d965f106b31 [INFO] [stdout] at src/disk_env.rs:206 [INFO] [stdout] 9: 0x5603cff67c8a - rusty_leveldb::disk_env::tests::test_files::{{closure}}::h0f15a4845a77b1f0 [INFO] [stdout] at src/disk_env.rs:200 [INFO] [stdout] 10: 0x5603cfe8a46e - core::ops::function::FnOnce::call_once::h166630d4a34d2c66 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 11: 0x5603d003303f - as core::ops::function::FnOnce>::call_once::hac0fbe2754f8bd24 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 12: 0x5603d00f5f3a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 13: 0x5603d004d62e - std::panicking::try::h9d6938917cc05e3f [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 14: 0x5603d004d62e - std::panic::catch_unwind::h5be70fd1d69515b0 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 15: 0x5603d004d62e - test::run_test::run_test_inner::{{closure}}::h056f206eafd8ff6e [INFO] [stdout] at src/libtest/lib.rs:1408 [INFO] [stdout] 16: 0x5603d0028a65 - std::sys_common::backtrace::__rust_begin_short_backtrace::h859abbc742a34b19 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 17: 0x5603d002cba5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf8192ec938c43694 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:470 [INFO] [stdout] 18: 0x5603d002cba5 - as core::ops::function::FnOnce<()>>::call_once::hae7b2431555cb4db [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:315 [INFO] [stdout] 19: 0x5603d002cba5 - std::panicking::try::do_call::h6da7ecd0783259d7 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:296 [INFO] [stdout] 20: 0x5603d00f5f3a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 21: 0x5603d002d182 - std::panicking::try::h3c1c35414c2c78f1 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 22: 0x5603d002d182 - std::panic::catch_unwind::ha5cfb2018fda983e [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 23: 0x5603d002d182 - std::thread::Builder::spawn_unchecked::{{closure}}::hc7620e41f0938c09 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:469 [INFO] [stdout] 24: 0x5603d002d182 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h1b3b20eeb6ea6ddd [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 25: 0x5603d00e646f - as core::ops::function::FnOnce>::call_once::h2877b2aefb0fd627 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 26: 0x5603d00f5310 - as core::ops::function::FnOnce>::call_once::h13f473dbcdaa0fef [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 27: 0x5603d00f5310 - std::sys_common::thread::start_thread::h562a7c4953cb1d31 [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 28: 0x5603d00f5310 - std::sys::unix::thread::Thread::new::thread_start::h382c6ae14181d163 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 29: 0x7ffb61d606db - start_thread [INFO] [stdout] 30: 0x7ffb6187188f - __clone [INFO] [stdout] 31: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- disk_env::tests::test_dirs stdout ---- [INFO] [stdout] thread 'disk_env::tests::test_dirs' panicked at 'assertion failed: env.mkdir(dirname).is_ok()', src/disk_env.rs:272:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5603d00f233b - backtrace::backtrace::libunwind::trace::h89fcc71e59e3bc5b [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x5603d00f233b - backtrace::backtrace::trace_unsynchronized::h0bad9be1379e729a [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x5603d00f233b - std::sys_common::backtrace::_print::hd3382a1f33c473da [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x5603d00f233b - std::sys_common::backtrace::print::h0ec6f03cfb8e76a6 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x5603d00f233b - std::panicking::default_hook::{{closure}}::h96cbf7b454e3f557 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x5603d00f1fac - std::panicking::default_hook::h95a8f00337383d83 [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x5603d00f2aad - std::panicking::rust_panic_with_hook::h92f98b46e22f14ed [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x5603d00d6a55 - std::panicking::begin_panic::h6c846a4ba10071bb [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:411 [INFO] [stdout] 8: 0x5603cff6971e - rusty_leveldb::disk_env::tests::test_dirs::hf91fc2ad67a4249a [INFO] [stdout] at src/disk_env.rs:272 [INFO] [stdout] 9: 0x5603cff695ea - rusty_leveldb::disk_env::tests::test_dirs::{{closure}}::h3a996f9a63b8497f [INFO] [stdout] at src/disk_env.rs:267 [INFO] [stdout] 10: 0x5603cfe8b54e - core::ops::function::FnOnce::call_once::ha9d126aa6b9facd3 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 11: 0x5603d003303f - as core::ops::function::FnOnce>::call_once::hac0fbe2754f8bd24 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 12: 0x5603d00f5f3a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 13: 0x5603d004d62e - std::panicking::try::h9d6938917cc05e3f [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 14: 0x5603d004d62e - std::panic::catch_unwind::h5be70fd1d69515b0 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 15: 0x5603d004d62e - test::run_test::run_test_inner::{{closure}}::h056f206eafd8ff6e [INFO] [stdout] at src/libtest/lib.rs:1408 [INFO] [stdout] 16: 0x5603d0028a65 - std::sys_common::backtrace::__rust_begin_short_backtrace::h859abbc742a34b19 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 17: 0x5603d002cba5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf8192ec938c43694 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:470 [INFO] [stdout] 18: 0x5603d002cba5 - as core::ops::function::FnOnce<()>>::call_once::hae7b2431555cb4db [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:315 [INFO] [stdout] 19: 0x5603d002cba5 - std::panicking::try::do_call::h6da7ecd0783259d7 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:296 [INFO] [stdout] 20: 0x5603d00f5f3a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 21: 0x5603d002d182 - std::panicking::try::h3c1c35414c2c78f1 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 22: 0x5603d002d182 - std::panic::catch_unwind::ha5cfb2018fda983e [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 23: 0x5603d002d182 - std::thread::Builder::spawn_unchecked::{{closure}}::hc7620e41f0938c09 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:469 [INFO] [stdout] 24: 0x5603d002d182 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h1b3b20eeb6ea6ddd [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 25: 0x5603d00e646f - as core::ops::function::FnOnce>::call_once::h2877b2aefb0fd627 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 26: 0x5603d00f5310 - as core::ops::function::FnOnce>::call_once::h13f473dbcdaa0fef [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 27: 0x5603d00f5310 - std::sys_common::thread::start_thread::h562a7c4953cb1d31 [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 28: 0x5603d00f5310 - std::sys::unix::thread::Thread::new::thread_start::h382c6ae14181d163 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 29: 0x7ffb61d606db - start_thread [INFO] [stdout] 30: 0x7ffb6187188f - __clone [INFO] [stdout] 31: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- disk_env::tests::test_locking stdout ---- [INFO] [stdout] thread 'disk_env::tests::test_locking' panicked at 'called `Result::unwrap()` on an `Err` value: Status { code: IOError, err: "open (write): IOError: other os error: testfile.123" }', src/libcore/result.rs:1084:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5603d00f233b - backtrace::backtrace::libunwind::trace::h89fcc71e59e3bc5b [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x5603d00f233b - backtrace::backtrace::trace_unsynchronized::h0bad9be1379e729a [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.34/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x5603d00f233b - std::sys_common::backtrace::_print::hd3382a1f33c473da [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x5603d00f233b - std::sys_common::backtrace::print::h0ec6f03cfb8e76a6 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x5603d00f233b - std::panicking::default_hook::{{closure}}::h96cbf7b454e3f557 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x5603d00f1fac - std::panicking::default_hook::h95a8f00337383d83 [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x5603d00f2aad - std::panicking::rust_panic_with_hook::h92f98b46e22f14ed [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x5603d00f2632 - std::panicking::continue_panic_fmt::h25abfbb4e5b7043a [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x5603d00f2516 - rust_begin_unwind [INFO] [stdout] at src/libstd/panicking.rs:311 [INFO] [stdout] 9: 0x5603d010968d - core::panicking::panic_fmt::h7e9f94035af782b3 [INFO] [stdout] at src/libcore/panicking.rs:85 [INFO] [stdout] 10: 0x5603d0109787 - core::result::unwrap_failed::hf7591c1dd9412006 [INFO] [stdout] at src/libcore/result.rs:1084 [INFO] [stdout] 11: 0x5603cfe9d8ff - core::result::Result::unwrap::h4e91f10479c57ed9 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/result.rs:852 [INFO] [stdout] 12: 0x5603cff68f47 - rusty_leveldb::disk_env::tests::test_locking::h5cb068324202e5f7 [INFO] [stdout] at src/disk_env.rs:244 [INFO] [stdout] 13: 0x5603cff68e6a - rusty_leveldb::disk_env::tests::test_locking::{{closure}}::h1acb9aa077c5b148 [INFO] [stdout] at src/disk_env.rs:238 [INFO] [stdout] 14: 0x5603cfe8a23e - core::ops::function::FnOnce::call_once::h0c4096ded375dd40 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 15: 0x5603d003303f - as core::ops::function::FnOnce>::call_once::hac0fbe2754f8bd24 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 16: 0x5603d00f5f3a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 17: 0x5603d004d62e - std::panicking::try::h9d6938917cc05e3f [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 18: 0x5603d004d62e - std::panic::catch_unwind::h5be70fd1d69515b0 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 19: 0x5603d004d62e - test::run_test::run_test_inner::{{closure}}::h056f206eafd8ff6e [INFO] [stdout] at src/libtest/lib.rs:1408 [INFO] [stdout] 20: 0x5603d0028a65 - std::sys_common::backtrace::__rust_begin_short_backtrace::h859abbc742a34b19 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 21: 0x5603d002cba5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf8192ec938c43694 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:470 [INFO] [stdout] 22: 0x5603d002cba5 - as core::ops::function::FnOnce<()>>::call_once::hae7b2431555cb4db [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:315 [INFO] [stdout] 23: 0x5603d002cba5 - std::panicking::try::do_call::h6da7ecd0783259d7 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:296 [INFO] [stdout] 24: 0x5603d00f5f3a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:80 [INFO] [stdout] 25: 0x5603d002d182 - std::panicking::try::h3c1c35414c2c78f1 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panicking.rs:275 [INFO] [stdout] 26: 0x5603d002d182 - std::panic::catch_unwind::ha5cfb2018fda983e [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/panic.rs:394 [INFO] [stdout] 27: 0x5603d002d182 - std::thread::Builder::spawn_unchecked::{{closure}}::hc7620e41f0938c09 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libstd/thread/mod.rs:469 [INFO] [stdout] 28: 0x5603d002d182 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h1b3b20eeb6ea6ddd [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/libcore/ops/function.rs:235 [INFO] [stdout] 29: 0x5603d00e646f - as core::ops::function::FnOnce>::call_once::h2877b2aefb0fd627 [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 30: 0x5603d00f5310 - as core::ops::function::FnOnce>::call_once::h13f473dbcdaa0fef [INFO] [stdout] at /rustc/625451e376bb2e5283fc4741caa0a3e8a2ca4d54/src/liballoc/boxed.rs:787 [INFO] [stdout] 31: 0x5603d00f5310 - std::sys_common::thread::start_thread::h562a7c4953cb1d31 [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 32: 0x5603d00f5310 - std::sys::unix::thread::Thread::new::thread_start::h382c6ae14181d163 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 33: 0x7ffb61d606db - start_thread [INFO] [stdout] 34: 0x7ffb6187188f - __clone [INFO] [stdout] 35: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] disk_env::tests::test_dirs [INFO] [stdout] disk_env::tests::test_files [INFO] [stdout] disk_env::tests::test_locking [INFO] [stdout] [INFO] [stdout] test result: FAILED. 140 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] (compaction tests took PT0.002209435S) (took PT0.004547574S) error: test failed, to rerun pass '--lib' [INFO] running `"docker" "inspect" "022fa36a857bb18461ad2edf14661feba19edcaa3f3691d1fa48517a088b7e7b"` [INFO] running `"docker" "rm" "-f" "022fa36a857bb18461ad2edf14661feba19edcaa3f3691d1fa48517a088b7e7b"` [INFO] [stdout] 022fa36a857bb18461ad2edf14661feba19edcaa3f3691d1fa48517a088b7e7b