[INFO] fetching crate rsspec 0.5.0... [INFO] testing rsspec-0.5.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2 [INFO] extracting crate rsspec 0.5.0 into /workspace/builds/worker-6-tc2/source [INFO] started tweaking crates.io crate rsspec 0.5.0 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate rsspec 0.5.0 [INFO] tweaked toml for crates.io crate rsspec 0.5.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate rsspec 0.5.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate rsspec 0.5.0 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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 72c4dd9e82899d281233a2dd029da76ce84d1da8bcbb988a7fb68c77d26c0efe [INFO] running `Command { std: "docker" "start" "-a" "72c4dd9e82899d281233a2dd029da76ce84d1da8bcbb988a7fb68c77d26c0efe", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "72c4dd9e82899d281233a2dd029da76ce84d1da8bcbb988a7fb68c77d26c0efe", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "72c4dd9e82899d281233a2dd029da76ce84d1da8bcbb988a7fb68c77d26c0efe", kill_on_drop: false }` [INFO] [stdout] 72c4dd9e82899d281233a2dd029da76ce84d1da8bcbb988a7fb68c77d26c0efe [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 19284bd08025ac07d057bd9489e162772dd046fd1e9e20560344d779a8fc6ff6 [INFO] running `Command { std: "docker" "start" "-a" "19284bd08025ac07d057bd9489e162772dd046fd1e9e20560344d779a8fc6ff6", kill_on_drop: false }` [INFO] [stderr] Compiling rsspec v0.5.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.05s [INFO] running `Command { std: "docker" "inspect" "19284bd08025ac07d057bd9489e162772dd046fd1e9e20560344d779a8fc6ff6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "19284bd08025ac07d057bd9489e162772dd046fd1e9e20560344d779a8fc6ff6", kill_on_drop: false }` [INFO] [stdout] 19284bd08025ac07d057bd9489e162772dd046fd1e9e20560344d779a8fc6ff6 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3764b96a9ed0ab66c646dd3b982264b55e82da3578b913983ba97741e8b9e65d [INFO] running `Command { std: "docker" "start" "-a" "3764b96a9ed0ab66c646dd3b982264b55e82da3578b913983ba97741e8b9e65d", kill_on_drop: false }` [INFO] [stderr] Compiling rsspec v0.5.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.33s [INFO] running `Command { std: "docker" "inspect" "3764b96a9ed0ab66c646dd3b982264b55e82da3578b913983ba97741e8b9e65d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3764b96a9ed0ab66c646dd3b982264b55e82da3578b913983ba97741e8b9e65d", kill_on_drop: false }` [INFO] [stdout] 3764b96a9ed0ab66c646dd3b982264b55e82da3578b913983ba97741e8b9e65d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8800c3d015680ec384b071c9f861ed373ca5d7b3937ccf2cb8f0a61d01bfc628 [INFO] running `Command { std: "docker" "start" "-a" "8800c3d015680ec384b071c9f861ed373ca5d7b3937ccf2cb8f0a61d01bfc628", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rsspec-f97367058e27e438) [INFO] [stdout] [INFO] [stdout] running 24 tests [INFO] [stdout] test runner::tests::detect_libtest_args_catches_other_libtest_flags ... ok [INFO] [stdout] test runner::tests::detect_libtest_args_catches_test_threads ... ok [INFO] [stdout] test runner::tests::detect_libtest_args_ignores_rsspec_args ... ok [INFO] [stdout] test runner::tests::detect_libtest_args_catches_format ... ok [INFO] [stdout] test runner::tests::ordered_is_skipped_when_focus_mode_is_active ... ok [INFO] [stdout] test runner::tests::mixed_and_or_filter_is_rejected ... ok [INFO] [stdout] test runner::tests::after_all_panic_reports_failure ... ok [INFO] [stdout] test runner::tests::after_each_panic_runs_remaining_hooks ... ok [INFO] [stdout] test runner::tests::before_all_panic_reports_failure_and_runs_after_all ... ok [INFO] [stdout] test runner::tests::before_each_panic_still_runs_after_each ... ok [INFO] [stdout] test runner::tests::deferred_cleanup_panic_does_not_skip_remaining ... ok [INFO] [stdout] test runner::tests::retries_and_must_pass_repeatedly_compose ... ok [INFO] [stdout] test runner::tests::skip_reports_as_skipped_not_passed ... ok [INFO] [stdout] test tests::test_guard_runs_on_success ... ok [INFO] [stdout] test tests::test_labels_mixed_and_or_rejected ... ok [INFO] [stdout] test runner::tests::after_each_panic_preserves_test_failure ... ok [INFO] [stdout] test tests::test_guard_runs_on_panic ... ok [INFO] [stdout] test tests::test_labels_and_filter_with_negation ... ok [INFO] [stdout] test tests::test_labels_or_filter_with_negation ... ok [INFO] [stdout] test tests::test_labels_pure_negation ... ok [INFO] [stdout] test tests::test_labels_positive_or ... ok [INFO] [stdout] test tests::test_with_retries_success_first_try ... ok [INFO] [stdout] test tests::test_with_retries_eventual_success ... ok [INFO] [stderr] Running tests/decorators_test.rs (/opt/rustwide/target/debug/deps/decorators_test-d0874c6d5292f20a) [INFO] [stdout] test runner::tests::retries_and_timeout_compose ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s [INFO] [stdout] [INFO] [stderr] attempt 1/4 failed, retrying... [INFO] [stdout] [INFO] [stderr] attempt 2/4 failed, retrying... [INFO] [stdout] decorators [INFO] [stderr] [1/2] step 1 [INFO] [stdout] ✓ supports labels for filtering [INFO] [stderr] [2/2] step 2 [INFO] [stdout] ✓ retries on failure up to N times [INFO] [stdout] ✓ requires N consecutive passes [INFO] [stdout] ✓ fails if execution exceeds timeout [INFO] [stdout] table-driven tests [INFO] [stdout] addition [INFO] [stdout] ✓ positive [INFO] [stdout] ✓ large [INFO] [stdout] ✓ negative [INFO] [stdout] ordered tests [INFO] [stdout] ✓ runs steps in sequence [INFO] [stdout] [INFO] [stdout] PASS [INFO] [stdout] 8 passed (0.000s) [INFO] [stderr] Running tests/describe_test.rs (/opt/rustwide/target/debug/deps/describe_test-360cd60b7705fc81) [INFO] [stdout] [INFO] [stdout] describe, context, when [INFO] [stdout] ✓ groups tests under describe [INFO] [stdout] nested with context [INFO] [stdout] ✓ inherits the outer scope [INFO] [stdout] using when as alias [INFO] [stdout] ✓ behaves like context [INFO] [stdout] it and specify [INFO] [stdout] ✓ defines a test case [INFO] [stdout] ✓ is an alias for it [INFO] [stdout] pending tests [INFO] [stdout] - skips individual tests with xit [INFO] [stdout] skips entire groups with xdescribe [INFO] [stdout] - is also pending [INFO] [stdout] describe-level labels [INFO] [stdout] ✓ are inherited by child tests [INFO] [stdout] [INFO] [stdout] PASS [INFO] [stdout] 6 passed, 2 pending (0.000s) [INFO] [stderr] Running tests/hooks_test.rs (/opt/rustwide/target/debug/deps/hooks_test-f786d955e3ebeeca) [INFO] [stdout] [INFO] [stdout] before_each [INFO] [stdout] returning a simple value [INFO] [stdout] ✓ passes the return value to it via &T [INFO] [stdout] returning a struct [INFO] [stdout] ✓ works with any type, no Clone required [INFO] [stdout] with no return value [INFO] [stdout] ✓ still works with plain Fn() closures [INFO] [stdout] test isolation [INFO] [stdout] ✓ provides a fresh value to each test [INFO] [stdout] ✓ is not affected by previous tests [INFO] [stdout] nested contexts [INFO] [stdout] inner scope with its own before_each [INFO] [stdout] ✓ receives the inner value for the same type [INFO] [stdout] before_each as action [INFO] [stdout] parsing and transforming data [INFO] [stdout] ✓ parses all entries [INFO] [stdout] ✓ extracts correct values [INFO] [stdout] building a complex object graph [INFO] [stdout] ✓ builds the correct depth [INFO] [stdout] ✓ builds the correct node count [INFO] [stdout] filtering and aggregating a dataset [INFO] [stdout] ✓ computes the correct total [INFO] [stdout] ✓ counts all elements [INFO] [stdout] ✓ filters values above threshold [INFO] [stdout] multi-step pipeline [INFO] [stdout] ✓ tokenizes the input [INFO] [stdout] ✓ counts word frequencies [INFO] [stdout] ✓ preserves the original input [INFO] [stdout] after_each [INFO] [stdout] ✓ runs after normal completion [INFO] [stdout] ✓ confirms it ran for the previous test [INFO] [stdout] before_all and after_all [INFO] [stdout] returning a value [INFO] [stdout] ✓ is available in the first test [INFO] [stdout] ✓ persists across subsequent tests [INFO] [stdout] runs exactly once [INFO] [stdout] ✓ has run once after the first test [INFO] [stdout] ✓ still only once after the second test [INFO] [stdout] expensive one-time setup [INFO] [stdout] ✓ provides config to the first test [INFO] [stdout] ✓ provides the same config to subsequent tests [INFO] [stdout] before_each same-type overwrite [INFO] [stdout] two hooks returning the same type [INFO] [stdout] ✓ receives the last-registered value [INFO] [stdout] before_each takes priority over before_all [INFO] [stdout] both hooks return the same type [INFO] [stdout] ✓ receives the before_each value [INFO] [stdout] before_all nested scope isolation [INFO] [stdout] outer and inner both register before_all for the same type [INFO] [stdout] inner scope [INFO] [stdout] ✓ receives the inner value inside the inner scope [INFO] [stdout] ✓ receives the outer value after inner scope closes [INFO] [stdout] just_before_each [INFO] [stdout] ✓ runs after before_each but before the test body [INFO] [stdout] [INFO] [stdout] PASS [INFO] [stdout] 29 passed (0.001s) [INFO] [stderr] Running tests/utilities_test.rs (/opt/rustwide/target/debug/deps/utilities_test-ef7c4c039b54ada0) [INFO] [stdout] [INFO] [stdout] defer_cleanup [INFO] [stdout] ✓ registers a cleanup function [INFO] [stdout] ✓ runs cleanup after the previous test [INFO] [stdout] by() [INFO] [stdout] ✓ documents steps within a test [INFO] [stderr] STEP: setting up [INFO] [stdout] [INFO] [stderr] STEP: verifying [INFO] [stdout] PASS [INFO] [stdout] 3 passed (0.000s) [INFO] [stderr] Doc-tests rsspec [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test src/context.rs - context::run (line 691) - compile ... ok [INFO] [stdout] test src/context.rs - context::ItBuilder (line 569) - compile ... ok [INFO] [stdout] test src/context.rs - context::Context::it (line 261) - compile ... ok [INFO] [stdout] test src/context.rs - context::run_inline (line 746) - compile ... ok [INFO] [stdout] test src/ordered.rs - ordered::OrderedContext (line 9) - compile ... ok [INFO] [stdout] test src/table.rs - table::TableBuilder (line 15) - compile ... ok [INFO] [stdout] test src/context.rs - context::Context::labels (line 367) - compile ... ok [INFO] [stdout] test src/context.rs - context::Context (line 188) - compile ... ok [INFO] [stdout] test src/context.rs - context::Context::before_each (line 309) - compile ... ok [INFO] [stdout] test src/context.rs - context::Context::describe_table (line 384) - compile ... ok [INFO] [stdout] test src/context.rs - context::Context::ordered (line 404) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 9) - compile ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.39s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "8800c3d015680ec384b071c9f861ed373ca5d7b3937ccf2cb8f0a61d01bfc628", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8800c3d015680ec384b071c9f861ed373ca5d7b3937ccf2cb8f0a61d01bfc628", kill_on_drop: false }` [INFO] [stdout] 8800c3d015680ec384b071c9f861ed373ca5d7b3937ccf2cb8f0a61d01bfc628