[INFO] fetching crate spoke-operations 0.14.1...
[INFO] testing spoke-operations-0.14.1 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate spoke-operations 0.14.1 into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate spoke-operations 0.14.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate spoke-operations 0.14.1
[INFO] tweaked toml for crates.io crate spoke-operations 0.14.1 written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate spoke-operations 0.14.1 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 spoke-operations 0.14.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358
[INFO] running `Command { std: "docker" "start" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358", 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" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358" "/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" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358", 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" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling regress v0.10.5
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling async-trait v0.1.91
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling spoke-schemas v0.14.1
[INFO] [stderr]    Compiling spoke-operations v0.14.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 28.40s
[INFO] running `Command { std: "docker" "inspect" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358", 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" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling pollster v0.4.0
[INFO] [stderr]    Compiling spoke-operations v0.14.1 (/opt/rustwide/workdir)
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]    --> src/scope.rs:732:13
[INFO] [stdout]     |
[INFO] [stdout] 732 |         let mut event = make_timeline_event(|ev| {
[INFO] [stdout]     |             ----^^^^^
[INFO] [stdout]     |             |
[INFO] [stdout]     |             help: remove this `mut`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 12.97s
[INFO] running `Command { std: "docker" "inspect" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358", 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" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: variable does not need to be mutable
[INFO] [stderr]    --> src/scope.rs:732:13
[INFO] [stderr]     |
[INFO] [stderr] 732 |         let mut event = make_timeline_event(|ev| {
[INFO] [stderr]     |             ----^^^^^
[INFO] [stderr]     |             |
[INFO] [stderr]     |             help: remove this `mut`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `spoke-operations` (lib test) generated 1 warning (run `cargo fix --lib -p spoke-operations --tests` to apply 1 suggestion)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/spoke-operations/09a714ca9c52c40a/out/spoke_operations-09a714ca9c52c40a)
[INFO] [stdout] 
[INFO] [stdout] running 232 tests
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_project_validates_then_calls_computable_port ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_check_lets_embedded_rules_win_by_rule_id_over_refs ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_promote_persists_confirmed_knowledge_entry ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_fork_check_uses_fork_timeline_port ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_promote_propagates_adapter_occ_reject_on_concurrent_advance ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_promote_rejects_on_stored_revision_mismatch ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_promote_rejects_when_stored_status_is_terminal ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_promote_succeeds_when_stored_provisional_matches_revision ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_relate_passes_none_expected_base_revision_on_create ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_assemble_builds_packet_from_scoped_knowledge_entries ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_check_loads_scope_runs_checker_and_puts_findings ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_relate_persists_relation ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_relate_passes_stored_revision_as_expected_base_on_update ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_compute_validates_then_calls_computable_port ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_promote_forces_persisted_revision_to_stored_plus_one ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_relate_propagates_relation_already_exists_when_create_races_existing_id ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_relate_rejects_concurrent_update_when_store_revision_advances ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_relate_rejects_update_when_candidate_revision_conflicts ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_upsert_rejects_concurrent_update_when_expected_base_is_stale ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_upsert_creates_knowledge_entry_through_ports ... ok
[INFO] [stdout] test adapter::orchestrate::tests::ownership_viewpoint_assemble_packs_only_entries_visible_to_scope_viewpoint ... ok
[INFO] [stdout] test adapter::orchestrate::tests::ownership_viewpoint_assemble_swaps_private_entry_for_foreign_viewpoint ... ok
[INFO] [stdout] test adapter::orchestrate::tests::ownership_viewpoint_check_withholds_owner_private_entries_without_viewpoint ... ok
[INFO] [stdout] test adapter::orchestrate::tests::ownership_viewpoint_check_supplies_shared_and_own_private_entries ... ok
[INFO] [stdout] test adapter::orchestrate::tests::ownership_viewpoint_fork_assemble_packs_only_visible_entries ... ok
[INFO] [stdout] test adapter::orchestrate::tests::ownership_viewpoint_fork_check_filters_scoped_entries ... ok
[INFO] [stdout] test adapter::orchestrate::tests::orchestrate_upsert_passes_none_expected_base_revision_on_create ... ok
[INFO] [stdout] test adapter::parity_export_checklist::public_exports_cover_ts_adapter_parity_table ... ok
[INFO] [stdout] test adapter::ports::tests::baseline_ports_accepts_all_six_baseline_families ... ok
[INFO] [stdout] test adapter::ports::tests::capability_port_missing_is_twentieth_spoke_reject_code ... ok
[INFO] [stdout] test adapter::ports::tests::host_manifest_port_accepts_empty_peer_list ... ok
[INFO] [stdout] test adapter::ports::tests::host_manifest_port_returns_seeded_peers_with_disjoint_namespaces ... ok
[INFO] [stdout] test adapter::ports::tests::host_manifest_port_excludes_self_dedupes_and_sorts_peers ... ok
[INFO] [stdout] test assemble::tests::build_packet_snippet_from_wire_deserialize ... ok
[INFO] [stdout] test assemble::tests::passes_extensions_through ... ok
[INFO] [stdout] test assemble::tests::rejects_empty_packet_id ... ok
[INFO] [stdout] test assemble::tests::builds_packet_with_empty_list ... ok
[INFO] [stdout] test assemble::tests::rejects_invalid_extension_namespace_key ... ok
[INFO] [stdout] test assemble::tests::rejects_null_body_from_wire_json_f002 ... ok
[INFO] [stdout] test assemble::tests::rejects_wire_json_with_non_string_summary ... ok
[INFO] [stdout] test assemble::tests::rejects_null_body_in_build_packet_f002 ... ok
[INFO] [stdout] test assemble::tests::truncates_entries_in_input_order ... ok
[INFO] [stdout] test body::tests::filter_matches_trait_type_with_exact_case_sensitive_equality ... ok
[INFO] [stdout] test body::tests::filter_returns_all_matches_in_order_for_duplicate_trait_types ... ok
[INFO] [stdout] test body::tests::filter_returns_empty_when_trait_type_has_no_matches ... ok
[INFO] [stdout] test body::tests::find_returns_first_matching_trait_in_array_order ... ok
[INFO] [stdout] test adapter::ports::tests::host_manifest_port_returns_self_manifest ... ok
[INFO] [stdout] test body::tests::find_returns_none_when_no_match_or_input_is_absent ... ok
[INFO] [stdout] test body::tests::list_returns_empty_when_entry_body_or_attributes_are_absent ... ok
[INFO] [stdout] test body::tests::list_returns_empty_when_attributes_is_not_an_array ... ok
[INFO] [stdout] test body::tests::list_returns_empty_when_wire_input_is_absent ... ok
[INFO] [stdout] test body::tests::list_reads_attributes_from_full_knowledge_entry ... ok
[INFO] [stdout] test body::tests::list_returns_empty_when_attributes_are_omitted_or_empty ... ok
[INFO] [stdout] test adapter::orchestrate::tests::returns_capability_port_missing_when_fork_timeline_absent ... ok
[INFO] [stdout] test adapter::orchestrate::tests::returns_capability_port_missing_when_project_absent ... ok
[INFO] [stdout] test body::tests::list_returns_valid_traits_in_order_and_skips_malformed_elements ... ok
[INFO] [stdout] test computable::tests::validate_computable_field_map_accepts_domain_values ... ok
[INFO] [stdout] test assemble::tests::maps_core_fields_with_snippet_from_wire_deserialize ... ok
[INFO] [stdout] test assemble::tests::omits_snippet_for_whitespace_only_summary ... ok
[INFO] [stdout] test computable::tests::validate_computable_field_map_rejects_null ... ok
[INFO] [stdout] test computable::tests::validate_computable_log_entry_accepts_datetime_without_timezone_suffix ... ok
[INFO] [stdout] test computable::tests::validate_computable_log_entry_accepts_valid_entry ... ok
[INFO] [stdout] test computable::tests::validate_computable_log_entry_rejects_empty_entry_id ... ok
[INFO] [stdout] test computable::tests::validate_computable_log_entry_rejects_change_without_path ... ok
[INFO] [stdout] test computable::tests::validate_computable_log_entry_rejects_invalid_logged_at ... ok
[INFO] [stdout] test computable::tests::validate_computable_field_map_accepts_empty_plain_object ... ok
[INFO] [stdout] test computable::tests::validate_computable_field_map_rejects_arrays ... ok
[INFO] [stdout] test computable::tests::validate_computable_log_entry_rejects_null_change_without_panicking ... ok
[INFO] [stdout] test computable::tests::validate_compute_request_accepts_settle_true ... ok
[INFO] [stdout] test computable::tests::validate_compute_request_accepts_valid_request ... ok
[INFO] [stdout] test computable::tests::validate_project_request_rejects_missing_session_id ... ok
[INFO] [stdout] test computable::tests::validate_computable_log_entry_rejects_undefined_change_without_panicking ... ok
[INFO] [stdout] test computable::tests::validate_compute_request_rejects_non_boolean_settle_via_wire ... ok
[INFO] [stdout] test computable::tests::validate_project_request_accepts_valid_request ... ok
[INFO] [stdout] test computable::tests::validate_compute_request_rejects_invalid_computable_map ... ok
[INFO] [stdout] test computable::tests::validate_project_request_rejects_invalid_state ... ok
[INFO] [stdout] test extensions::tests::module_deep_merges_object_valued_namespaces ... ok
[INFO] [stdout] test extensions::tests::module_does_not_alias_arrays_from_inputs ... ok
[INFO] [stdout] test error::tests::rejects_unknown_wire_error_codes_with_invalid_input ... ok
[INFO] [stdout] test computable::tests::validate_project_request_rejects_non_object_extensions_via_wire ... ok
[INFO] [stdout] test error::tests::omits_details_when_absent_on_outbound_map ... ok
[INFO] [stdout] test error::tests::round_trips_all_documented_codes ... ok
[INFO] [stdout] test extensions::tests::does_not_mutate_inputs ... ok
[INFO] [stdout] test extensions::tests::does_not_alias_nested_objects_from_inputs ... ok
[INFO] [stdout] test extensions::tests::keeps_empty_namespace_objects ... ok
[INFO] [stdout] test extensions::tests::module_preserves_unknown_namespaces_object_and_array ... ok
[INFO] [stdout] test extensions::tests::module_replaces_array_valued_namespaces ... ok
[INFO] [stdout] test extensions::tests::module_treats_empty_maps_and_namespaces_as_valid ... ok
[INFO] [stdout] test extensions::tests::preserves_unknown_namespaces_from_both_inputs ... ok
[INFO] [stdout] test extensions::tests::module_preserve_does_not_delete_sibling_namespaces ... ok
[INFO] [stdout] test extensions::tests::preserve_retains_unknown_keys_from_source ... ok
[INFO] [stdout] test extensions::tests::overlay_wins_on_scalar_conflicts ... ok
[INFO] [stdout] test finding::tests::accepts_allowed_transition_and_sets_updated_at ... ok
[INFO] [stdout] test extensions::tests::module_preserve_lets_target_replace_array_namespace ... ok
[INFO] [stdout] test finding::tests::accepts_no_op_same_status ... ok
[INFO] [stdout] test extensions::tests::module_preserve_retains_unknown_namespaces_from_source ... ok
[INFO] [stdout] test extensions::tests::preserve_does_not_delete_sibling_namespaces ... ok
[INFO] [stdout] test knowledge_entry::tests::accepts_when_no_conflicting_active_knowledge_entry_exists ... ok
[INFO] [stdout] test knowledge_entry::tests::accepts_no_op_same_status_transition ... ok
[INFO] [stdout] test knowledge_entry::tests::allows_documented_status_transitions ... ok
[INFO] [stdout] test finding::tests::allows_documented_transitions ... ok
[INFO] [stdout] test finding::tests::rejects_disallowed_transition_with_details ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_excludes_owner_private_entry_for_foreign_viewpoint ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_excludes_owner_private_entry_without_owner ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_excludes_owner_private_entry_without_viewpoint ... ok
[INFO] [stdout] test finding::tests::rejects_disallowed_transitions ... ok
[INFO] [stdout] test finding::tests::rejects_invalid_target_status ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_includes_entry_with_owner_but_no_disclosure ... ok
[INFO] [stdout] test knowledge_entry::tests::allows_same_entry_id_update_in_place ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_includes_entry_without_disclosure_for_any_viewpoint ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_returns_holder_entry_id_when_present ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_includes_owner_private_entry_for_its_own_viewpoint ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_returns_none_when_unspecified ... ok
[INFO] [stdout] test knowledge_entry::tests::passes_when_candidate_is_inactive ... ok
[INFO] [stdout] test knowledge_entry::tests::ignores_inactive_existing_knowledge_entries ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_compares_identifiers_exactly ... ok
[INFO] [stdout] test knowledge_entry::tests::rejects_when_entry_type_or_canonical_name_do_not_match_candidate_wire_fields ... ok
[INFO] [stdout] test knowledge_entry::tests::rejects_invalid_target_status ... ok
[INFO] [stdout] test knowledge_entry::tests::rejects_terminal_outbound_transition ... ok
[INFO] [stdout] test knowledge_entry::tests::rejects_invalid_current_status ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_accepts_minimal_required_only_record ... ok
[INFO] [stdout] test knowledge_entry::tests::rejects_duplicate_active_triple_for_different_entry_id ... ok
[INFO] [stdout] test knowledge_entry::tests::rejects_disallowed_status_transitions ... ok
[INFO] [stdout] test knowledge_entry::tests::updates_status_on_allowed_transition_without_mutating_input ... ok
[INFO] [stdout] test knowledge_entry::tests::rejects_disallowed_transition_with_from_to_details ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_accepts_delta_with_path_only ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_accepts_valid_record ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_delta_without_path ... ok
[INFO] [stdout] test knowledge_entry::tests::ownership_excludes_unknown_disclosure_value_even_for_matching_owner ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_empty_holder_entry_id ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_non_object_snapshot ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_missing_mind_state_id ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_extra_property ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_missing_holder_entry_id ... ok
[INFO] [stdout] test occ::tests::accepts_revisions_above_js_safe_integer_range ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_invalid_occurred_at ... ok
[INFO] [stdout] test occ::tests::detects_stale_revision_above_js_safe_integer_range ... ok
[INFO] [stdout] test occ::tests::rejects_when_actual_revision_is_greater_than_expected ... ok
[INFO] [stdout] test occ::tests::rejects_when_actual_revision_is_less_than_expected ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_null_and_non_object_state ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_invalid_schema_version ... ok
[INFO] [stdout] test occ::tests::accepts_equal_non_negative_integer_revisions ... ok
[INFO] [stdout] test promote::tests::accepts_valid_provisional_candidate ... ok
[INFO] [stdout] test promote::tests::promotes_provisional_candidate_to_confirmed ... ok
[INFO] [stdout] test promote::tests::rejects_deleted_candidate ... ok
[INFO] [stdout] test promote::tests::rejects_empty_canonical_name ... ok
[INFO] [stdout] test promote::tests::rejects_merge_target_equal_to_candidate ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_non_array_deltas ... ok
[INFO] [stdout] test promote::tests::bumps_revision_from_none_to_one ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_rejects_non_object_extensions ... ok
[INFO] [stdout] test promote::tests::rejects_merged_candidate ... ok
[INFO] [stdout] test promote::tests::bumps_revision_from_two_to_three ... ok
[INFO] [stdout] test promote::tests::does_not_set_updated_at ... ok
[INFO] [stdout] test promote::tests::rejects_empty_entry_type ... ok
[INFO] [stdout] test promote::tests::rejects_non_provisional_candidate ... ok
[INFO] [stdout] test promote::tests::rejects_negative_revision_f003 ... ok
[INFO] [stdout] test promote::tests::rejects_promote_when_revision_is_max ... ok
[INFO] [stdout] test promote::tests::rejects_string_revision_f001 ... ok
[INFO] [stdout] test relate::tests::rejects_missing_to_id ... ok
[INFO] [stdout] test relate::tests::rejects_create_when_revision_is_one_or_greater ... ok
[INFO] [stdout] test relate::tests::rejects_missing_from_id ... ok
[INFO] [stdout] test relate::tests::rejects_self_edge ... ok
[INFO] [stdout] test relate::tests::rejects_self_edge_when_ids_differ_only_by_surrounding_whitespace ... ok
[INFO] [stdout] test relate::tests::rejects_update_path_without_stored_via_explicit_mode ... ok
[INFO] [stdout] test relate::tests::accepts_create_with_revision_zero ... ok
[INFO] [stdout] test relate::tests::rejects_create_path_when_stored_is_provided_via_explicit_mode ... ok
[INFO] [stdout] test relate::tests::accepts_valid_relation ... ok
[INFO] [stdout] test result::tests::reject_code_strings_match_typescript ... ok
[INFO] [stdout] test scope::tests::filter_knowledge_entries_keeps_shared_and_own_private_entries ... ok
[INFO] [stdout] test scope::tests::filter_knowledge_entries_without_viewpoint_keeps_only_shared_entries ... ok
[INFO] [stdout] test relate::tests::update_rejects_when_candidate_revision_is_behind_stored ... ok
[INFO] [stdout] test scope::tests::filter_timeline_events_by_fork_id ... ok
[INFO] [stdout] test relate::tests::update_accepts_when_candidate_revision_matches_stored ... ok
[INFO] [stdout] test relate::tests::update_rejects_when_candidate_omits_revision ... ok
[INFO] [stdout] test relate::tests::update_rejects_when_candidate_relation_id_differs_from_stored ... ok
[INFO] [stdout] test relate::tests::update_rejects_when_candidate_revision_is_ahead_of_stored ... ok
[INFO] [stdout] test scope::tests::filter_knowledge_entries_by_combined_refinements ... ok
[INFO] [stdout] test scope::tests::filter_timeline_events_by_timeline_scale ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_composes_disclosure_predicate_with_entry_refinements ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_matches_entry_ids_refinement ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_matches_source_id_refinement ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_ignores_timeline_event_refinements ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_owner_private_excluded_from_foreign_scope_viewpoint ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_requires_all_present_refinements ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_owner_private_excluded_from_scope_without_viewpoint ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_matches_entry_types_refinement ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_matches_scope_view_keeps_viewpoint_and_wire_array_presence ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_owner_private_matches_its_own_scope_viewpoint ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_unknown_disclosure_excluded_under_matching_scope_viewpoint ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_without_disclosure_matches_foreign_scope_viewpoint ... ok
[INFO] [stdout] test scope::tests::knowledge_entry_passes_when_only_scope_id_is_set ... ok
[INFO] [stdout] test scope::tests::present_empty_entry_ids_from_wire_matches_nothing ... ok
[INFO] [stdout] test scope::tests::timeline_event_ignores_knowledge_entry_refinements ... ok
[INFO] [stdout] test scope::tests::timeline_event_matches_fork_id_refinement_when_equal ... ok
[INFO] [stdout] test scope::tests::scope_extensions_are_opaque_to_matchers ... ok
[INFO] [stdout] test scope::tests::timeline_event_does_not_filter_on_parent_fork_id ... ok
[INFO] [stdout] test scope::tests::timeline_event_misses_fork_id_refinement_when_unequal ... ok
[INFO] [stdout] test scope::tests::timeline_event_passes_when_only_scope_id_is_set ... ok
[INFO] [stdout] test scope::tests::timeline_event_passes_when_scope_omits_fork_id ... ok
[INFO] [stdout] test timeline::tests::filter_keeps_only_moment_scale_events_in_input_order ... ok
[INFO] [stdout] test scope::tests::present_empty_entry_types_from_wire_matches_nothing ... ok
[INFO] [stdout] test scope::tests::timeline_event_misses_fork_id_refinement_when_event_lacks_fork_id ... ok
[INFO] [stdout] test timeline::tests::order_by_ids_rejects_duplicate_timeline_event_ids_in_input ... ok
[INFO] [stdout] test scope::tests::timeline_event_matches_timeline_scale_refinement ... ok
[INFO] [stdout] test timeline::tests::order_by_ids_rejects_duplicate_ids ... ok
[INFO] [stdout] test timeline::tests::filter_returns_empty_for_empty_input ... ok
[INFO] [stdout] test scope::tests::present_empty_timeline_event_ids_from_wire_matches_nothing ... ok
[INFO] [stdout] test timeline::tests::order_by_ids_orders_explicit_list_and_appends_stable_tail ... ok
[INFO] [stdout] test timeline::tests::order_by_ids_rejects_unknown_timeline_event_ids ... ok
[INFO] [stdout] test scope::tests::timeline_event_matches_timeline_event_ids_refinement ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_appends_unlinked_events_in_input_order ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_rejects_cycles ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_rejects_self_loop_relations ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_rejects_duplicate_timeline_event_ids_in_input ... ok
[INFO] [stdout] test upsert::tests::accepts_valid_create_with_revision_zero ... ok
[INFO] [stdout] test upsert::tests::accepts_valid_create_without_revision ... ok
[INFO] [stdout] test upsert::tests::rejects_create_path_when_stored_is_provided_via_explicit_mode ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_breaks_ready_queue_ties_lexicographically ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_honors_relation_type_override ... ok
[INFO] [stdout] test mind_state::tests::validate_mind_state_timestamp_parity_with_typescript ... FAILED
[INFO] [stdout] test upsert::tests::rejects_create_with_whitespace_only_canonical_name ... ok
[INFO] [stdout] test upsert::tests::accepts_valid_update_with_matching_revision ... ok
[INFO] [stdout] test upsert::tests::rejects_update_path_without_stored_via_explicit_mode ... ok
[INFO] [stdout] test upsert::tests::rejects_update_when_candidate_has_empty_entry_type ... ok
[INFO] [stdout] test upsert::tests::rejects_update_without_revision ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_ignores_relations_outside_input_link_map ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_keeps_all_events_sharing_timeline_entry_id ... ok
[INFO] [stdout] test upsert::tests::rejects_update_when_stored_has_terminal_status ... ok
[INFO] [stdout] test upsert::tests::rejects_entry_id_mismatch_on_update ... ok
[INFO] [stdout] test upsert::tests::rejects_create_with_revision_at_least_one ... ok
[INFO] [stdout] test upsert::tests::rejects_update_when_stored_revision_is_stale ... ok
[INFO] [stdout] test timeline::tests::order_by_precedes_orders_harbor_moment_beats ... FAILED
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- mind_state::tests::validate_mind_state_timestamp_parity_with_typescript stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'mind_state::tests::validate_mind_state_timestamp_parity_with_typescript' (533) panicked at src/mind_state.rs:380:37:
[INFO] [stdout] failed to read /opt/rustwide/workdir/../../fixtures/timestamp-parity-cases.json: No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5c45f3650081 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5c45f3650081 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5c45f3650081 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5c45f3650081 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5c45f366540a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5c45f366540a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x5c45f36542bc - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x5c45f36542bc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x5c45f362bef6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5c45f362bef6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x5c45f36483b9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x5c45f3368ee0 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x5c45f3368ee0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x5c45f3648572 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x5c45f3648572 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x5c45f362bfa2 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x5c45f3624b29 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5c45f362cbad - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x5c45f3665bfc - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5c45f3288484 - spoke_operations[593b17c0a5c7b233]::mind_state::tests::validate_mind_state_timestamp_parity_with_typescript::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mind_state.rs:380:37
[INFO] [stdout]   20:     0x5c45f3091ef1 - <core[a373ad73a504971]::result::Result<alloc[2e1b2a31b91974c5]::string::String, core[a373ad73a504971]::io::error::Error>>::unwrap_or_else::<spoke_operations[593b17c0a5c7b233]::mind_state::tests::validate_mind_state_timestamp_parity_with_typescript::{closure#0}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1619:23
[INFO] [stdout]   21:     0x5c45f32a0ac4 - spoke_operations[593b17c0a5c7b233]::mind_state::tests::validate_mind_state_timestamp_parity_with_typescript
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mind_state.rs:380:14
[INFO] [stdout]   22:     0x5c45f32882f7 - spoke_operations[593b17c0a5c7b233]::mind_state::tests::validate_mind_state_timestamp_parity_with_typescript::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mind_state.rs:373:62
[INFO] [stdout]   23:     0x5c45f312c146 - <spoke_operations[593b17c0a5c7b233]::mind_state::tests::validate_mind_state_timestamp_parity_with_typescript::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5c45f335c32b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5c45f335c32b - 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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x5c45f3369505 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x5c45f3369505 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5c45f3369505 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x5c45f3369505 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x5c45f3369505 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5c45f3369505 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x5c45f3369505 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x5c45f3362df4 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x5c45f3362df4 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5c45f336c592 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5c45f336c592 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5c45f336c592 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x5c45f336c592 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x5c45f336c592 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5c45f336c592 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5c45f336c592 - <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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5c45f364f57f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x5c45f364f57f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x706c49e3fdfa - <unknown>
[INFO] [stdout]   45:     0x706c49ed33d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- timeline::tests::order_by_precedes_orders_harbor_moment_beats stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'timeline::tests::order_by_precedes_orders_harbor_moment_beats' (610) panicked at src/timeline.rs:292:37:
[INFO] [stdout] failed to read fixture /opt/rustwide/workdir/../../fixtures/toy-world/evt_tw_harbor_berth_confirm.json: No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5c45f3650081 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5c45f3650081 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5c45f3650081 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5c45f3650081 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5c45f366540a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5c45f366540a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x5c45f36542bc - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x5c45f36542bc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x5c45f362bef6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5c45f362bef6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x5c45f36483b9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x5c45f3368ee0 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x5c45f3368ee0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x5c45f3648572 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x5c45f3648572 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x5c45f362bfa2 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x5c45f3624b29 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5c45f362cbad - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x5c45f3665bfc - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5c45f31606c4 - spoke_operations[593b17c0a5c7b233]::timeline::tests::load_fixture::<spoke_schemas[b20b295ca9ce84fd]::generated::data::timeline_event::TimelineEvent>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/timeline.rs:292:37
[INFO] [stdout]   20:     0x5c45f3091df1 - <core[a373ad73a504971]::result::Result<alloc[2e1b2a31b91974c5]::string::String, core[a373ad73a504971]::io::error::Error>>::unwrap_or_else::<spoke_operations[593b17c0a5c7b233]::timeline::tests::load_fixture<spoke_schemas[b20b295ca9ce84fd]::generated::data::timeline_event::TimelineEvent>::{closure#0}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1619:23
[INFO] [stdout]   21:     0x5c45f313d407 - spoke_operations[593b17c0a5c7b233]::timeline::tests::load_fixture::<spoke_schemas[b20b295ca9ce84fd]::generated::data::timeline_event::TimelineEvent>
[INFO] [stdout]                                at /opt/rustwide/workdir/src/timeline.rs:292:14
[INFO] [stdout]   22:     0x5c45f316facf - spoke_operations[593b17c0a5c7b233]::timeline::tests::order_by_precedes_orders_harbor_moment_beats
[INFO] [stdout]                                at /opt/rustwide/workdir/src/timeline.rs:456:13
[INFO] [stdout]   23:     0x5c45f3162a67 - spoke_operations[593b17c0a5c7b233]::timeline::tests::order_by_precedes_orders_harbor_moment_beats::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/timeline.rs:454:54
[INFO] [stdout]   24:     0x5c45f312d2a6 - <spoke_operations[593b17c0a5c7b233]::timeline::tests::order_by_precedes_orders_harbor_moment_beats::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5c45f335c32b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5c45f335c32b - 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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   27:     0x5c45f3369505 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   28:     0x5c45f3369505 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5c45f3369505 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   30:     0x5c45f3369505 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   31:     0x5c45f3369505 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5c45f3369505 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   33:     0x5c45f3369505 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   34:     0x5c45f3362df4 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   35:     0x5c45f3362df4 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5c45f336c592 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x5c45f336c592 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5c45f336c592 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   39:     0x5c45f336c592 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   40:     0x5c45f336c592 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5c45f336c592 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x5c45f336c592 - <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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5c45f364f57f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   44:     0x5c45f364f57f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x706c49e3fdfa - <unknown>
[INFO] [stdout]   46:     0x706c49ed33d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     mind_state::tests::validate_mind_state_timestamp_parity_with_typescript
[INFO] [stdout]     timeline::tests::order_by_precedes_orders_harbor_moment_beats
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 230 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358", kill_on_drop: false }`
[INFO] [stdout] 1509056ff9d13e7e5e72400d2eb04daaad2ee63e5d18cc1dca15181d9c366358
