Dec 04 09:45:53.109 INFO checking souvik1997/fsbench against try#1df97983eb2057dc6a8f7eb364e263b51ae23230 for pr-56481
Dec 04 09:45:53.109 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56481/worker-1/try#1df97983eb2057dc6a8f7eb364e263b51ae23230:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56481/try#1df97983eb2057dc6a8f7eb364e263b51ae23230:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +1df97983eb2057dc6a8f7eb364e263b51ae23230-alt check --frozen --all --all-targets" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 04 09:45:53.651 INFO [stdout] 78a1d91b2d982d3189c09dbbc76e1ec5bcdbf64310b1110b84358ed26a8d2708
Dec 04 09:45:53.653 INFO running `"docker" "start" "-a" "78a1d91b2d982d3189c09dbbc76e1ec5bcdbf64310b1110b84358ed26a8d2708"`
Dec 04 09:45:56.342 INFO [stderr] usermod: no changes
Dec 04 09:45:56.547 INFO [stderr]     Checking serde v1.0.29
Dec 04 09:45:56.552 INFO [stderr]     Checking log v0.4.1
Dec 04 09:45:56.552 INFO [stderr]     Checking atty v0.2.6
Dec 04 09:45:56.552 INFO [stderr]     Checking num-complex v0.1.43
Dec 04 09:45:56.552 INFO [stderr]     Checking colored v1.6.0
Dec 04 09:45:56.552 INFO [stderr]     Checking crossbeam-epoch v0.3.0
Dec 04 09:45:56.552 INFO [stderr]     Checking num-bigint v0.1.43
Dec 04 09:45:56.552 INFO [stderr]     Checking nix v0.10.0
Dec 04 09:45:57.671 INFO [stderr]    Compiling serde_derive_internals v0.20.0
Dec 04 09:45:58.223 INFO [stderr]    Compiling num-derive v0.2.0
Dec 04 09:45:58.858 INFO [stderr]     Checking remove_dir_all v0.3.0
Dec 04 09:45:59.395 INFO [stderr]     Checking clap v2.29.2
Dec 04 09:45:59.879 INFO [stderr]     Checking fern v0.5.2
Dec 04 09:46:02.767 INFO [stderr]     Checking crossbeam-deque v0.2.0
Dec 04 09:46:03.767 INFO [stderr]     Checking tempdir v0.3.6
Dec 04 09:46:04.547 INFO [stderr]     Checking rayon-core v1.4.0
Dec 04 09:46:10.260 INFO [stderr]     Checking num-rational v0.1.42
Dec 04 09:46:10.271 INFO [stderr]     Checking rayon v1.0.0
Dec 04 09:46:10.808 INFO [stderr]    Compiling serde_derive v1.0.29
Dec 04 09:46:13.731 INFO [stderr]     Checking num v0.1.42
Dec 04 09:46:14.705 INFO [stderr]     Checking chrono v0.4.0
Dec 04 09:46:34.431 INFO [stderr]     Checking serde_json v1.0.11
Dec 04 09:46:36.298 INFO [stderr]     Checking fsbench v0.1.0 (/source)
Dec 04 09:46:37.831 INFO [stderr] warning: unused import: `std::process::Command`
Dec 04 09:46:37.831 INFO [stderr]    --> src/fsbench/blktrace/trace.rs:173:13
Dec 04 09:46:37.831 INFO [stderr]     |
Dec 04 09:46:37.831 INFO [stderr] 173 |         use std::process::Command;
Dec 04 09:46:37.831 INFO [stderr]     |             ^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:37.831 INFO [stderr]     |
Dec 04 09:46:37.831 INFO [stderr]     = note: #[warn(unused_imports)] on by default
Dec 04 09:46:37.831 INFO [stderr] 
Dec 04 09:46:38.087 INFO [stderr] warning: unused import: `std::process::Command`
Dec 04 09:46:38.087 INFO [stderr]    --> src/fsbench/blktrace/trace.rs:173:13
Dec 04 09:46:38.087 INFO [stderr]     |
Dec 04 09:46:38.087 INFO [stderr] 173 |         use std::process::Command;
Dec 04 09:46:38.087 INFO [stderr]     |             ^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:38.087 INFO [stderr]     |
Dec 04 09:46:38.087 INFO [stderr]     = note: #[warn(unused_imports)] on by default
Dec 04 09:46:38.087 INFO [stderr] 
Dec 04 09:46:39.288 INFO [stderr] warning: unused variable: `split_string`
Dec 04 09:46:39.288 INFO [stderr]   --> src/fsbench/operation.rs:28:9
Dec 04 09:46:39.288 INFO [stderr]    |
Dec 04 09:46:39.288 INFO [stderr] 28 |     let split_string = vec![String::new()];
Dec 04 09:46:39.288 INFO [stderr]    |         ^^^^^^^^^^^^ help: consider using `_split_string` instead
Dec 04 09:46:39.288 INFO [stderr]    |
Dec 04 09:46:39.288 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 04 09:46:39.288 INFO [stderr] 
Dec 04 09:46:39.290 INFO [stderr] warning: variable `bytes` is assigned to, but never used
Dec 04 09:46:39.290 INFO [stderr]    --> src/fsbench/operation.rs:304:17
Dec 04 09:46:39.290 INFO [stderr]     |
Dec 04 09:46:39.290 INFO [stderr] 304 |         let mut bytes = 0;
Dec 04 09:46:39.290 INFO [stderr]     |                 ^^^^^
Dec 04 09:46:39.290 INFO [stderr]     |
Dec 04 09:46:39.290 INFO [stderr]     = note: consider using `_bytes` instead
Dec 04 09:46:39.290 INFO [stderr] 
Dec 04 09:46:39.675 INFO [stderr] warning: unused variable: `split_string`
Dec 04 09:46:39.675 INFO [stderr]   --> src/fsbench/operation.rs:28:9
Dec 04 09:46:39.675 INFO [stderr]    |
Dec 04 09:46:39.676 INFO [stderr] 28 |     let split_string = vec![String::new()];
Dec 04 09:46:39.676 INFO [stderr]    |         ^^^^^^^^^^^^ help: consider using `_split_string` instead
Dec 04 09:46:39.676 INFO [stderr]    |
Dec 04 09:46:39.677 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 04 09:46:39.677 INFO [stderr] 
Dec 04 09:46:39.680 INFO [stderr] warning: variable `bytes` is assigned to, but never used
Dec 04 09:46:39.680 INFO [stderr]    --> src/fsbench/operation.rs:304:17
Dec 04 09:46:39.680 INFO [stderr]     |
Dec 04 09:46:39.681 INFO [stderr] 304 |         let mut bytes = 0;
Dec 04 09:46:39.681 INFO [stderr]     |                 ^^^^^
Dec 04 09:46:39.681 INFO [stderr]     |
Dec 04 09:46:39.681 INFO [stderr]     = note: consider using `_bytes` instead
Dec 04 09:46:39.682 INFO [stderr] 
Dec 04 09:46:39.872 INFO [stderr] warning: constant item is never used: `SECTOR_SIZE`
Dec 04 09:46:39.872 INFO [stderr]  --> src/fsbench/blktrace/trace.rs:9:1
Dec 04 09:46:39.872 INFO [stderr]   |
Dec 04 09:46:39.872 INFO [stderr] 9 | pub const SECTOR_SIZE: usize = 512;
Dec 04 09:46:39.872 INFO [stderr]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.872 INFO [stderr]   |
Dec 04 09:46:39.872 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 04 09:46:39.872 INFO [stderr] 
Dec 04 09:46:39.872 INFO [stderr] warning: field is never used: `elapsed`
Dec 04 09:46:39.872 INFO [stderr]    --> src/fsbench/blktrace/trace.rs:147:5
Dec 04 09:46:39.872 INFO [stderr]     |
Dec 04 09:46:39.872 INFO [stderr] 147 |     elapsed: Duration,
Dec 04 09:46:39.872 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.872 INFO [stderr] 
Dec 04 09:46:39.872 INFO [stderr] warning: method is never used: `total_duration`
Dec 04 09:46:39.872 INFO [stderr]    --> src/fsbench/blktrace/trace.rs:243:5
Dec 04 09:46:39.872 INFO [stderr]     |
Dec 04 09:46:39.872 INFO [stderr] 243 |     pub fn total_duration(&self) -> Duration {
Dec 04 09:46:39.872 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.872 INFO [stderr] 
Dec 04 09:46:39.872 INFO [stderr] warning: struct is never constructed: `Read`
Dec 04 09:46:39.872 INFO [stderr]    --> src/fsbench/operation.rs:160:1
Dec 04 09:46:39.872 INFO [stderr]     |
Dec 04 09:46:39.872 INFO [stderr] 160 | pub struct Read {
Dec 04 09:46:39.872 INFO [stderr]     | ^^^^^^^^^^^^^^^
Dec 04 09:46:39.872 INFO [stderr] 
Dec 04 09:46:39.872 INFO [stderr] warning: method is never used: `new`
Dec 04 09:46:39.872 INFO [stderr]    --> src/fsbench/operation.rs:165:5
Dec 04 09:46:39.872 INFO [stderr]     |
Dec 04 09:46:39.873 INFO [stderr] 165 |     pub fn new() -> Read {
Dec 04 09:46:39.873 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.873 INFO [stderr] 
Dec 04 09:46:39.873 INFO [stderr] warning: method is never used: `run`
Dec 04 09:46:39.873 INFO [stderr]    --> src/fsbench/operation.rs:171:5
Dec 04 09:46:39.873 INFO [stderr]     |
Dec 04 09:46:39.873 INFO [stderr] 171 |     pub fn run(&mut self, fd: RawFd, buf: &mut [u8]) -> nix::Result<usize> {
Dec 04 09:46:39.873 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.873 INFO [stderr] 
Dec 04 09:46:39.873 INFO [stderr] warning: struct is never constructed: `Write`
Dec 04 09:46:39.873 INFO [stderr]    --> src/fsbench/operation.rs:192:1
Dec 04 09:46:39.873 INFO [stderr]     |
Dec 04 09:46:39.873 INFO [stderr] 192 | pub struct Write {
Dec 04 09:46:39.873 INFO [stderr]     | ^^^^^^^^^^^^^^^^
Dec 04 09:46:39.873 INFO [stderr] 
Dec 04 09:46:39.873 INFO [stderr] warning: method is never used: `new`
Dec 04 09:46:39.873 INFO [stderr]    --> src/fsbench/operation.rs:197:5
Dec 04 09:46:39.873 INFO [stderr]     |
Dec 04 09:46:39.873 INFO [stderr] 197 |     pub fn new() -> Write {
Dec 04 09:46:39.873 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.873 INFO [stderr] 
Dec 04 09:46:39.873 INFO [stderr] warning: method is never used: `run`
Dec 04 09:46:39.873 INFO [stderr]    --> src/fsbench/operation.rs:203:5
Dec 04 09:46:39.873 INFO [stderr]     |
Dec 04 09:46:39.873 INFO [stderr] 203 |     pub fn run(&mut self, fd: RawFd, buf: &[u8]) -> nix::Result<usize> {
Dec 04 09:46:39.873 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.873 INFO [stderr] 
Dec 04 09:46:39.873 INFO [stderr] warning: method is never used: `ops_per_second`
Dec 04 09:46:39.873 INFO [stderr]   --> src/fsbench/statistics.rs:42:5
Dec 04 09:46:39.873 INFO [stderr]    |
Dec 04 09:46:39.873 INFO [stderr] 42 |     pub fn ops_per_second(&self) -> f64 {
Dec 04 09:46:39.873 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:39.873 INFO [stderr] 
Dec 04 09:46:39.875 INFO [stderr] warning: the feature `duration_extras` has been stable since 1.27.0 and no longer requires an attribute to enable
Dec 04 09:46:39.875 INFO [stderr]  --> src/main.rs:1:12
Dec 04 09:46:39.875 INFO [stderr]   |
Dec 04 09:46:39.875 INFO [stderr] 1 | #![feature(duration_extras)]
Dec 04 09:46:39.875 INFO [stderr]   |            ^^^^^^^^^^^^^^^
Dec 04 09:46:39.875 INFO [stderr]   |
Dec 04 09:46:39.875 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 04 09:46:39.875 INFO [stderr] 
Dec 04 09:46:40.138 INFO [stderr] warning: constant item is never used: `SECTOR_SIZE`
Dec 04 09:46:40.138 INFO [stderr]  --> src/fsbench/blktrace/trace.rs:9:1
Dec 04 09:46:40.138 INFO [stderr]   |
Dec 04 09:46:40.138 INFO [stderr] 9 | pub const SECTOR_SIZE: usize = 512;
Dec 04 09:46:40.138 INFO [stderr]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.138 INFO [stderr]   |
Dec 04 09:46:40.138 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 04 09:46:40.138 INFO [stderr] 
Dec 04 09:46:40.138 INFO [stderr] warning: field is never used: `elapsed`
Dec 04 09:46:40.138 INFO [stderr]    --> src/fsbench/blktrace/trace.rs:147:5
Dec 04 09:46:40.138 INFO [stderr]     |
Dec 04 09:46:40.138 INFO [stderr] 147 |     elapsed: Duration,
Dec 04 09:46:40.138 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.138 INFO [stderr] 
Dec 04 09:46:40.138 INFO [stderr] warning: method is never used: `total_duration`
Dec 04 09:46:40.138 INFO [stderr]    --> src/fsbench/blktrace/trace.rs:243:5
Dec 04 09:46:40.138 INFO [stderr]     |
Dec 04 09:46:40.138 INFO [stderr] 243 |     pub fn total_duration(&self) -> Duration {
Dec 04 09:46:40.138 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.138 INFO [stderr] 
Dec 04 09:46:40.139 INFO [stderr] warning: struct is never constructed: `Read`
Dec 04 09:46:40.139 INFO [stderr]    --> src/fsbench/operation.rs:160:1
Dec 04 09:46:40.139 INFO [stderr]     |
Dec 04 09:46:40.139 INFO [stderr] 160 | pub struct Read {
Dec 04 09:46:40.139 INFO [stderr]     | ^^^^^^^^^^^^^^^
Dec 04 09:46:40.139 INFO [stderr] 
Dec 04 09:46:40.139 INFO [stderr] warning: method is never used: `new`
Dec 04 09:46:40.139 INFO [stderr]    --> src/fsbench/operation.rs:165:5
Dec 04 09:46:40.139 INFO [stderr]     |
Dec 04 09:46:40.139 INFO [stderr] 165 |     pub fn new() -> Read {
Dec 04 09:46:40.139 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.139 INFO [stderr] 
Dec 04 09:46:40.139 INFO [stderr] warning: method is never used: `run`
Dec 04 09:46:40.139 INFO [stderr]    --> src/fsbench/operation.rs:171:5
Dec 04 09:46:40.139 INFO [stderr]     |
Dec 04 09:46:40.139 INFO [stderr] 171 |     pub fn run(&mut self, fd: RawFd, buf: &mut [u8]) -> nix::Result<usize> {
Dec 04 09:46:40.139 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.139 INFO [stderr] 
Dec 04 09:46:40.139 INFO [stderr] warning: struct is never constructed: `Write`
Dec 04 09:46:40.139 INFO [stderr]    --> src/fsbench/operation.rs:192:1
Dec 04 09:46:40.139 INFO [stderr]     |
Dec 04 09:46:40.139 INFO [stderr] 192 | pub struct Write {
Dec 04 09:46:40.139 INFO [stderr]     | ^^^^^^^^^^^^^^^^
Dec 04 09:46:40.139 INFO [stderr] 
Dec 04 09:46:40.139 INFO [stderr] warning: method is never used: `new`
Dec 04 09:46:40.139 INFO [stderr]    --> src/fsbench/operation.rs:197:5
Dec 04 09:46:40.139 INFO [stderr]     |
Dec 04 09:46:40.139 INFO [stderr] 197 |     pub fn new() -> Write {
Dec 04 09:46:40.139 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.139 INFO [stderr] 
Dec 04 09:46:40.139 INFO [stderr] warning: method is never used: `run`
Dec 04 09:46:40.139 INFO [stderr]    --> src/fsbench/operation.rs:203:5
Dec 04 09:46:40.139 INFO [stderr]     |
Dec 04 09:46:40.139 INFO [stderr] 203 |     pub fn run(&mut self, fd: RawFd, buf: &[u8]) -> nix::Result<usize> {
Dec 04 09:46:40.139 INFO [stderr]     |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.139 INFO [stderr] 
Dec 04 09:46:40.140 INFO [stderr] warning: method is never used: `ops_per_second`
Dec 04 09:46:40.140 INFO [stderr]   --> src/fsbench/statistics.rs:42:5
Dec 04 09:46:40.140 INFO [stderr]    |
Dec 04 09:46:40.140 INFO [stderr] 42 |     pub fn ops_per_second(&self) -> f64 {
Dec 04 09:46:40.140 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 04 09:46:40.140 INFO [stderr] 
Dec 04 09:46:40.141 INFO [stderr] warning: the feature `duration_extras` has been stable since 1.27.0 and no longer requires an attribute to enable
Dec 04 09:46:40.141 INFO [stderr]  --> src/main.rs:1:12
Dec 04 09:46:40.141 INFO [stderr]   |
Dec 04 09:46:40.141 INFO [stderr] 1 | #![feature(duration_extras)]
Dec 04 09:46:40.141 INFO [stderr]   |            ^^^^^^^^^^^^^^^
Dec 04 09:46:40.141 INFO [stderr]   |
Dec 04 09:46:40.141 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 04 09:46:40.141 INFO [stderr] 
Dec 04 09:46:40.216 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 43.83s
Dec 04 09:46:40.228 INFO [stderr] su: No module specific data is present
Dec 04 09:46:41.485 INFO running `"docker" "inspect" "78a1d91b2d982d3189c09dbbc76e1ec5bcdbf64310b1110b84358ed26a8d2708"`
Dec 04 09:46:41.829 INFO running `"docker" "rm" "-f" "78a1d91b2d982d3189c09dbbc76e1ec5bcdbf64310b1110b84358ed26a8d2708"`
Dec 04 09:46:42.097 INFO [stdout] 78a1d91b2d982d3189c09dbbc76e1ec5bcdbf64310b1110b84358ed26a8d2708