[INFO] fetching crate iperf3-rs 1.0.2...
[INFO] testing iperf3-rs-1.0.2 against 1.97.0-beta.6 for beta-1.98-1
[INFO] extracting crate iperf3-rs 1.0.2 into /workspace/builds/worker-2-tc1/source
[INFO] removed /workspace/builds/worker-2-tc1/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate iperf3-rs 1.0.2
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate iperf3-rs 1.0.2
[INFO] tweaked toml for crates.io crate iperf3-rs 1.0.2 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate iperf3-rs 1.0.2 on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate iperf3-rs 1.0.2 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.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded rustls v0.23.39
[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:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278
[INFO] running `Command { std: "docker" "start" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278", 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" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278", 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" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling cc v1.2.61
[INFO] [stderr]    Compiling rustls-pki-types v1.14.1
[INFO] [stderr]    Compiling rustls v0.23.39
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling tokio v1.52.1
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling webpki-roots v1.0.7
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling iperf3-rs v1.0.2 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling zerovec-derive v0.11.3
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling zerofrom-derive v0.1.7
[INFO] [stderr]    Compiling yoke-derive v0.8.2
[INFO] [stderr]    Compiling zerofrom v0.1.7
[INFO] [stderr]    Compiling yoke v0.8.2
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling rustls-webpki v0.103.13
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling hyper-rustls v0.27.9
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 41.67s
[INFO] running `Command { std: "docker" "inspect" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278", 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" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling iperf3-rs v1.0.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.18s
[INFO] running `Command { std: "docker" "inspect" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278", 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" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/iperf3_rs-01938178ddcdd3e6)
[INFO] [stdout] 
[INFO] [stdout] running 95 tests
[INFO] [stdout] test args::tests::help_request_skips_pushgateway_consistency_checks ... ok
[INFO] [stdout] test args::tests::informational_requests_ignore_malformed_pushgateway_environment ... ok
[INFO] [stdout] test args::tests::cli_values_override_environment_defaults ... ok
[INFO] [stdout] test args::tests::metrics_prefix_requires_an_output_sink ... ok
[INFO] [stdout] test args::tests::metrics_labels_require_prometheus_file_output ... ok
[INFO] [stdout] test args::tests::parses_metrics_formats ... ok
[INFO] [stdout] test args::tests::parses_metrics_prefix_for_pushgateway_without_file_metrics ... ok
[INFO] [stdout] test args::tests::parses_push_timeout_units ... ok
[INFO] [stdout] test args::tests::parses_push_transport_and_metric_options_from_environment ... ok
[INFO] [stdout] test args::tests::rejects_duplicate_metrics_labels ... ok
[INFO] [stdout] test args::tests::rejects_duplicate_push_labels ... ok
[INFO] [stdout] test args::tests::parses_bool_options ... ok
[INFO] [stdout] test args::tests::preserves_arguments_after_double_dash ... ok
[INFO] [stdout] test args::tests::rejects_empty_grouping_when_pushgateway_is_enabled ... ok
[INFO] [stdout] test args::tests::rejects_malformed_metrics_format ... ok
[INFO] [stdout] test args::tests::rejects_malformed_metrics_label ... ok
[INFO] [stdout] test args::tests::rejects_malformed_push_delete_on_exit_value ... ok
[INFO] [stdout] test args::tests::strips_version_options ... ok
[INFO] [stdout] test args::tests::rejects_malformed_push_label ... ok
[INFO] [stdout] test command::tests::argv_includes_program_name_before_iperf_arguments ... ok
[INFO] [stdout] test command::tests::bidirectional_helper_appends_long_option ... ok
[INFO] [stdout] test command::tests::direct_pushgateway_rejects_disabled_or_zero_window_mode ... ok
[INFO] [stdout] test args::tests::strips_help_options ... ok
[INFO] [stdout] test args::tests::unprefixed_environment_names_are_ignored ... ok
[INFO] [stdout] test args::tests::rejects_metrics_settings_without_metrics_file ... ok
[INFO] [stdout] test args::tests::rejects_malformed_push_transport_and_metric_options ... ok
[INFO] [stdout] test args::tests::rejects_missing_custom_option_value ... ok
[INFO] [stdout] test args::tests::rejects_push_labels_without_push_url ... ok
[INFO] [stdout] test args::tests::rejects_push_settings_without_push_url ... ok
[INFO] [stdout] test args::tests::strips_custom_options ... ok
[INFO] [stdout] test command::tests::duration_helpers_preserve_nonzero_subsecond_intent ... ok
[INFO] [stdout] test command::tests::inherit_output_disables_library_quiet_default ... ok
[INFO] [stdout] test command::tests::explicit_logfile_disables_null_output_sink ... ok
[INFO] [stdout] test command::tests::library_output_is_quiet_by_default ... ok
[INFO] [stdout] test command::tests::one_off_server_mode_is_allowed ... ok
[INFO] [stdout] test args::tests::version_request_skips_pushgateway_consistency_checks ... ok
[INFO] [stdout] test command::tests::pushgateway_convenience_helpers_do_not_persist_config ... ok
[INFO] [stdout] test command::tests::run_without_client_or_server_role_fails_fast ... ok
[INFO] [stdout] test command::tests::sctp_helper_appends_long_option ... ok
[INFO] [stdout] test command::tests::custom_program_name_is_used_as_argv_zero ... ok
[INFO] [stdout] test command::tests::direct_pushgateway_is_rejected_when_metrics_stream_is_enabled ... ok
[INFO] [stdout] test command::tests::typed_client_builder_appends_iperf_arguments ... ok
[INFO] [stdout] test command::tests::zero_metrics_window_interval_is_rejected_before_running_iperf ... ok
[INFO] [stdout] test command::tests::spawn_with_metrics_does_not_persist_metrics_mode ... ok
[INFO] [stdout] test help::tests::full_help_inserts_wrapper_help_before_upstream_sections ... ok
[INFO] [stdout] test help::tests::wrapper_help_documents_pushgateway_options ... ok
[INFO] [stdout] test iperf::tests::parser_sets_server_role ... ok
[INFO] [stdout] test metrics::tests::aggregate_window_ignores_invalid_counter_values ... ok
[INFO] [stdout] test command::tests::typed_operational_helpers_append_iperf_arguments ... ok
[INFO] [stdout] test command::tests::typed_server_constructors_select_expected_lifecycle ... ok
[INFO] [stdout] test command::tests::unbounded_server_mode_can_be_explicitly_allowed ... ok
[INFO] [stdout] test metrics::tests::aggregate_window_returns_none_for_empty_samples ... ok
[INFO] [stdout] test help::tests::wrapper_help_aligns_descriptions_without_tabs ... ok
[INFO] [stdout] test metrics::tests::aggregate_window_summarizes_interval_samples_by_metric_semantics ... ok
[INFO] [stdout] test iperf::tests::parser_sets_client_role ... ok
[INFO] [stdout] test metrics::tests::metric_direction_maps_callback_values ... ok
[INFO] [stdout] test metrics::tests::aggregate_window_falls_back_to_observed_bandwidth_when_duration_is_zero ... ok
[INFO] [stdout] test command::tests::pushgateway_helper_records_delivery_config ... ok
[INFO] [stdout] test command::tests::unbounded_server_mode_is_rejected_by_default ... ok
[INFO] [stdout] test metrics::tests::enqueue_latest_replaces_queued_metric ... ok
[INFO] [stdout] test metrics::tests::transport_protocol_maps_callback_values ... ok
[INFO] [stdout] test metrics::tests::metrics_stream_try_recv_reports_empty_and_closed ... ok
[INFO] [stdout] test metrics::tests::metrics_file_errors_are_returned_from_sink_worker ... ok
[INFO] [stdout] test metrics::tests::metrics_stream_recv_timeout_reports_timeout_and_closed ... ok
[INFO] [stdout] test metrics::tests::metric_event_stream_splits_windows_when_context_changes ... ok
[INFO] [stdout] test metrics::tests::metric_event_stream_flushes_final_window ... ok
[INFO] [stdout] test prometheus::tests::custom_prefix_changes_metric_names ... ok
[INFO] [stdout] test metrics::tests::metric_event_stream_forwards_interval_samples ... ok
[INFO] [stdout] test prometheus::tests::default_encoder_renders_prometheus_gauges ... ok
[INFO] [stdout] test prometheus::tests::fixed_labels_are_rendered_on_samples ... ok
[INFO] [stdout] test prometheus::tests::invalid_labels_are_rejected ... ok
[INFO] [stdout] test prometheus::tests::invalid_prefix_is_rejected ... ok
[INFO] [stdout] test prometheus::tests::renders_all_expected_metric_names ... ok
[INFO] [stdout] test metrics_file::tests::write_event_supports_window_jsonl ... ok
[INFO] [stdout] test metrics_file::tests::prometheus_format_replaces_latest_snapshot ... ok
[INFO] [stdout] test prometheus::tests::renders_all_expected_window_metric_names ... ok
[INFO] [stdout] test metrics_file::tests::jsonl_format_appends_interval_events ... ok
[INFO] [stdout] test metrics_file::tests::write_interval_reports_file_errors ... ok
[INFO] [stdout] test prometheus::tests::renders_window_prometheus_gauges ... ok
[INFO] [stdout] test pushgateway::tests::config_builder_sets_defaults ... ok
[INFO] [stdout] test pushgateway::tests::caps_retry_delay ... ok
[INFO] [stdout] test pushgateway::tests::config_validation_rejects_values_cli_would_reject ... ok
[INFO] [stdout] test pushgateway::tests::identifies_retryable_statuses ... ok
[INFO] [stdout] test pushgateway::tests::encodes_grouping_segments ... ok
[INFO] [stdout] test pushgateway::tests::parses_bare_pushgateway_endpoint_as_http ... ok
[INFO] [stdout] test pushgateway::tests::builds_pushgateway_grouping_url ... ok
[INFO] [stdout] test pushgateway::tests::renders_all_expected_metric_names ... ok
[INFO] [stdout] test pushgateway::tests::renders_all_expected_window_metric_names ... ok
[INFO] [stdout] test command::tests::running_iperf_try_wait_returns_none_while_worker_is_running ... ok
[INFO] [stdout] test pushgateway::tests::renders_metric_names_with_custom_prefix ... ok
[INFO] [stdout] test pushgateway::tests::renders_prometheus_gauges ... ok
[INFO] [stdout] test pushgateway::tests::renders_window_prometheus_gauges ... ok
[INFO] [stdout] test version::tests::renders_wrapper_and_upstream_versions ... ok
[INFO] [stdout] test command::tests::running_iperf_try_wait_observes_finished_worker_once ... ok
[INFO] [stdout] test pushgateway::tests::delete_sends_http_delete_to_grouping_url ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 95 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/iperf3_rs-889c418942f7005a)
[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]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-fea6796809e088a4)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test integration::api::command_rejects_zero_metrics_window ... ok
[INFO] [stdout] test integration::api::public_prometheus_encoder_renders_metrics_without_pushgateway ... ok
[INFO] [stdout] test integration::api::public_metrics_file_sink_writes_jsonl_events ... ok
[INFO] [stdout] test integration::cli::cli_treats_metrics_file_create_failure_as_fatal ... ok
[INFO] [stdout] test integration::api::public_api_exposes_upstream_metadata ... ok
[INFO] [stdout] test integration::cli::cli_writes_prometheus_metrics_file_with_custom_prefix ... ok
[INFO] [stdout] test integration::cli::cli_writes_jsonl_metrics_file_without_replacing_stdout ... ok
[INFO] [stdout] test integration::command::command_spawn_streams_interval_metrics_against_one_off_server ... ok
[INFO] [stdout] test integration::command::command_run_with_pushgateway_pushes_interval_metrics ... ok
[INFO] [stdout] test integration::command::command_spawn_streams_window_metrics_against_one_off_server ... ok
[INFO] [stdout] test integration::command::command_run_collects_interval_metrics_in_result ... ok
[INFO] [stdout] test integration::command::command_run_collects_window_metrics_in_result ... ok
[INFO] [stderr]    Doc-tests iperf3_rs
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 6.06s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/command.rs - command::IperfCommand (line 52) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 27) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.74s; merged doctests compilation took 0.72s
[INFO] running `Command { std: "docker" "inspect" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278", kill_on_drop: false }`
[INFO] [stdout] dfa2c8ac9b6201d88f88401fe955ddf02aa020f579176d7bc674361b1e2a1278
