[INFO] fetching crate servicrab-core 1.0.0...
[INFO] testing servicrab-core-1.0.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate servicrab-core 1.0.0 into /workspace/builds/worker-6-tc2/source
[INFO] started tweaking crates.io crate servicrab-core 1.0.0
[INFO] finished tweaking crates.io crate servicrab-core 1.0.0
[INFO] tweaked toml for crates.io crate servicrab-core 1.0.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate servicrab-core 1.0.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 servicrab-core 1.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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:43:12
[INFO] [stderr]    |
[INFO] [stderr] 43 | homepage = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 48 | repository = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |              ---------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `servicrab-core` (manifest) generated 1 warning
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95
[INFO] running `Command { std: "docker" "start" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95", 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" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95" "/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" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95", 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" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:43:12
[INFO] [stderr]    |
[INFO] [stderr] 43 | homepage = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 48 | repository = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |              ---------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `servicrab-core` (manifest) generated 1 warning
[INFO] [stderr]    Compiling memoffset v0.9.1
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling nix v0.31.3
[INFO] [stderr]    Compiling thiserror v2.0.19
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling humantime v2.4.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.19
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling servicrab-core v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 00s
[INFO] running `Command { std: "docker" "inspect" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95", 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" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:43:12
[INFO] [stderr]    |
[INFO] [stderr] 43 | homepage = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 48 | repository = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |              ---------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `servicrab-core` (manifest) generated 1 warning
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling nix v0.31.3
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling servicrab-core v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 19s
[INFO] running `Command { std: "docker" "inspect" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95", 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" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:43:12
[INFO] [stderr]    |
[INFO] [stderr] 43 | homepage = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 48 | repository = "https://github.com/gaborini/servicrab"
[INFO] [stderr]    |              ---------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `servicrab-core` (manifest) generated 1 warning
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.13s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/servicrab-core/88195ac53db258f0/out/servicrab_core-88195ac53db258f0)
[INFO] [stdout] 
[INFO] [stdout] running 295 tests
[INFO] [stdout] test envfile::tests::a_comment_may_follow_a_quoted_value ... ok
[INFO] [stdout] test envfile::tests::an_unterminated_quote_is_an_error ... ok
[INFO] [stdout] test envfile::tests::double_quotes_keep_spaces_and_expand_escapes ... ok
[INFO] [stdout] test envfile::tests::empty_values_are_allowed ... ok
[INFO] [stdout] test envfile::tests::export_prefix_is_accepted ... ok
[INFO] [stdout] test envfile::tests::a_missing_file_is_a_read_error ... ok
[INFO] [stdout] test envfile::tests::a_key_with_spaces_is_an_error ... ok
[INFO] [stdout] test envfile::tests::a_line_without_equals_is_an_error ... ok
[INFO] [stdout] test envfile::tests::a_hash_inside_a_value_is_kept ... ok
[INFO] [stdout] test envfile::tests::later_assignments_win ... ok
[INFO] [stdout] test envfile::tests::plain_assignments_are_parsed ... ok
[INFO] [stdout] test envfile::tests::a_byte_order_mark_is_ignored ... ok
[INFO] [stdout] test envfile::tests::comments_and_blank_lines_are_skipped ... ok
[INFO] [stdout] test graph::tests::diamond_dependency ... ok
[INFO] [stdout] test graph::tests::single_node_no_deps ... ok
[INFO] [stdout] test envfile::tests::single_quotes_are_literal ... ok
[INFO] [stdout] test envfile::tests::text_after_the_closing_quote_is_an_error ... ok
[INFO] [stdout] test graph::tests::three_node_cycle ... ok
[INFO] [stdout] test graph::tests::simple_cycle_detected ... ok
[INFO] [stdout] test graph::tests::deterministic_order ... ok
[INFO] [stdout] test graph::tests::linear_chain ... ok
[INFO] [stdout] test include::tests::a_cycle_back_to_the_root_is_a_cycle ... ok
[INFO] [stdout] test include::tests::a_file_that_includes_itself_is_a_cycle ... ok
[INFO] [stdout] test include::tests::a_fragment_may_not_declare_a_version ... ok
[INFO] [stdout] test include::tests::a_single_path_needs_no_list ... ok
[INFO] [stdout] test include::tests::a_fragment_may_not_declare_the_project ... ok
[INFO] [stdout] test include::tests::a_fragment_with_broken_toml_is_reported_against_the_fragment ... ok
[INFO] [stdout] test envfile::tests::trailing_comment_after_an_unquoted_value_is_stripped ... ok
[INFO] [stdout] test include::tests::a_missing_include_names_who_asked_for_it ... ok
[INFO] [stdout] test include::tests::an_unknown_field_in_a_fragment_is_still_a_typo ... ok
[INFO] [stdout] test include::tests::a_file_reached_twice_is_reported_once_and_clearly ... ok
[INFO] [stdout] test include::tests::an_included_service_joins_the_config ... ok
[INFO] [stdout] test lifecycle::tests::a_user_shutdown_outranks_an_exhausted_budget ... ok
[INFO] [stdout] test include::tests::every_broken_fragment_is_reported_at_once ... ok
[INFO] [stdout] test lifecycle::tests::an_unlimited_budget_still_obeys_the_policy ... ok
[INFO] [stdout] test include::tests::a_fragment_may_include_further_files ... ok
[INFO] [stdout] test include::tests::the_root_keeps_its_own_services ... ok
[INFO] [stdout] test lifecycle::tests::exit_reason_success_and_display ... ok
[INFO] [stdout] test lifecycle::tests::happy_path_transitions_are_accepted ... ok
[INFO] [stdout] test include::tests::two_files_may_not_declare_the_same_service ... ok
[INFO] [stdout] test lifecycle::tests::always_restarts_failed_exit ... ok
[INFO] [stdout] test lifecycle::tests::always_restarts_successful_exit ... ok
[INFO] [stdout] test lifecycle::tests::illegal_transitions_are_rejected ... ok
[INFO] [stdout] test lifecycle::tests::on_failure_ignores_successful_exit ... ok
[INFO] [stdout] test lifecycle::tests::an_unlimited_budget_still_stops_on_a_user_shutdown ... ok
[INFO] [stdout] test lifecycle::tests::on_failure_restarts_non_zero_exit ... ok
[INFO] [stdout] test lifecycle::tests::backoff_doubles_each_attempt ... ok
[INFO] [stdout] test lifecycle::tests::backoff_is_capped_at_max_delay ... ok
[INFO] [stdout] test lifecycle::tests::display_covers_every_state ... ok
[INFO] [stdout] test lifecycle::tests::invalid_transition_displays_both_states ... ok
[INFO] [stdout] test lifecycle::tests::max_restarts_is_enforced ... ok
[INFO] [stdout] test lifecycle::tests::never_does_not_restart_anything ... ok
[INFO] [stdout] test lifecycle::tests::on_failure_restarts_retryable_spawn_failure_only ... ok
[INFO] [stdout] test lifecycle::tests::terminal_states_reject_further_transitions ... ok
[INFO] [stdout] test lifecycle::tests::zero_max_restarts_means_unlimited ... ok
[INFO] [stdout] test load::tests::a_config_from_a_later_schema_reports_its_version_not_its_keys ... ok
[INFO] [stdout] test lifecycle::tests::on_failure_restarts_signal_termination ... ok
[INFO] [stdout] test lifecycle::tests::stable_period_resets_attempt_counter ... ok
[INFO] [stdout] test lifecycle::tests::restart_limit_shutdown_is_not_user_requested ... ok
[INFO] [stdout] test lifecycle::tests::stable_reset_revives_an_almost_exhausted_budget ... ok
[INFO] [stdout] test lifecycle::tests::unless_stopped_restarts_whatever_the_exit_status_was ... ok
[INFO] [stdout] test lifecycle::tests::user_shutdown_never_restarts ... ok
[INFO] [stdout] test load::tests::a_later_schema_is_reported_before_an_unreadable_include ... ok
[INFO] [stdout] test load::tests::load_valid_config ... ok
[INFO] [stdout] test load::tests::a_missing_or_unreadable_version_is_left_to_the_ordinary_parse ... ok
[INFO] [stdout] test runtime::event::tests::a_sustained_flood_is_not_reported_once_per_delivered_line ... ok
[INFO] [stdout] test load::tests::discover_returns_error_when_not_found ... ok
[INFO] [stdout] test runtime::event::tests::a_real_let_up_reports_the_loss_without_waiting_for_the_backstop ... ok
[INFO] [stdout] test load::tests::discover_walks_up_to_parent ... ok
[INFO] [stdout] test load::tests::an_unknown_key_under_the_supported_version_is_still_fatal ... ok
[INFO] [stdout] test load::tests::load_invalid_toml_returns_parse_error ... ok
[INFO] [stdout] test load::tests::load_missing_file_returns_read_error ... ok
[INFO] [stdout] test load::tests::discover_finds_config_in_current_dir ... ok
[INFO] [stdout] test runtime::event::tests::streams_display_as_lowercase_names ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_new_file_is_a_change ... ok
[INFO] [stdout] test runtime::event::tests::active_sink_forwards_events ... ok
[INFO] [stdout] test runtime::event::tests::emitting_into_a_closed_channel_is_not_an_error ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_removed_file_is_a_change ... ok
[INFO] [stdout] test runtime::event::tests::events_other_than_log_lines_are_never_dropped ... ok
[INFO] [stdout] test runtime::event::tests::inactive_sink_drops_events ... ok
[INFO] [stdout] test runtime::event::tests::the_allowance_comes_back_once_a_line_is_delivered ... ok
[INFO] [stdout] test runtime::event::tests::queued_log_lines_are_capped_and_the_loss_is_reported ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_missing_root_scans_to_nothing ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_scan_records_every_file_below_the_root ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_watched_file_may_be_a_single_path ... ok
[INFO] [stdout] test runtime::filewatch::tests::an_unchanged_tree_reports_no_changes ... ok
[INFO] [stdout] test runtime::filewatch::tests::an_ignore_prefix_with_a_slash_matches_a_subtree ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_resized_file_is_a_change_even_with_a_coarse_clock ... ok
[INFO] [stdout] test runtime::filewatch::tests::ignored_directories_are_not_scanned ... ok
[INFO] [stdout] test runtime::filewatch::tests::ignored_extensions_are_not_scanned ... ok
[INFO] [stdout] test runtime::health::tests::a_permanently_dead_probe_is_reported_sparsely ... ok
[INFO] [stdout] test runtime::health::tests::a_command_probe_reports_a_missing_executable ... ok
[INFO] [stdout] test runtime::health::tests::a_tcp_probe_fails_when_nothing_listens ... ok
[INFO] [stdout] test runtime::health::tests::an_http_probe_accepts_a_2xx_response ... ok
[INFO] [stdout] test runtime::health::tests::a_command_probe_succeeds_on_exit_code_zero ... ok
[INFO] [stdout] test runtime::health::tests::a_tcp_probe_succeeds_against_a_listener ... ok
[INFO] [stdout] test runtime::health::tests::an_http_probe_rejects_a_5xx_response ... ok
[INFO] [stdout] test runtime::health::tests::exhausting_the_retry_budget_is_reported ... ok
[INFO] [stdout] test runtime::health::tests::the_ceiling_never_hides_the_unhealthy_transition ... ok
[INFO] [stdout] test runtime::health::tests::the_first_failure_is_always_reported ... ok
[INFO] [stdout] test runtime::health::tests::the_failure_counter_stops_at_its_ceiling ... ok
[INFO] [stdout] test runtime::health::tests::a_command_probe_fails_on_a_non_zero_exit_code ... ok
[INFO] [stdout] test runtime::logs::tests::a_write_failure_is_reported_only_once ... ok
[INFO] [stdout] test runtime::logs::tests::an_existing_log_is_appended_to ... ok
[INFO] [stdout] test runtime::logs::tests::dropping_the_writer_flushes_what_is_left ... ok
[INFO] [stdout] test runtime::logs::tests::excluded_services_are_not_written_to_disk ... ok
[INFO] [stdout] test runtime::logs::tests::a_line_longer_than_the_limit_is_still_written_whole ... ok
[INFO] [stdout] test runtime::logs::tests::lines_are_appended_in_order_when_flushed ... ok
[INFO] [stdout] test runtime::logs::tests::max_files_zero_truncates_instead_of_keeping_history ... ok
[INFO] [stdout] test runtime::logs::tests::rotated_files_are_shifted_and_dropped ... ok
[INFO] [stdout] test runtime::logs::tests::rotation_takes_the_buffered_lines_with_the_old_file ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_tree_within_the_depth_limit_is_scanned_whole ... ok
[INFO] [stdout] test runtime::logs::tests::the_file_rotates_once_it_is_full ... ok
[INFO] [stdout] test runtime::logs::tests::handing_a_line_over_never_waits_for_the_writer ... ok
[INFO] [stdout] test runtime::logs::tests::the_router_writes_one_file_per_service ... ok
[INFO] [stdout] test runtime::logs::tests::the_sink_reports_a_broken_log_directory ... ok
[INFO] [stdout] test runtime::plan::tests::a_dependency_comes_along_whatever_its_profile ... ok
[INFO] [stdout] test runtime::logs::tests::the_sink_writes_every_line_in_order_by_the_time_it_is_shut_down ... ok
[INFO] [stdout] test runtime::plan::tests::a_profile_nothing_declares_is_a_typo ... ok
[INFO] [stdout] test runtime::logs::tests::a_flood_is_flushed_without_being_asked_to ... ok
[INFO] [stdout] test runtime::logs::tests::writing_a_line_does_not_cost_a_flush ... ok
[INFO] [stdout] test runtime::plan::tests::a_profiled_service_can_still_be_named ... ok
[INFO] [stdout] test runtime::plan::tests::a_profiled_service_stays_out_until_its_profile_is_enabled ... ok
[INFO] [stdout] test runtime::plan::tests::a_service_joins_when_any_of_its_profiles_is_enabled ... ok
[INFO] [stdout] test runtime::plan::tests::a_service_nothing_depends_on_brings_nobody ... ok
[INFO] [stdout] test runtime::plan::tests::a_seed_outside_the_plan_is_ignored_along_with_its_dependents ... ok
[INFO] [stdout] test runtime::plan::tests::dependents_are_collected_through_the_chain ... ok
[INFO] [stdout] test runtime::plan::tests::explicit_request_pulls_in_dependencies ... ok
[INFO] [stdout] test runtime::plan::tests::duplicate_requests_are_deduplicated ... ok
[INFO] [stdout] test runtime::plan::tests::several_profiles_add_up ... ok
[INFO] [stdout] test runtime::plan::tests::empty_request_selects_autostart_services_and_their_dependencies ... ok
[INFO] [stdout] test runtime::plan::tests::plan_follows_the_topological_start_order ... ok
[INFO] [stdout] test runtime::stack::tests::a_changed_environment_counts_as_a_change ... ok
[INFO] [stdout] test runtime::plan::tests::the_far_end_of_the_chain_pulls_nothing_back ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_tree_deeper_than_the_limit_is_reported_rather_than_overflowing_the_stack ... ok
[INFO] [stdout] test runtime::stack::tests::a_dropped_service_is_reported_as_removed ... ok
[INFO] [stdout] test runtime::stack::tests::a_held_back_service_reports_itself_stopped_without_running ... ok
[INFO] [stdout] test runtime::plan::tests::unknown_service_is_rejected ... ok
[INFO] [stdout] test runtime::stack::tests::a_new_service_is_reported_as_added ... ok
[INFO] [stdout] test runtime::stack::tests::a_one_shot_dependency_counts_as_started_and_as_healthy_once_it_exits ... ok
[INFO] [stdout] test runtime::stack::tests::a_refusal_still_reads_as_the_sentence_it_replaced ... ok
[INFO] [stdout] test runtime::stack::tests::a_restart_resets_the_unhealthy_verdict ... ok
[INFO] [stdout] test runtime::stack::tests::a_service_stopped_for_being_unhealthy_never_becomes_available ... ok
[INFO] [stdout] test runtime::stack::tests::a_skipped_dependency_blocks_the_dependent ... ok
[INFO] [stdout] test runtime::stack::tests::a_retired_slot_is_reported_as_added_again ... ok
[INFO] [stdout] test runtime::stack::tests::an_unchanged_config_produces_an_empty_diff ... ok
[INFO] [stdout] test runtime::stack::tests::an_outcome_still_reads_as_the_sentence_it_replaced ... ok
[INFO] [stdout] test runtime::stack::tests::an_edited_service_is_reported_as_changed ... ok
[INFO] [stdout] test runtime::stack::tests::dependencies_are_awaited_until_ready ... ok
[INFO] [stdout] test runtime::stack::tests::inserting_over_a_live_slot_is_a_bug - should panic ... FAILED
[INFO] [stdout] test runtime::stack::tests::outcome_reports_success_only_without_failures ... ok
[INFO] [stdout] test runtime::stack::tests::dependencies_are_rewired_after_a_reload ... ok
[INFO] [stdout] test runtime::stack::tests::service_completed_successfully_waits_for_a_clean_exit ... ok
[INFO] [stdout] test runtime::stack::tests::service_started_only_needs_the_process_to_be_up ... ok
[INFO] [stdout] test runtime::stack::tests::shutdown_interrupts_the_dependency_wait ... ok
[INFO] [stdout] test runtime::stack::tests::a_failed_dependency_blocks_the_dependent ... ok
[INFO] [stdout] test runtime::stack::tests::skipped_and_failed_results_count_as_failures ... ok
[INFO] [stdout] test runtime::status::tests::a_running_service_reports_its_pid_and_uptime ... ok
[INFO] [stdout] test runtime::status::tests::a_service_without_a_health_check_never_reports_health ... ok
[INFO] [stdout] test runtime::status::tests::a_stopped_service_has_no_pid ... ok
[INFO] [stdout] test runtime::status::tests::events_for_dropped_services_are_ignored ... ok
[INFO] [stdout] test runtime::status::tests::events_for_unknown_services_are_dropped ... ok
[INFO] [stdout] test runtime::status::tests::health_follows_the_probes ... ok
[INFO] [stdout] test runtime::status::tests::noisy_events_are_ignored ... ok
[INFO] [stdout] test runtime::status::tests::services_start_out_pending ... ok
[INFO] [stdout] test runtime::status::tests::sync_adds_and_drops_services_without_disturbing_the_rest ... ok
[INFO] [stdout] test runtime::status::tests::sync_reports_services_in_the_new_order ... ok
[INFO] [stdout] test runtime::tests::default_options_keep_configured_policy ... ok
[INFO] [stdout] test runtime::tests::no_restart_overrides_configured_policy ... ok
[INFO] [stdout] test runtime::tests::output_mode_can_be_overridden ... ok
[INFO] [stdout] test runtime::tests::wait_for_shutdown_resolves_on_request ... ok
[INFO] [stdout] test runtime::tests::wait_for_shutdown_waits_for_a_later_request ... ok
[INFO] [stdout] test runtime::unix::tests::a_stuck_output_reader_is_aborted_so_the_event_channel_can_close ... ok
[INFO] [stdout] test runtime::unix::tests::a_swept_group_is_not_signalled_again_on_drop ... ok
[INFO] [stdout] test runtime::status::tests::restarts_are_counted_from_backoff_attempts ... ok
[INFO] [stdout] test runtime::unix::tests::a_vanished_group_is_not_an_error ... ok
[INFO] [stdout] test runtime::stack::tests::readiness_is_recorded_even_without_a_subscriber ... ok
[INFO] [stdout] test runtime::stack::tests::service_healthy_waits_for_a_passing_probe ... ok
[INFO] [stdout] test runtime::unix::tests::missing_executable_is_not_retryable ... ok
[INFO] [stdout] test runtime::unix::tests::shutdown_signals_map_to_os_signals ... ok
[INFO] [stdout] test subst::tests::a_braced_reference_expands_anywhere_in_a_value ... ok
[INFO] [stdout] test runtime::unix::tests::exit_status_maps_to_exit_reason ... ok
[INFO] [stdout] test subst::tests::a_dollar_that_does_not_open_a_brace_is_left_alone ... ok
[INFO] [stdout] test subst::tests::a_default_may_be_another_reference ... ok
[INFO] [stdout] test subst::tests::a_dollar_before_the_brace_escapes_the_reference ... ok
[INFO] [stdout] test subst::tests::a_set_but_empty_variable_expands_to_nothing ... ok
[INFO] [stdout] test subst::tests::an_unclosed_or_nameless_reference_is_malformed ... ok
[INFO] [stdout] test subst::tests::an_unsupported_modifier_names_what_is_supported ... ok
[INFO] [stdout] test subst::tests::an_unset_variable_is_an_error ... ok
[INFO] [stdout] test subst::tests::every_failure_is_reported_at_once_with_its_location ... ok
[INFO] [stdout] test subst::tests::defaults_differ_on_whether_empty_counts ... ok
[INFO] [stdout] test subst::tests::expansion_does_not_recurse_into_a_resolved_value ... ok
[INFO] [stdout] test subst::tests::every_substitutable_field_is_expanded ... ok
[INFO] [stdout] test subst::tests::the_shape_of_the_stack_is_not_substituted ... ok
[INFO] [stdout] test validation::tests::a_health_check_can_override_every_field ... ok
[INFO] [stdout] test validation::tests::a_declared_condition_survives_validation ... ok
[INFO] [stdout] test validation::tests::a_health_check_defaults_are_applied ... ok
[INFO] [stdout] test validation::tests::a_health_check_used_only_for_gating_does_not_warn ... ok
[INFO] [stdout] test validation::tests::a_health_table_with_two_probes_is_rejected ... ok
[INFO] [stdout] test validation::tests::a_log_file_where_a_directory_belongs_is_a_config_error ... ok
[INFO] [stdout] test validation::tests::a_malformed_env_file_is_a_config_error ... ok
[INFO] [stdout] test validation::tests::a_health_table_without_a_probe_is_rejected ... ok
[INFO] [stdout] test validation::tests::a_malformed_tcp_probe_is_rejected ... ok
[INFO] [stdout] test validation::tests::a_profile_name_follows_the_service_name_rules ... ok
[INFO] [stdout] test validation::tests::a_project_env_file_reaches_every_service ... ok
[INFO] [stdout] test validation::tests::a_repeated_profile_is_a_typo ... ok
[INFO] [stdout] test validation::tests::a_missing_env_file_is_a_config_error ... ok
[INFO] [stdout] test validation::tests::a_service_env_file_beats_the_project_env_file ... ok
[INFO] [stdout] test validation::tests::a_service_can_opt_out_of_file_logging ... ok
[INFO] [stdout] test validation::tests::a_service_env_file_is_loaded ... ok
[INFO] [stdout] test validation::tests::a_service_without_profiles_has_none ... ok
[INFO] [stdout] test validation::tests::a_tiny_max_size_is_rejected ... ok
[INFO] [stdout] test validation::tests::a_typo_inside_the_table_form_names_the_field ... ok
[INFO] [stdout] test validation::tests::a_watch_block_resolves_paths_against_the_service_cwd ... ok
[INFO] [stdout] test validation::tests::a_watch_interval_below_the_minimum_is_a_config_error ... ok
[INFO] [stdout] test validation::tests::an_empty_profile_name_is_rejected ... ok
[INFO] [stdout] test validation::tests::an_explicit_env_entry_beats_the_env_file ... ok
[INFO] [stdout] test validation::tests::an_http_probe_defaults_to_port_80_and_root ... ok
[INFO] [stdout] test validation::tests::an_empty_probe_command_is_rejected ... ok
[INFO] [stdout] test validation::tests::an_absolute_log_dir_is_used_as_is ... ok
[INFO] [stdout] test validation::tests::an_http_probe_is_split_into_host_port_and_path ... ok
[INFO] [stdout] test validation::tests::an_out_of_range_health_interval_is_rejected ... ok
[INFO] [stdout] test validation::tests::an_ipv6_tcp_probe_is_accepted ... ok
[INFO] [stdout] test validation::tests::an_unknown_condition_errors ... ok
[INFO] [stdout] test validation::tests::an_undefined_variable_fails_the_load ... ok
[INFO] [stdout] test validation::tests::an_unknown_on_unhealthy_action_is_rejected ... ok
[INFO] [stdout] test validation::tests::an_unknown_size_unit_is_a_config_error ... ok
[INFO] [stdout] test validation::tests::autostart_false_parsed ... ok
[INFO] [stdout] test validation::tests::dependency_cycle_readable_path ... ok
[INFO] [stdout] test validation::tests::cwd_points_to_file_errors ... ok
[INFO] [stdout] test validation::tests::disabled_service_logs_do_not_warn ... ok
[INFO] [stdout] test validation::tests::deterministic_start_order ... ok
[INFO] [stdout] test validation::tests::duplicate_dependency_errors ... ok
[INFO] [stdout] test validation::tests::duration_parsed_correctly ... ok
[INFO] [stdout] test validation::tests::empty_command_vec_errors ... ok
[INFO] [stdout] test validation::tests::empty_executable_errors ... ok
[INFO] [stdout] test validation::tests::env_key_empty_rejected ... ok
[INFO] [stdout] test validation::tests::env_key_with_equals_rejected ... ok
[INFO] [stdout] test validation::tests::env_override_order ... ok
[INFO] [stdout] test validation::tests::https_health_urls_are_rejected_with_a_hint ... ok
[INFO] [stdout] test validation::tests::invalid_duration_string_errors ... ok
[INFO] [stdout] test validation::tests::an_unknown_health_field_is_rejected ... ok
[INFO] [stdout] test validation::tests::env_files_are_layered_in_declaration_order ... ok
[INFO] [stdout] test validation::tests::log_settings_default_to_a_project_local_directory ... ok
[INFO] [stdout] test validation::tests::keeping_no_rotated_files_is_allowed ... ok
[INFO] [stdout] test validation::tests::log_files_live_next_to_each_other_per_service ... ok
[INFO] [stdout] test validation::tests::log_sizes_accept_si_and_binary_suffixes ... ok
[INFO] [stdout] test validation::tests::minimal_valid_config ... ok
[INFO] [stdout] test validation::tests::missing_cwd_errors ... ok
[INFO] [stdout] test validation::tests::no_logs_table_means_no_file_logging ... ok
[INFO] [stdout] test validation::tests::no_services_errors ... ok
[INFO] [stdout] test validation::tests::log_sizes_reject_nonsense ... ok
[INFO] [stdout] test validation::tests::nul_in_executable_errors ... ok
[INFO] [stdout] test validation::tests::max_restarts_warns_when_restart_never ... ok
[INFO] [stdout] test validation::tests::on_unhealthy_restart_is_silent_with_a_restart_policy ... ok
[INFO] [stdout] test validation::tests::project_name_at_max_length ... ok
[INFO] [stdout] test validation::tests::project_name_starts_with_dash_invalid ... ok
[INFO] [stdout] test validation::tests::project_name_too_long ... ok
[INFO] [stdout] test validation::tests::project_name_with_valid_special_chars ... ok
[INFO] [stdout] test validation::tests::relative_cwd_resolved_against_config_dir ... ok
[INFO] [stdout] test validation::tests::restart_delay_at_minimum_valid ... ok
[INFO] [stdout] test validation::tests::restart_delay_below_minimum_errors ... ok
[INFO] [stdout] test validation::tests::on_unhealthy_restart_warns_when_restart_never ... ok
[INFO] [stdout] test validation::tests::restart_max_delay_less_than_restart_delay_errors ... ok
[INFO] [stdout] test validation::tests::profiles_survive_validation_in_declaration_order ... ok
[INFO] [stdout] test validation::tests::restart_policy_never ... ok
[INFO] [stdout] test validation::tests::restart_policy_always ... ok
[INFO] [stdout] test validation::tests::restart_policy_on_failure ... ok
[INFO] [stdout] test validation::tests::restart_policy_unless_stopped ... ok
[INFO] [stdout] test validation::tests::restart_settings_warn_when_restart_never ... ok
[INFO] [stdout] test validation::tests::self_dependency_errors ... ok
[INFO] [stdout] test validation::tests::service_completed_successfully_rejects_a_dependency_that_always_restarts ... ok
[INFO] [stdout] test validation::tests::service_defaults ... ok
[INFO] [stdout] test validation::tests::service_logs_warn_without_a_project_logs_table ... ok
[INFO] [stdout] test validation::tests::service_name_at_max_length ... ok
[INFO] [stdout] test validation::tests::service_healthy_needs_the_dependency_to_have_a_health_check ... ok
[INFO] [stdout] test validation::tests::service_name_too_long ... ok
[INFO] [stdout] test validation::tests::service_logs_are_silent_when_the_project_declares_a_log_directory ... ok
[INFO] [stdout] test validation::tests::services_log_to_file_by_default ... ok
[INFO] [stdout] test validation::tests::the_table_form_is_checked_like_the_list_form ... ok
[INFO] [stdout] test validation::tests::the_short_form_leaves_the_condition_to_the_dependency ... ok
[INFO] [stdout] test validation::tests::unknown_field_in_project_is_rejected ... ok
[INFO] [stdout] test validation::tests::unknown_dependency_errors ... ok
[INFO] [stdout] test validation::tests::unsupported_version_errors ... ok
[INFO] [stdout] test validation::tests::valid_dependency_passes ... ok
[INFO] [stdout] test validation::tests::too_many_rotated_files_are_rejected ... ok
[INFO] [stdout] test validation::tests::unknown_field_in_service_is_rejected ... ok
[INFO] [stdout] test validation::tests::values_are_expanded_before_they_are_validated ... ok
[INFO] [stdout] test validation::tests::watch_always_ignores_git_and_servicrab_state ... ok
[INFO] [stdout] test validation::tests::zero_retries_are_rejected ... ok
[INFO] [stdout] test runtime::health::tests::a_command_probe_times_out ... ok
[INFO] [stdout] test runtime::filewatch::tests::a_scan_goes_through_the_blocking_pool_rather_than_the_worker ... ok
[INFO] [stdout] test runtime::health::tests::the_monitor_lets_go_of_its_sink_without_waiting_for_the_next_tick ... ok
[INFO] [stdout] test runtime::stack::tests::a_detached_service_has_its_process_group_swept ... FAILED
[INFO] [stdout] test runtime::unix::tests::dropping_a_handle_sweeps_the_whole_process_group ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- runtime::stack::tests::inserting_over_a_live_slot_is_a_bug stdout ----
[INFO] [stdout] note: test did not panic as expected at src/runtime/stack.rs:1437:8
[INFO] [stdout] ---- runtime::stack::tests::a_detached_service_has_its_process_group_swept stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runtime::stack::tests::a_detached_service_has_its_process_group_swept' (825) panicked at src/runtime/stack.rs:1696:9:
[INFO] [stdout] grandchild 830 of the detached group 826 was orphaned
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x654ffb11ec61 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x654ffb1357ea - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x654ffb123a1c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x654ffb0f6fd6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x654ffb115789 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x654ffb07e980 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x654ffb115ab2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x654ffb0f7082 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x654ffb0ef7a9 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x654ffb0f818d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x654ffb135f8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x654ffb00ec99 - servicrab_core[cf30a9b4bc2e7bd2]::runtime::stack::tests::a_detached_service_has_its_process_group_swept::{closure#0}
[INFO] [stdout]   12:     0x654ffb005c43 - <tokio[6d2e55254909c821]::runtime::scheduler::current_thread::Context>::enter::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   13:     0x654ffafb166c - <tokio[6d2e55254909c821]::runtime::context::scoped::Scoped<tokio[6d2e55254909c821]::runtime::scheduler::Context>>::set::<<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]   14:     0x654ffb006107 - <tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   15:     0x654ffaf6562d - tokio[6d2e55254909c821]::runtime::context::runtime::enter_runtime::<<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   16:     0x654ffaf85b35 - <tokio[6d2e55254909c821]::runtime::runtime::Runtime>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]   17:     0x654ffb0200ae - <servicrab_core[cf30a9b4bc2e7bd2]::runtime::stack::tests::a_detached_service_has_its_process_group_swept::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   18:     0x654ffb071dcb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   19:     0x654ffb07efa5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   20:     0x654ffb078894 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   21:     0x654ffb082032 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   22:     0x654ffb11dbcf - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   23:     0x7846451dfdfa - <unknown>
[INFO] [stdout]   24:     0x7846452733d4 - clone
[INFO] [stdout]   25:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- runtime::unix::tests::dropping_a_handle_sweeps_the_whole_process_group stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runtime::unix::tests::dropping_a_handle_sweeps_the_whole_process_group' (871) panicked at src/runtime/unix.rs:811:9:
[INFO] [stdout] grandchild 877 of group 876 survived the handle
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x654ffb11ec61 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x654ffb1357ea - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x654ffb123a1c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x654ffb0f6fd6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x654ffb115789 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x654ffb07e980 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x654ffb115ab2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x654ffb0f7082 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x654ffb0ef7a9 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x654ffb0f818d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x654ffb135f8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x654ffaf8ddd8 - servicrab_core[cf30a9b4bc2e7bd2]::runtime::unix::tests::dropping_a_handle_sweeps_the_whole_process_group::{closure#0}
[INFO] [stdout]   12:     0x654ffb005c43 - <tokio[6d2e55254909c821]::runtime::scheduler::current_thread::Context>::enter::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   13:     0x654ffafb166c - <tokio[6d2e55254909c821]::runtime::context::scoped::Scoped<tokio[6d2e55254909c821]::runtime::scheduler::Context>>::set::<<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]   14:     0x654ffb006107 - <tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   15:     0x654ffaf6562d - tokio[6d2e55254909c821]::runtime::context::runtime::enter_runtime::<<tokio[6d2e55254909c821]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   16:     0x654ffaf85b35 - <tokio[6d2e55254909c821]::runtime::runtime::Runtime>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]   17:     0x654ffaf918ee - <servicrab_core[cf30a9b4bc2e7bd2]::runtime::unix::tests::dropping_a_handle_sweeps_the_whole_process_group::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   18:     0x654ffb071dcb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   19:     0x654ffb07efa5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   20:     0x654ffb078894 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   21:     0x654ffb082032 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   22:     0x654ffb11dbcf - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   23:     0x7846451dfdfa - <unknown>
[INFO] [stdout]   24:     0x7846452733d4 - clone
[INFO] [stdout]   25:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     runtime::stack::tests::a_detached_service_has_its_process_group_swept
[INFO] [stdout]     runtime::stack::tests::inserting_over_a_live_slot_is_a_bug
[INFO] [stdout]     runtime::unix::tests::dropping_a_handle_sweeps_the_whole_process_group
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 292 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.17s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95", kill_on_drop: false }`
[INFO] [stdout] a77dfacbbf36b665e1d70e66c050486532c61563091cde6fc4b01c6a8cc58e95
