[INFO] cloning repository https://github.com/paulm17/rust_bg_remover
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/paulm17/rust_bg_remover" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fpaulm17%2Frust_bg_remover", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fpaulm17%2Frust_bg_remover'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 44e7023e9007dcf21a0f4791e10da3dcc3952aa0
[INFO] testing paulm17/rust_bg_remover/44e7023e9007dcf21a0f4791e10da3dcc3952aa0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fpaulm17%2Frust_bg_remover" "/workspace/builds/worker-2-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc1/source'...
[INFO] [stderr] done.
[INFO] [stderr] Updating files:  97% (7658/7872)
Updating files:  98% (7715/7872)
Updating files:  99% (7794/7872)
Updating files: 100% (7872/7872)
Updating files: 100% (7872/7872), done.
[INFO] started tweaking git repo https://github.com/paulm17/rust_bg_remover
[INFO] finished tweaking git repo https://github.com/paulm17/rust_bg_remover
[INFO] tweaked toml for git repo https://github.com/paulm17/rust_bg_remover written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/paulm17/rust_bg_remover on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/paulm17/rust_bg_remover 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" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded portable-atomic-util v0.2.5
[INFO] [stderr]   Downloaded ort-sys v2.0.0-rc.11
[INFO] [stderr]   Downloaded ort v2.0.0-rc.11
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d
[INFO] running `Command { std: "docker" "start" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling zune-core v0.5.3
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling moxcms v0.8.1
[INFO] [stderr]    Compiling matrixmultiply v0.3.11
[INFO] [stderr]    Compiling bytemuck v1.25.2
[INFO] [stderr]    Compiling png v0.18.1
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling ort-sys v2.0.0-rc.11
[INFO] [stderr]    Compiling zune-jpeg v0.5.15
[INFO] [stderr]    Compiling winnow v1.0.4
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling num-integer v0.1.47
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling toml_parser v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling ndarray v0.17.2
[INFO] [stderr]    Compiling smallvec v1.15.2
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling toml v0.9.12+spec-1.1.0
[INFO] [stderr]    Compiling image v0.25.10
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling clap_derive v4.6.4
[INFO] [stderr]    Compiling clap v4.6.6
[INFO] [stderr]    Compiling ort v2.0.0-rc.11
[INFO] [stderr]    Compiling bgremove-core v0.1.0 (/opt/rustwide/workdir/crates/bgremove-core)
[INFO] [stderr]    Compiling bgremove-models v0.1.0 (/opt/rustwide/workdir/crates/bgremove-models)
[INFO] [stderr]    Compiling bgremove-matting v0.1.0 (/opt/rustwide/workdir/crates/bgremove-matting)
[INFO] [stderr]    Compiling bgremove-ort v0.1.0 (/opt/rustwide/workdir/crates/bgremove-ort)
[INFO] [stderr]    Compiling bgremove-color v0.1.0 (/opt/rustwide/workdir/crates/bgremove-color)
[INFO] [stderr]    Compiling bgremove-cli v0.1.0 (/opt/rustwide/workdir/crates/bgremove-cli)
[INFO] [stderr]    Compiling bgremove-bench v0.1.0 (/opt/rustwide/workdir/crates/bgremove-bench)
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]   --> crates/bgremove-bench/src/m17.rs:37:9
[INFO] [stdout]    |
[INFO] [stdout] 37 |     let mut providers = vec!["cpu".to_string()];
[INFO] [stdout]    |         ----^^^^^^^^^
[INFO] [stdout]    |         |
[INFO] [stdout]    |         help: remove this `mut`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 16s
[INFO] running `Command { std: "docker" "inspect" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling bgremove-color v0.1.0 (/opt/rustwide/workdir/crates/bgremove-color)
[INFO] [stderr]    Compiling bgremove-models v0.1.0 (/opt/rustwide/workdir/crates/bgremove-models)
[INFO] [stderr]    Compiling bgremove-ort v0.1.0 (/opt/rustwide/workdir/crates/bgremove-ort)
[INFO] [stderr]    Compiling bgremove-cli v0.1.0 (/opt/rustwide/workdir/crates/bgremove-cli)
[INFO] [stderr]    Compiling bgremove-bench v0.1.0 (/opt/rustwide/workdir/crates/bgremove-bench)
[INFO] [stderr]    Compiling bgremove-matting v0.1.0 (/opt/rustwide/workdir/crates/bgremove-matting)
[INFO] [stderr]    Compiling bgremove-core v0.1.0 (/opt/rustwide/workdir/crates/bgremove-core)
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]   --> crates/bgremove-bench/src/m17.rs:37:9
[INFO] [stdout]    |
[INFO] [stdout] 37 |     let mut providers = vec!["cpu".to_string()];
[INFO] [stdout]    |         ----^^^^^^^^^
[INFO] [stdout]    |         |
[INFO] [stdout]    |         help: remove this `mut`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 30.68s
[INFO] running `Command { std: "docker" "inspect" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: variable does not need to be mutable
[INFO] [stderr]   --> crates/bgremove-bench/src/m17.rs:37:9
[INFO] [stderr]    |
[INFO] [stderr] 37 |     let mut providers = vec!["cpu".to_string()];
[INFO] [stderr]    |         ----^^^^^^^^^
[INFO] [stderr]    |         |
[INFO] [stderr]    |         help: remove this `mut`
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `bgremove-bench` (bin "bgremove-bench" test) generated 1 warning (run `cargo fix --bin "bgremove-bench" -p bgremove-bench --tests` to apply 1 suggestion)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.18s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/bgremove_bench-b7422b5ae87ac35d)
[INFO] [stdout] 
[INFO] [stdout] running 73 tests
[INFO] [stdout] test m15::tests::m15_blind_lifecycle_does_not_require_new_set_before_influence ... ok
[INFO] [stdout] test m15::tests::m15_boundary_and_composite_metrics_are_not_perfect_for_mismatch ... ok
[INFO] [stdout] test m15::tests::m15_bootstrap_and_tie_breaks_are_deterministic ... ok
[INFO] [stdout] test m15::tests::m15_blind_lifecycle_transitions_reject_retired_promotion ... ok
[INFO] [stdout] test m15::tests::m15_fixed_arena_loo_holds_each_id_once_and_trains_on_the_other_five ... ok
[INFO] [stdout] test m15::tests::m15_html_escapes_hostile_status_strings ... ok
[INFO] [stdout] test m15::tests::m15_lhs_has_one_sample_per_stratum_and_seed_changes_order ... ok
[INFO] [stdout] test m15::tests::m15_loo_requires_one_identical_resolved_config_for_champion ... ok
[INFO] [stdout] test m15::tests::m15_negative_contracts_reject_invalid_ids_and_zero_lhs_seed ... ok
[INFO] [stdout] test m15::tests::m15_cache_recovers_corruption_and_rejects_bad_key ... ok
[INFO] [stdout] test m15::tests::m15_cache_rejects_uppercase_hashes_and_failure_scores_zero ... ok
[INFO] [stdout] test m15::tests::m15_section_62_metrics_are_finite_and_distinguish_fractional_alpha ... ok
[INFO] [stdout] test m16::tests::m16_blind_lifecycle_allows_one_qualified_pass_then_retires ... ok
[INFO] [stdout] test m16::tests::m16_blind_lifecycle_stays_untouched_without_real_loo ... ok
[INFO] [stdout] test m16::tests::m16_blind_registration_rejects_overlap_and_failed_pass_cannot_promote ... ok
[INFO] [stdout] test m16::tests::m16_bootstrap_rejects_empty_nonfinite_and_zero_seed ... ok
[INFO] [stdout] test m15::tests::m15_evaluation_is_shared_by_score_and_artifact_stages ... ok
[INFO] [stdout] test m16::tests::m16_crop_bounds_and_seam_overlap_are_source_safe ... ok
[INFO] [stdout] test m16::tests::m16_crop_geometry_handles_wide_and_tall_degenerate_aspects ... ok
[INFO] [stdout] test m16::tests::m16_crop_geometry_has_multiple_tiles_and_no_holes ... ok
[INFO] [stdout] test m16::tests::m16_cache_probe_proves_reuse_and_invalidation ... ok
[INFO] [stdout] test m16::tests::m16_end_to_end_metric_parity_covers_randomized_geometries ... ok
[INFO] [stdout] test m16::tests::m16_escape_html_is_safe_for_status_and_ids ... ok
[INFO] [stdout] test m16::tests::m16_extreme_and_failure_inputs_fail_closed ... ok
[INFO] [stdout] test m16::tests::m16_foreground_policy_changes_only_risk_regions ... ok
[INFO] [stdout] test m16::tests::m16_high_resolution_crop_uses_bilinear_source_geometry ... ok
[INFO] [stdout] test m15::tests::m15_real_mode_does_not_apply_synthetic_affine_transform ... ok
[INFO] [stdout] test m16::tests::m16_manifest_verification_rejects_tamper_and_missing_entries ... ok
[INFO] [stdout] test m16::tests::m16_manifest_verification_rejects_unlisted_extra_duplicate_and_traversal ... ok
[INFO] [stdout] test m16::tests::m16_end_to_end_metrics_match_m15_shared_contract ... ok
[INFO] [stdout] test m16::tests::m16_metric_ssim_uses_the_frozen_m15_gaussian_primitive ... ok
[INFO] [stdout] test m16::tests::m16_prediction_contract_has_no_reference_or_filename_input ... ok
[INFO] [stdout] test m16::tests::m16_qualified_real_candidate_requires_one_paired_blind_pass ... ok
[INFO] [stdout] test m16::tests::m16_real_cache_keys_separate_model_manifests ... ok
[INFO] [stdout] test m16::tests::m16_metric_contract_identity_and_known_mismatch ... ok
[INFO] [stdout] test m16::tests::m16_integrated_blind_coordinator_promotes_once_after_qualification ... ok
[INFO] [stdout] test m16::tests::m16_real_session_seam_uses_injected_masks_and_fails_closed ... ok
[INFO] [stdout] test m16::tests::m16_reference_oracle_is_analytical_and_not_candidate_derived ... ok
[INFO] [stdout] test m16::tests::m16_router_and_complementary_ablations_are_independent ... ok
[INFO] [stdout] test m16::tests::m16_routing_and_uncertainty_are_deterministic_and_bounded ... ok
[INFO] [stdout] test m16::tests::m16_topology_and_foreground_are_real_selective_operations ... ok
[INFO] [stdout] test m17::tests::m17_failed_staging_cleanup_preserves_published_output ... ok
[INFO] [stdout] test m17::tests::m17_failure_probes_are_executed_not_constant_gate_claims ... ok
[INFO] [stdout] test m17::tests::m17_fallback_policy_is_strict_unless_explicitly_enabled ... ok
[INFO] [stdout] test m17::tests::m17_final_manifest_rejects_an_unlisted_extra_file ... ok
[INFO] [stdout] test m17::tests::m17_limited_decoder_rejects_dimensions_before_pixel_decode ... ok
[INFO] [stdout] test m17::tests::m17_limits_and_cancellation_fail_closed ... ok
[INFO] [stdout] test m17::tests::m17_manifest_hash_is_lowercase_sha256 ... ok
[INFO] [stdout] test m17::tests::m17_provider_order_is_cpu_first_and_strict ... ok
[INFO] [stdout] test m17::tests::m17_report_checksum_covers_newline_terminated_file ... ok
[INFO] [stdout] test m17::tests::m17_unowned_output_is_never_deleted ... ok
[INFO] [stdout] test m17::tests::m17_worker_pool_is_bounded_and_preserves_input_order ... ok
[INFO] [stdout] test tests::constant_baselines_are_deterministic_and_bounded ... ok
[INFO] [stdout] test tests::duplicate_group_split_is_checked_by_validator ... ok
[INFO] [stdout] test tests::m10_report_acceptance_catches_authority_tolerance_fallback_and_bounds ... ok
[INFO] [stdout] test tests::m11_report_acceptance_covers_source_contract_and_all_artifacts ... ok
[INFO] [stdout] test tests::m12_report_acceptance_requires_source_authority_and_full_artifact_hashes ... ok
[INFO] [stdout] test tests::m6_accepted_report_has_five_truthful_quantitative_runs ... ok
[INFO] [stdout] test tests::m7_accepted_report_has_truthful_registry_and_benchmark_evidence ... ok
[INFO] [stdout] test tests::m8_report_is_truthful_about_unavailable_restrictive_checkpoints ... ok
[INFO] [stdout] test tests::m9_report_has_both_source_profiles_and_quantitative_unknown_stats ... ok
[INFO] [stdout] test tests::median_and_nearest_rank_p95_are_defined_for_even_samples ... ok
[INFO] [stdout] test tests::pair_dimension_invariant_rejects_mismatch ... ok
[INFO] [stdout] test tests::png_metadata_rejects_bad_signature ... ok
[INFO] [stdout] test tests::record_invariants_reject_bad_hash_schema_and_empty_tags ... ok
[INFO] [stdout] test tests::serde_rejects_unknown_manifest_fields ... ok
[INFO] [stdout] test m15::tests::m15_fixed_arena_loo_does_not_claim_legacy_blind_ids_excluded has been running for over 60 seconds
[INFO] [stdout] test m15::tests::m15_fixed_arena_loo_retires_legacy_declared_blind_labels has been running for over 60 seconds
[INFO] [stdout] test m15::tests::m15_fixture_is_deterministic has been running for over 60 seconds
[INFO] [stdout] test m15::tests::m15_real_arena_preserves_declared_splits_and_excludes_blind has been running for over 60 seconds
[INFO] [stdout] test m16::tests::m16_ablation_disablement_is_evidence_driven has been running for over 60 seconds
[INFO] [stdout] test m16::tests::m16_real_loo_reuses_each_raw_model_once_per_image has been running for over 60 seconds
[INFO] [stdout] test m16::tests::m16_real_session_runs_the_same_hybrid_stages_with_injected_masks has been running for over 60 seconds
[INFO] [stdout] test m15::tests::m15_fixed_arena_loo_does_not_claim_legacy_blind_ids_excluded ... ok
[INFO] [stdout] test m15::tests::m15_fixed_arena_loo_retires_legacy_declared_blind_labels ... ok
[INFO] [stdout] test m15::tests::m15_real_arena_preserves_declared_splits_and_excludes_blind ... ok
[INFO] [stdout] test m16::tests::m16_real_loo_reuses_each_raw_model_once_per_image ... ok
[INFO] [stdout] test m16::tests::m16_real_session_runs_the_same_hybrid_stages_with_injected_masks ... ok
[INFO] [stdout] test m16::tests::m16_ablation_disablement_is_evidence_driven ... ok
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d", kill_on_drop: false }`
[INFO] [stdout] 37c9928f1e04064c9ed5e222ce3072724dcd11edc047b6abb2884a29638a307d
