[INFO] fetching crate assert_cmd 2.0.17...
[INFO] testing assert_cmd-2.0.17 against try#981ca440e18f6cc4bc9026d4be8ddb1ca8378af7 for pr-145277
[INFO] extracting crate assert_cmd 2.0.17 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate assert_cmd 2.0.17
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate assert_cmd 2.0.17
[INFO] tweaked toml for crates.io crate assert_cmd 2.0.17 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate assert_cmd 2.0.17 on toolchain 981ca440e18f6cc4bc9026d4be8ddb1ca8378af7
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+981ca440e18f6cc4bc9026d4be8ddb1ca8378af7" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate assert_cmd 2.0.17 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+981ca440e18f6cc4bc9026d4be8ddb1ca8378af7" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+981ca440e18f6cc4bc9026d4be8ddb1ca8378af7" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1ff1d9cb5b549ae75f9b3f1a3eb1de7db1b3e7bc24b38ea2d15d6d42e8b0f9cb
[INFO] running `Command { std: "docker" "start" "-a" "1ff1d9cb5b549ae75f9b3f1a3eb1de7db1b3e7bc24b38ea2d15d6d42e8b0f9cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1ff1d9cb5b549ae75f9b3f1a3eb1de7db1b3e7bc24b38ea2d15d6d42e8b0f9cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1ff1d9cb5b549ae75f9b3f1a3eb1de7db1b3e7bc24b38ea2d15d6d42e8b0f9cb", kill_on_drop: false }`
[INFO] [stdout] 1ff1d9cb5b549ae75f9b3f1a3eb1de7db1b3e7bc24b38ea2d15d6d42e8b0f9cb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+981ca440e18f6cc4bc9026d4be8ddb1ca8378af7" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e52ef408421444974f03a6e6824a81ccec3d799979e868b83d791b37020033db
[INFO] running `Command { std: "docker" "start" "-a" "e52ef408421444974f03a6e6824a81ccec3d799979e868b83d791b37020033db", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling libc v0.2.137
[INFO] [stderr]    Compiling either v1.8.0
[INFO] [stderr]    Compiling predicates-core v1.0.6
[INFO] [stderr]    Compiling doc-comment v0.3.3
[INFO] [stderr]    Compiling assert_cmd v2.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling once_cell v1.16.0
[INFO] [stderr]    Compiling anstyle v1.0.0
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling termtree v0.2.4
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling predicates-tree v1.0.5
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling bstr v1.0.1
[INFO] [stderr]    Compiling wait-timeout v0.2.0
[INFO] [stderr]    Compiling predicates v3.0.3
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.20s
[INFO] running `Command { std: "docker" "inspect" "e52ef408421444974f03a6e6824a81ccec3d799979e868b83d791b37020033db", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e52ef408421444974f03a6e6824a81ccec3d799979e868b83d791b37020033db", kill_on_drop: false }`
[INFO] [stdout] e52ef408421444974f03a6e6824a81ccec3d799979e868b83d791b37020033db
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+981ca440e18f6cc4bc9026d4be8ddb1ca8378af7" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 18da1f49c0c5bd5b05775dd1241a309f13b8a779e768a5d732297738194b21b6
[INFO] running `Command { std: "docker" "start" "-a" "18da1f49c0c5bd5b05775dd1241a309f13b8a779e768a5d732297738194b21b6", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.79
[INFO] [stderr]    Compiling unicode-ident v1.0.5
[INFO] [stderr]    Compiling syn v1.0.103
[INFO] [stderr]    Compiling serde_derive v1.0.147
[INFO] [stderr]    Compiling serde v1.0.147
[INFO] [stderr]    Compiling log v0.4.17
[INFO] [stderr]    Compiling serde_json v1.0.85
[INFO] [stderr]    Compiling escargot v0.5.13
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling ryu v1.0.11
[INFO] [stderr]    Compiling itoa v1.0.3
[INFO] [stderr]    Compiling quote v1.0.35
[INFO] [stderr]    Compiling syn v2.0.57
[INFO] [stderr]    Compiling automod v1.0.15
[INFO] [stderr]    Compiling assert_cmd v2.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 11.79s
[INFO] running `Command { std: "docker" "inspect" "18da1f49c0c5bd5b05775dd1241a309f13b8a779e768a5d732297738194b21b6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "18da1f49c0c5bd5b05775dd1241a309f13b8a779e768a5d732297738194b21b6", kill_on_drop: false }`
[INFO] [stdout] 18da1f49c0c5bd5b05775dd1241a309f13b8a779e768a5d732297738194b21b6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+981ca440e18f6cc4bc9026d4be8ddb1ca8378af7" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 1ed71fc373c2662ad5a7f95b7aedee29073acaaacb9779d4bcc0376bb3aa36a2
[INFO] running `Command { std: "docker" "start" "-a" "1ed71fc373c2662ad5a7f95b7aedee29073acaaacb9779d4bcc0376bb3aa36a2", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/assert_cmd-794be99c7e11a7b2)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test assert::test::into_code_from_i32 ... ok
[INFO] [stdout] test assert::test::into_code_from_pred ... ok
[INFO] [stdout] test assert::test::into_code_from_vec ... ok
[INFO] [stdout] test assert::test::into_output_from_bytes ... ok
[INFO] [stdout] test assert::test::into_output_from_vec ... ok
[INFO] [stdout] test output::test::format_bytes ... ok
[INFO] [stdout] test output::test::no_trailing_newline ... ok
[INFO] [stdout] test assert::test::into_code_from_array ... ok
[INFO] [stdout] test assert::test::into_output_from_pred ... ok
[INFO] [stdout] test assert::test::into_output_from_str ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/bin_fixture.rs (/opt/rustwide/target/debug/deps/bin_fixture-64a5457828e68c9d)
[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] [stderr]    Doc-tests assert_cmd
[INFO] [stdout] 
[INFO] [stdout] running 66 tests
[INFO] [stdout] test src/assert.rs - assert::Assert::stderr (line 441) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::code (line 221) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert (line 77) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::stderr (line 427) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::success (line 146) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::code (line 248) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::stderr (line 412) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::failure (line 174) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::stdout (line 345) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::stderr (line 397) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::stdout (line 316) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::AssertError::assert (line 1041) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::code (line 235) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::append_context (line 116) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::stdout (line 331) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::Assert::stdout (line 301) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::IntoOutputPredicate (line 700) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::StrOutputPredicate (line 909) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::StrContentOutputPredicate (line 821) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::OutputAssertExt::assert (line 38) - compile ... ok
[INFO] [stdout] test src/cargo.rs - cargo::CommandCargoExt::cargo_bin (line 105) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::IntoCodePredicate (line 508) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::InCodePredicate (line 623) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::arg (line 228) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::assert (line 174) - compile ... ok
[INFO] [stdout] test src/cargo.rs - cargo (line 10) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::EqCodePredicate (line 554) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::OutputAssertExt (line 21) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::current_dir (line 397) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::arg (line 236) - compile ... ok
[INFO] [stdout] test src/cargo.rs - cargo::CommandCargoExt::cargo_bin (line 116) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::args (line 274) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::env_remove (line 353) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::cargo_bin (line 53) - compile ... ok
[INFO] [stdout] test src/cargo.rs - cargo (line 29) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::BytesContentOutputPredicate (line 748) - compile ... ok
[INFO] [stdout] test src/cargo.rs - cargo::CommandCargoExt (line 75) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::arg (line 251) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::new (line 214) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::unwrap_err (line 157) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::cargo_bin (line 44) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::envs (line 321) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::env_clear (line 371) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::env (line 299) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::timeout (line 90) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 142) - compile ... ok
[INFO] [stdout] test src/output.rs - output::OutputError::as_output (line 217) - compile ... ok
[INFO] [stdout] test src/output.rs - output::OutputError (line 156) - compile ... ok
[INFO] [stdout] test src/macros.rs - macros::cargo_bin (line 36) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 41) - compile ... ok
[INFO] [stdout] test src/assert.rs - assert::AssertResult (line 998) ... ok
[INFO] [stdout] test src/lib.rs - (line 49) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::get_program (line 512) ... ok
[INFO] [stdout] test src/output.rs - output::OutputOkExt::unwrap_err (line 73) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::get_args (line 532) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::ok (line 124) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::get_envs (line 565) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::output (line 420) ... ok
[INFO] [stdout] test src/output.rs - output::OutputOkExt::ok (line 33) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::unwrap (line 141) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::write_stdin (line 71) ... ok
[INFO] [stdout] test src/output.rs - output::OutputOkExt::unwrap (line 51) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::get_current_dir (line 589) ... ok
[INFO] [stdout] test src/macros.rs - macros::crate_name (line 5) ... ok
[INFO] [stdout] test src/output.rs - output::OutputOkExt (line 14) ... ok
[INFO] [stdout] test src/output.rs - output::OutputResult (line 135) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 66 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.84s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1ed71fc373c2662ad5a7f95b7aedee29073acaaacb9779d4bcc0376bb3aa36a2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1ed71fc373c2662ad5a7f95b7aedee29073acaaacb9779d4bcc0376bb3aa36a2", kill_on_drop: false }`
[INFO] [stdout] 1ed71fc373c2662ad5a7f95b7aedee29073acaaacb9779d4bcc0376bb3aa36a2