[INFO] fetching crate dubbo-rs-filter 0.1.0...
[INFO] testing dubbo-rs-filter-0.1.0 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate dubbo-rs-filter 0.1.0 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate dubbo-rs-filter 0.1.0
[INFO] finished tweaking crates.io crate dubbo-rs-filter 0.1.0
[INFO] tweaked toml for crates.io crate dubbo-rs-filter 0.1.0 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate dubbo-rs-filter 0.1.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 dubbo-rs-filter 0.1.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 dubbo-rs-protocol v0.1.0
[INFO] [stderr]   Downloaded dubbo-rs-common v0.1.2
[INFO] [stderr]   Downloaded tokio v1.52.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb
[INFO] running `Command { std: "docker" "start" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb", 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" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb" "/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" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb", 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" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling hashbrown v0.17.0
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling inventory v0.3.24
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling dashmap v6.1.0
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tokio v1.52.1
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling dubbo-rs-common v0.1.2
[INFO] [stderr]    Compiling dubbo-rs-protocol v0.1.0
[INFO] [stderr]    Compiling dubbo-rs-filter v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 30.00s
[INFO] running `Command { std: "docker" "inspect" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb", 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" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling dubbo-rs-filter v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 6.13s
[INFO] running `Command { std: "docker" "inspect" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb", 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" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/dubbo_rs_filter-11bc6ff21879c4d4)
[INFO] [stdout] 
[INFO] [stdout] running 104 tests
[INFO] [stdout] test auth_filter_tests::test_auth_filter_rejects_expired_timestamp ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_add_credential_at_runtime ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_rejects_unknown_access_key ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_rejects_invalid_signature ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_rejects_missing_timestamp ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_signs_request_on_consumer_side ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_rejects_missing_signature ... ok
[INFO] [stdout] test cache_filter_tests::test_cache_filter_cache_key_varies_by_args ... ok
[INFO] [stdout] test cache_filter_tests::test_cache_filter_cache_key_varies_by_method ... ok
[INFO] [stdout] test cache_filter_tests::test_cache_filter_does_not_cache_errors ... ok
[INFO] [stdout] test cache_filter_tests::test_lru_cache_clear ... ok
[INFO] [stdout] test cache_filter_tests::test_lru_cache_evicts_oldest ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_signature_computation_deterministic ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_validates_correct_signature ... ok
[INFO] [stdout] test cache_filter_tests::test_lru_cache_put_and_get ... ok
[INFO] [stdout] test cache_filter_tests::test_lru_cache_remove ... ok
[INFO] [stdout] test cache_filter_tests::test_ttl_cache_entry_valid_within_ttl ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_call_permitted_when_closed ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_default_has_sensible_defaults ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_filter_allows_when_closed ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_filter_rejects_when_open ... ok
[INFO] [stdout] test cache_filter_tests::test_cache_filter_returns_cached_result ... ok
[INFO] [stdout] test auth_filter_tests::test_auth_filter_no_credentials_passes_through ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_records_success_and_failure ... ok
[INFO] [stdout] test generic_tests::test_generic_filter_identifies_generic_call ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_initial_state_closed ... ok
[INFO] [stdout] test generic_tests::test_generic_filter_on_response_passthrough_for_json_mode ... ok
[INFO] [stdout] test generic_tests::test_generic_filter_on_response_protobuf_json ... ok
[INFO] [stdout] test context_exception_tests::test_context_filter_filters_internal_attachments ... ok
[INFO] [stdout] test context_exception_tests::test_exception_filter_wraps_undeclared_exception ... ok
[INFO] [stdout] test generic_tests::test_generic_invocation_attachment_set ... ok
[INFO] [stdout] test context_exception_tests::test_exception_filter_passes_through_success ... ok
[INFO] [stdout] test generic_tests::test_generic_invocation_json_mode_sets_attachment ... ok
[INFO] [stdout] test generic_tests::test_generic_invocation_map_mode ... ok
[INFO] [stdout] test context_exception_tests::test_context_filter_propagates_business_attachments ... ok
[INFO] [stdout] test generic_tests::test_generic_invocation_protobuf_json_sets_attachment ... ok
[INFO] [stdout] test generic_tests::test_generic_invocation_protobuf_json_mode ... ok
[INFO] [stdout] test generic_tests::test_generic_invoke_error ... ok
[INFO] [stdout] test generic_tests::test_generic_filter_passthrough_non_generic ... ok
[INFO] [stdout] test generic_tests::test_generic_invocation_json_mode ... ok
[INFO] [stdout] test generic_tests::test_generic_invoke_multiple_args ... ok
[INFO] [stdout] test generic_tests::test_generic_invoke_success ... ok
[INFO] [stdout] test context_exception_tests::test_exception_filter_passes_through_declared_exception ... ok
[INFO] [stdout] test generic_tests::test_generic_invoker_error_contains_method_name ... ok
[INFO] [stdout] test generic_tests::test_generic_invocation_map_mode_sets_attachment ... ok
[INFO] [stdout] test tests::test_access_log_filter_handles_error_result ... ok
[INFO] [stdout] test tests::test_access_log_filter_passes_result_unchanged ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_opens_after_threshold ... ok
[INFO] [stdout] test tests::test_active_limit_allows_within_limit ... ok
[INFO] [stdout] test context_exception_tests::test_context_filter_passes_through ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_stays_closed_below_threshold ... ok
[INFO] [stdout] test tests::test_echo_filter_echoes_method_name ... ok
[INFO] [stdout] test tests::test_echo_filter_passes_through_other_methods ... ok
[INFO] [stdout] test tests::test_echo_filter_short_circuits ... ok
[INFO] [stdout] test tests::test_execute_limit_allows_within_limit ... ok
[INFO] [stdout] test tests::test_filter_can_short_circuit ... ok
[INFO] [stdout] test tests::test_filter_chain_empty_passes_through ... ok
[INFO] [stdout] test tests::test_filter_chain_execution_order ... ok
[INFO] [stdout] test tests::test_filter_chain_single_filter_calls_base ... ok
[INFO] [stdout] test generic_tests::test_generic_invoker_url ... ok
[INFO] [stdout] test tests::test_filter_node_destroy_delegates ... ok
[INFO] [stdout] test tests::test_active_limit_rejects_when_full ... ok
[INFO] [stdout] test tests::test_filter_node_get_url_delegates ... ok
[INFO] [stdout] test tests::test_filter_node_delegates ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_resets_window ... ok
[INFO] [stdout] test generic_tests::test_generic_serialization_default_is_json ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_reopens_on_failure_in_half_open ... ok
[INFO] [stdout] test tests::test_filter_node_is_available_delegates ... ok
[INFO] [stdout] test tests::test_active_limit_on_response_decrements ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_allows_when_not_shutdown ... ok
[INFO] [stdout] test tests::test_execute_limit_rejects_when_semaphore_exhausted ... ok
[INFO] [stdout] test generic_tests::test_generic_service_invoke_with_mode_default ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_rejects_when_shutdown ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_resolve_timeout_missing ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_shared_flag ... ok
[INFO] [stdout] test tests::test_timeout_filter_custom_default ... ok
[INFO] [stdout] test tests::test_timeout_filter_default_3_seconds ... ok
[INFO] [stdout] test tests::test_timeout_filter_ignores_invalid_param ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_max_half_open_probes ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_resolve_timeout_from_url ... ok
[INFO] [stdout] test tests::test_timeout_filter_allows_fast_calls ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_inflight_error_path ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_closes_after_success_threshold_in_half_open ... ok
[INFO] [stdout] test tests::test_token_filter_custom_key ... ok
[INFO] [stdout] test tests::test_token_filter_custom_key_still_rejects_default_key ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_resolve_timeout_invalid ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_with_custom_timeout ... ok
[INFO] [stdout] test tests::test_token_filter_correct_token_passes ... ok
[INFO] [stdout] test tests::test_token_filter_default_key_should_work ... ok
[INFO] [stdout] test tests::test_token_filter_empty_token ... ok
[INFO] [stdout] test tests::test_token_filter_missing_token_blocked ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_inflight_tracking ... ok
[INFO] [stdout] test tests::test_token_filter_wrong_token_blocked ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_rejects_new_requests ... ok
[INFO] [stdout] test tests::test_tps_limit_filter_blocks_when_exhausted ... ok
[INFO] [stdout] test circuit_breaker_tests::test_circuit_breaker_half_open_after_recovery_timeout ... ok
[INFO] [stdout] test tests::test_tps_limiter_exhausts_tokens ... ok
[INFO] [stdout] test tests::test_tps_limiter_initial_allowable ... ok
[INFO] [stdout] test tests::test_tps_limiter_new_capacity ... ok
[INFO] [stdout] test tests::test_timeout_filter_reads_url_param ... ok
[INFO] [stdout] test tests::test_timeout_filter_rejects_slow_calls ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_waits_for_inflight ... ok
[INFO] [stdout] test tests::test_graceful_shutdown_timeout ... ok
[INFO] [stderr]    Doc-tests dubbo_rs_filter
[INFO] [stdout] test cache_filter_tests::test_ttl_cache_entry_expires ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 104 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[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] running `Command { std: "docker" "inspect" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb", kill_on_drop: false }`
[INFO] [stdout] b9bda2d00c49f59ea472cc0200a41f2d3f7d6b8e1b28ae0edbefb2b05b19a2bb
