[INFO] fetching crate uucore 0.0.13...
[INFO] testing uucore-0.0.13 against try#1b74e096b9bfb06f84a3007193dcd2f059cbdf6a for pr-96025
[INFO] extracting crate uucore 0.0.13 into /workspace/builds/worker-2/source
[INFO] validating manifest of crates.io crate uucore 0.0.13 on toolchain 1b74e096b9bfb06f84a3007193dcd2f059cbdf6a
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate uucore 0.0.13
[INFO] finished tweaking crates.io crate uucore 0.0.13
[INFO] tweaked toml for crates.io crate uucore 0.0.13 written to /workspace/builds/worker-2/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 43c85130ba50f72dbc762979f3ac5cb260bee52ee32f8da02f060aac446de58c
[INFO] running `Command { std: "docker" "start" "-a" "43c85130ba50f72dbc762979f3ac5cb260bee52ee32f8da02f060aac446de58c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "43c85130ba50f72dbc762979f3ac5cb260bee52ee32f8da02f060aac446de58c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "43c85130ba50f72dbc762979f3ac5cb260bee52ee32f8da02f060aac446de58c", kill_on_drop: false }`
[INFO] [stdout] 43c85130ba50f72dbc762979f3ac5cb260bee52ee32f8da02f060aac446de58c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3927148f2e6aabb5ea64318cb0021b9e7e412dbc1ff73c36f449728ffbb42496
[INFO] running `Command { std: "docker" "start" "-a" "3927148f2e6aabb5ea64318cb0021b9e7e412dbc1ff73c36f449728ffbb42496", kill_on_drop: false }`
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling libc v0.2.124
[INFO] [stderr]    Compiling proc-macro2 v1.0.37
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling os_str_bytes v6.0.0
[INFO] [stderr]    Compiling textwrap v0.15.0
[INFO] [stderr]    Compiling unicode-width v0.1.9
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling termcolor v1.1.3
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling dunce v1.0.2
[INFO] [stderr]    Compiling wild v2.0.4
[INFO] [stderr]    Compiling once_cell v1.10.0
[INFO] [stderr]    Compiling os_display v0.1.3
[INFO] [stderr]    Compiling clap_lex v0.1.1
[INFO] [stderr]    Compiling indexmap v1.8.1
[INFO] [stderr]    Compiling quote v1.0.18
[INFO] [stderr]    Compiling uucore_procs v0.0.13
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling clap v3.1.12
[INFO] [stderr]    Compiling uucore v0.0.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.38s
[INFO] running `Command { std: "docker" "inspect" "3927148f2e6aabb5ea64318cb0021b9e7e412dbc1ff73c36f449728ffbb42496", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3927148f2e6aabb5ea64318cb0021b9e7e412dbc1ff73c36f449728ffbb42496", kill_on_drop: false }`
[INFO] [stdout] 3927148f2e6aabb5ea64318cb0021b9e7e412dbc1ff73c36f449728ffbb42496
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b7184716a12effeb8d9002c22052be3df0adb6d2192583e5a9f8774e8ca2435a
[INFO] running `Command { std: "docker" "start" "-a" "b7184716a12effeb8d9002c22052be3df0adb6d2192583e5a9f8774e8ca2435a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling uucore v0.0.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.54s
[INFO] [stderr]   Executable unittests src/lib/lib.rs (/opt/rustwide/target/debug/deps/uucore-e7e1c1edd808425b)
[INFO] running `Command { std: "docker" "inspect" "b7184716a12effeb8d9002c22052be3df0adb6d2192583e5a9f8774e8ca2435a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b7184716a12effeb8d9002c22052be3df0adb6d2192583e5a9f8774e8ca2435a", kill_on_drop: false }`
[INFO] [stdout] b7184716a12effeb8d9002c22052be3df0adb6d2192583e5a9f8774e8ca2435a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] e3bdf6f16febd07e9457a4dd97b2b52572c29ff3d7bddb54a9da1dc7850b9675
[INFO] running `Command { std: "docker" "start" "-a" "e3bdf6f16febd07e9457a4dd97b2b52572c29ff3d7bddb54a9da1dc7850b9675", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib/lib.rs (/opt/rustwide/target/debug/deps/uucore-e7e1c1edd808425b)
[INFO] [stdout] 
[INFO] [stdout] running 33 tests
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_preferred_over_short ... ok
[INFO] [stdout] test parser::parse_size::tests::kilobytes_suffix ... ok
[INFO] [stdout] test parser::parse_size::tests::b_suffix ... ok
[INFO] [stdout] test parser::parse_size::tests::all_suffixes ... ok
[INFO] [stdout] test parser::parse_size::tests::gigabytes_suffix ... ok
[INFO] [stdout] test parser::parse_size::tests::invalid_syntax ... ok
[INFO] [stdout] test parser::parse_size::tests::megabytes_suffix ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_short_only ... ok
[INFO] [stdout] test mods::version_cmp::tests::test_version_cmp ... ok
[INFO] [stdout] test parser::parse_size::tests::overflow_x64 ... ok
[INFO] [stdout] test parser::parse_size::tests::x64 ... ok
[INFO] [stdout] test parser::parse_time::tests::test_error_empty ... ok
[INFO] [stdout] test parser::parse_time::tests::test_error_invalid_magnitude ... ok
[INFO] [stdout] test parser::parse_size::tests::no_suffix ... ok
[INFO] [stdout] test parser::parse_time::tests::test_units ... ok
[INFO] [stdout] test parser::parse_time::tests::test_saturating_mul ... ok
[INFO] [stdout] test parser::parse_time::tests::test_negative ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_without_args_no_env ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_without_args_with_env ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_with_arg_shortened ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_with_env_var_ambiguous ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_with_args ... ok
[INFO] [stdout] test tests::valid_utf8_encoding_args ... ok
[INFO] [stdout] test tests::invalid_utf8_args_unix ... ok
[INFO] [stdout] test parser::parse_time::tests::test_no_units ... ok
[INFO] [stdout] test parser::parse_time::tests::test_no_capital_letters ... ok
[INFO] [stdout] test parser::parse_time::tests::test_error_invalid_unit ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_with_args_ambiguous ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_with_env_var_invalid ... ok
[INFO] [stderr]    Doc-tests uucore
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_with_args_invalid ... ok
[INFO] [stdout] test mods::backup_control::tests::test_suffix_takes_hyphen_value ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_long_with_env_var_shortened ... ok
[INFO] [stdout] test mods::backup_control::tests::test_backup_mode_short_only_ignore_env ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test src/lib/macros.rs - macros (line 9) ... ignored
[INFO] [stdout] test src/lib/macros.rs - macros::show_if_err (line 102) ... ignored
[INFO] [stdout] test src/lib/macros.rs - macros::show_if_err (line 108) ... ignored
[INFO] [stdout] test src/lib/mods/error.rs - mods::error (line 17) ... ignored
[INFO] [stdout] test src/lib/mods/error.rs - mods::error (line 31) ... ignored
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::UError (line 142) ... ignored
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::set_exit_code (line 72) ... ignored
[INFO] [stdout] test src/lib/macros.rs - macros (line 17) - compile ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::UError::usage (line 218) ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::UError::code (line 164) ... ok
[INFO] [stdout] test src/lib/mods/display.rs - mods::display::OsStr (line 12) ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::ExitCode (line 580) ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::UError (line 102) ... ok
[INFO] [stdout] test src/lib/macros.rs - macros::show (line 75) ... ok
[INFO] [stdout] test src/lib/macros.rs - macros::show (line 59) ... ok
[INFO] [stdout] test src/lib/macros.rs - macros::crash (line 231) ... ok
[INFO] [stdout] test src/lib/macros.rs - macros::show_error (line 141) ... ok
[INFO] [stdout] test src/lib/parser/parse_size.rs - parser::parse_size::parse_size (line 30) ... ok
[INFO] [stdout] test src/lib/parser/parse_time.rs - parser::parse_time::from_str (line 43) ... ok
[INFO] [stdout] test src/lib/macros.rs - macros::show_warning (line 183) ... ok
[INFO] [stdout] test src/lib/macros.rs - macros::show_usage_error (line 206) ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::uio_error (line 552) ... ok
[INFO] [stdout] test src/lib/mods/backup_control.rs - mods::backup_control::determine_backup_mode (line 312) ... ok
[INFO] [stdout] test src/lib/macros.rs - macros::crash_if_err (line 255) ... ok
[INFO] [stdout] test src/lib/mods/ranges.rs - mods::ranges::contain (line 153) ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::USimpleError (line 276) ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::uio_error (line 523) ... ok
[INFO] [stdout] test src/lib/mods/error.rs - mods::error::UIoError (line 354) ... ok
[INFO] [stdout] test src/lib/mods/backup_control.rs - mods::backup_control (line 33) ... ok
[INFO] [stdout] test src/lib/mods/backup_control.rs - mods::backup_control::determine_backup_mode (line 289) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 7 ignored; 0 measured; 0 filtered out; finished in 1.14s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e3bdf6f16febd07e9457a4dd97b2b52572c29ff3d7bddb54a9da1dc7850b9675", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e3bdf6f16febd07e9457a4dd97b2b52572c29ff3d7bddb54a9da1dc7850b9675", kill_on_drop: false }`
[INFO] [stdout] e3bdf6f16febd07e9457a4dd97b2b52572c29ff3d7bddb54a9da1dc7850b9675