[INFO] fetching crate sz-orm-diagnosis 9.0.0...
[INFO] testing sz-orm-diagnosis-9.0.0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate sz-orm-diagnosis 9.0.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate sz-orm-diagnosis 9.0.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sz-orm-diagnosis 9.0.0
[INFO] tweaked toml for crates.io crate sz-orm-diagnosis 9.0.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate sz-orm-diagnosis 9.0.0 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 crates.io crate sz-orm-diagnosis 9.0.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" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded tokio-macros v2.7.1
[INFO] [stderr]   Downloaded sz-orm-flamegraph v9.0.0
[INFO] [stderr]   Downloaded sz-orm-adaptive v9.0.0
[INFO] [stderr]   Downloaded sz-orm-ai v9.0.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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] b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797
[INFO] running `Command { std: "docker" "start" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797", 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" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797" "/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" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797", 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" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling sz-orm-diagnosis v9.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.89s
[INFO] running `Command { std: "docker" "inspect" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797", 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" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797" "/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 sz-orm-diagnosis v9.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.63s
[INFO] running `Command { std: "docker" "inspect" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797", 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" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", 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/sz_orm_diagnosis-69c08c8412f21a24)
[INFO] [stdout] 
[INFO] [stdout] running 135 tests
[INFO] [stdout] test bottleneck_locator::tests::locator_has_severe_bottleneck ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_top_n_limit ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_no_severe_bottleneck ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_worst_bottleneck ... ok
[INFO] [stdout] test bottleneck_locator::tests::config_default_values ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_clear ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_severity_assigned ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_empty ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_has_critical_bottleneck ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_add_samples_batch ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_multiple_stages ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_report_with_data ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_zero_duration_no_panic ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_boundary_values ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_from_percentage_minor ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_from_percentage_critical ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_from_percentage_moderate ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_from_percentage_severe ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_empty ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_record ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_ordering ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_report_empty ... ok
[INFO] [stdout] test bottleneck_locator::tests::sample_new ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_from_percentage_normal ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_default ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_events_ref ... ok
[INFO] [stdout] test bottleneck_locator::tests::severity_as_str ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_multiple_events ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_persistent_bottleneck ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_trend_worsening ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_aggregates_same_stage ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_add_events_batch ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_avg_wait ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_empty ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_complete_transaction ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_clear ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_no_deadlock_risk ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_top_contended ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_detect_cycle_returns_path ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_complex_graph_with_cycle ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_detects_deadlock_risk ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_trend_improving ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_detect_deadlock_returns_resources ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_not_persistent ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_persistent_bottlenecks_list ... ok
[INFO] [stdout] test bottleneck_locator::tests::trend_analyzer_trend_single_window ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_default ... ok
[INFO] [stdout] test deadlock_detector::tests::analyzer_single_event ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_no_cycle_dag ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_edge_count ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_disconnected_components ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_transaction_count ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_two_node_cycle ... ok
[INFO] [stdout] test deadlock_detector::tests::resolution_new ... ok
[INFO] [stdout] test deadlock_detector::tests::resolution_select_victim_minimum ... ok
[INFO] [stdout] test deadlock_detector::tests::strategy_descriptions_nonempty ... ok
[INFO] [stdout] test deadlock_detector::tests::strategy_distinct ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_no_deadlock_initially ... ok
[INFO] [stdout] test metrics::tests::fix_action_add_index_description_contains_name ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_self_loop_is_deadlock ... ok
[INFO] [stdout] test deadlock_detector::tests::strategy_requires_timestamp ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_remove_edge ... ok
[INFO] [stdout] test deadlock_detector::tests::event_equality ... ok
[INFO] [stdout] test deadlock_detector::tests::resolution_select_victim_empty ... ok
[INFO] [stdout] test deadlock_detector::tests::resolution_select_victim_single ... ok
[INFO] [stdout] test deadlock_detector::tests::event_inequality ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_single_edge_no_deadlock ... ok
[INFO] [stdout] test metrics::tests::metrics_record_info ... ok
[INFO] [stdout] test metrics::tests::metrics_record_warning ... ok
[INFO] [stdout] test metrics::tests::metrics_total_counts ... ok
[INFO] [stdout] test metrics::tests::ranker_add_and_top ... ok
[INFO] [stdout] test metrics::tests::ranker_top_n_more_than_available ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_three_node_cycle ... ok
[INFO] [stdout] test metrics::tests::fix_action_all_variants_distinct ... ok
[INFO] [stdout] test bottleneck_locator::tests::locator_single_sample ... ok
[INFO] [stdout] test metrics::tests::summary_add_report ... ok
[INFO] [stdout] test metrics::tests::ranker_top_n_sorted_desc ... ok
[INFO] [stdout] test metrics::tests::ranker_total_phases ... ok
[INFO] [stdout] test metrics::tests::fix_action_description_nonempty ... ok
[INFO] [stdout] test metrics::tests::summary_new_empty ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_waiting_for ... ok
[INFO] [stdout] test metrics::tests::summary_max_elapsed ... ok
[INFO] [stdout] test deadlock_detector::tests::detector_waiting_for_none ... ok
[INFO] [stdout] test pool_diagnoser::tests::avg_hold_ms_basic ... ok
[INFO] [stdout] test metrics::tests::fix_action_priority_ordering ... ok
[INFO] [stdout] test metrics::tests::metrics_new_empty ... ok
[INFO] [stdout] test pool_diagnoser::tests::avg_wait_ms_basic ... ok
[INFO] [stdout] test metrics::tests::ranker_new_empty ... ok
[INFO] [stdout] test metrics::tests::metrics_critical_rate ... ok
[INFO] [stdout] test metrics::tests::metrics_critical_rate_empty ... ok
[INFO] [stdout] test metrics::tests::metrics_record_critical ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_result_fields_populated ... ok
[INFO] [stdout] test metrics::tests::summary_avg_elapsed ... ok
[INFO] [stdout] test pool_diagnoser::tests::config_default_values ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_critical_by_wait_queue ... ok
[INFO] [stdout] test pool_diagnoser::tests::config_custom_values ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_suggests_increase_timeout_for_failures ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_suggests_prewarm_for_wait_queue ... ok
[INFO] [stdout] test pool_diagnoser::tests::failure_rate_zero_acquires ... ok
[INFO] [stdout] test pool_diagnoser::tests::health_status_distinct ... ok
[INFO] [stdout] test pool_diagnoser::tests::idle_rate_basic ... ok
[INFO] [stdout] test pool_diagnoser::tests::idle_rate_zero_pool ... ok
[INFO] [stdout] test pool_diagnoser::tests::leak_detector_acquire_increment_count ... ok
[INFO] [stdout] test pool_diagnoser::tests::leak_detector_clear ... ok
[INFO] [stdout] test pool_diagnoser::tests::leak_detector_no_leaks_initially ... ok
[INFO] [stdout] test pool_diagnoser::tests::failure_rate_with_failures ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_suggests_optimize_hold_time ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_suggests_increase_pool ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_count_increments ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_suggests_check_leak ... ok
[INFO] [stdout] test pool_diagnoser::tests::health_status_as_str ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_critical_by_utilization ... ok
[INFO] [stdout] test pool_diagnoser::tests::leak_detector_release_decrement_count ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_healthy ... ok
[INFO] [stdout] test pool_diagnoser::tests::leak_detector_release_unknown_returns_none ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_suggests_decrease_pool ... ok
[INFO] [stdout] test pool_diagnoser::tests::leak_detector_threshold_getter ... ok
[INFO] [stdout] test pool_diagnoser::tests::diagnose_warning ... ok
[INFO] [stdout] test pool_diagnoser::tests::metrics_new ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_trend_increasing ... ok
[INFO] [stdout] test pool_diagnoser::tests::suggestion_increase_contains_size ... ok
[INFO] [stdout] test pool_diagnoser::tests::utilization_rate_basic ... ok
[INFO] [stdout] test pool_diagnoser::tests::utilization_rate_full ... ok
[INFO] [stdout] test pool_diagnoser::tests::utilization_rate_zero_pool ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_evicts_oldest ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_max_utilization ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_empty_initially ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_avg_utilization ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_samples_ref ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_trend_empty ... ok
[INFO] [stdout] test pool_diagnoser::tests::suggestion_descriptions_nonempty ... ok
[INFO] [stdout] test pool_diagnoser::tests::suggestion_distinct ... ok
[INFO] [stdout] test pool_diagnoser::tests::sampler_trend_single_sample ... ok
[INFO] [stdout] test pool_diagnoser::tests::leak_detector_release_returns_hold_time ... ok
[INFO] [stdout] test metrics::tests::summary_root_cause_distribution ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 135 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests sz_orm_diagnosis
[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] running `Command { std: "docker" "inspect" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797", kill_on_drop: false }`
[INFO] [stdout] b9e0f848b44a0c4cb698fa7f3125b44ce18b7e1b90078839eb698930389d2797
