[INFO] fetching crate snapbox 1.2.1...
[INFO] testing snapbox-1.2.1 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate snapbox 1.2.1 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate snapbox 1.2.1
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate snapbox 1.2.1
[INFO] tweaked toml for crates.io crate snapbox 1.2.1 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate snapbox 1.2.1 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate snapbox 1.2.1 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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded filetime v0.2.27
[INFO] [stderr]   Downloaded libredox v0.1.14
[INFO] [stderr]   Downloaded os_pipe v1.2.2
[INFO] [stderr]   Downloaded snapbox-macros v1.1.0
[INFO] [stderr]   Downloaded plain v0.2.3
[INFO] [stderr]   Downloaded document-features v0.2.12
[INFO] [stderr]   Downloaded utf8-width v0.1.8
[INFO] [stderr]   Downloaded dunce v1.0.5
[INFO] [stderr]   Downloaded content_inspector v0.2.4
[INFO] [stderr]   Downloaded anstyle-lossy v1.1.4
[INFO] [stderr]   Downloaded automod v1.0.16
[INFO] [stderr]   Downloaded redox_syscall v0.7.3
[INFO] [stderr]   Downloaded escargot v0.5.15
[INFO] [stderr]   Downloaded anstyle-svg v1.1.0
[INFO] [stderr]   Downloaded similar v2.7.0
[INFO] [stderr]   Downloaded litrs v1.0.0
[INFO] [stderr]   Downloaded html-escape v0.2.13
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 818be294a09c3f5df6c418c37008d92ec1bc7a1209372d16052f70f017632c41
[INFO] running `Command { std: "docker" "start" "-a" "818be294a09c3f5df6c418c37008d92ec1bc7a1209372d16052f70f017632c41", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "818be294a09c3f5df6c418c37008d92ec1bc7a1209372d16052f70f017632c41", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "818be294a09c3f5df6c418c37008d92ec1bc7a1209372d16052f70f017632c41", kill_on_drop: false }`
[INFO] [stdout] 818be294a09c3f5df6c418c37008d92ec1bc7a1209372d16052f70f017632c41
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bb9c037fb611768527614e8d9612eee01f84bf7fecad772796a76130fc99da47
[INFO] running `Command { std: "docker" "start" "-a" "bb9c037fb611768527614e8d9612eee01f84bf7fecad772796a76130fc99da47", kill_on_drop: false }`
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling snapbox-macros v1.1.0
[INFO] [stderr]    Compiling snapbox v1.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 5.55s
[INFO] running `Command { std: "docker" "inspect" "bb9c037fb611768527614e8d9612eee01f84bf7fecad772796a76130fc99da47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bb9c037fb611768527614e8d9612eee01f84bf7fecad772796a76130fc99da47", kill_on_drop: false }`
[INFO] [stdout] bb9c037fb611768527614e8d9612eee01f84bf7fecad772796a76130fc99da47
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c7378b8409f467c2e7538bcebb71731de1a9987125729f5fdf100e92cd5bf466
[INFO] running `Command { std: "docker" "start" "-a" "c7378b8409f467c2e7538bcebb71731de1a9987125729f5fdf100e92cd5bf466", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling automod v1.0.16
[INFO] [stderr]    Compiling snapbox v1.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.55s
[INFO] running `Command { std: "docker" "inspect" "c7378b8409f467c2e7538bcebb71731de1a9987125729f5fdf100e92cd5bf466", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c7378b8409f467c2e7538bcebb71731de1a9987125729f5fdf100e92cd5bf466", kill_on_drop: false }`
[INFO] [stdout] c7378b8409f467c2e7538bcebb71731de1a9987125729f5fdf100e92cd5bf466
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8d98f43e3a23d66225a290e551ccdb82ba82083b4f2a8b3d8159c15a2dec3c6a
[INFO] running `Command { std: "docker" "start" "-a" "8d98f43e3a23d66225a290e551ccdb82ba82083b4f2a8b3d8159c15a2dec3c6a", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/snapbox-e7de6b02fed4f52e)
[INFO] [stdout] 
[INFO] [stdout] running 63 tests
[INFO] [stdout] test data::runtime::tests::test_find_str_lit_len ... ok
[INFO] [stdout] test data::runtime::tests::test_format_patch ... ok
[INFO] [stdout] test data::runtime::tests::test_locate ... ok
[INFO] [stdout] test data::runtime::tests::test_patchwork ... ok
[INFO] [stdout] test data::test::text ... ok
[INFO] [stdout] test data::tests::binary_to_text ... ok
[INFO] [stdout] test data::runtime::tests::test_patchwork_overlap_diverge ... ok
[INFO] [stdout] test data::tests::binary_to_text_not_utf8 ... ok
[INFO] [stdout] test data::tests::text_to_bin_coerce_equals_to_bytes ... ok
[INFO] [stdout] test data::tests::text_to_binary ... ok
[INFO] [stdout] test data::format::test::combos ... ok
[INFO] [stdout] test data::tests::text_to_bytes_render ... ok
[INFO] [stdout] test dir::tests::file_type_detect_dir ... ok
[INFO] [stdout] test data::runtime::tests::test_patchwork_overlap_converge ... ok
[INFO] [stdout] test dir::tests::file_type_detect_file ... ok
[INFO] [stdout] test dir::tests::strips_trailing_slash ... ok
[INFO] [stdout] test filter::redactions::test::test_validate_placeholder ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_all_different ... ok
[INFO] [stdout] test filter::pattern::test::str_normalize_redactions_line_matches_cases ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_elide_delimited_with_sub ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_empty ... ok
[INFO] [stdout] test dir::tests::file_type_detect_missing ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_inline_elide ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_middle_elide ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_post_diverge_elide ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_input_shorter ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_leading_elide ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_trailing_elide ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_user_literal ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_literals_match ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_middles_diverge ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_pattern_shorter ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_user_overlapping_path ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_user_path ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_actual_duplicated ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_actual_missing ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_elide_delimited_with_sub ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_post_elide_diverge ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_expected_duplicated ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_expected_missing ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_inline_elide ... ok
[INFO] [stdout] test filter::test_redactions::str_normalize_user_disabled ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_middle_elide ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_post_elide_diverge ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_empty ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_post_diverge_elide ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_leading_elide ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_same_order ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_reverse_order ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_user_disabled ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_trailing_elide ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_user_overlapping_path ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_user_literal ... ok
[INFO] [stdout] test report::diff::test::diff_eq_trailing_extra_newline ... ok
[INFO] [stdout] test report::diff::test::diff_eq_trailing_newline_missing ... ok
[INFO] [stdout] test filter::test_unordered_redactions::str_normalize_user_path ... ok
[INFO] [stdout] test macros::test::closure_fn_path ... ok
[INFO] [stdout] test macros::test::direct_fn_path ... ok
[INFO] [stdout] test macros::test::nested_fn_path ... ok
[INFO] [stdout] test report::diff::test::diff_ne_line_missing ... ok
[INFO] [stdout] test report::diff::test::diff_eq ... ok
[INFO] [stdout] test report::diff::test::diff_eq_elided ... ok
[INFO] [stderr]      Running unittests src/bin/snap-fixture.rs (/opt/rustwide/target/debug/deps/snap_fixture-3eaff0b1bafa26cd)
[INFO] [stderr]    Doc-tests snapbox
[INFO] [stdout] test cmd::cargo_bin_in_unit_test - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 63 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[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] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test src/assert/mod.rs - assert::Assert::eq (line 69) - compile ... ok
[INFO] [stdout] test src/assert/mod.rs - assert::Assert (line 25) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::arg (line 73) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::arg (line 65) - compile ... ok
[INFO] [stdout] test src/assert/mod.rs - assert::Assert::eq (line 61) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::current_dir (line 234) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::arg (line 88) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::envs (line 157) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::env (line 134) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::env_clear (line 207) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::env_remove (line 188) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::OutputAssert::code (line 576) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::OutputAssert::stderr_eq (line 681) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::OutputAssert::failure (line 524) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::OutputAssert::stderr_eq (line 693) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::OutputAssert::stdout_eq (line 621) - compile ... ok
[INFO] [stdout] test src/data/mod.rs - data::IntoData::against (line 203) ... ok
[INFO] [stdout] test src/data/mod.rs - data::IntoData::unordered (line 88) ... ok
[INFO] [stdout] test src/data/mod.rs - data::ToDebug (line 23) - compile ... ok
[INFO] [stdout] test src/data/mod.rs - data::file (line 315) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::OutputAssert::stdout_eq (line 633) - compile ... ok
[INFO] [stdout] test src/cmd.rs - cmd::OutputAssert::success (line 493) - compile ... ok
[INFO] [stdout] test src/data/mod.rs - data::str (line 351) ... ok
[INFO] [stdout] test src/data/mod.rs - data::Data::against (line 660) ... ok
[INFO] [stdout] test src/filter/redactions.rs - filter::redactions::Redactions (line 14) ... ok
[INFO] [stdout] test src/filter/redactions.rs - filter::redactions::Redactions::insert (line 47) ... ok
[INFO] [stdout] test src/lib.rs - (line 53) - compile ... ok
[INFO] [stdout] test src/filter/redactions.rs - filter::redactions::Redactions::insert (line 56) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::assert (line 297) ... ok
[INFO] [stdout] test src/macros.rs - macros::assert_data_eq (line 33) - compile ... ok
[INFO] [stdout] test src/macros.rs - macros::cargo_bin (line 144) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 48) ... ok
[INFO] [stdout] test src/macros.rs - macros::assert_data_eq (line 16) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::stdin (line 253) ... ok
[INFO] [stdout] test src/macros.rs - macros::assert_data_eq (line 25) ... ok
[INFO] [stdout] test src/cmd.rs - cmd::Command::args (line 112) - compile ... ok
[INFO] [stdout] test src/data/mod.rs - data::IntoData::is (line 113) ... ok
[INFO] [stdout] test src/filter/redactions.rs - filter::redactions::Redactions::redact (line 114) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.93s; merged doctests compilation took 0.88s
[INFO] running `Command { std: "docker" "inspect" "8d98f43e3a23d66225a290e551ccdb82ba82083b4f2a8b3d8159c15a2dec3c6a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d98f43e3a23d66225a290e551ccdb82ba82083b4f2a8b3d8159c15a2dec3c6a", kill_on_drop: false }`
[INFO] [stdout] 8d98f43e3a23d66225a290e551ccdb82ba82083b4f2a8b3d8159c15a2dec3c6a
