[INFO] fetching crate dola 0.0.2...
[INFO] testing dola-0.0.2 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate dola 0.0.2 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate dola 0.0.2
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate dola 0.0.2
[INFO] tweaked toml for crates.io crate dola 0.0.2 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate dola 0.0.2 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate dola 0.0.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded interpolation v0.3.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65
[INFO] running `Command { std: "docker" "start" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65", 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" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65", 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" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.26
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling cpufeatures v0.3.1
[INFO] [stderr]    Compiling thiserror v2.0.21
[INFO] [stderr]    Compiling interpolation v0.3.0
[INFO] [stderr]    Compiling chacha20 v0.10.2
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling rand v0.10.3
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.21
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling dola v0.0.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 16.49s
[INFO] running `Command { std: "docker" "inspect" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65", 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" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling dola v0.0.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 33.08s
[INFO] running `Command { std: "docker" "inspect" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65", 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" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/dola-a23d715df4106dba)
[INFO] [stdout] 
[INFO] [stdout] running 184 tests
[INFO] [stdout] test builder::tests::storyboard_builder_loop_offset_set ... ok
[INFO] [stdout] test builder::tests::storyboard_builder_loop_offset_default_none ... ok
[INFO] [stdout] test cue::command::tests::cue_command_balloon_surface_serde_roundtrip ... ok
[INFO] [stdout] test cue::command::tests::cue_command_cursor_serde_roundtrip ... ok
[INFO] [stdout] test builder::tests::storyboard_builder_default_equals_new ... ok
[INFO] [stdout] test cue::command::tests::cue_command_newline_serde_roundtrip ... ok
[INFO] [stdout] test cue::command::tests::cue_command_ten_variants ... ok
[INFO] [stdout] test cue::command::tests::cue_command_wait_and_clear_all_serde_roundtrip ... ok
[INFO] [stdout] test cue::command::tests::actor_key_new_display_as_str ... ok
[INFO] [stdout] test cue::command::tests::as_command_carrier_returns_none_for_non_canonical ... ok
[INFO] [stdout] test cue::command::tests::choice_references_additive_wire_form ... ok
[INFO] [stdout] test cue::command::tests::cue_construction ... ok
[INFO] [stdout] test cue::command::tests::barrier_kind_clone_debug_partial_eq ... ok
[INFO] [stdout] test cue::command::tests::barrier_kind_three_variants ... ok
[INFO] [stdout] test cue::command::tests::clear_and_clear_all_are_distinct_commands ... ok
[INFO] [stdout] test cue::command::tests::command_carrier_round_trip_preserves_empty_tokens ... ok
[INFO] [stdout] test cue::command::tests::cue_duration_roundtrip_preserves_value ... ok
[INFO] [stdout] test cue::command::tests::cue_target_window_is_additive_unit_variant ... ok
[INFO] [stdout] test cue::command::tests::cue_payload_and_cue_serde_roundtrip ... ok
[INFO] [stdout] test cue::command::tests::domain_types_serde_roundtrip ... ok
[INFO] [stdout] test cue::command::tests::cue_payload_from_conversions ... ok
[INFO] [stdout] test cue::command::tests::duration_is_uniform_envelope_field_across_all_payloads ... ok
[INFO] [stdout] test cue::command::tests::entity_key_namespaces_are_distinct ... ok
[INFO] [stdout] test builder::tests::document_builder_duplicate_name_last_wins ... ok
[INFO] [stdout] test cue::command::tests::cue_duration_defaults_to_zero_for_legacy_serialized_data ... ok
[INFO] [stdout] test cue::command::tests::command_carrier_wire_form_is_canonical ... ok
[INFO] [stdout] test cue::command::tests::actor_key_hash_eq ... ok
[INFO] [stdout] test error::tests::display_loop_offset_variants ... ok
[INFO] [stdout] test cue::command::tests::entity_key_serde_roundtrip ... ok
[INFO] [stdout] test cue::command::tests::routing_command_serde_roundtrip ... ok
[INFO] [stdout] test cue::command::tests::existing_eight_variants_wire_forms_are_unchanged_by_additive_extension ... ok
[INFO] [stdout] test cue::command::tests::wait_carries_no_action_and_time_lives_in_envelope_duration ... ok
[INFO] [stdout] test cue::command::tests::routing_command_three_variants ... ok
[INFO] [stdout] test error::tests::display_schema_and_keyframe_variants ... ok
[INFO] [stdout] test document::tests::deserialize_with_only_schema_version_defaults_to_empty_maps ... ok
[INFO] [stdout] test error::tests::display_reference_and_entry_variants ... ok
[INFO] [stdout] test cue::command::tests::entity_ref_u64_boundary_serde_roundtrip ... ok
[INFO] [stdout] test error::tests::display_value_out_of_range_variant ... ok
[INFO] [stdout] test runtime::document_store::tests::get_storyboard_found ... ok
[INFO] [stdout] test runtime::document_store::tests::initial_state_is_none ... ok
[INFO] [stdout] test error::tests::display_trigger_variants ... ok
[INFO] [stdout] test runtime::document_store::tests::get_storyboard_not_found ... ok
[INFO] [stdout] test error::tests::error_trait_object_usable ... ok
[INFO] [stdout] test runtime::document_store::tests::overwrite_document ... ok
[INFO] [stdout] test runtime::document_store::tests::store_invalid_document_on_empty_store_keeps_none ... ok
[INFO] [stdout] test runtime::instance_manager::tests::create_instance_initial_state ... ok
[INFO] [stdout] test runtime::document_store::tests::store_valid_document ... ok
[INFO] [stdout] test runtime::instance_manager::tests::check_finish_deadlines_ignores_instances_without_deadline ... ok
[INFO] [stdout] test runtime::instance_manager::tests::create_instance_with_same_group_id_overwrites ... ok
[INFO] [stdout] test runtime::instance_manager::tests::finish_deadline_check ... ok
[INFO] [stdout] test document::tests::deserialize_without_schema_version_fails ... ok
[INFO] [stdout] test runtime::document_store::tests::store_invalid_document_preserves_existing ... ok
[INFO] [stdout] test runtime::instance_manager::tests::finish_deadline_on_terminal_state_rejected ... ok
[INFO] [stdout] test runtime::instance_manager::tests::invalid_transition_on_existing_instance_reports_invalid_group_id ... ok
[INFO] [stdout] test runtime::instance_manager::tests::operations_on_nonexistent_group_id_return_invalid_group_id ... ok
[INFO] [stdout] test runtime::instance_manager::tests::resume_without_pause_start_keeps_end_time ... ok
[INFO] [stdout] test runtime::instance_manager::tests::pause_and_resume ... ok
[INFO] [stdout] test runtime::instance_manager::tests::invalid_transition_rejected ... ok
[INFO] [stdout] test runtime::instance_manager::tests::transition_created_to_playing ... ok
[INFO] [stdout] test runtime::instance_manager::tests::pause_on_created_rejected_keeps_state ... ok
[INFO] [stdout] test runtime::instance_manager::tests::transition_paused_to_playing ... ok
[INFO] [stdout] test runtime::instance_manager::tests::transition_to_cancelled_removes_instance ... ok
[INFO] [stdout] test runtime::instance_manager::tests::transition_to_trimmed_removes_instance ... ok
[INFO] [stdout] test runtime::instance_manager::tests::transition_playing_to_paused ... ok
[INFO] [stdout] test runtime::instance_manager::tests::trigger_states_initialized_sequential_and_unfired ... ok
[INFO] [stdout] test runtime::instance_manager::tests::multiple_independent_instances ... ok
[INFO] [stdout] test runtime::instance_manager::tests::transition_to_compressed_removes_instance ... ok
[INFO] [stdout] test runtime::interpolator::tests::all_30_easing_names_mapping ... ok
[INFO] [stdout] test runtime::interpolator::tests::all_named_easings_no_panic_on_non_finite_t ... ok
[INFO] [stdout] test runtime::interpolator::tests::boundary_t_one ... ok
[INFO] [stdout] test runtime::instance_manager::tests::transition_to_concluded_removes_instance ... ok
[INFO] [stdout] test runtime::instance_manager::tests::infinite_finish_deadline_fires_only_at_infinity ... ok
[INFO] [stdout] test runtime::instance_manager::tests::get_mut_allows_field_mutation ... ok
[INFO] [stdout] test runtime::instance_manager::tests::nan_finish_deadline_never_fires ... ok
[INFO] [stdout] test runtime::interpolator::tests::clamp_above_one ... ok
[INFO] [stdout] test runtime::instance_manager::tests::resume_on_playing_rejected ... ok
[INFO] [stdout] test runtime::interpolator::tests::boundary_t_zero ... ok
[INFO] [stdout] test runtime::instance_manager::tests::nonexistent_group_id_error ... ok
[INFO] [stdout] test runtime::instance_manager::tests::remove_deletes_instance_and_is_noop_for_unknown_id ... ok
[INFO] [stdout] test runtime::interpolator::tests::float_interpolation_from_dynamic_float_and_integer ... ok
[INFO] [stdout] test runtime::interpolator::tests::infinite_progress_clamps_to_endpoints ... ok
[INFO] [stdout] test runtime::interpolator::tests::clamp_below_zero ... ok
[INFO] [stdout] test runtime::interpolator::tests::cubic_bezier_easing ... ok
[INFO] [stdout] test runtime::interpolator::tests::integer_interpolation_saturates_at_i64_bounds ... ok
[INFO] [stdout] test runtime::interpolator::tests::integer_interpolation_with_easing ... ok
[INFO] [stdout] test runtime::interpolator::tests::integer_negative_interpolation_rounds_away_from_zero ... ok
[INFO] [stdout] test runtime::interpolator::tests::integer_rounding ... ok
[INFO] [stdout] test runtime::interpolator::tests::intern_pool_returns_distinct_rc_for_different_values ... ok
[INFO] [stdout] test runtime::interpolator::tests::integer_exact ... ok
[INFO] [stdout] test runtime::interpolator::tests::intern_pool_returns_same_rc_for_equal_values ... ok
[INFO] [stdout] test runtime::interpolator::tests::interpolate_with_pool_shares_rc_across_calls ... ok
[INFO] [stdout] test runtime::interpolator::tests::nan_progress_returns_from_value_for_object ... ok
[INFO] [stdout] test runtime::interpolator::tests::nan_progress_saturates_to_zero_for_integer ... ok
[INFO] [stdout] test runtime::interpolator::tests::object_at_end ... ok
[INFO] [stdout] test runtime::interpolator::tests::parametric_easing_nan_control_points_propagate_without_panic ... ok
[INFO] [stdout] test runtime::loop_controller::tests::advance_loop_with_offset_adds_delay ... ok
[INFO] [stdout] test runtime::interpolator::tests::linear_easing_explicit ... ok
[INFO] [stdout] test runtime::interpolator::tests::object_before_end ... ok
[INFO] [stdout] test runtime::interpolator::tests::interpolate_without_pool_allocates_fresh_rc ... ok
[INFO] [stdout] test runtime::interpolator::tests::float_interpolation_non_numeric_dynamic_falls_back_to_zero ... ok
[INFO] [stdout] test runtime::interpolator::tests::linear_interpolation_default ... ok
[INFO] [stdout] test runtime::interpolator::tests::nan_endpoints_propagate_without_panic ... ok
[INFO] [stdout] test runtime::loop_controller::tests::apply_easing_parametric_cubic_bezier ... ok
[INFO] [stdout] test runtime::loop_controller::tests::advance_loop_updates_fields ... ok
[INFO] [stdout] test runtime::loop_controller::tests::apply_easing_parametric_quadratic_bezier ... ok
[INFO] [stdout] test runtime::loop_controller::tests::generate_delay_deterministic_with_same_seed ... ok
[INFO] [stdout] test runtime::loop_controller::tests::advance_loop_without_offset_no_delay ... ok
[INFO] [stdout] test runtime::loop_controller::tests::generate_delay_min_eq_max_returns_fixed ... ok
[INFO] [stdout] test runtime::loop_controller::tests::generate_delay_within_range ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_all_loops_completed ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_all_loops_completed_overshoot ... ok
[INFO] [stdout] test runtime::interpolator::tests::nan_progress_propagates_nan_for_float ... ok
[INFO] [stdout] test runtime::loop_controller::tests::apply_easing_linear_identity ... ok
[INFO] [stdout] test runtime::interpolator::tests::quadratic_bezier_easing ... ok
[INFO] [stdout] test runtime::interpolator::tests::quadratic_in_easing ... ok
[INFO] [stdout] test runtime::interpolator::tests::object_with_scalar_values_converts_to_dynamic_float ... ok
[INFO] [stdout] test runtime::interpolator::tests::parametric_easing_overshoots_beyond_endpoints ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_one_loop_completed_continue ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_single_loop_conclude ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_with_delay_prevents_multi_skip ... ok
[INFO] [stdout] test runtime::loop_controller::tests::generate_delay_quadratic_out_skews_high ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_within_loop ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_multi_loops_at_once ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::convert_names_to_ids_excludes_unsubscribed_name ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::diff_and_update_ignores_values_for_unsubscribed_names ... ok
[INFO] [stdout] test runtime::loop_controller::tests::should_continue_loop_basic ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::diff_no_change_returns_empty ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_exact_boundary ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_infinite_with_offset_applies_each_loop ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::diff_detects_change ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::convert_names_to_ids_basic ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_loop_count_1_ignores_offset ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::frozen_variable_persists ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::get_variable_name_after_unsubscribe_still_works ... ok
[INFO] [stdout] test runtime::loop_controller::tests::should_continue_loop_infinite ... ok
[INFO] [stdout] test runtime::loop_controller::tests::generate_delay_linear_distribution ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::force_update_last_values_for_conclude ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::frozen_value_preserved_after_unrelated_update ... ok
[INFO] [stdout] test runtime::loop_controller::tests::generate_delay_quadratic_in_skews_low ... ok
[INFO] [stdout] test runtime::loop_controller::tests::should_continue_loop_single ... ok
[INFO] [stdout] test runtime::loop_controller::tests::process_loops_infinite_multi_loops ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::resubscribe_after_unsubscribe_all_gets_new_id ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::subscribe_before_document ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::force_update_ignores_unsubscribed_id ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::collect_current_segment_final_values_after_all_segments_uses_last ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::collect_current_segment_final_values_missing_instance_returns_empty ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::subscribe_returns_sequential_ids ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::unsubscribe_all_clears_subscriptions ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::collect_current_segment_final_values_before_first_segment_is_empty ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::unsubscribe_by_id ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::object_ptr_eq_comparison ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::subscribe_and_get_variable_names ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::collect_final_values ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::effective_time_paused_frozen_at_pause_start ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::get_variable_name_error_on_invalid_id ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::collect_current_segment_final_values_returns_active_segment_final ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::unsubscribe_error_on_already_unsubscribed ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::effective_time_paused_without_pause_start_falls_back_to_current ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::get_variable_name_valid ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_all_for_group_missing_instance_returns_empty ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::effective_time_playing_basic ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_all_for_group_returns_all_variables ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::collect_final_values_unknown_group_returns_empty ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::unsubscribe_error_on_invalid_id ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::resubscribe_after_unsubscribe_gets_new_id ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::get_timeline_returns_some_for_known_variable ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::insert_and_evaluate_float ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::latest_group_id_priority ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_nonexistent_variable ... ok
[INFO] [stdout] test runtime::types::tests::start_result_has_affected_group_ids ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::pause_freezes_value ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::effective_time_with_time_scale ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_all_for_group_ignores_other_groups ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_before_first_segment_returns_from_value ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_removes_entry_when_instance_missing ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_multi_segment_progression ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::evaluate_zero_duration_segment_returns_to_value ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::expired_entry_auto_removal ... ok
[INFO] [stdout] test runtime::types::tests::conflict_error_display ... ok
[INFO] [stdout] test runtime::timeline_manager::tests::remove_entries ... ok
[INFO] [stdout] test runtime::types::tests::conflict_error_contains_group_ids ... ok
[INFO] [stdout] test runtime::instance_manager::tests::resume_with_time_before_pause_start_shrinks_end_time ... ok
[INFO] [stdout] test builder::tests::document_builder_schema_mismatch_fails_validation ... ok
[INFO] [stdout] test runtime::subscription_manager::tests::subscribe_idempotent ... ok
[INFO] [stderr]      Running tests/compile.rs (/opt/rustwide/target/release/deps/compile-1a81955c6b3bc588)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 184 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 65 tests
[INFO] [stdout] test boundary_test::builder_boundary_tests::storyboard_builder_cannot_bypass_compile_validation ... ok
[INFO] [stdout] test boundary_test::keyframe_name_collision_tests::explicit_implicit_name_collision_silently_shadows_user_keyframe ... ok
[INFO] [stdout] test error_test::error_tests::keyframe_cycle_detection ... ok
[INFO] [stdout] test error_test::error_tests::between_delay_exceeds_interval ... ok
[INFO] [stdout] test boundary_test::numeric_boundary_tests::negative_duration_produces_inverted_segment ... ok
[INFO] [stdout] test boundary_test::numeric_boundary_tests::infinite_delay_yields_infinite_segment_times ... ok
[INFO] [stdout] test boundary_test::numeric_boundary_tests::nan_duration_propagates_without_panic ... ok
[INFO] [stdout] test boundary_test::numeric_boundary_tests::nan_times_bypass_overlap_detection ... ok
[INFO] [stdout] test integration_test::compilation_flow::empty_storyboard_compiles ... ok
[INFO] [stdout] test integration_test::compilation_flow::all_variable_types_mixed ... ok
[INFO] [stdout] test boundary_test::numeric_boundary_tests::between_nan_delay_bypasses_inversion_check ... ok
[INFO] [stdout] test integration_test::keyframe_and_trigger::entry_anchored_at_trigger_keyframe ... ok
[INFO] [stdout] test integration_test::keyframe_and_trigger::multiple_keyframe_wait ... ok
[INFO] [stdout] test integration_test::keyframe_and_trigger::trigger_without_at_inherits_previous_entry_time ... ok
[INFO] [stdout] test integration_test::compilation_flow::builder_to_compile_flow ... ok
[INFO] [stdout] test metadata_test::metadata_tests::base_duration_and_total_base_duration ... ok
[INFO] [stdout] test integration_test::compilation_flow::compile_result_serializable ... ok
[INFO] [stdout] test integration_test::compilation_flow::complex_multi_variable_mixed_placement ... ok
[INFO] [stdout] test metadata_test::metadata_tests::interruption_policy_propagated ... ok
[INFO] [stdout] test error_test::error_tests::multiple_errors_accumulated_with_unresolvable_downstream_keyframe ... ok
[INFO] [stdout] test error_test::error_tests::validate_failure_passthrough ... ok
[INFO] [stdout] test metadata_test::metadata_tests::loop_offset_scalar_propagated ... ok
[INFO] [stdout] test integration_test::keyframe_and_trigger::pure_keyframe_with_at ... ok
[INFO] [stdout] test metadata_test::metadata_tests::integer_min_max_converted_to_f64 ... ok
[INFO] [stdout] test metadata_test::metadata_tests::loop_offset_range_propagated ... ok
[INFO] [stdout] test metadata_test::metadata_tests::loop_count_propagated ... ok
[INFO] [stdout] test metadata_test::metadata_tests::loop_offset_default_none_propagated ... ok
[INFO] [stdout] test error_test::error_tests::segment_overlap_detected ... ok
[INFO] [stdout] test serde_test::serde_tests::compiled_segment_instant_transition_serde ... ok
[INFO] [stdout] test boundary_test::numeric_boundary_tests::negative_delay_shifts_segment_before_start_time ... ok
[INFO] [stdout] test boundary_test::numeric_boundary_tests::nan_trigger_start_offset_passes_through ... ok
[INFO] [stdout] test boundary_test::stack_and_capacity_tests::long_dependency_chain_compiles_without_stack_exhaustion ... ok
[INFO] [stdout] test metadata_test::metadata_tests::time_scale_propagated_not_applied ... ok
[INFO] [stdout] test time_resolution_test::between::between_from_start_pseudo_keyframe ... ok
[INFO] [stdout] test metadata_test::metadata_tests::min_max_propagated ... ok
[INFO] [stdout] test time_resolution_test::at_placement::pure_keyframe_without_at_inherits_previous_entry_time ... ok
[INFO] [stdout] test serde_test::serde_tests::optional_fields_skipped_when_absent ... ok
[INFO] [stdout] test metadata_test::metadata_tests::variable_type_hint_integer_with_typewriter ... ok
[INFO] [stdout] test metadata_test::metadata_tests::variable_type_hint_float ... ok
[INFO] [stdout] test serde_test::serde_tests::compiled_storyboard_json_roundtrip ... ok
[INFO] [stdout] test serde_test::serde_tests::full_roundtrip_with_loop_offset_and_triggers ... ok
[INFO] [stdout] test time_resolution_test::sequential::sequential_with_delay ... ok
[INFO] [stdout] test serde_test::serde_tests::variable_type_hint_serde_tagged ... ok
[INFO] [stdout] test time_resolution_test::interaction::sequential_after_at_placement_continues_from_segment_end ... ok
[INFO] [stdout] test transition_test::transition_resolution_tests::from_inferred_from_initial_value ... ok
[INFO] [stdout] test transition_test::transition_resolution_tests::easing_function_preserved ... ok
[INFO] [stdout] test transition_test::transition_resolution_tests::from_inferred_from_integer_initial_as_f64 ... ok
[INFO] [stdout] test time_resolution_test::interaction::out_of_order_at_entries_sorted_by_start_time ... ok
[INFO] [stdout] test transition_test::transition_resolution_tests::from_inferred_from_previous_segment ... ok
[INFO] [stdout] test time_resolution_test::sequential::simple_sequential_single_variable ... ok
[INFO] [stdout] test time_resolution_test::at_placement::at_reference_keyframe ... ok
[INFO] [stdout] test transition_test::transition_resolution_tests::object_type_instant_switch ... ok
[INFO] [stdout] test transition_test::transition_resolution_tests::named_transition_resolved ... ok
[INFO] [stdout] test time_resolution_test::at_placement::at_with_negative_offset ... ok
[INFO] [stdout] test error_test::error_tests::undefined_storyboard_error ... ok
[INFO] [stdout] test time_resolution_test::sequential::start_time_offset ... ok
[INFO] [stdout] test time_resolution_test::at_placement::pure_keyframe_without_at_as_first_entry_falls_back_to_start ... ok
[INFO] [stdout] test time_resolution_test::between::between_with_valid_delay ... ok
[INFO] [stdout] test transition_test::transition_resolution_tests::relative_to_calculation ... ok
[INFO] [stdout] test time_resolution_test::between::between_placement ... ok
[INFO] [stdout] test time_resolution_test::at_placement::at_with_offset ... ok
[INFO] [stdout] test time_resolution_test::sequential::duration_zero_instant_transition ... ok
[INFO] [stderr]      Running tests/cue.rs (/opt/rustwide/target/release/deps/cue-f20a8a0f1c9b96ec)
[INFO] [stdout] test boundary_test::numeric_boundary_tests::json_rejects_nan_literal_at_deserialization_boundary ... ok
[INFO] [stdout] test time_resolution_test::at_placement::at_with_offset_multiple_keyframes ... ok
[INFO] [stdout] test time_resolution_test::sequential::sequential_first_entry_uses_compile_start_time ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 65 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 111 tests
[INFO] [stdout] test runtime_test::broadcast_tests::broadcast_does_not_redeliver_across_timeout_barrier_continuation ... ok
[INFO] [stdout] test runtime_test::broadcast_tests::broadcast_delivers_identical_stream_to_every_sink_at_same_absolute_time ... ok
[INFO] [stdout] test runtime_test::broadcast_tests::is_completed_is_gated_by_final_text_duration ... ok
[INFO] [stdout] test runtime_test::broadcast_tests::stop_discards_remaining_and_halts_further_delivery ... ok
[INFO] [stdout] test runtime_test::broadcast_tests::broadcast_stops_at_barrier_and_resumes_delivery_after_resolve ... ok
[INFO] [stdout] test runtime_test::barrier_tests::skip_barrier_force_resumes_from_waiting ... ok
[INFO] [stdout] test runtime_test::choice_delivery_tests::choice_bag_coexists_with_delivery_stream_and_is_invariant_across_reticks ... ok
[INFO] [stdout] test runtime_test::barrier_tests::resolve_on_non_waiting_state_is_noop ... ok
[INFO] [stdout] test runtime_test::broadcast_tests::tick_with_no_registered_sinks_still_advances_and_completes ... ok
[INFO] [stdout] test runtime_test::barrier_tests::timeout_barrier_keeps_playing_and_auto_resolves_by_continued_ticking ... ok
[INFO] [stdout] test runtime_test::occupancy_horizon_tests::occupancy_horizon_matches_completion_threshold ... ok
[INFO] [stdout] test runtime_test::broadcast_tests::is_completed_is_gated_by_occupancy_horizon_for_trailing_wait ... ok
[INFO] [stdout] test runtime_test::barrier_tests::wait_for_input_barrier_stops_and_resolve_click_resumes ... ok
[INFO] [stdout] test runtime_test::occupancy_horizon_tests::occupancy_horizon_returns_anchor_plus_relative_horizon ... ok
[INFO] [stdout] test runtime_test::preview_tests::late_registered_sink_previews_only_the_rest ... ok
[INFO] [stdout] test runtime_test::barrier_tests::from_schedule_is_equivalent_to_from_sheet ... ok
[INFO] [stdout] test runtime_test::barrier_tests::wait_for_choice_barrier_preloads_choices_and_resolve_choice_resumes ... ok
[INFO] [stdout] test runtime_test::choice_delivery_tests::choice_interleaves_with_newline_and_cursor_in_delivery_stream ... ok
[INFO] [stdout] test runtime_test::preview_tests::default_preview_sink_emits_unchanged ... ok
[INFO] [stdout] test runtime_test::occupancy_horizon_tests::occupancy_horizon_after_stop_is_the_anchor ... ok
[INFO] [stdout] test schedule_test::barrier_already_past_at_exact_absolute_deadline_is_skipped ... ok
[INFO] [stdout] test schedule_test::barrier_resolved_resumes_progress ... ok
[INFO] [stdout] test runtime_test::occupancy_horizon_tests::occupancy_horizon_is_observable_while_waiting_for_choice ... ok
[INFO] [stdout] test schedule_test::choice_barrier_with_negative_timeout_stops_on_arrival ... ok
[INFO] [stdout] test runtime_test::broadcast_tests::broadcast_delivers_each_cue_once_even_when_ticked_repeatedly ... ok
[INFO] [stdout] test runtime_test::preview_tests::preview_arrives_before_first_emit ... ok
[INFO] [stdout] test schedule_test::barrier_timeout_releases_at_exact_absolute_deadline ... ok
[INFO] [stdout] test runtime_test::occupancy_horizon_tests::barrier_free_sheet_completes_at_last_cue ... ok
[INFO] [stdout] test schedule_test::clear_resets_active_barrier ... ok
[INFO] [stdout] test runtime_test::choice_delivery_tests::choices_accumulate_across_ticks_before_choice_barrier ... ok
[INFO] [stdout] test schedule_test::clear_resets_all_state ... ok
[INFO] [stdout] test runtime_test::occupancy_horizon_tests::occupancy_horizon_without_anchor_is_the_relative_horizon ... ok
[INFO] [stdout] test runtime_test::preview_tests::preview_carries_every_upcoming_cue_in_delivery_order ... ok
[INFO] [stdout] test schedule_test::clear_resets_horizon_so_cleared_schedule_is_completed ... ok
[INFO] [stdout] test schedule_test::completion_is_reached_at_exact_occupancy_horizon ... ok
[INFO] [stdout] test schedule_test::entry_offset_accessor_for_all_variants ... ok
[INFO] [stdout] test schedule_test::extend_inserts_multiple_entries ... ok
[INFO] [stdout] test schedule_test::extend_same_offset_payloads_delivered_lifo ... ok
[INFO] [stdout] test schedule_test::occupancy_horizon_of_default_schedule_is_the_anchor ... ok
[INFO] [stdout] test schedule_test::input_barrier_with_timeout_skipped_when_jumped_past ... ok
[INFO] [stdout] test schedule_test::occupancy_horizon_is_invariant_across_ticks ... ok
[INFO] [stdout] test schedule_test::payload_is_delivered_at_exact_absolute_fire_time ... ok
[INFO] [stdout] test schedule_test::occupancy_horizon_without_anchor_is_the_relative_horizon ... ok
[INFO] [stdout] test schedule_test::new_defaults_horizon_to_zero_preserving_legacy_is_completed ... ok
[INFO] [stdout] test schedule_test::multiple_routings_fifo_order ... ok
[INFO] [stdout] test schedule_test::notify_barrier_resolved_noop_when_no_barrier ... ok
[INFO] [stdout] test schedule_test::occupancy_horizon_returns_anchor_plus_relative_horizon ... ok
[INFO] [stdout] test schedule_test::occupancy_horizon_matches_is_completed_threshold ... ok
[INFO] [stdout] test runtime_test::occupancy_horizon_tests::player_reaches_completed_only_at_occupancy_horizon ... ok
[INFO] [stdout] test schedule_test::remaining_and_is_completed ... ok
[INFO] [stdout] test schedule_test::barrier_not_completed_while_active ... ok
[INFO] [stdout] test schedule_test::rounds_down_value_really_rounds_down_when_subtracted ... ok
[INFO] [stdout] test schedule_test::choice_barrier_with_timeout_not_skipped_when_jumped_past ... ok
[INFO] [stdout] test schedule_test::choice_barrier_with_timeout_never_self_releases_only_external_resolve ... ok
[INFO] [stdout] test schedule_test::routing_collected_without_stopping ... ok
[INFO] [stdout] test schedule_test::barrier_stops_progress ... ok
[INFO] [stdout] test schedule_test::routing_not_in_ready ... ok
[INFO] [stdout] test schedule_test::choice_barrier_with_zero_timeout_stops_on_arrival ... ok
[INFO] [stdout] test schedule_test::tick_before_start_time_is_noop ... ok
[INFO] [stdout] test schedule_test::tick_with_nan_time_delivers_all_pending_payloads ... ok
[INFO] [stdout] test schedule_test::tick_with_nan_time_stops_at_barrier_then_normal_tick_recovers ... ok
[INFO] [stdout] test schedule_test::tick_idempotent_same_time ... ok
[INFO] [stdout] test schedule_test::tick_collects_payloads_at_reached_time ... ok
[INFO] [stdout] test schedule_test::tick_collects_multiple_payloads_at_same_time ... ok
[INFO] [stdout] test schedule_test::player_emits_cue_at_sheet_absolute_fire_time ... ok
[INFO] [stdout] test schedule_test::timed_schedule_with_cue_command ... ok
[INFO] [stdout] test schedule_test::timeout_barrier_auto_releases ... ok
[INFO] [stdout] test schedule_test::timeout_barrier_skipped_when_already_past ... ok
[INFO] [stdout] test schedule_test::barrier_resolved_externally_before_timeout ... ok
[INFO] [stdout] test sheet_test::absolute_fire_time_of_every_cue_derives_from_sheet_alone ... ok
[INFO] [stdout] test schedule_test::insert_same_offset_payloads_delivered_fifo ... ok
[INFO] [stdout] test sheet_test::cue_sheet_len ... ok
[INFO] [stdout] test schedule_test::barrier_timeout_auto_releases ... ok
[INFO] [stdout] test schedule_test::wait_for_choice_barrier_resolved_with_choice_id ... ok
[INFO] [stdout] test schedule_test::with_horizon_not_completed_while_barrier_active_even_past_horizon ... ok
[INFO] [stdout] test schedule_test::with_horizon_defers_completion_until_elapsed_time_reaches_horizon ... ok
[INFO] [stdout] test sheet_test::actors_unique_list ... ok
[INFO] [stdout] test sheet_test::absolute_end_time_includes_trailing_wait_duration ... ok
[INFO] [stdout] test sheet_test::absolute_end_time_is_max_of_start_plus_duration_not_last_cue_start ... ok
[INFO] [stdout] test sheet_test::cue_sheet_absolute_start_time_defaults_to_zero ... ok
[INFO] [stdout] test sheet_test::absolute_end_time_of_empty_sheet_is_the_anchor ... ok
[INFO] [stdout] test sheet_test::cue_sheet_deserializes_without_absolute_start_time_as_zero ... ok
[INFO] [stdout] test sheet_test::cue_sheet_empty ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_completes_exactly_at_sheet_absolute_end_time ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_duration_uniform_across_every_command_variant ... ok
[INFO] [stdout] test sheet_test::cue_sheet_new_with_nan_start_time_does_not_panic ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_not_completed_until_occupancy_horizon_reached ... ok
[INFO] [stdout] test schedule_test::routing_before_barrier_collected_then_stops ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_of_empty_sheet_is_immediately_completed ... ok
[INFO] [stdout] test sheet_test::cue_sheet_serde_roundtrip ... ok
[INFO] [stdout] test schedule_test::tick_absolute_time_to_relative_offset ... ok
[INFO] [stdout] test sheet_test::cue_sheet_sorts_by_start_time ... ok
[INFO] [stdout] test sheet_test::cue_sheet_stable_sort_preserves_equal_start_time_order ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_carries_finite_duration_untransformed ... ok
[INFO] [stdout] test sink_test::dummy_presenter_selects_only_its_relevant_cues_by_relevance ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_carries_wait_duration_without_action ... ok
[INFO] [stdout] test tick_last_result_test::deprecated_update_still_works ... ok
[INFO] [stdout] test sink_test::cue_target_of_classifies_every_variant ... ok
[INFO] [stdout] test tick_last_result_test::tick_last_result_equivalent_to_update ... ok
[INFO] [stdout] test sink_test::custom_type_level_none_defers_to_consumer_name_self_selection ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_clamps_non_finite_and_negative_duration_into_envelope_and_horizon ... ok
[INFO] [stdout] test tick_last_result_test::last_result_idempotent_without_tick ... ok
[INFO] [stdout] test sheet_test::stamping_absolute_start_time_leaves_relative_times_untouched ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_preserves_leading_wait ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_anchors_schedule_at_absolute_start_time ... ok
[INFO] [stdout] test sheet_test::to_talk_schedule_routes_barrier_and_routing_not_skipping ... ok
[INFO] [stdout] test tick_last_result_test::last_result_empty_before_first_tick ... ok
[INFO] [stdout] test tick_last_result_test::tick_updates_last_result ... ok
[INFO] [stdout] test schedule_test::tick_collects_all_past_payloads_on_jump ... ok
[INFO] [stdout] test sheet_test::filter_by_actor ... ok
[INFO] [stdout] test sheet_test::cue_sheet_serde_roundtrip_preserves_absolute_start_time ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 111 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/general.rs (/opt/rustwide/target/release/deps/general-3f2c9b11fc932562)
[INFO] [stdout] 
[INFO] [stdout] running 64 tests
[INFO] [stdout] test builder_test::document_builder_tests::build_with_all_components ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::bool_roundtrip ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::btreemap_deterministic_order ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::float_negative_zero_eq_but_hash_differs ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::float_nan_not_equal_to_itself ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::hash_consistent_for_equal_values ... ok
[INFO] [stdout] test core_types_test::document_variable::variable_tests::integer_variable_with_typewriter_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::null_roundtrip ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::string_roundtrip ... ok
[INFO] [stdout] test core_types_test::document_variable::document_tests::document_with_variables_json_roundtrip ... ok
[INFO] [stdout] test builder_test::document_builder_tests::build_with_invalid_data_returns_errors ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::array_roundtrip ... ok
[INFO] [stdout] test builder_test::storyboard_builder_tests::custom_meta_fields ... ok
[INFO] [stdout] test core_types_test::easing_transition::easing_tests::parametric_cubic_bezier_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::easing_transition::easing_tests::all_31_easing_names_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::integer_roundtrip ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::map_roundtrip ... ok
[INFO] [stdout] test core_types_test::document_variable::document_tests::minimal_document_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::document_variable::variable_tests::float_variable_json_roundtrip ... ok
[INFO] [stdout] test builder_test::storyboard_builder_tests::entry_added ... ok
[INFO] [stdout] test core_types_test::dynamic_value::dynamic_value_tests::float_roundtrip ... ok
[INFO] [stdout] test builder_test::document_builder_tests::minimal_build_ok ... ok
[INFO] [stdout] test core_types_test::easing_transition::easing_tests::easing_function_named_untagged_deserialize ... ok
[INFO] [stdout] test core_types_test::easing_transition::easing_tests::easing_function_parametric_untagged_deserialize ... ok
[INFO] [stdout] test core_types_test::easing_transition::transition_tests::transition_def_relative_to_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::easing_transition::transition_tests::transition_def_delay_default_json ... ok
[INFO] [stdout] test core_types_test::easing_transition::transition_tests::transition_def_full_fields_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::document_variable::variable_tests::integer_variable_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::easing_transition::easing_tests::parametric_quadratic_bezier_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::easing_transition::transition_tests::transition_ref_inline_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::document_variable::variable_tests::object_variable_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::easing_transition::transition_tests::transition_ref_named_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::keyframe_ref_multiple_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::keyframe_ref_single_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::keyframe_ref_with_offset_multiple_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::keyframe_ref_with_offset_single_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::interruption_policy_all_variants_json_roundtrip ... ok
[INFO] [stdout] test builder_test::storyboard_builder_tests::default_values ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::storyboard_default_values_json ... ok
[INFO] [stdout] test core_types_test::easing_transition::transition_tests::transition_value_dynamic_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::storyboard_entry_at_pattern_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::easing_transition::transition_tests::transition_value_scalar_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::playback_tests::playback_state_all_variants_json_roundtrip ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::playback_tests::schedule_request_json_roundtrip ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::object_transition_dynamic_value ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::value_out_of_range_v12_error ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::pure_keyframe_only_storyboard ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::storyboard_entry_chain_pattern_json_roundtrip ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::empty_storyboard_ok ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::storyboard_entry_pure_keyframe_json_roundtrip ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::keyframe_ref_with_offset ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::at_start_keyword ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::type_mismatch_v13_error ... ok
[INFO] [stdout] test integration_test::e2e_full_flow::e2e_tests::builder_validate_serialize_deserialize_revalidate ... ok
[INFO] [stdout] test integration_test::e2e_full_flow::e2e_tests::implicit_keyframe_chain_pattern ... ok
[INFO] [stderr]      Running tests/runtime.rs (/opt/rustwide/target/release/deps/runtime-515c2d2488dab549)
[INFO] [stdout] test integration_test::e2e_full_flow::feature_json_enabled_by_default ... ok
[INFO] [stdout] test integration_test::serialization_round_trip::json_integration_tests::interruption_policy_snake_case_in_json ... ok
[INFO] [stdout] test integration_test::serialization_round_trip::json_integration_tests::complete_document_json_roundtrip ... ok
[INFO] [stdout] test integration_test::serialization_round_trip::json_integration_tests::easing_name_snake_case_in_json ... ok
[INFO] [stdout] test core_types_test::storyboard_playback::storyboard_tests::storyboard_entry_between_pattern_json_roundtrip ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::typewriter_variable_with_transition ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::bezier_easing_inline_transition ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::delay_only_instant_transition ... ok
[INFO] [stdout] test integration_test::domain_integration::edge_case_tests::multiple_keyframe_wait ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 64 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 149 tests
[INFO] [stdout] test conflict_resolution_test::conflict_detection::conflict_detection_boundaries::overlap_with_multiple_instances_affects_all ... ok
[INFO] [stdout] test conflict_resolution_test::error_handling::never_strategy::never_rejects_start_with_conflict ... ok
[INFO] [stdout] test conflict_resolution_test::error_handling::never_strategy::never_new_instance_cleaned_up_on_conflict ... ok
[INFO] [stdout] test conflict_resolution_test::conflict_detection::conflict_detection::conflict_detected_on_same_variable ... ok
[INFO] [stdout] test conflict_resolution_test::error_handling::conflict_terminated_parent_triggers::triggered_child_excludes_parent_from_conflict ... ok
[INFO] [stdout] test conflict_resolution_test::conflict_detection::conflict_detection_boundaries::paused_instance_still_conflicts ... ok
[INFO] [stdout] test conflict_resolution_test::conflict_detection::conflict_detection::no_conflict_after_natural_end ... ok
[INFO] [stdout] test conflict_resolution_test::error_handling::never_strategy::never_partial_conflict_rejects_entirely ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::cancel_strategy::cancel_freezes_at_interrupt_time ... ok
[INFO] [stdout] test conflict_resolution_test::error_handling::conflict_terminated_parent_triggers::conflict_terminated_parent_trigger_never_fires ... ok
[INFO] [stdout] test conflict_resolution_test::conflict_detection::conflict_detection::no_conflict_when_different_variables ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::cancel_strategy::cancel_group_id_all_variables ... ok
[INFO] [stdout] test conflict_resolution_test::conflict_detection::conflict_detection::no_conflict_when_no_existing_instances ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::conclude_strategy::conclude_jumps_to_current_segment_final ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::compress_strategy::compress_jumps_to_all_final_values ... ok
[INFO] [stdout] test conflict_resolution_test::conflict_detection::conflict_detection_boundaries::time_shifted_start_on_same_variable_still_conflicts ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::display_float ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::display_integer ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::float_nan_is_never_equal_to_itself ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::integer_variant ... ok
[INFO] [stdout] test core_types_test::instance_state_properties::from_policy_mapping ... ok
[INFO] [stdout] test core_types_test::instance_state_properties::from_policy_results_are_terminal ... ok
[INFO] [stdout] test core_types_test::instance_state_properties::terminal_states ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::display_object ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::conclude_strategy::default_policy_is_conclude ... ok
[INFO] [stdout] test core_types_test::instance_state_self_transitions::paused_to_paused_rejected ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::trim_strategy::trim_cuts_at_interrupt_time ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::edge_cases::mixed_policies_simultaneous_conflict ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::compressed_to_playing_rejected ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::float_variant ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::concluded_to_concluded_rejected ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::cross_variant_never_equal ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::concluded_to_playing_rejected ... ok
[INFO] [stdout] test core_types_test::instance_state_self_transitions::created_to_created_rejected ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::playing_to_compressed ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::playing_to_concluded ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::paused_to_cancelled ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::paused_to_compressed ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::playing_to_cancelled ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::paused_to_concluded ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::cancelled_to_playing_rejected ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::paused_to_trimmed ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::playing_to_trimmed ... ok
[INFO] [stdout] test conflict_resolution_test::termination_strategy::edge_cases::no_side_effects_when_no_conflict ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::paused_to_playing ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::compile_error_display ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::from_vec_dola_error_conversion ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::invalid_variable_id_display ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::zero_duration_with_loop_display ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::playing_to_created_rejected ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::playing_to_paused ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::trimmed_to_playing_rejected ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::runtime_error_is_std_error ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::storyboard_not_found_display ... ok
[INFO] [stdout] test facade_test::diff_delivery::document_replacement::invalid_document_preserves_existing ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::too_short_duration_with_infinite_loop_display ... ok
[INFO] [stdout] test core_types_test::start_result_tests::start_result_fields ... ok
[INFO] [stdout] test core_types_test::start_result_tests::start_result_infinity ... ok
[INFO] [stdout] test facade_test::load_start::full_playback_cycle::calculate_end_time_does_not_create_instance ... ok
[INFO] [stdout] test facade_test::diff_delivery::subscription_via_facade::unsubscribe_all_stops_diff_delivery ... ok
[INFO] [stdout] test facade_test::load_start::full_playback_cycle::load_start_update_natural_end ... ok
[INFO] [stdout] test facade_test::load_start::full_playback_cycle::start_without_document_fails ... ok
[INFO] [stdout] test facade_test::load_start::full_playback_cycle::storyboard_not_found_error ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::calculate_end_time_nonexistent_storyboard_fails ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::calculate_end_time_short_duration_infinite_loop_fails ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::calculate_end_time_with_zero_loop_count_fails ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::calculate_end_time_without_document_fails ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::pause_on_invalid_group_id_fails ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::calculate_end_time_zero_duration_infinite_loop_fails ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::invalid_group_id_display ... ok
[INFO] [stdout] test facade_test::diff_delivery::subscription_via_facade::default_is_equivalent_to_new ... ok
[INFO] [stdout] test facade_test::diff_delivery::document_replacement::same_variable_carries_over_value ... ok
[INFO] [stdout] test core_types_test::runtime_error_tests::invalid_loop_count_display ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::resume_on_invalid_group_id_fails ... ok
[INFO] [stdout] test facade_test::load_start::time_scale_boundary::time_scale_zero_instance_never_concludes_naturally ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::start_with_negative_loop_count_fails ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::start_with_zero_loop_count_fails ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::zero_duration_without_loop_is_allowed ... ok
[INFO] [stdout] test facade_test::load_start::time_scale_boundary::negative_time_scale_start_succeeds_and_concludes_immediately ... ok
[INFO] [stdout] test facade_test::load_start::time_scale_boundary::calculate_end_time_with_zero_time_scale_is_infinite ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::cancel_after_conclude_fails ... ok
[INFO] [stdout] test facade_test::load_start::time_scale_boundary::time_scale_zero_start_succeeds_with_infinite_end_time ... ok
[INFO] [stdout] test facade_test::load_start::time_scale_boundary::time_scale_zero_with_zero_duration_yields_nan_end_time ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::cancel_freezes_current_value ... ok
[INFO] [stdout] test facade_test::diff_delivery::subscription_via_facade::unsubscribe_invalid_id_fails ... ok
[INFO] [stdout] test facade_test::diff_delivery::subscription_via_facade::unsubscribe_stops_diff_delivery ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::object_variant_different_rc_not_eq ... ok
[INFO] [stdout] test core_types_test::evaluated_value_tests::object_variant_ptr_eq ... ok
[INFO] [stdout] test core_types_test::instance_state_self_transitions::playing_to_playing_rejected ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::cancel_on_invalid_group_id_fails ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::conclude_delivers_final_values ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::finish_after_conclude_fails ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::conclude_on_invalid_group_id_fails ... ok
[INFO] [stdout] test loop_integration_test::end_time_unified_for_single_and_infinite ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::double_conclude_fails ... ok
[INFO] [stdout] test loop_integration_test::finite_loop_3_cycles ... ok
[INFO] [stdout] test facade_test::update_flow::concurrent_playback::two_storyboards_on_different_variables ... ok
[INFO] [stdout] test loop_integration_test::loop_count_1_compatible_with_existing_behavior ... ok
[INFO] [stdout] test loop_integration_test::short_duration_finite_loop_allowed ... ok
[INFO] [stdout] test loop_integration_test::multi_loop_batch_processing ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::finish_delayed_conclude ... ok
[INFO] [stdout] test facade_test::update_flow::pause_resume_cycle::pause_freezes_value_and_resume_continues ... ok
[INFO] [stdout] test loop_integration_test::short_duration_infinite_loop_error ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_cancel_during_delay ... ok
[INFO] [stdout] test facade_test::termination::conclude_cancel_finish::finish_on_invalid_group_id_fails ... ok
[INFO] [stdout] test loop_integration_test::cancel_during_loop_stops_immediately ... ok
[INFO] [stdout] test loop_integration_test::pause_during_loop_resumes_correctly ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::compile_integration_tests::compile_with_range_loop_offset ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::compile_integration_tests::compile_loop_offset_preserved_across_serialization ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::compile_integration_tests::compile_with_scalar_loop_offset ... ok
[INFO] [stdout] test loop_integration_test::infinite_loop_continues_until_cancel ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::compile_integration_tests::compile_without_loop_offset ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_infinite_loop_with_offset_continues ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_without_offset_backward_compatible ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_with_fixed_delay_extends_playback ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::min_default_to_zero ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::easing_default_to_linear ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::object_form_round_trip ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::object_form_with_all_fields ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::parametric_easing_round_trip ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::storyboard_round_trip_with_loop_offset ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::storyboard_with_object_loop_offset ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::storyboard_with_scalar_loop_offset ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::scalar_shorthand_round_trip ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::storyboard_without_loop_offset ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::storyboard_round_trip_without_loop_offset_skips_field ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::nan_boundary_tests::nan_range_max_passes_validation_even_with_positive_min ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::v14_negative_min_error ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_loop_count_1_ignores_offset ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_f64_precision_many_loops ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_no_offset_natural_end ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::no_offset_ok ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::v15_negative_scalar_error ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::v16_range_inverted_error ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::valid_range_offset_ok ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::v15_negative_max_error ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::zero_offset_ok ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::nan_boundary_tests::nan_range_min_passes_validation ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_large_delay ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::nan_boundary_tests::nan_scalar_loop_offset_passes_validation ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::min_equals_max_ok ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_serde::serde_tests::scalar_shorthand_deserialize ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_validation::validation_tests::valid_scalar_offset_ok ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::created_to_concluded_rejected ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::created_to_paused_rejected ... ok
[INFO] [stdout] test core_types_test::instance_state_transitions::created_to_playing ... ok
[INFO] [stdout] test facade_test::load_start::start_error_paths::start_zero_duration_infinite_loop_fails ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_extreme_small_delay ... ok
[INFO] [stdout] test loop_offset_test::loop_offset_compile::e2e_tests::e2e_pause_during_delay_preserves_timing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 149 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/trigger.rs (/opt/rustwide/target/release/deps/trigger-9380440326ab470d)
[INFO] [stdout] running 33 tests
[INFO] [stdout] test runtime_test::loop_trigger_tests::trigger_refires_each_loop ... ok
[INFO] [stdout] test compile_test::compile_trigger_tests::multiple_triggers_sorted_by_fire_time ... ok
[INFO] [stdout] test runtime_test::trigger_execution_tests::trigger_starts_child_storyboard ... ok
[INFO] [stdout] test runtime_test::trigger_execution_tests::trigger_fires_only_once_per_loop ... ok
[INFO] [stdout] test runtime_test::trigger_execution_tests::trigger_with_start_offset ... ok
[INFO] [stdout] test runtime_test::e2e_tests::full_lifecycle_with_triggers ... ok
[INFO] [stdout] test runtime_test::loop_trigger_tests::infinite_loop_trigger_fires_each_cycle ... ok
[INFO] [stdout] test compile_test::compile_trigger_tests::trigger_with_start_offset_compiled ... ok
[INFO] [stdout] test validation_test::validation_tests::v14t_self_reference_detected ... ok
[INFO] [stdout] test validation_test::validation_tests::v15t_cycle_a_b_a ... ok
[INFO] [stdout] test validation_test::validation_tests::v15t_cycle_a_b_c_a ... ok
[INFO] [stdout] test validation_test::validation_tests::v14t_self_reference_also_reports_cycle ... ok
[INFO] [stdout] test validation_test::validation_tests::v15t_diamond_join_is_not_a_cycle ... ok
[INFO] [stdout] test validation_test::validation_tests::v15t_cycle_path_is_closed_and_contains_members ... ok
[INFO] [stdout] test validation_test::validation_tests::v15t_long_chain_200_storyboards_validates_ok ... ok
[INFO] [stdout] test compile_test::compile_trigger_tests::trigger_after_keyframe_fire_time ... ok
[INFO] [stdout] test validation_test::validation_tests::v16t_trigger_with_transition_is_error ... ok
[INFO] [stdout] test validation_test::validation_tests::v16t_trigger_with_variable_is_error ... ok
[INFO] [stdout] test validation_test::validation_tests::v18t_trigger_target_not_found ... ok
[INFO] [stdout] test validation_test::validation_tests::v9_no_variable_no_trigger_is_error ... ok
[INFO] [stdout] test validation_test::validation_tests::v9_trigger_only_entry_is_valid ... ok
[INFO] [stdout] test serde_test::serde_tests::compiled_trigger_no_offset_serde_roundtrip ... ok
[INFO] [stdout] test compile_test::compile_trigger_tests::trigger_at_start_fire_time ... ok
[INFO] [stdout] test compile_test::compile_trigger_tests::trigger_fire_time_with_start_time_offset ... ok
[INFO] [stdout] test runtime_test::e2e_tests::parent_cancel_does_not_affect_child ... ok
[INFO] [stdout] test compile_test::compile_trigger_tests::trigger_does_not_affect_total_base_duration ... ok
[INFO] [stdout] test runtime_test::trigger_execution_tests::update_result_contains_changes_and_triggered ... ok
[INFO] [stdout] test serde_test::serde_tests::trigger_entry_full_json_roundtrip ... ok
[INFO] [stdout] test serde_test::serde_tests::compiled_trigger_serde_roundtrip ... ok
[INFO] [stdout] test serde_test::serde_tests::trigger_entry_absent_fields_deserialize_to_none ... ok
[INFO] [stdout] test serde_test::serde_tests::trigger_entry_minimal_json_roundtrip ... ok
[INFO] [stdout] test runtime_test::e2e_tests::trigger_chain_a_b_c ... ok
[INFO] [stdout] test validation_test::validation_tests::v15t_no_cycle_chain_is_valid ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/validation.rs (/opt/rustwide/target/release/deps/validation-fc3c148a19b064e6)
[INFO] [stdout] 
[INFO] [stdout] running 39 tests
[INFO] [stdout] test keyframe_test::v9_tests::empty_entry_without_keyframe_error ... ok
[INFO] [stdout] test keyframe_test::v6_ref_shape_tests::at_with_offset_single_undefined_detected ... ok
[INFO] [stdout] test keyframe_test::v6_ref_shape_tests::between_undefined_from_and_to_both_detected ... ok
[INFO] [stdout] test keyframe_test::v6_tests::at_start_reserved_keyframe_ok ... ok
[INFO] [stdout] test schema_test::v3_tests::reserved_keyframe_start_rejected ... ok
[INFO] [stdout] test keyframe_test::v6_ref_shape_tests::at_with_offset_multiple_all_known_ok ... ok
[INFO] [stdout] test keyframe_test::v6_tests::forward_reference_ok ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v11_tests::to_and_relative_to_mutually_exclusive ... ok
[INFO] [stdout] test schema_test::error_accumulation_tests::validate_collects_errors_from_multiple_rules_in_one_pass ... ok
[INFO] [stdout] test keyframe_test::v8_tests::at_and_between_mutually_exclusive ... ok
[INFO] [stdout] test keyframe_test::v6_tests::implicit_keyframe_forward_reference_ok ... ok
[INFO] [stdout] test schema_test::v1_tests::schema_version_1_0_ok ... ok
[INFO] [stdout] test schema_test::v1_tests::schema_version_mismatch ... ok
[INFO] [stdout] test schema_test::v2_tests::duplicate_keyframe_detected ... ok
[INFO] [stdout] test schema_test::v4_tests::undefined_variable_detected ... ok
[INFO] [stdout] test keyframe_test::v6_tests::undefined_keyframe_reference_detected ... ok
[INFO] [stdout] test schema_test::loop_count_gap_tests::invalid_loop_count_passes_document_validation ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_tests::initial_above_max_error ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_tests::transition_to_out_of_range_error ... ok
[INFO] [stdout] test transition_test::transition_v13_nan::v12_nan_tests::nan_initial_passes_range_validation ... ok
[INFO] [stdout] test schema_test::v5_tests::undefined_transition_detected ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_boundary_tests::i64_variable_transition_to_out_of_range_error ... ok
[INFO] [stdout] test transition_test::transition_v13_nan::v13_tests::float_variable_with_dynamic_from_error ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_boundary_tests::i64_variable_initial_below_min_error ... ok
[INFO] [stdout] test transition_test::transition_v13_nan::v13_tests::object_variable_with_scalar_to_error ... ok
[INFO] [stdout] test transition_test::transition_v13_nan::v13_tests::float_variable_with_dynamic_to_error ... ok
[INFO] [stdout] test transition_test::transition_v7_v10::v10_relative_easing_tests::object_with_easing_error ... ok
[INFO] [stdout] test transition_test::transition_v7_v10::v10_relative_easing_tests::object_with_relative_to_error ... ok
[INFO] [stdout] test transition_test::transition_v7_v10::v10_tests::object_with_from_error ... ok
[INFO] [stdout] test transition_test::transition_v7_v10::v10_tests::object_with_scalar_to_error ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_boundary_tests::values_exactly_at_min_max_are_valid ... ok
[INFO] [stdout] test transition_test::transition_v7_v10::v7_tests::transition_without_variable_error ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_tests::i64_variable_initial_out_of_range ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_tests::initial_below_min_error ... ok
[INFO] [stdout] test transition_test::transition_v13_nan::v12_nan_tests::nan_bounds_pass_range_validation ... ok
[INFO] [stdout] test transition_test::transition_v13_nan::v12_nan_tests::nan_transition_value_passes_range_validation ... ok
[INFO] [stdout] test keyframe_test::v6_ref_shape_tests::at_multiple_with_one_undefined_detected ... ok
[INFO] [stdout] test transition_test::transition_v11_v12::v12_boundary_tests::transition_from_out_of_range_error ... ok
[INFO] [stderr]    Doc-tests dola
[INFO] [stdout] test keyframe_test::v9_tests::pure_keyframe_entry_ok ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/runtime/facade.rs - runtime::facade::DolaRuntime (line 24) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.30s; merged doctests compilation took 0.29s
[INFO] running `Command { std: "docker" "inspect" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65", kill_on_drop: false }`
[INFO] [stdout] 82a5752aa29665c5fa41d13b85dc5898c63b790f2b42962c14b4f34205708d65
