[INFO] fetching crate sstable 0.11.1...
[INFO] testing sstable-0.11.1 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate sstable 0.11.1 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate sstable 0.11.1
[INFO] finished tweaking crates.io crate sstable 0.11.1
[INFO] tweaked toml for crates.io crate sstable 0.11.1 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate sstable 0.11.1 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 26 packages to latest compatible versions
[INFO] [stderr]       Adding integer-encoding v3.0.4 (available: v4.1.0)
[INFO] [stderr]       Adding rand v0.7.3 (available: v0.10.1)
[INFO] [stderr]       Adding time-test v0.2.3 (available: v0.3.0)
[INFO] [stderr]       Adding wasi v0.10.0+wasi-snapshot-preview1 (available: v0.10.2+wasi-snapshot-preview1)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded integer-encoding v3.0.4
[INFO] [stderr]   Downloaded time-test v0.2.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8cfe92c20a738aa56145173102343b58b3f2637c7418f2e3210956072f237d13
[INFO] running `Command { std: "docker" "start" "-a" "8cfe92c20a738aa56145173102343b58b3f2637c7418f2e3210956072f237d13", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8cfe92c20a738aa56145173102343b58b3f2637c7418f2e3210956072f237d13", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8cfe92c20a738aa56145173102343b58b3f2637c7418f2e3210956072f237d13", kill_on_drop: false }`
[INFO] [stdout] 8cfe92c20a738aa56145173102343b58b3f2637c7418f2e3210956072f237d13
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2341c53744e9f5737bc5f1d50142c55e2ca100404720755eb85d5d2891531ac0
[INFO] running `Command { std: "docker" "start" "-a" "2341c53744e9f5737bc5f1d50142c55e2ca100404720755eb85d5d2891531ac0", kill_on_drop: false }`
[INFO] [stderr]    Compiling snap v1.1.1
[INFO] [stderr]    Compiling integer-encoding v3.0.4
[INFO] [stderr]    Compiling sstable v0.11.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.33s
[INFO] running `Command { std: "docker" "inspect" "2341c53744e9f5737bc5f1d50142c55e2ca100404720755eb85d5d2891531ac0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2341c53744e9f5737bc5f1d50142c55e2ca100404720755eb85d5d2891531ac0", kill_on_drop: false }`
[INFO] [stdout] 2341c53744e9f5737bc5f1d50142c55e2ca100404720755eb85d5d2891531ac0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 36107b1c03b03506fa34e938bbfff04526881d69b37ef2a599c70ad5f82fd6c2
[INFO] running `Command { std: "docker" "start" "-a" "36107b1c03b03506fa34e938bbfff04526881d69b37ef2a599c70ad5f82fd6c2", kill_on_drop: false }`
[INFO] [stderr]    Compiling bencher v0.1.5
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling time v0.1.45
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling time-test v0.2.3
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling sstable v0.11.1 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unnecessary parentheses around closure body
[INFO] [stdout]    --> src/cache.rs:363:52
[INFO] [stdout]     |
[INFO] [stdout] 363 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stdout]     |                                                    ^  ^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_parens)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] help: remove these parentheses
[INFO] [stdout]     |
[INFO] [stdout] 363 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stdout] 363 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 244);
[INFO] [stdout]     |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unnecessary parentheses around closure body
[INFO] [stdout]    --> src/cache.rs:367:52
[INFO] [stdout]     |
[INFO] [stdout] 367 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 56);
[INFO] [stdout]     |                                                    ^  ^
[INFO] [stdout]     |
[INFO] [stdout] help: remove these parentheses
[INFO] [stdout]     |
[INFO] [stdout] 367 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 56);
[INFO] [stdout] 367 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 56);
[INFO] [stdout]     |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unnecessary parentheses around closure body
[INFO] [stdout]    --> src/cache.rs:371:52
[INFO] [stdout]     |
[INFO] [stdout] 371 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stdout]     |                                                    ^  ^
[INFO] [stdout]     |
[INFO] [stdout] help: remove these parentheses
[INFO] [stdout]     |
[INFO] [stdout] 371 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stdout] 371 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 244);
[INFO] [stdout]     |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unnecessary parentheses around closure body
[INFO] [stdout]    --> src/cache.rs:375:52
[INFO] [stdout]     |
[INFO] [stdout] 375 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 22);
[INFO] [stdout]     |                                                    ^  ^
[INFO] [stdout]     |
[INFO] [stdout] help: remove these parentheses
[INFO] [stdout]     |
[INFO] [stdout] 375 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 22);
[INFO] [stdout] 375 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 22);
[INFO] [stdout]     |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.08s
[INFO] running `Command { std: "docker" "inspect" "36107b1c03b03506fa34e938bbfff04526881d69b37ef2a599c70ad5f82fd6c2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "36107b1c03b03506fa34e938bbfff04526881d69b37ef2a599c70ad5f82fd6c2", kill_on_drop: false }`
[INFO] [stdout] 36107b1c03b03506fa34e938bbfff04526881d69b37ef2a599c70ad5f82fd6c2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] dda45959b30ea652a4744dcf873de590fbaa217a4596290d42e2af313519bcf8
[INFO] running `Command { std: "docker" "start" "-a" "dda45959b30ea652a4744dcf873de590fbaa217a4596290d42e2af313519bcf8", kill_on_drop: false }`
[INFO] [stderr] warning: unnecessary parentheses around closure body
[INFO] [stderr]    --> src/cache.rs:363:52
[INFO] [stderr]     |
[INFO] [stderr] 363 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stderr]     |                                                    ^  ^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_parens)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] help: remove these parentheses
[INFO] [stderr]     |
[INFO] [stderr] 363 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stderr] 363 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 244);
[INFO] [stderr]     |
[INFO] [stderr] 
[INFO] [stderr] warning: unnecessary parentheses around closure body
[INFO] [stderr]    --> src/cache.rs:367:52
[INFO] [stderr]     |
[INFO] [stderr] 367 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 56);
[INFO] [stderr]     |                                                    ^  ^
[INFO] [stderr]     |
[INFO] [stderr] help: remove these parentheses
[INFO] [stderr]     |
[INFO] [stderr] 367 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 56);
[INFO] [stderr] 367 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 56);
[INFO] [stderr]     |
[INFO] [stderr] 
[INFO] [stderr] warning: unnecessary parentheses around closure body
[INFO] [stderr]    --> src/cache.rs:371:52
[INFO] [stderr]     |
[INFO] [stderr] 371 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stderr]     |                                                    ^  ^
[INFO] [stderr]     |
[INFO] [stderr] help: remove these parentheses
[INFO] [stderr]     |
[INFO] [stderr] 371 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 244);
[INFO] [stderr] 371 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 244);
[INFO] [stderr]     |
[INFO] [stderr] 
[INFO] [stderr] warning: unnecessary parentheses around closure body
[INFO] [stderr]    --> src/cache.rs:375:52
[INFO] [stderr]     |
[INFO] [stderr] 375 |         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 22);
[INFO] [stderr]     |                                                    ^  ^
[INFO] [stderr]     |
[INFO] [stderr] help: remove these parentheses
[INFO] [stderr]     |
[INFO] [stderr] 375 -         assert_eq!(lru._testing_head_ref().map(|r| (*r)).unwrap(), 22);
[INFO] [stderr] 375 +         assert_eq!(lru._testing_head_ref().map(|r| *r ).unwrap(), 22);
[INFO] [stderr]     |
[INFO] [stderr] 
[INFO] [stderr] warning: `sstable` (lib test) generated 4 warnings (run `cargo fix --lib -p sstable --tests` to apply 4 suggestions)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sstable-2359547b21747b85)
[INFO] [stdout] 
[INFO] [stdout] running 39 tests
[INFO] [stdout] test block::tests::test_block_build_iterate ... ok
[INFO] [stdout] test block::tests::test_block_empty ... ok
[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_iterator_properties ... ok
[INFO] [stdout] test block::tests::test_block_seek_to_last ... ok
[INFO] [stdout] test block_builder::tests::test_block_builder_sanity ... ok
[INFO] [stdout] test blockhandle::tests::test_blockhandle ... ok
[INFO] [stdout] test cache::tests::test_blockcache_cache_add_rm ... 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_edge_cases ... ok
[INFO] [stdout] test cache::tests::test_blockcache_lru_reinsert ... ok
[INFO] [stdout] test cache::tests::test_blockcache_lru_reinsert_2 ... ok
[INFO] [stdout] test cache::tests::test_blockcache_lru_remove ... ok
[INFO] [stdout] test cmp::tests::test_cmp_defaultcmp_short_succ ... ok
[INFO] [stdout] test filter::tests::test_filter_bloom_hash ... ok
[INFO] [stdout] test filter::tests::test_filter_bloom ... ok
[INFO] [stdout] test cmp::tests::test_cmp_defaultcmp_shortest_sep ... ok
[INFO] [stdout] test filter_block::tests::test_filter_block_build_read ... 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 table_builder::tests::test_footer ... ok
[INFO] [stdout] test table_builder::tests::test_table_builder ... ok
[INFO] [stdout] test table_reader::tests::test_table_block_tiny_cache ... ok
[INFO] [stdout] test table_reader::tests::test_table_block_cache_use ... ok
[INFO] [stdout] test table_reader::tests::test_table_iterator_filter ... ok
[INFO] [stdout] test table_reader::tests::test_table_get ... ok
[INFO] [stdout] test table_reader::tests::test_table_iterator_seek ... ok
[INFO] [stdout] test table_reader::tests::test_table_iterator_behavior_standard ... ok
[INFO] [stdout] test table_reader::tests::test_table_iterator_state_behavior ... ok
[INFO] [stdout] test test_util::tests::test_test_util_basic ... ok
[INFO] [stdout] test table_reader::tests::test_table_iterator_fwd_bwd ... ok
[INFO] [stdout] test table_reader::tests::test_table_approximate_offset ... ok
[INFO] [stdout] test test_util::tests::test_test_util_ssiter_properties ... ok
[INFO] [stdout] test table_reader::tests::test_table_iterator_values ... ok
[INFO] [stdout] test table_reader::tests::test_table_reader_checksum ... ok
[INFO] [stdout] test block_builder::tests::test_block_builder_panics - should panic ... ok
[INFO] [stdout] test table_builder::tests::test_bad_input - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr] (init took PT0.000000870S) (took PT0.000030450S)    Doc-tests sstable
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "dda45959b30ea652a4744dcf873de590fbaa217a4596290d42e2af313519bcf8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dda45959b30ea652a4744dcf873de590fbaa217a4596290d42e2af313519bcf8", kill_on_drop: false }`
[INFO] [stdout] dda45959b30ea652a4744dcf873de590fbaa217a4596290d42e2af313519bcf8