Dec 12 21:11:56.208 INFO testing wisechengyi/rust_tar_repro against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 12 21:11:56.208 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-alt build --frozen" "-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 12 21:11:56.628 INFO [stdout] 56164ae53c3254d3e4bdd5a12b7ba32a000146ecbaa4bae5b171c4185df4b7c0
Dec 12 21:11:56.631 INFO running `"docker" "start" "-a" "56164ae53c3254d3e4bdd5a12b7ba32a000146ecbaa4bae5b171c4185df4b7c0"`
Dec 12 21:11:58.034 INFO [stderr] usermod: no changes
Dec 12 21:11:58.147 INFO [stderr]    Compiling filetime v0.2.3
Dec 12 21:11:58.147 INFO [stderr]    Compiling flate2 v1.0.4
Dec 12 21:11:58.863 INFO [stderr]    Compiling tar v0.4.19
Dec 12 21:12:02.175 INFO [stderr]    Compiling tar_api v0.0.1 (/source)
Dec 12 21:12:02.371 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 12 21:12:02.371 INFO [stderr]   --> src/tar_api.rs:29:3
Dec 12 21:12:02.371 INFO [stderr]    |
Dec 12 21:12:02.371 INFO [stderr] 29 |   tar.finish();
Dec 12 21:12:02.371 INFO [stderr]    |   ^^^^^^^^^^^^^
Dec 12 21:12:02.371 INFO [stderr]    |
Dec 12 21:12:02.371 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 12 21:12:02.371 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 12 21:12:02.371 INFO [stderr] 
Dec 12 21:12:02.987 INFO [stderr] warning: unused import: `value_t`
Dec 12 21:12:02.987 INFO [stderr]  --> src/main.rs:5:34
Dec 12 21:12:02.987 INFO [stderr]   |
Dec 12 21:12:02.987 INFO [stderr] 5 | use clap::{App, Arg, SubCommand, value_t};
Dec 12 21:12:02.987 INFO [stderr]   |                                  ^^^^^^^
Dec 12 21:12:02.987 INFO [stderr]   |
Dec 12 21:12:02.987 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 12 21:12:02.987 INFO [stderr] 
Dec 12 21:12:02.987 INFO [stderr] warning: unused import: `Path`
Dec 12 21:12:02.987 INFO [stderr]  --> src/main.rs:6:17
Dec 12 21:12:02.987 INFO [stderr]   |
Dec 12 21:12:02.987 INFO [stderr] 6 | use std::path::{Path, PathBuf};
Dec 12 21:12:02.987 INFO [stderr]   |                 ^^^^
Dec 12 21:12:02.987 INFO [stderr] 
Dec 12 21:12:03.015 INFO [stderr] warning: unused variable: `sub_matches`
Dec 12 21:12:03.015 INFO [stderr]   --> src/main.rs:47:15
Dec 12 21:12:03.018 INFO [stderr]    |
Dec 12 21:12:03.018 INFO [stderr] 47 |   if let Some(sub_matches) = matches.subcommand_matches("tar") {
Dec 12 21:12:03.018 INFO [stderr]    |               ^^^^^^^^^^^ help: consider using `_sub_matches` instead
Dec 12 21:12:03.018 INFO [stderr]    |
Dec 12 21:12:03.018 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 12 21:12:03.018 INFO [stderr] 
Dec 12 21:12:04.447 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.39s
Dec 12 21:12:04.452 INFO [stderr] su: No module specific data is present
Dec 12 21:12:05.425 INFO running `"docker" "inspect" "56164ae53c3254d3e4bdd5a12b7ba32a000146ecbaa4bae5b171c4185df4b7c0"`
Dec 12 21:12:05.613 INFO running `"docker" "rm" "-f" "56164ae53c3254d3e4bdd5a12b7ba32a000146ecbaa4bae5b171c4185df4b7c0"`
Dec 12 21:12:05.837 INFO [stdout] 56164ae53c3254d3e4bdd5a12b7ba32a000146ecbaa4bae5b171c4185df4b7c0
Dec 12 21:12:05.840 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen --no-run" "-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 12 21:12:06.178 INFO [stdout] d7be4a1efea3b58fb9c9753c9fcdb22c803deb18f4127a6c617b2b0da027ca51
Dec 12 21:12:06.180 INFO running `"docker" "start" "-a" "d7be4a1efea3b58fb9c9753c9fcdb22c803deb18f4127a6c617b2b0da027ca51"`
Dec 12 21:12:07.315 INFO [stderr] usermod: no changes
Dec 12 21:12:07.402 INFO [stderr]    Compiling tar_api v0.0.1 (/source)
Dec 12 21:12:07.775 INFO [stderr] warning: unused import: `value_t`
Dec 12 21:12:07.775 INFO [stderr]  --> src/main.rs:5:34
Dec 12 21:12:07.775 INFO [stderr]   |
Dec 12 21:12:07.775 INFO [stderr] 5 | use clap::{App, Arg, SubCommand, value_t};
Dec 12 21:12:07.775 INFO [stderr]   |                                  ^^^^^^^
Dec 12 21:12:07.775 INFO [stderr]   |
Dec 12 21:12:07.775 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 12 21:12:07.775 INFO [stderr] 
Dec 12 21:12:07.775 INFO [stderr] warning: unused import: `Path`
Dec 12 21:12:07.775 INFO [stderr]  --> src/main.rs:6:17
Dec 12 21:12:07.775 INFO [stderr]   |
Dec 12 21:12:07.775 INFO [stderr] 6 | use std::path::{Path, PathBuf};
Dec 12 21:12:07.775 INFO [stderr]   |                 ^^^^
Dec 12 21:12:07.775 INFO [stderr] 
Dec 12 21:12:07.804 INFO [stderr] warning: unused variable: `sub_matches`
Dec 12 21:12:07.804 INFO [stderr]   --> src/main.rs:47:15
Dec 12 21:12:07.804 INFO [stderr]    |
Dec 12 21:12:07.804 INFO [stderr] 47 |   if let Some(sub_matches) = matches.subcommand_matches("tar") {
Dec 12 21:12:07.804 INFO [stderr]    |               ^^^^^^^^^^^ help: consider using `_sub_matches` instead
Dec 12 21:12:07.804 INFO [stderr]    |
Dec 12 21:12:07.804 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 12 21:12:07.804 INFO [stderr] 
Dec 12 21:12:07.819 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 12 21:12:07.819 INFO [stderr]   --> src/tar_api.rs:29:3
Dec 12 21:12:07.819 INFO [stderr]    |
Dec 12 21:12:07.819 INFO [stderr] 29 |   tar.finish();
Dec 12 21:12:07.819 INFO [stderr]    |   ^^^^^^^^^^^^^
Dec 12 21:12:07.819 INFO [stderr]    |
Dec 12 21:12:07.819 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 12 21:12:07.819 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 12 21:12:07.819 INFO [stderr] 
Dec 12 21:12:08.343 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.99s
Dec 12 21:12:08.348 INFO [stderr] su: No module specific data is present
Dec 12 21:12:09.179 INFO running `"docker" "inspect" "d7be4a1efea3b58fb9c9753c9fcdb22c803deb18f4127a6c617b2b0da027ca51"`
Dec 12 21:12:09.393 INFO running `"docker" "rm" "-f" "d7be4a1efea3b58fb9c9753c9fcdb22c803deb18f4127a6c617b2b0da027ca51"`
Dec 12 21:12:09.681 INFO [stdout] d7be4a1efea3b58fb9c9753c9fcdb22c803deb18f4127a6c617b2b0da027ca51
Dec 12 21:12:09.687 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen" "-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 12 21:12:10.079 INFO [stdout] 35d14f13fee241877515ee20f893ce3f4d345014ce26773908ac95fecacbc73d
Dec 12 21:12:10.084 INFO running `"docker" "start" "-a" "35d14f13fee241877515ee20f893ce3f4d345014ce26773908ac95fecacbc73d"`
Dec 12 21:12:10.965 INFO [stderr] usermod: no changes
Dec 12 21:12:11.083 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 12 21:12:11.083 INFO [stderr]      Running /target/debug/deps/tar_api-2a4584f22ebd3a79
Dec 12 21:12:11.095 INFO [stderr]      Running /target/debug/deps/rust_tar-b9c99fdd9b5fe68d
Dec 12 21:12:11.095 INFO [stdout] 
Dec 12 21:12:11.095 INFO [stdout] running 0 tests
Dec 12 21:12:11.095 INFO [stdout] 
Dec 12 21:12:11.095 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 12 21:12:11.095 INFO [stdout] 
Dec 12 21:12:11.103 INFO [stdout] 
Dec 12 21:12:11.103 INFO [stderr]    Doc-tests tar_api
Dec 12 21:12:11.103 INFO [stdout] running 0 tests
Dec 12 21:12:11.103 INFO [stdout] 
Dec 12 21:12:11.103 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 12 21:12:11.103 INFO [stdout] 
Dec 12 21:12:11.355 INFO [stdout] 
Dec 12 21:12:11.355 INFO [stdout] running 0 tests
Dec 12 21:12:11.355 INFO [stdout] 
Dec 12 21:12:11.355 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 12 21:12:11.355 INFO [stdout] 
Dec 12 21:12:11.362 INFO [stderr] su: No module specific data is present
Dec 12 21:12:12.276 INFO running `"docker" "inspect" "35d14f13fee241877515ee20f893ce3f4d345014ce26773908ac95fecacbc73d"`
Dec 12 21:12:12.691 INFO running `"docker" "rm" "-f" "35d14f13fee241877515ee20f893ce3f4d345014ce26773908ac95fecacbc73d"`
Dec 12 21:12:13.073 INFO [stdout] 35d14f13fee241877515ee20f893ce3f4d345014ce26773908ac95fecacbc73d