[INFO] fetching crate r402-server 0.21.0...
[INFO] testing r402-server-0.21.0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate r402-server 0.21.0 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate r402-server 0.21.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate r402-server 0.21.0
[INFO] tweaked toml for crates.io crate r402-server 0.21.0 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate r402-server 0.21.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 r402-server 0.21.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 jiff-static v0.2.35
[INFO] [stderr]   Downloaded serde_with_macros v3.22.0
[INFO] [stderr]   Downloaded rapidhash v4.5.1
[INFO] [stderr]   Downloaded r402-protocol v0.21.0
[INFO] [stderr]   Downloaded serde_with v3.22.0
[INFO] [stderr]   Downloaded metrics v0.24.6
[INFO] [stderr]   Downloaded jiff-tzdb v0.1.8
[INFO] [stderr]   Downloaded r402-facilitator v0.21.0
[INFO] [stderr]   Downloaded compact_str v0.10.0
[INFO] [stderr]   Downloaded crossbeam-channel v0.5.16
[INFO] [stderr]   Downloaded jiff-core v0.1.0
[INFO] [stderr]   Downloaded moka v0.12.16
[INFO] [stderr]   Downloaded jiff v0.2.35
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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] 61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0
[INFO] running `Command { std: "docker" "start" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0", 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" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0" "/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" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0", 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" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0" "/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 crossbeam-utils v0.8.22
[INFO] [stderr]    Compiling rustversion v1.0.23
[INFO] [stderr]    Compiling smallvec v1.16.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.20
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling portable-atomic v1.15.0
[INFO] [stderr]    Compiling rust_decimal v1.43.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling arrayvec v0.7.8
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling uuid v1.26.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling syn v3.0.4
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling castaway v0.2.4
[INFO] [stderr]    Compiling crossbeam-channel v0.5.16
[INFO] [stderr]    Compiling tagptr v0.2.0
[INFO] [stderr]    Compiling moka v0.12.16
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling darling_core v0.23.0
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling darling_macro v0.23.0
[INFO] [stderr]    Compiling darling v0.23.0
[INFO] [stderr]    Compiling serde_with_macros v3.22.0
[INFO] [stderr]    Compiling compact_str v0.10.0
[INFO] [stderr]    Compiling serde_with v3.22.0
[INFO] [stderr]    Compiling r402-protocol v0.21.0
[INFO] [stderr]    Compiling r402-facilitator v0.21.0
[INFO] [stderr]    Compiling r402-server v0.21.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 37.53s
[INFO] running `Command { std: "docker" "inspect" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0", 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" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0" "/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 r402-server v0.21.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.54s
[INFO] running `Command { std: "docker" "inspect" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0", 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" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0" "/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.14s
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/r402_server-545a0714b8f153c3)
[INFO] [stdout] test hooks::policy::tests::additive_settlement_extra_allows_nested_fields ... ok
[INFO] [stdout] test hooks::policy::tests::additive_settlement_extra_rejects_nested_overwrite ... ok
[INFO] [stdout] test hooks::policy::tests::additive_payload_allows_new_fields ... ok
[INFO] [stdout] test hooks::policy::tests::additive_payload_rejects_overwrite ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_allows_adding_extra_keys ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_rejects_scheme_change ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_allows_filling_vacant_pay_to_amount_asset ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_rejects_removed_extra_key ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_detects_nested_extra_mutation ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_rejects_changed_extra_value ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_rejects_injected_asset_transfer_method ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_rejects_non_vacant_amount_change ... ok
[INFO] [stdout] test hooks::policy::tests::extension_enrich_rejects_injected_payment_flow ... ok
[INFO] [stdout] test hooks::policy::tests::scheme_enrich_rejects_new_extra_on_unbound_network ... ok
[INFO] [stdout] test hooks::policy::tests::merge_additive_settlement_extra_merges_nested ... ok
[INFO] [stdout] test hooks::policy::tests::scheme_enrich_allows_new_extra_only_on_bound_network ... ok
[INFO] [stdout] test hooks::policy::tests::scheme_enrich_rejects_injected_payment_flow_on_matching_accept ... ok
[INFO] [stdout] test hooks::policy::tests::vacant_string_treats_empty_and_whitespace_as_vacant ... ok
[INFO] [stdout] test hooks::snapshot::tests::settle_core_unchanged_allows_extension_map_edits ... ok
[INFO] [stdout] test hooks::snapshot::tests::settle_core_unchanged_rejects_transaction_change ... ok
[INFO] [stdout] test settlement::tracker::tests::nested_guards_decrement_in_order ... ok
[INFO] [stdout] test settlement::tracker::tests::empty_tracker_drains_immediately ... ok
[INFO] [stdout] test settlement::tracker::tests::drain_waits_for_guard_drop ... ok
[INFO] [stdout] test settlement::tracker::tests::drain_times_out_when_guards_outlive_deadline ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/facilitator_support.rs (/opt/rustwide/target/debug/deps/facilitator_support-8ed5aeef6d165e79)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test unused_registration_is_ignored ... ok
[INFO] [stdout] test unregistered_accept_skips_hook ... ok
[INFO] [stdout] test version_mismatch_is_kind_missing ... ok
[INFO] [stdout] test matching_kind_forwards_scheme_error ... ok
[INFO] [stdout] test matching_kind_default_ok ... ok
[INFO] [stdout] test second_accept_kind_missing ... ok
[INFO] [stdout] test empty_kinds_is_kind_missing ... ok
[INFO] [stdout] test mismatched_kind_is_kind_missing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/hooks.rs (/opt/rustwide/target/debug/deps/hooks-f800a9120244e870)
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test after_verify_abort_fires_cancel ... ok
[INFO] [stdout] test after_verify_skip_handler ... ok
[INFO] [stdout] test cancel_settle_error_becomes_failed_receipt ... ok
[INFO] [stdout] test cancel_settles_when_before_handler_and_settle_on_cancel ... ok
[INFO] [stdout] test before_verify_abort ... ok
[INFO] [stdout] test before_verify_skip_bypasses_facilitator ... ok
[INFO] [stdout] test cancel_skips_settle_without_before_handler_phase ... ok
[INFO] [stdout] test failure_path_none_when_nothing_available ... ok
[INFO] [stdout] test failure_path_prefers_successful_cancel ... ok
[INFO] [stdout] test find_matching_omits_scheme_dynamic_extra_fields ... ok
[INFO] [stdout] test get_payment_flow_errors_when_table_empty ... ok
[INFO] [stdout] test get_payment_flow_resolves_registered_scheme ... ok
[INFO] [stdout] test registered_extension_attaches_settle_receipt ... ok
[INFO] [stdout] test create_payment_required_rejects_cross_network_enrich ... ok
[INFO] [stdout] test create_payment_required_two_networks_enriches_each_row ... ok
[INFO] [stdout] test registered_extension_enriches_402 ... ok
[INFO] [stdout] test settle_does_not_retry_on_facilitator_error ... ok
[INFO] [stdout] test settle_payment_merges_scheme_payload_enrichment_after_handler ... ok
[INFO] [stdout] test verify_and_settle_invoke_facilitator ... ok
[INFO] [stdout] test verify_failure_recovers ... ok
[INFO] [stdout] test verify_payment_errors_when_table_empty ... ok
[INFO] [stdout] test verify_rejects_builder_code_a_without_declaration ... ok
[INFO] [stdout] test verify_rejects_builder_code_s_over_budget ... ok
[INFO] [stdout] test verify_rejects_forged_builder_code_a ... ok
[INFO] [stdout] test cancellation_guard_fires_once ... ok
[INFO] [stdout] test create_payment_required_omits_authorization_payment_flow ... ok
[INFO] [stdout] test verify_skips_facilitator_when_not_verify_before_handler ... ok
[INFO] [stdout] test failure_path_failed_cancel_includes_deposit_recovery ... ok
[INFO] [stderr]      Running tests/payment_flow.rs (/opt/rustwide/target/debug/deps/payment_flow-f729a47b61cc2f3b)
[INFO] [stdout] test settle_retries_once_on_pending_then_success ... ok
[INFO] [stdout] test verify_accepts_matching_builder_code_a_and_superset_s ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test apply_forces_non_authorization_payment_flow ... ok
[INFO] [stdout] test apply_strips_sdk_atm_sentinel ... ok
[INFO] [stdout] test payment_flow_name_wire_strings ... ok
[INFO] [stdout] test payment_flows_table_matches_closed_set ... ok
[INFO] [stdout] test recognized_payment_flow_accepts_omit_null_and_closed_names ... ok
[INFO] [stdout] test resolve_explicit_defaults_match_omitted ... ok
[INFO] [stdout] test resolve_throws_on_unknown_atm ... ok
[INFO] [stdout] test resolve_throws_on_unsupported_flow ... ok
[INFO] [stdout] test resolve_upfront_and_permit2_atm ... ok
[INFO] [stdout] test settle_phase_wire_strings ... ok
[INFO] [stdout] test apply_leaves_authorization_alone ... ok
[INFO] [stdout] test resolve_null_payment_flow_uses_default ... ok
[INFO] [stderr]      Running tests/schema_ref.rs (/opt/rustwide/target/debug/deps/schema_ref-a46aa359f136bfc9)
[INFO] [stdout] test resolve_omits_atm_and_payment_flow_to_scheme_defaults ... ok
[INFO] [stdout] test resolve_rejects_default_not_in_supported ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test verify_advertised_bazaar_external_ref_is_invalid_format ... ok
[INFO] [stdout] test verify_bazaar_nested_ref_is_invalid_format ... ok
[INFO] [stdout] test verify_bazaar_non_string_ref_is_invalid_format ... ok
[INFO] [stdout] test verify_bazaar_raw_entry_is_not_checked ... ok
[INFO] [stdout] test verify_bazaar_schema_url_is_ok ... ok
[INFO] [stdout] test verify_payload_bazaar_external_ref_is_invalid_format ... ok
[INFO] [stdout] test verify_bazaar_fragment_ref_is_ok ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/settlement.rs (/opt/rustwide/target/debug/deps/settlement-f61c4d9f3c40ba9e)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test concurrent_upfront_is_incompatible ... ok
[INFO] [stdout] test background_escrow_is_incompatible ... ok
[INFO] [stdout] test finish_wait_then_settle_propagates_error ... ok
[INFO] [stdout] test concurrent_escrow_is_incompatible ... ok
[INFO] [stdout] test run_does_not_execute_sequential_as_wait_then_settle ... ok
[INFO] [stdout] test run_join_settle_err ... ok
[INFO] [stdout] test run_join_settle_handler_err_detaches ... ok
[INFO] [stdout] test run_join_settle_ok ... ok
[INFO] [stdout] test sequential_authorization_is_wait_then_settle ... ok
[INFO] [stdout] test run_spawn_settle_returns_without_waiting ... ok
[INFO] [stdout] test sequential_escrow_is_wait_then_settle ... ok
[INFO] [stdout] test concurrent_and_background_authorization_are_legal ... ok
[INFO] [stdout] test sequential_escrow_settles_before_and_after ... ok
[INFO] [stdout] test finish_wait_then_settle_awaits_receipt ... ok
[INFO] [stdout] test sequential_upfront_is_echo_receipt ... ok
[INFO] [stdout] test sequential_upfront_settles_once_then_echo ... ok
[INFO] [stdout] test finish_echo_receipt_takes_none ... ok
[INFO] [stderr]    Doc-tests r402_server
[INFO] [stdout] test finish_rejects_concurrent_schedule ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[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" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0", kill_on_drop: false }`
[INFO] [stdout] 61dc9dd4647a29c8fef2fce9d5eb138a247be2db44adcbd9d035e1c5d5b478b0
