[INFO] fetching crate subms-icehouse-control-plane 0.2.0...
[INFO] testing subms-icehouse-control-plane-0.2.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate subms-icehouse-control-plane 0.2.0 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate subms-icehouse-control-plane 0.2.0
[INFO] finished tweaking crates.io crate subms-icehouse-control-plane 0.2.0
[INFO] tweaked toml for crates.io crate subms-icehouse-control-plane 0.2.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate subms-icehouse-control-plane 0.2.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate subms-icehouse-control-plane 0.2.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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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] 17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7
[INFO] running `Command { std: "docker" "start" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7", 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" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7", 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" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling subms-icehouse-control-plane v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.39s
[INFO] running `Command { std: "docker" "inspect" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7", 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" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling subms-icehouse-control-plane v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.25s
[INFO] running `Command { std: "docker" "inspect" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7", 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" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/subms-icehouse-control-plane/ce5bd57bb4f7f659/out/subms_icehouse_control_plane-ce5bd57bb4f7f659)
[INFO] [stdout] 
[INFO] [stdout] running 112 tests
[INFO] [stdout] test cluster::tests::a_cluster_with_no_stated_target_is_never_degraded ... ok
[INFO] [stdout] test cluster::tests::a_confirmation_for_a_superseded_generation_is_ignored ... ok
[INFO] [stdout] test cluster::tests::a_destination_is_told_where_to_pull_from_only_once_the_source_has_stopped ... ok
[INFO] [stdout] test cluster::tests::a_dead_member_does_not_count_as_capacity ... ok
[INFO] [stdout] test cluster::tests::a_heartbeat_from_an_unknown_member_is_refused ... ok
[INFO] [stdout] test cluster::tests::a_lone_member_that_dies_is_reported_degraded ... ok
[INFO] [stdout] test cluster::tests::a_prefix_in_transit_is_owned_by_nobody ... ok
[INFO] [stdout] test cluster::tests::a_dead_leader_is_never_still_reported_as_the_writer ... ok
[INFO] [stdout] test cluster::tests::a_member_that_steps_down_is_not_re_granted_under_the_live_leader ... ok
[INFO] [stdout] test cluster::tests::a_leader_that_stops_heartbeating_is_replaced ... ok
[INFO] [stdout] test cluster::tests::a_full_cluster_with_no_leader_is_not_degraded ... ok
[INFO] [stdout] test cluster::tests::a_missing_member_is_reported_as_a_shortfall ... ok
[INFO] [stdout] test cluster::tests::a_live_leader_is_left_alone ... ok
[INFO] [stdout] test cluster::tests::a_restart_does_not_re_shard_the_cluster ... ok
[INFO] [stdout] test cluster::tests::a_new_grant_starts_unconfirmed_even_for_a_member_that_led_before ... ok
[INFO] [stdout] test cluster::tests::a_member_joins_owning_everything_rather_than_nothing ... ok
[INFO] [stdout] test cluster::tests::a_dead_member_is_not_a_route ... ok
[INFO] [stdout] test cluster::tests::a_member_owning_everything_is_not_published_as_a_route ... ok
[INFO] [stdout] test cluster::tests::a_share_can_be_assigned_and_shows_up_in_the_topology ... ok
[INFO] [stdout] test cluster::tests::a_restarted_member_keeps_its_place_in_the_join_order ... ok
[INFO] [stdout] test cluster::tests::a_transfer_moves_through_its_states_in_order ... ok
[INFO] [stdout] test cluster::tests::an_aborted_transfer_withdraws_the_pull ... ok
[INFO] [stdout] test cluster::tests::a_transfer_will_not_complete_into_a_member_that_holds_nothing ... ok
[INFO] [stdout] test cluster::tests::an_outstanding_grant_stops_a_second_member_racing_for_the_same_lock ... ok
[INFO] [stdout] test cluster::tests::declaring_for_an_unknown_member_is_refused_rather_than_stored ... ok
[INFO] [stdout] test cluster::tests::degraded_can_never_disagree_with_the_counts_beside_it ... ok
[INFO] [stdout] test cluster::tests::every_novation_state_has_a_stable_wire_name ... ok
[INFO] [stdout] test cluster::tests::a_target_of_zero_still_disables_the_signal_for_a_caller_who_asks ... ok
[INFO] [stdout] test cluster::tests::a_source_that_has_not_said_where_it_serves_yields_no_pull ... ok
[INFO] [stdout] test cluster::tests::aborting_a_transfer_that_is_not_running_is_refused ... ok
[INFO] [stdout] test cluster::tests::a_share_cannot_be_moved_out_of_a_member_that_owns_everything ... ok
[INFO] [stdout] test cluster::tests::automatic_rebalances_only_when_the_fleet_is_whole_and_still ... ok
[INFO] [stdout] test cluster::tests::completing_a_move_takes_the_share_off_the_source ... ok
[INFO] [stdout] test cluster::tests::a_transfer_cannot_complete_before_the_old_owner_has_quiesced ... ok
[INFO] [stdout] test cluster::tests::an_abandoned_transfer_gives_the_share_back ... ok
[INFO] [stdout] test cluster::tests::assigning_to_an_unknown_member_is_refused ... ok
[INFO] [stdout] test cluster::tests::automatic_will_not_rebalance_on_top_of_a_transfer ... ok
[INFO] [stdout] test cluster::tests::only_the_destination_is_told_to_pull ... ok
[INFO] [stdout] test cluster::tests::quiescing_an_unknown_transfer_is_refused ... ok
[INFO] [stdout] test cluster::tests::only_static_lets_a_member_declare_its_own_share ... ok
[INFO] [stdout] test cluster::tests::overlapping_prefixes_resolve_longest_first ... ok
[INFO] [stdout] test cluster::tests::every_policy_has_a_stable_wire_name ... ok
[INFO] [stdout] test cluster::tests::the_default_policy_moves_nothing ... ok
[INFO] [stdout] test cluster::tests::the_generation_advances_on_every_change_of_leadership ... ok
[INFO] [stdout] test cluster::tests::readiness_is_only_accepted_from_the_destination ... ok
[INFO] [stdout] test routes::tests::a_malformed_entry_is_dropped_rather_than_taking_the_next_address ... ok
[INFO] [stdout] test cluster::tests::readiness_alone_does_not_complete_a_transfer_either ... ok
[INFO] [stdout] test cluster::tests::eviction_is_separate_from_liveness ... ok
[INFO] [stdout] test cluster::tests::exactly_one_member_is_ever_marked_the_writer ... ok
[INFO] [stdout] test cluster::tests::manual_does_not_rebalance_either ... ok
[INFO] [stdout] test cluster::tests::no_grant_is_made_when_nothing_is_alive ... ok
[INFO] [stdout] test routes::tests::a_room_resolves_to_the_member_that_owns_its_prefix ... ok
[INFO] [stdout] test routes::tests::an_absent_or_unterminated_array_is_none_rather_than_a_guess ... ok
[INFO] [stdout] test routes::tests::an_empty_or_absent_table_yields_nothing_rather_than_a_phantom_entry ... ok
[INFO] [stdout] test routes::tests::every_entry_is_read_regardless_of_key_order ... ok
[INFO] [stdout] test routes::tests::an_array_field_is_read_whole_rather_than_to_the_first_comma ... ok
[INFO] [stdout] test routes::tests::key_order_does_not_change_the_answer ... ok
[INFO] [stdout] test routes::tests::overlapping_prefixes_resolve_longest_first_whatever_the_table_order ... ok
[INFO] [stdout] test share::tests::a_new_room_goes_under_the_first_prefix_a_member_owns ... ok
[INFO] [stdout] test share::tests::a_prefix_list_covers_only_what_it_names ... ok
[INFO] [stdout] test cluster::tests::nobody_leads_until_leadership_is_granted ... ok
[INFO] [stdout] test share::tests::a_room_being_moved_is_served_by_nobody ... ok
[INFO] [stdout] test routes::tests::a_malformed_entry_is_skipped_rather_than_taken_as_a_route ... ok
[INFO] [stdout] test cluster::tests::serving_address_is_accepted_under_every_policy ... ok
[INFO] [stdout] test share::tests::a_room_placed_under_the_home_prefix_is_one_this_member_serves ... ok
[INFO] [stdout] test routes::tests::a_nested_array_does_not_end_the_field_early ... ok
[INFO] [stdout] test routes::tests::a_prefix_is_matched_as_a_prefix_not_as_a_whole_room ... ok
[INFO] [stdout] test routes::tests::a_room_nobody_owns_resolves_nowhere ... ok
[INFO] [stdout] test share::tests::an_unreadable_share_is_read_as_everything ... ok
[INFO] [stdout] test share::tests::an_empty_list_means_owns_nothing ... ok
[INFO] [stdout] test share::tests::nothing_in_transit_holds_up_nothing ... ok
[INFO] [stdout] test supervisor::tests::a_process_that_ran_and_then_died_is_restarted_promptly ... ok
[INFO] [stdout] test supervisor::tests::one_healthy_run_clears_the_history ... ok
[INFO] [stdout] test supervisor::tests::rapid_failures_back_off_by_doubling ... ok
[INFO] [stdout] test supervisor::tests::the_backoff_is_capped ... ok
[INFO] [stdout] test cluster::tests::a_completed_transfer_moves_the_share_and_nothing_else ... ok
[INFO] [stdout] test supervisor::tests::the_healthy_threshold_is_inclusive_at_its_boundary ... ok
[INFO] [stdout] test cluster::tests::a_route_needs_a_service_endpoint_not_a_member_port ... ok
[INFO] [stdout] test cluster::tests::a_share_cannot_be_handed_to_a_member_nobody_has_seen ... ok
[INFO] [stdout] test cluster::tests::static_assignment_refuses_a_move_rather_than_reporting_a_silent_one ... ok
[INFO] [stdout] test cluster::tests::the_choice_is_deterministic ... ok
[INFO] [stdout] test cluster::tests::the_topology_carries_what_a_reconciler_reads ... ok
[INFO] [stdout] test cluster::tests::two_overlapping_transfers_of_one_share_are_refused ... ok
[INFO] [stdout] test tests::a_member_that_has_not_bound_a_port_reports_null_rather_than_a_guess ... ok
[INFO] [stdout] test tests::a_member_serves_the_rooms_it_owns ... ok
[INFO] [stdout] test tests::a_room_owned_elsewhere_names_where_to_send_it ... ok
[INFO] [stdout] test tests::a_room_nobody_owns_is_refused_not_served ... ok
[INFO] [stdout] test tests::a_standby_shard_does_not_own_its_prefix ... ok
[INFO] [stdout] test tests::a_topology_with_no_writer_owns_nothing_rather_than_guessing ... ok
[INFO] [stdout] test tests::a_member_that_has_not_said_where_it_serves_is_not_forwarded_to ... ok
[INFO] [stdout] test tests::a_room_nobody_owns_has_no_owner_rather_than_a_guess ... ok
[INFO] [stdout] test share::tests::owning_everything_covers_every_room ... ok
[INFO] [stdout] test supervisor::tests::a_process_that_cannot_start_makes_the_supervisor_give_up_and_say_why ... ok
[INFO] [stdout] test tests::a_new_room_needs_no_ownership_change ... ok
[INFO] [stdout] test tests::a_batch_verb_is_not_read_as_a_room ... ok
[INFO] [stdout] test tests::a_generation_starts_above_zero ... ok
[INFO] [stdout] test tests::a_room_routes_to_the_shard_that_owns_its_prefix ... ok
[INFO] [stdout] test tests::a_room_that_is_not_room_scoped_must_be_served_not_refused ... ok
[INFO] [stdout] test tests::a_single_process_run_owns_every_room_it_is_asked_about ... ok
[INFO] [stdout] test tests::a_single_process_serves_everything_it_is_asked ... ok
[INFO] [stdout] test tests::all_covers_every_room_and_a_prefix_set_covers_its_own ... ok
[INFO] [stdout] test tests::management_paths_name_the_room_after_rooms ... ok
[INFO] [stdout] test tests::the_iceberg_prefix_segment_is_the_room ... ok
[INFO] [stdout] test tests::the_single_topology_is_one_writer_and_no_standby ... ok
[INFO] [stdout] test tests::the_same_topology_answers_differently_per_member ... ok
[INFO] [stdout] test tests::the_json_answer_carries_mode_generation_and_every_member ... ok
[INFO] [stdout] test tests::the_topology_body_reports_which_prefixes_a_member_holds ... ok
[INFO] [stdout] test tests::paths_that_are_not_room_scoped_have_no_room ... ok
[INFO] [stdout] test tests::requests_that_are_not_room_scoped_are_always_served ... ok
[INFO] [stderr]    Doc-tests subms_icehouse_control_plane
[INFO] [stdout] test tests::an_empty_prefix_set_owns_nothing ... ok
[INFO] [stdout] test tests::every_mode_and_role_has_a_stable_wire_name ... ok
[INFO] [stdout] test tests::spec_endpoints_that_sit_where_a_room_would_are_not_rooms ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 112 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[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" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7", kill_on_drop: false }`
[INFO] [stdout] 17fb1650a4fc7ee7c7c9b77a9d3295af808f1612916f09bf5f0d1058b88a75a7
