[INFO] cloning repository https://github.com/XuanLee-HEALER/ai-write
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/XuanLee-HEALER/ai-write" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FXuanLee-HEALER%2Fai-write", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FXuanLee-HEALER%2Fai-write'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 2c67c008d1d6649fe8c19ea11fddfb7e8061ecb3
[INFO] testing XuanLee-HEALER/ai-write against 1.97.0-beta.6 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FXuanLee-HEALER%2Fai-write" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/XuanLee-HEALER/ai-write
[INFO] finished tweaking git repo https://github.com/XuanLee-HEALER/ai-write
[INFO] tweaked toml for git repo https://github.com/XuanLee-HEALER/ai-write written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/XuanLee-HEALER/ai-write on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/XuanLee-HEALER/ai-write already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded utf8-zero v0.8.1
[INFO] [stderr]   Downloaded ureq-proto v0.6.0
[INFO] [stderr]   Downloaded ureq v3.3.0
[INFO] [stderr]   Downloaded git2 v0.21.0
[INFO] [stderr]   Downloaded libgit2-sys v0.18.5+1.9.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7
[INFO] running `Command { std: "docker" "start" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7", 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" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7", 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" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling zeroize v1.9.0
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling log v0.4.32
[INFO] [stderr]    Compiling rustls v0.23.40
[INFO] [stderr]    Compiling simd-adler32 v0.3.9
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling http v1.4.2
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling memchr v2.8.2
[INFO] [stderr]    Compiling syn v2.0.118
[INFO] [stderr]    Compiling utf8-zero v0.8.1
[INFO] [stderr]    Compiling bitflags v2.13.0
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling rustls-pki-types v1.14.1
[INFO] [stderr]    Compiling cc v1.2.64
[INFO] [stderr]    Compiling webpki-roots v1.0.8
[INFO] [stderr]    Compiling flate2 v1.1.9
[INFO] [stderr]    Compiling ureq-proto v0.6.0
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling libz-sys v1.1.29
[INFO] [stderr]    Compiling libgit2-sys v0.18.5+1.9.4
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling rustls-webpki v0.103.13
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling git2 v0.21.0
[INFO] [stderr]    Compiling ureq v3.3.0
[INFO] [stderr]    Compiling ai-write v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 41.95s
[INFO] running `Command { std: "docker" "inspect" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7", 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" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling bitflags v2.13.0
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling syn v2.0.118
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling git2 v0.21.0
[INFO] [stderr]    Compiling tempfile v3.27.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 futures-macro v0.3.32
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling ai-write v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 21.12s
[INFO] running `Command { std: "docker" "inspect" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7", 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" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ai_write-600fdff8cae636e0)
[INFO] [stdout] 
[INFO] [stdout] running 293 tests
[INFO] [stdout] test content::tests::author_tag_matches_provenance_convention ... ok
[INFO] [stdout] test content::tests::document_plain_string_joins_blocks ... ok
[INFO] [stdout] test coordinator::tests::lock_set_is_a_sorted_dedup_set ... ok
[INFO] [stdout] test content::tests::content_model_serde_round_trips ... ok
[INFO] [stdout] test coordinator::tests::priority_derives_from_writer ... ok
[INFO] [stdout] test content::tests::from_plain_and_plain_string_round_trip ... ok
[INFO] [stdout] test coordinator::tests::empty_transaction_makes_no_commit ... ok
[INFO] [stdout] test coordinator::tests::single_edit_commits_body_and_index_as_one_commit ... ok
[INFO] [stdout] test coordinator::tests::declaring_a_short_output_list_is_rejected ... ok
[INFO] [stdout] test coordinator::tests::request_edit_on_idle_coordinator_is_up_now_and_emits_handoff ... ok
[INFO] [stdout] test coordinator::tests::merge_rejects_a_malformed_plan ... ok
[INFO] [stdout] test coordinator::tests::body_error_is_aborted_and_releases_locks ... ok
[INFO] [stdout] test coordinator::tests::merge_reusing_a_source_name_as_target_is_allowed ... ok
[INFO] [stdout] test coordinator::tests::split_rejects_a_malformed_plan ... ok
[INFO] [stdout] test coordinator::tests::cancel_request_edit_removes_a_pending_reservation ... ok
[INFO] [stdout] test coordinator::tests::submit_emits_acquired_then_released_in_order ... ok
[INFO] [stdout] test dsl::tests::blank_lines_between_blocks_are_ignored ... ok
[INFO] [stdout] test coordinator::tests::human_submit_consuming_a_reservation_does_not_double_announce_handoff ... ok
[INFO] [stdout] test dsl::tests::empty_document_round_trips ... ok
[INFO] [stdout] test dsl::tests::empty_blocks_serialize_to_bare_sigils ... ok
[INFO] [stdout] test coordinator::tests::split_is_exactly_one_commit ... ok
[INFO] [stdout] test coordinator::tests::request_edit_queues_human_at_head_ahead_of_a_waiting_agent ... ok
[INFO] [stdout] test dsl::tests::heading_level_bounds_enforced ... ok
[INFO] [stdout] test dsl::tests::parsed_prose_is_attributed_to_the_passed_author ... ok
[INFO] [stdout] test dsl::tests::leading_sigil_chars_in_prose_survive ... ok
[INFO] [stdout] test dsl::tests::render_html_escapes_code_block_lang_and_body ... ok
[INFO] [stdout] test dsl::tests::inline_backslash_and_newline_round_trip ... ok
[INFO] [stdout] test dsl::tests::render_html_all_block_kinds ... ok
[INFO] [stdout] test dsl::tests::render_html_groups_consecutive_list_items_in_one_ul ... ok
[INFO] [stdout] test dsl::tests::round_trip_all_heading_levels ... ok
[INFO] [stdout] test dsl::tests::render_html_escapes_text_and_attributes ... ok
[INFO] [stdout] test dsl::tests::round_trip_code_block_no_lang_multiline ... ok
[INFO] [stdout] test dsl::tests::render_html_multi_run_emits_one_span_per_run ... ok
[INFO] [stdout] test dsl::tests::round_trip_code_block_with_lang ... ok
[INFO] [stdout] test dsl::tests::round_trip_list_and_quote ... ok
[INFO] [stdout] test dsl::tests::round_trip_paragraph ... ok
[INFO] [stdout] test dsl::tests::serialize_then_parse_reproduces_value ... ok
[INFO] [stdout] test dsl::tests::round_trip_mixed_document ... ok
[INFO] [stdout] test dsl::tests::round_trip_empty_code_block ... ok
[INFO] [stdout] test dsl::tests::unknown_block_is_rejected_with_line_number ... ok
[INFO] [stdout] test dsl::tests::unterminated_code_block_is_rejected ... ok
[INFO] [stdout] test coordinator::tests::undo_article_emits_lifecycle_and_routes_through_the_lock ... ok
[INFO] [stdout] test dsl::tests::empty_paragraph_renders_empty_tag ... ok
[INFO] [stdout] test engine::orchestration::tests::create_article_missing_theme_errors ... ok
[INFO] [stdout] test engine::orchestration::tests::create_theme_is_idempotent ... ok
[INFO] [stdout] test engine::orchestration::tests::organize_articles_propagates_workspace_errors ... ok
[INFO] [stdout] test engine::orchestration::tests::create_article_is_idempotent_and_listed ... ok
[INFO] [stdout] test engine::orchestration::tests::create_theme_rejects_sandbox_escape ... ok
[INFO] [stdout] test engine::tests::model_for_writer_pins_the_agents_dated_snapshot ... ok
[INFO] [stdout] test engine::tests::report_from_history_absent_triggers_synthesis_path ... ok
[INFO] [stdout] test engine::tests::report_from_history_empty_is_none ... ok
[INFO] [stdout] test engine::tests::master_setup_creates_theme_and_article_idempotently ... ok
[INFO] [stdout] test engine::tests::report_from_history_ignores_non_report_tool_replies ... ok
[INFO] [stdout] test coordinator::tests::writing_an_undeclared_path_is_rejected ... ok
[INFO] [stdout] test engine::tests::report_from_history_maps_all_statuses ... ok
[INFO] [stdout] test engine::tests::report_from_history_requires_summary ... ok
[INFO] [stdout] test engine::tests::report_from_history_reads_last_report_reply ... ok
[INFO] [stdout] test engine::tests::report_status_str_round_trips_with_from_report_status ... ok
[INFO] [stdout] test engine::tests::slave_report_failed_constructor ... ok
[INFO] [stdout] test engine::orchestration::tests::dispatch_writer_rejects_empty_task ... ok
[INFO] [stdout] test coordinator::tests::txn_write_path_persists_char_level_authorship ... ok
[INFO] [stdout] test coordinator::tests::all_or_nothing_blocks_until_whole_set_is_free ... ok
[INFO] [stdout] test engine::orchestration::tests::list_reports_starts_empty ... ok
[INFO] [stdout] test coordinator::tests::split_produces_one_commit_touching_source_each_new_file_and_index ... ok
[INFO] [stdout] test engine::orchestration::tests::organize_articles_sets_hierarchy_and_order ... ok
[INFO] [stdout] test engine::orchestration::tests::dispatch_writer_runs_a_slave_and_records_the_report ... ok
[INFO] [stdout] test observe::tests::event_serializes_to_json ... ok
[INFO] [stdout] test observe::tests::null_sink_discards_without_panicking ... ok
[INFO] [stdout] test observe::tests::recorder_captures_events_in_order ... ok
[INFO] [stdout] test provenance::tests::author_at_empty_text_end ... ok
[INFO] [stdout] test provenance::tests::author_at_reports_correct_author ... ok
[INFO] [stdout] test provenance::tests::authors_in_range_empty_range_is_empty ... ok
[INFO] [stdout] test provenance::tests::authors_in_range_single_run ... ok
[INFO] [stdout] test provenance::tests::authors_in_range_full ... ok
[INFO] [stdout] test provenance::tests::authors_in_range_tiles_exactly ... ok
[INFO] [stdout] test provenance::tests::contributors_of_empty ... ok
[INFO] [stdout] test provenance::tests::contributors_of_first_seen_order ... ok
[INFO] [stdout] test provenance::tests::delete_at_end ... ok
[INFO] [stdout] test provenance::tests::delete_at_start ... ok
[INFO] [stdout] test provenance::tests::delete_empty_range_is_noop ... ok
[INFO] [stdout] test provenance::tests::delete_everything_yields_empty ... ok
[INFO] [stdout] test provenance::tests::delete_off_char_boundary_is_rejected ... ok
[INFO] [stdout] test provenance::tests::delete_middle_keeps_surrounding_authorship ... ok
[INFO] [stdout] test provenance::tests::delete_whole_run_then_coalesce ... ok
[INFO] [stdout] test provenance::tests::diff_from_empty_is_all_insert ... ok
[INFO] [stdout] test provenance::tests::diff_identical_is_all_equal ... ok
[INFO] [stdout] test provenance::tests::diff_insertion_in_middle ... ok
[INFO] [stdout] test coordinator::tests::human_waits_at_queue_head_but_does_not_preempt ... ok
[INFO] [stdout] test provenance::tests::diff_to_empty_is_all_delete ... ok
[INFO] [stdout] test provenance::tests::diff_replacement_attributes_old_and_new ... ok
[INFO] [stdout] test provenance::tests::diff_unicode ... ok
[INFO] [stdout] test provenance::tests::document_contributors_code_only_is_empty ... ok
[INFO] [stdout] test engine::tests::slave_stacks_two_skills_in_order_with_later_wins_precedence ... ok
[INFO] [stdout] test provenance::tests::document_contributors_empty ... ok
[INFO] [stdout] test provenance::tests::flatten_then_paragraph_round_trips_single_paragraph ... ok
[INFO] [stdout] test provenance::tests::insert_at_end ... ok
[INFO] [stdout] test provenance::tests::document_contributors_first_seen_across_blocks ... ok
[INFO] [stdout] test provenance::tests::insert_at_start ... ok
[INFO] [stdout] test coordinator::tests::merge_produces_one_commit_touching_sources_target_and_index ... ok
[INFO] [stdout] test provenance::tests::insert_empty_string_is_noop ... ok
[INFO] [stdout] test provenance::tests::insert_in_middle_splits_run_and_tags_new_text ... ok
[INFO] [stdout] test provenance::tests::boundary_across_run_split_is_rejected ... ok
[INFO] [stdout] test provenance::tests::diff_deletion ... ok
[INFO] [stdout] test observe::tests::sink_is_shareable_across_threads ... ok
[INFO] [stdout] test provenance::tests::insert_into_empty ... ok
[INFO] [stdout] test provenance::tests::insert_off_char_boundary_is_rejected ... ok
[INFO] [stdout] test provenance::tests::insert_same_author_coalesces ... ok
[INFO] [stdout] test provenance::tests::inverted_range_is_rejected ... ok
[INFO] [stdout] test dsl::tests::bad_escape_is_rejected ... ok
[INFO] [stdout] test provenance::tests::normalize_empty_is_empty ... ok
[INFO] [stdout] test provenance::tests::normalize_keeps_distinct_authors_separate ... ok
[INFO] [stdout] test provenance::tests::offset_out_of_bounds_is_rejected ... ok
[INFO] [stdout] test provenance::tests::normalize_drops_empty_runs ... ok
[INFO] [stdout] test provenance::tests::paragraph_document_of_empty_body_is_empty ... ok
[INFO] [stdout] test coordinator::tests::two_edits_grow_history_by_one_each ... ok
[INFO] [stdout] test provenance::tests::multibyte_edit_succeeds_on_boundaries ... ok
[INFO] [stdout] test provenance::tests::normalize_coalesces_adjacent_same_author ... ok
[INFO] [stdout] test provenance::tests::reauthor_attributes_only_the_changed_middle ... ok
[INFO] [stdout] test provenance::tests::reauthor_full_rewrite_attributes_all_to_new_author ... ok
[INFO] [stdout] test provenance::tests::reauthor_handles_multibyte_boundaries ... ok
[INFO] [stdout] test provenance::tests::reauthor_pure_append_keeps_prefix_authorship ... ok
[INFO] [stdout] test provenance::tests::paragraph_document_splits_on_blank_lines_preserving_runs ... ok
[INFO] [stdout] test provenance::tests::reauthor_then_second_writer_blends_three_authors ... ok
[INFO] [stdout] test provenance::tests::replace_middle_tags_new_text ... ok
[INFO] [stdout] test provenance::tests::replace_whole_text ... ok
[INFO] [stdout] test provenance::tests::reauthor_identical_body_is_a_noop ... ok
[INFO] [stdout] test provenance::tests::replace_spanning_runs ... ok
[INFO] [stdout] test provenance::tests::sequential_edits_preserve_per_char_authorship ... ok
[INFO] [stdout] test req::model::tests::from_str_is_infallible_and_matches_pinned ... ok
[INFO] [stdout] test req::model::tests::pinned_carries_dated_snapshot_verbatim ... ok
[INFO] [stdout] test req::model::tests::serializes_to_the_wire_id_for_both_kinds ... ok
[INFO] [stdout] test req::model::tests::pinned_collapses_known_family_ids_to_named_variants ... ok
[INFO] [stdout] test provenance::tests::reauthor_pure_prepend_keeps_suffix_authorship ... ok
[INFO] [stdout] test search::tests::backend_error_maps_to_tool_error ... ok
[INFO] [stdout] test search::tests::hits_truncated_to_limit ... ok
[INFO] [stdout] test search::tests::empty_query_rejected ... ok
[INFO] [stdout] test search::tests::results_serialize_omits_absent_note ... ok
[INFO] [stdout] test search::tests::search_error_display_is_descriptive ... ok
[INFO] [stdout] test search::tests::stub_provider_returns_unconfigured_result ... ok
[INFO] [stdout] test search::tests::limit_defaults_and_clamps ... ok
[INFO] [stdout] test session::tests::build_request_omits_tools_when_registry_empty ... ok
[INFO] [stdout] test session::tests::build_request_exports_tool_definitions_with_auto_choice ... ok
[INFO] [stdout] test req::model::tests::named_variants_have_stable_wire_ids ... ok
[INFO] [stdout] test engine::tests::run_goal_surfaces_a_collected_slave_failure_without_erroring ... ok
[INFO] [stdout] test engine::tests::run_goal_plans_dispatches_and_aggregates_over_a_fake ... ok
[INFO] [stdout] test engine::tests::slave_rereads_skill_from_disk_each_round_so_a_midrun_edit_takes_effect ... ok
[INFO] [stdout] test search::tests::fake_provider_is_exercised_through_the_trait ... ok
[INFO] [stdout] test provenance::tests::replace_with_empty_is_delete ... ok
[INFO] [stdout] test search::tests::search_schema_is_distinct_from_find ... ok
[INFO] [stdout] test engine::tests::spawn_slave_with_sink_emits_lifecycle_events ... ok
[INFO] [stdout] test session::tests::default_options_match_spec ... ok
[INFO] [stdout] test session::tests::empty_registry_exports_no_definitions ... ok
[INFO] [stdout] test engine::tests::slave_without_skill_source_keeps_a_fixed_prompt_across_rounds ... ok
[INFO] [stdout] test session::tests::build_request_puts_system_first_then_history ... ok
[INFO] [stdout] test session::tests::push_user_appends_user_message ... ok
[INFO] [stdout] test session::tests::no_segments_compose_to_the_base_prompt_exactly ... ok
[INFO] [stdout] test session::tests::pushing_a_segment_appends_it_after_the_base ... ok
[INFO] [stdout] test search::tests::stub_tool_reports_unconfigured_explicitly ... ok
[INFO] [stdout] test session::tests::history_back_fill_strips_reasoning_content_keeps_tool_calls ... ok
[INFO] [stdout] test session::tests::no_provider_is_byte_identical_to_fixed_prompt ... ok
[INFO] [stdout] test session::tests::default_sink_is_silent_and_changes_no_behaviour ... ok
[INFO] [stdout] test skill::tests::compose_stack_single_is_just_the_body ... ok
[INFO] [stdout] test skill::tests::load_skill_found_and_not_found ... ok
[INFO] [stdout] test session::tests::pushing_same_name_overrides_in_place ... ok
[INFO] [stdout] test session::tests::removing_a_segment_drops_it_and_reports_presence ... ok
[INFO] [stdout] test session::tests::provider_is_reevaluated_each_round_and_changes_the_system_message ... ok
[INFO] [stdout] test session::tests::segments_are_ordered_by_ordinal_then_name ... ok
[INFO] [stdout] test session::tests::segments_compose_on_top_of_a_provider_base ... ok
[INFO] [stdout] test session::tests::snapshot_restore_round_trip_preserves_state ... ok
[INFO] [stdout] test session::tests::usage_totals_accumulate_across_rounds ... ok
[INFO] [stdout] test skill::tests::compose_stack_empty_is_empty ... ok
[INFO] [stdout] test skill::tests::compose_stack_orders_bodies_and_documents_precedence ... ok
[INFO] [stdout] test skill::tests::load_skill_rejects_traversal_ids ... ok
[INFO] [stdout] test skill::tests::load_skills_missing_dir_is_empty_not_error ... ok
[INFO] [stdout] test skill::tests::parse_skill_with_front_matter ... ok
[INFO] [stdout] test skill::tests::parse_skill_without_front_matter_uses_id_as_name ... ok
[INFO] [stdout] test skill::tests::load_skills_ordered_preserves_order_and_fails_fast ... ok
[INFO] [stdout] test skill::tests::unterminated_front_matter_is_treated_as_body ... ok
[INFO] [stdout] test skill::tests::load_skills_reads_md_sorted_and_ignores_others ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_offset_ops ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_rejects_non_unique_anchor ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_rejects_out_of_bounds_offset ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_rejects_overlapping_spans ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_rejects_empty_batch ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_requires_lock ... ok
[INFO] [stdout] test session::tests::segment_inserted_mid_run_appears_in_subsequent_rounds_only ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_rolls_back_on_failing_op ... ok
[INFO] [stdout] test session::tests::build_request_propagates_thinking_and_max_tokens ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_anchor_ops ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_rejects_offset_off_char_boundary ... ok
[INFO] [stdout] test tool::tools::tests::create_and_delete_theme_tools ... ok
[INFO] [stdout] test tool::tools::tests::each_tool_schema_name_matches_tool_name ... ok
[INFO] [stdout] test tool::tools::tests::apply_edits_message_records_op_count ... ok
[INFO] [stdout] test tool::tools::tests::create_delete_list_articles_tools_maintain_index ... ok
[INFO] [stdout] test tool::tools::tests::history_tools_error_when_vcs_disabled ... ok
[INFO] [stdout] test tool::tools::tests::edit_article_rejects_non_unique_and_absent ... ok
[INFO] [stdout] test tool::tools::tests::edits_without_vcs_skip_commit_but_still_write ... ok
[INFO] [stdout] test tool::tools::tests::edit_article_unique_match ... ok
[INFO] [stdout] test tool::tools::tests::coordinator_routed_write_commits_body_and_index_as_one_commit ... ok
[INFO] [stdout] test tool::tools::tests::report_tool_echoes_structured_report ... ok
[INFO] [stdout] test tool::tools::tests::edit_article_requires_lock ... ok
[INFO] [stdout] test tool::tools::tests::read_missing_article_errors ... ok
[INFO] [stdout] test tool::tools::tests::split_merge_tools_require_a_coordinator ... ok
[INFO] [stdout] test tool::tools::tests::tools_reject_malformed_args ... ok
[INFO] [stdout] test tool::tools::tests::read_article_tool_returns_text ... ok
[INFO] [stdout] test tool::tools::tests::tools_reject_sandbox_escape_in_name ... ok
[INFO] [stdout] test tool::tools::tests::find_tool_locates_matches_across_workspace ... ok
[INFO] [stdout] test tool::tools::tests::split_article_tool_rejects_duplicate_output ... ok
[INFO] [stdout] test tool::tools::tests::write_article_tool_requires_lock ... ok
[INFO] [stdout] test tool::tools::tests::writing_tools_registers_full_set ... ok
[INFO] [stdout] test tool::workspace::tests::article_is_writable_only_by_lock_holder ... ok
[INFO] [stdout] test tool::workspace::tests::asset_dir_appends_suffix_to_full_file_name ... ok
[INFO] [stdout] test tool::workspace::tests::asset_dir_rejects_illegal_names ... ok
[INFO] [stdout] test tool::workspace::tests::author_from_tag_round_trips ... ok
[INFO] [stdout] test tool::workspace::tests::create_article_maintains_index ... ok
[INFO] [stdout] test tool::workspace::tests::create_article_with_content_seeds_sidecar_authored_by_writer ... ok
[INFO] [stdout] test tool::workspace::tests::acquire_lock_on_missing_article_is_not_found ... ok
[INFO] [stdout] test tool::tools::tests::write_article_produces_one_commit_with_the_right_author ... ok
[INFO] [stdout] test tool::workspace::tests::delete_article_rejected_while_locked ... ok
[INFO] [stdout] test tool::workspace::tests::delete_article_maintains_index ... ok
[INFO] [stdout] test tool::workspace::tests::delete_article_removes_sidecar ... ok
[INFO] [stdout] test tool::tools::tests::undo_last_tool_with_single_version_reports_nothing_to_undo ... ok
[INFO] [stdout] test tool::workspace::tests::index_insert_and_remove_maintain_order ... ok
[INFO] [stdout] test tool::tools::tests::split_article_tool_commits_once_and_updates_manifest ... ok
[INFO] [stdout] test tool::tools::tests::merge_articles_tool_commits_once_and_updates_manifest ... ok
[INFO] [stdout] test tool::workspace::tests::create_theme_writes_empty_index ... ok
[INFO] [stdout] test tool::workspace::tests::list_assets_empty_when_no_dir ... ok
[INFO] [stdout] test tool::workspace::tests::delete_theme_removes_dir_and_locks ... ok
[INFO] [stdout] test tool::tools::tests::coordinator_routed_history_reads_through_the_coordinator ... ok
[INFO] [stdout] test tool::workspace::tests::delete_article_reparents_children_to_grandparent ... ok
[INFO] [stdout] test tool::tools::tests::article_blame_tool_attributes_each_line_to_its_writer ... ok
[INFO] [stdout] test tool::workspace::tests::old_index_without_parent_or_config_deserializes ... ok
[INFO] [stdout] test tool::workspace::tests::list_assets_returns_nested_files_sorted ... ok
[INFO] [stdout] test session::tests::run_emits_full_event_sequence_over_a_fake_round ... FAILED
[INFO] [stdout] test tool::workspace::tests::open_canonicalizes_and_creates_root ... ok
[INFO] [stdout] test tool::workspace::tests::multi_paragraph_body_round_trips_through_sidecar ... ok
[INFO] [stdout] test tool::workspace::tests::resolve_asset_rejects_symlink_escape ... ok
[INFO] [stdout] test tool::workspace::tests::read_missing_article_is_not_found ... ok
[INFO] [stdout] test tool::workspace::tests::resolve_asset_rejects_traversal ... ok
[INFO] [stdout] test tool::workspace::tests::resolve_asset_stays_inside_sandbox ... ok
[INFO] [stdout] test tool::workspace::tests::pinned_dated_model_id_round_trips_into_contributors ... ok
[INFO] [stdout] test tool::workspace::tests::resolve_rejects_absolute_paths ... ok
[INFO] [stdout] test coordinator::tests::a_queued_writer_emits_txn_queued_with_ahead_count ... FAILED
[INFO] [stdout] test tool::workspace::tests::release_lock_rules ... ok
[INFO] [stdout] test tool::workspace::tests::resolve_rejects_parent_traversal ... ok
[INFO] [stdout] test tool::workspace::tests::read_document_for_legacy_article_uses_last_contributor ... ok
[INFO] [stdout] test tool::workspace::tests::resolve_accepts_relative_paths ... ok
[INFO] [stdout] test tool::workspace::tests::reorder_requires_a_permutation ... ok
[INFO] [stdout] test tool::workspace::tests::read_oversized_article_is_unsupported ... ok
[INFO] [stdout] test tool::workspace::tests::single_writer_enforced ... ok
[INFO] [stdout] test tool::workspace::tests::validate_name_rejects_separators_and_dots ... ok
[INFO] [stdout] test tool::workspace::tests::resolve_rejects_symlink_escape ... ok
[INFO] [stdout] test tool::tools::tests::undo_last_tool_needs_no_explicit_lock ... ok
[INFO] [stdout] test tool::workspace::tests::writer_provenance_tags ... ok
[INFO] [stdout] test tool::workspace::tests::theme_config_round_trips_through_index ... ok
[INFO] [stdout] test tool::workspace::tests::set_parent_rejects_self_cycle_and_missing ... ok
[INFO] [stdout] test tool::workspace::tests::write_without_lock_is_rejected ... ok
[INFO] [stdout] test tool::workspace::tests::write_article_persists_char_level_authorship ... ok
[INFO] [stdout] test tool::workspace::tests::three_writer_edits_each_persist_their_authorship ... ok
[INFO] [stdout] test tool::workspace::tests::read_binary_article_is_unsupported ... ok
[INFO] [stdout] test tool::tools::tests::undo_last_tool_reverts_to_previous_version ... ok
[INFO] [stdout] test tool::workspace::tests::write_then_read_round_trips ... ok
[INFO] [stdout] test tool::workspace::tests::set_parent_builds_hierarchy_and_outline_depths ... ok
[INFO] [stdout] test tool::tools::tests::article_history_tool_lists_commits_newest_first ... ok
[INFO] [stdout] test vcs::tests::blame_maps_each_line_to_the_writer_that_last_touched_it ... ok
[INFO] [stdout] test vcs::tests::blame_of_uncommitted_file_is_empty_not_error ... ok
[INFO] [stdout] test vcs::tests::diff_between_two_versions_shows_change ... ok
[INFO] [stdout] test vcs::tests::blame_reflects_only_committed_content_not_the_work_tree ... ok
[INFO] [stdout] test vcs::tests::commit_file_delegates_to_commit_paths ... ok
[INFO] [stdout] test vcs::tests::blame_non_utf8_path_is_non_utf8_path ... ok
[INFO] [stdout] test vcs::tests::blame_single_commit_attributes_every_line_to_its_author ... ok
[INFO] [stdout] test vcs::tests::commit_file_returns_a_short_sha ... ok
[INFO] [stdout] test vcs::tests::commit_paths_empty_slice_is_error ... ok
[INFO] [stdout] test vcs::tests::commit_paths_non_utf8_path_is_non_utf8_path ... ok
[INFO] [stdout] test tool::tools::tests::index_json_is_committed_in_the_same_commit_as_the_article ... ok
[INFO] [stdout] test vcs::tests::open_or_init_creates_then_reopens_repo ... ok
[INFO] [stdout] test vcs::tests::history_of_unknown_file_is_empty_not_error ... ok
[INFO] [stdout] test vcs::tests::blame_unknown_file_is_empty_not_error ... ok
[INFO] [stdout] test vcs::tests::history_lists_commits_newest_first ... ok
[INFO] [stdout] test vcs::tests::commit_paths_commits_multiple_paths_as_one_commit ... ok
[INFO] [stdout] test vcs::tests::commit_only_stages_the_named_file ... ok
[INFO] [stdout] test vcs::tests::first_commit_is_a_root_commit ... ok
[INFO] [stdout] test vcs::tests::diff_from_none_shows_full_addition ... ok
[INFO] [stdout] test vcs::tests::undo_last_on_untracked_file_returns_none ... ok
[INFO] [stdout] test vcs::tests::diff_unresolvable_revision_is_no_history ... ok
[INFO] [stdout] test vcs::tests::pinned_dated_model_id_round_trips_into_commit_author ... ok
[INFO] [stdout] test vcs::tests::undo_last_reverts_content_and_adds_a_commit ... ok
[INFO] [stdout] test vcs::tests::restore_missing_path_at_revision_is_no_history ... ok
[INFO] [stdout] test vcs::tests::undo_last_with_single_commit_returns_none ... ok
[INFO] [stdout] test tool::tools::tests::article_diff_tool_shows_change_between_versions ... ok
[INFO] [stdout] test vcs::tests::history_records_author_identity ... ok
[INFO] [stdout] test vcs::tests::restore_to_specific_commit_round_trips_content ... ok
[INFO] [stdout] test coordinator::tests::deadlock_stress_random_intersecting_sets_all_complete ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- session::tests::run_emits_full_event_sequence_over_a_fake_round stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'session::tests::run_emits_full_event_sequence_over_a_fake_round' (2203) panicked at src/session/mod.rs:1523:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: ["SessionStarted", "RoundStarted", "ModelMessage", "RoundStarted", "ModelMessage", "Finished"]
[INFO] [stdout]  right: ["SessionStarted", "RoundStarted", "ModelMessage", "ToolCalled", "ToolResult", "RoundStarted", "ModelMessage", "Finished"]
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5fceb0d9e218 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5fceb0d9e218 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5fceb0d9e218 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5fceb0d9e218 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5fceb0db501a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5fceb0db501a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5fceb0da31c2 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5fceb0da31c2 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5fceb0d78f66 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5fceb0d78f66 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5fceb0d94ea9 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5fceb0914a3c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5fceb0914a3c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5fceb0d95122 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5fceb0d95122 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5fceb0d79022 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5fceb0d6de79 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5fceb0d79fbd - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5fceb0db57dc - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5fceb0db5693 - core[8fb95b77d25ab6c8]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x5fceb07a504d - core[8fb95b77d25ab6c8]::panicking::assert_failed::<alloc[a7ee25936407c584]::vec::Vec<&str>, [&str; 8usize]>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5fceb0798db5 - ai_write[b325bb973e31478e]::session::tests::run_emits_full_event_sequence_over_a_fake_round
[INFO] [stdout]                                at /opt/rustwide/workdir/src/session/mod.rs:1523:9
[INFO] [stdout]   22:     0x5fceb077c0f7 - ai_write[b325bb973e31478e]::session::tests::run_emits_full_event_sequence_over_a_fake_round::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/session/mod.rs:1501:57
[INFO] [stdout]   23:     0x5fceb07ee316 - <ai_write[b325bb973e31478e]::session::tests::run_emits_full_event_sequence_over_a_fake_round::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5fceb0907b1b - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5fceb0907b1b - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x5fceb0915395 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x5fceb0915395 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5fceb0915395 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5fceb0915395 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5fceb0915395 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5fceb0915395 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x5fceb0915395 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x5fceb090eca4 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x5fceb090eca4 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5fceb0918412 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5fceb0918412 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5fceb0918412 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5fceb0918412 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5fceb0918412 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5fceb0918412 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5fceb0918412 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5fceb0d9ceef - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   43:     0x5fceb0d9ceef - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7dfe2e433aa4 - <unknown>
[INFO] [stdout]   45:     0x7dfe2e4c0a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- coordinator::tests::a_queued_writer_emits_txn_queued_with_ahead_count stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'coordinator::tests::a_queued_writer_emits_txn_queued_with_ahead_count' (2008) panicked at src/coordinator/mod.rs:2420:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: ["TxnAcquired", "TxnQueued", "TxnAcquired", "TxnReleased", "TxnReleased"]
[INFO] [stdout]  right: ["TxnAcquired", "TxnQueued", "TxnReleased", "TxnAcquired", "TxnReleased"]
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5fceb0d9e218 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5fceb0d9e218 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5fceb0d9e218 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5fceb0d9e218 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5fceb0db501a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5fceb0db501a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5fceb0da31c2 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5fceb0da31c2 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5fceb0d78f66 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5fceb0d78f66 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5fceb0d94ea9 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5fceb0914a3c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5fceb0914a3c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5fceb0d95122 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5fceb0d95122 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5fceb0d79022 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5fceb0d6de79 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5fceb0d79fbd - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5fceb0db57dc - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5fceb0db5693 - core[8fb95b77d25ab6c8]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x5fceb07a4ffc - core[8fb95b77d25ab6c8]::panicking::assert_failed::<alloc[a7ee25936407c584]::vec::Vec<&str>, [&str; 5usize]>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5fceb06e4dec - ai_write[b325bb973e31478e]::coordinator::tests::a_queued_writer_emits_txn_queued_with_ahead_count
[INFO] [stdout]                                at /opt/rustwide/workdir/src/coordinator/mod.rs:2420:9
[INFO] [stdout]   22:     0x5fceb06cbf87 - ai_write[b325bb973e31478e]::coordinator::tests::a_queued_writer_emits_txn_queued_with_ahead_count::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/coordinator/mod.rs:2369:59
[INFO] [stdout]   23:     0x5fceb07ec596 - <ai_write[b325bb973e31478e]::coordinator::tests::a_queued_writer_emits_txn_queued_with_ahead_count::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5fceb0907b1b - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5fceb0907b1b - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x5fceb0915395 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x5fceb0915395 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5fceb0915395 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5fceb0915395 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5fceb0915395 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5fceb0915395 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x5fceb0915395 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x5fceb090eca4 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x5fceb090eca4 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5fceb0918412 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5fceb0918412 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5fceb0918412 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5fceb0918412 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5fceb0918412 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5fceb0918412 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5fceb0918412 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5fceb0d9ceef - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   43:     0x5fceb0d9ceef - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7dfe2e433aa4 - <unknown>
[INFO] [stdout]   45:     0x7dfe2e4c0a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     coordinator::tests::a_queued_writer_emits_txn_queued_with_ahead_count
[INFO] [stdout]     session::tests::run_emits_full_event_sequence_over_a_fake_round
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 291 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.62s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7", kill_on_drop: false }`
[INFO] [stdout] 0b30c183a617d3cf8295c13cd66c73ae5d7716934b9739bba7ff428b4ddde4b7
