[INFO] fetching crate tympan-aspl 0.1.0...
[INFO] testing tympan-aspl-0.1.0 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate tympan-aspl 0.1.0 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate tympan-aspl 0.1.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tympan-aspl 0.1.0
[INFO] tweaked toml for crates.io crate tympan-aspl 0.1.0 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tympan-aspl 0.1.0 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 tympan-aspl 0.1.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.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 assert_no_alloc v1.1.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0
[INFO] running `Command { std: "docker" "start" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0", 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" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0" "/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" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0", 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" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling tympan-aspl v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1.38s
[INFO] running `Command { std: "docker" "inspect" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0", 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" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0" "/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 assert_no_alloc v1.1.2
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling tympan-aspl v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 22.87s
[INFO] running `Command { std: "docker" "inspect" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0", 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" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0" "/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.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/tympan_aspl-5e5a9ede15d7f17c)
[INFO] [stdout] 
[INFO] [stdout] running 269 tests
[INFO] [stdout] test bundle::plist::tests::escape_xml_handles_all_five_entities ... ok
[INFO] [stdout] test bundle::plist::tests::generated_plist_embeds_identity_and_factory_values ... ok
[INFO] [stdout] test bundle::plist::tests::builder_setters_override_defaults ... ok
[INFO] [stdout] test bundle::plist::tests::audioserver_type_uuid_matches_core_audio ... ok
[INFO] [stdout] test bundle::plist::tests::generated_plist_has_xml_and_doctype_preamble ... ok
[INFO] [stdout] test bundle::plist::tests::new_defaults_optional_fields_to_the_identifier ... ok
[INFO] [stdout] test bundle::plist::tests::string_values_are_xml_escaped ... ok
[INFO] [stdout] test device::tests::device_id_round_trips ... ok
[INFO] [stdout] test device::tests::device_pairs_id_and_spec ... ok
[INFO] [stdout] test device::tests::identity_fields_round_trip ... ok
[INFO] [stdout] test bundle::plist::tests::key_value_pairs_are_balanced ... ok
[INFO] [stdout] test device::tests::loopback_has_both_streams ... ok
[INFO] [stdout] test bundle::plist::tests::generated_plist_embeds_all_cfbundle_keys ... ok
[INFO] [stdout] test device::tests::new_device_starts_streamless_at_48k ... ok
[INFO] [stdout] test device::tests::output_only_device_is_not_loopback ... ok
[INFO] [stdout] test dispatch::tests::device_identity_comes_from_the_spec ... ok
[INFO] [stdout] test device::tests::with_setters_replace_streams ... ok
[INFO] [stdout] test bundle::plist::tests::generated_plist_wires_the_audioserver_type_uuid ... ok
[INFO] [stdout] test dispatch::tests::device_is_alive_and_reflects_running_state ... ok
[INFO] [stdout] test dispatch::tests::device_latency_and_safety_offset_are_zero ... ok
[INFO] [stdout] test dispatch::tests::device_owner_is_the_plugin ... ok
[INFO] [stdout] test dispatch::tests::device_sample_rate_tracks_runtime_state ... ok
[INFO] [stdout] test dispatch::tests::device_state_from_spec_is_idle_at_nominal_rate ... ok
[INFO] [stdout] test dispatch::tests::device_streams_filter_by_scope ... ok
[INFO] [stdout] test dispatch::tests::device_transport_type_is_virtual ... ok
[INFO] [stdout] test dispatch::tests::device_zero_timestamp_period_is_one_second_of_frames ... ok
[INFO] [stdout] test dispatch::tests::is_property_settable_rejects_unknown_object_and_property ... ok
[INFO] [stdout] test dispatch::tests::only_the_sample_rate_is_settable ... ok
[INFO] [stdout] test dispatch::tests::plugin_box_list_is_empty ... ok
[INFO] [stdout] test dispatch::tests::plugin_device_list_and_owned_objects_point_at_the_device ... ok
[INFO] [stdout] test dispatch::tests::plugin_class_and_base_class ... ok
[INFO] [stdout] test dispatch::tests::property_data_size_propagates_errors ... ok
[INFO] [stdout] test dispatch::tests::set_read_only_property_is_illegal ... ok
[INFO] [stdout] test dispatch::tests::set_rejects_unknown_object_and_property ... ok
[INFO] [stdout] test dispatch::tests::set_sample_rate_applies_a_supported_rate ... ok
[INFO] [stdout] test dispatch::tests::property_data_size_matches_the_value_size ... ok
[INFO] [stdout] test dispatch::tests::set_sample_rate_rejects_an_undersized_buffer ... ok
[INFO] [stdout] test dispatch::tests::plugin_has_no_owner ... ok
[INFO] [stdout] test driver::tests::add_ref_release_delegate_to_refcount ... ok
[INFO] [stdout] test dispatch::tests::stream_class_owner_and_direction ... ok
[INFO] [stdout] test driver::tests::device_is_forwarded_from_the_user_driver ... ok
[INFO] [stdout] test driver::tests::double_initialize_is_illegal ... ok
[INFO] [stdout] test driver::tests::full_lifecycle_round_trip ... ok
[INFO] [stdout] test driver::tests::default_matches_new ... ok
[INFO] [stdout] test driver::tests::initialize_transitions_and_forwards_to_user ... ok
[INFO] [stdout] test driver::tests::new_starts_uninitialized_with_refcount_one ... ok
[INFO] [stdout] test dispatch::tests::set_sample_rate_rejects_an_unsupported_rate ... ok
[INFO] [stdout] test driver::tests::process_io_after_start_copies_input_to_output ... ok
[INFO] [stdout] test dispatch::tests::stream_starting_channel_comes_from_the_spec ... ok
[INFO] [stdout] test dispatch::tests::stream_formats_come_from_the_stream_spec ... ok
[INFO] [stdout] test driver::tests::stop_without_start_is_illegal ... ok
[INFO] [stdout] test dispatch::tests::unknown_object_is_bad_object ... ok
[INFO] [stdout] test driver::tests::start_io_transitions_and_forwards_to_user ... ok
[INFO] [stdout] test driver::tests::start_failure_rolls_state_back_to_initialized ... ok
[INFO] [stdout] test error::tests::debug_renders_non_fourcc_errors_numerically ... ok
[INFO] [stdout] test error::tests::debug_renders_ok_specially ... ok
[INFO] [stdout] test dispatch::tests::unknown_selector_is_unknown_property ... ok
[INFO] [stdout] test error::tests::debug_renders_fourcc_errors ... ok
[INFO] [stdout] test error::tests::error_codes_classify_correctly ... ok
[INFO] [stdout] test driver::tests::info_reflects_associated_constants ... ok
[INFO] [stdout] test error::tests::layout_is_transparent_i32 ... ok
[INFO] [stdout] test dispatch::tests::plugin_identity_comes_from_driver_info ... ok
[INFO] [stdout] test driver::tests::type_erased_dispatch_drives_full_lifecycle ... ok
[INFO] [stdout] test driver::tests::start_requires_initialized ... ok
[INFO] [stdout] test driver::tests::stop_io_returns_to_initialized ... ok
[INFO] [stdout] test error::tests::ok_classifies_correctly ... ok
[INFO] [stdout] test error::tests::ok_method_converts_to_result ... ok
[INFO] [stdout] test error::tests::result_flattens_back_to_status ... ok
[INFO] [stdout] test error::tests::round_trips_through_i32 ... ok
[INFO] [stdout] test format::tests::float32_48k_stereo_has_expected_fields ... ok
[INFO] [stdout] test driver::tests::process_io_requires_running_state ... ok
[INFO] [stdout] test format::tests::format_linear_pcm_constant_is_lpcm ... ok
[INFO] [stdout] test format::tests::int24_packs_into_three_bytes ... ok
[INFO] [stdout] test format::tests::int32_uses_four_byte_words ... ok
[INFO] [stdout] test format::tests::int16_44k1_mono_has_expected_fields ... ok
[INFO] [stdout] test format::tests::negotiation_variants_distinguish ... ok
[INFO] [stdout] test format::tests::non_interleaved_float32_is_not_canonical ... ok
[INFO] [stdout] test format::tests::only_float32_interleaved_is_canonical ... ok
[INFO] [stdout] test error::tests::error_constants_match_fourcc_values ... ok
[INFO] [stdout] test format::tests::sample_format_flag_sets_are_distinct ... ok
[INFO] [stdout] test format::tests::sample_format_round_trips_through_constructors ... ok
[INFO] [stdout] test fourcc::tests::debug_wraps_display ... ok
[INFO] [stdout] test fourcc::tests::display_falls_back_to_hex_for_unprintable ... ok
[INFO] [stdout] test fourcc::tests::display_quotes_printable_codes ... ok
[INFO] [stdout] test fourcc::tests::layout_is_transparent_u32 ... ok
[INFO] [stdout] test fourcc::tests::ordering_is_by_raw_value ... ok
[INFO] [stdout] test fourcc::tests::printable_detection ... ok
[INFO] [stdout] test fourcc::tests::round_trips_through_bytes ... ok
[INFO] [stdout] test fourcc::tests::round_trips_through_u32 ... ok
[INFO] [stdout] test fourcc::tests::zero_is_zero ... ok
[INFO] [stdout] test io::tests::io_buffer_reports_slice_lengths ... ok
[INFO] [stdout] test io::tests::io_operation_constants_match_core_audio_codes ... ok
[INFO] [stdout] test io::tests::io_operation_layout_is_transparent ... ok
[INFO] [stdout] test io::tests::only_process_operations_are_processing ... ok
[INFO] [stdout] test io::tests::output_only_device_sees_empty_input ... ok
[INFO] [stdout] test io::tests::silence_output_zeroes_the_buffer ... ok
[INFO] [stdout] test io::tests::timestamp_zero_is_origin ... ok
[INFO] [stdout] test format::tests::unknown_format_id_has_no_sample_format ... ok
[INFO] [stdout] test io::tests::timestamp_default_is_zero ... ok
[INFO] [stdout] test object::tests::class_ids_match_core_audio_codes ... ok
[INFO] [stdout] test object::tests::every_kind_bases_on_audio_object ... ok
[INFO] [stdout] test object::tests::ids_order_numerically ... ok
[INFO] [stdout] test object::tests::layout_is_transparent_u32 ... ok
[INFO] [stdout] test object::tests::predicates_classify_reserved_ids ... ok
[INFO] [stdout] test object::tests::reserved_ids_have_fixed_values ... ok
[INFO] [stdout] test object::tests::round_trips_through_u32 ... ok
[INFO] [stdout] test objects::tests::all_ids_is_tree_ordered ... ok
[INFO] [stdout] test objects::tests::contains_matches_resolve ... ok
[INFO] [stdout] test objects::tests::device_owns_streams_filtered_by_scope ... ok
[INFO] [stdout] test fourcc::tests::new_packs_bytes_big_endian ... ok
[INFO] [stdout] test objects::tests::device_streams_respects_a_one_sided_device ... ok
[INFO] [stdout] test objects::tests::loopback_assigns_ids_in_tree_order ... ok
[INFO] [stdout] test objects::tests::object_kinds_follow_the_tree ... ok
[INFO] [stdout] test objects::tests::output_only_device_skips_the_input_id ... ok
[INFO] [stdout] test objects::tests::owner_walks_up_the_tree ... ok
[INFO] [stdout] test objects::tests::plugin_owns_the_device ... ok
[INFO] [stdout] test objects::tests::resolve_maps_ids_back_to_objects ... ok
[INFO] [stdout] test objects::tests::stream_spec_is_forwarded_from_the_device_spec ... ok
[INFO] [stdout] test objects::tests::streamless_device_has_only_plugin_and_device ... ok
[INFO] [stdout] test objects::tests::streams_own_nothing ... ok
[INFO] [stdout] test property::tests::address_equality_is_structural ... ok
[INFO] [stdout] test property::tests::element_main_is_zero ... ok
[INFO] [stdout] test property::tests::global_address_is_object_wide ... ok
[INFO] [stdout] test property::tests::newtype_layouts_are_transparent ... ok
[INFO] [stdout] test property::tests::property_value_byte_sizes_match_the_c_types ... ok
[INFO] [stdout] test property::tests::property_value_is_empty_only_for_empty_lists ... ok
[INFO] [stdout] test property::tests::scope_constants_match_core_audio_codes ... ok
[INFO] [stdout] test property::tests::scoped_address_is_not_object_wide ... ok
[INFO] [stdout] test property::tests::selector_constants_match_core_audio_codes ... ok
[INFO] [stdout] test property::tests::selectors_built_from_fourcc_round_trip ... ok
[INFO] [stdout] test property::tests::value_range_contains_is_inclusive ... ok
[INFO] [stdout] test property::tests::value_range_point_has_equal_bounds ... ok
[INFO] [stdout] test raw::abi::tests::asbd_is_40_bytes ... ok
[INFO] [stdout] test raw::abi::tests::audio_timestamp_layout ... ok
[INFO] [stdout] test raw::abi::tests::cfuuid_bytes_is_16_bytes ... ok
[INFO] [stdout] test raw::abi::tests::client_info_layout ... ok
[INFO] [stdout] test raw::abi::tests::driver_interface_is_a_dense_pointer_table ... ok
[INFO] [stdout] test raw::abi::tests::io_cycle_info_is_two_timestamps ... ok
[INFO] [stdout] test raw::abi::tests::option_fn_is_abi_compatible_with_a_bare_fn_pointer ... ok
[INFO] [stdout] test raw::abi::tests::property_address_is_three_packed_u32s ... ok
[INFO] [stdout] test raw::abi::tests::scalar_aliases_have_the_expected_widths ... ok
[INFO] [stdout] test raw::abi::tests::smpte_time_layout ... ok
[INFO] [stdout] test raw::abi::tests::value_range_is_two_f64s ... ok
[INFO] [stdout] test raw::clock::tests::default_matches_new ... ok
[INFO] [stdout] test raw::clock::tests::new_clock_is_stopped ... ok
[INFO] [stdout] test raw::clock::tests::seed_is_carried_into_the_timestamp ... ok
[INFO] [stdout] test raw::clock::tests::start_anchors_running_and_bumps_the_seed ... ok
[INFO] [stdout] test raw::clock::tests::stop_halts_the_clock ... ok
[INFO] [stdout] test raw::clock::tests::zero_timestamp_clamps_a_backwards_clock_to_the_anchor ... ok
[INFO] [stdout] test raw::clock::tests::zero_timestamp_floors_within_a_period ... ok
[INFO] [stdout] test raw::clock::tests::zero_timestamp_reports_period_boundaries ... ok
[INFO] [stdout] test raw::clock::tests::zero_timestamp_tolerates_a_zero_tick_rate ... ok
[INFO] [stdout] test raw::entry::tests::add_and_remove_device_client_succeed ... ok
[INFO] [stdout] test raw::entry::tests::begin_and_end_io_operation_succeed ... ok
[INFO] [stdout] test raw::entry::tests::do_io_operation_declines_an_oversized_cycle ... ok
[INFO] [stdout] test raw::entry::tests::do_io_operation_ignores_an_operation_it_does_not_handle ... ok
[INFO] [stdout] test raw::entry::tests::add_ref_and_release_track_the_count ... ok
[INFO] [stdout] test raw::entry::tests::do_io_operation_round_trips_audio_through_the_device_ring ... ok
[INFO] [stdout] test raw::entry::tests::get_property_data_reads_an_object_list ... ok
[INFO] [stdout] test raw::entry::tests::get_property_data_size_and_data_agree_for_a_scalar ... ok
[INFO] [stdout] test raw::entry::tests::get_property_data_rejects_an_unknown_property ... ok
[INFO] [stdout] test raw::entry::tests::do_io_operation_reads_silence_from_an_untouched_ring ... ok
[INFO] [stdout] test raw::entry::tests::get_zero_time_stamp_reports_a_timeline_once_running ... ok
[INFO] [stdout] test raw::entry::tests::get_zero_time_stamp_requires_a_running_device ... ok
[INFO] [stdout] test raw::entry::tests::get_zero_time_stamp_tolerates_null_out_pointers ... ok
[INFO] [stdout] test raw::entry::tests::has_property_distinguishes_known_and_unknown ... ok
[INFO] [stdout] test raw::entry::tests::initialize_records_the_host_pointer ... ok
[INFO] [stdout] test raw::entry::tests::initialize_start_stop_drive_the_lifecycle ... ok
[INFO] [stdout] test raw::entry::tests::io_timing_entry_points_reject_a_null_driver ... ok
[INFO] [stdout] test raw::entry::tests::is_property_settable_reports_the_sample_rate_as_writable ... ok
[INFO] [stdout] test raw::entry::tests::null_driver_ref_is_handled ... ok
[INFO] [stdout] test raw::entry::tests::set_property_data_writes_the_sample_rate ... ok
[INFO] [stdout] test raw::entry::tests::query_interface_rejects_an_unknown_uuid ... ok
[INFO] [stdout] test raw::entry::tests::query_interface_accepts_the_driver_and_iunknown_uuids ... ok
[INFO] [stdout] test raw::entry::tests::start_io_anchors_the_clock_and_stop_io_halts_it ... ok
[INFO] [stdout] test raw::entry::tests::text_properties_report_unspecified_off_macos ... ok
[INFO] [stdout] test raw::entry::tests::will_do_io_operation_claims_only_the_data_operations ... ok
[INFO] [stdout] test raw::entry::tests::will_do_io_operation_declines_every_operation_for_now ... ok
[INFO] [stdout] test raw::marshal::tests::asbd_round_trips_through_a_buffer ... ok
[INFO] [stdout] test raw::marshal::tests::property_address_round_trips ... ok
[INFO] [stdout] test raw::marshal::tests::read_scalars_reject_short_buffers ... ok
[INFO] [stdout] test raw::marshal::tests::read_u32_and_f64_parse_native_endian ... ok
[INFO] [stdout] test raw::marshal::tests::timestamp_extracts_sample_and_host_time ... ok
[INFO] [stdout] test raw::marshal::tests::stream_format_round_trips_through_asbd ... ok
[INFO] [stdout] test raw::marshal::tests::timestamp_to_raw_marks_the_two_fields_valid ... ok
[INFO] [stdout] test raw::marshal::tests::value_range_round_trips ... ok
[INFO] [stdout] test raw::marshal::tests::write_accepts_an_oversized_buffer_and_reports_the_used_length ... ok
[INFO] [stdout] test raw::marshal::tests::write_f64_value ... ok
[INFO] [stdout] test raw::marshal::tests::write_object_id_value ... ok
[INFO] [stdout] test raw::marshal::tests::write_object_list_value ... ok
[INFO] [stdout] test raw::marshal::tests::write_range_list_value ... ok
[INFO] [stdout] test raw::marshal::tests::write_rejects_an_undersized_buffer ... ok
[INFO] [stdout] test raw::marshal::tests::write_rejects_text_values ... ok
[INFO] [stdout] test raw::marshal::tests::write_u32_value ... ok
[INFO] [stdout] test raw::platform::tests::host_ticks_per_period_rejects_a_nonpositive_sample_rate ... ok
[INFO] [stdout] test raw::platform::tests::host_ticks_per_period_is_positive_for_a_real_format ... ok
[INFO] [stdout] test raw::platform::tests::host_ticks_per_period_scales_with_the_frame_count ... ok
[INFO] [stdout] test raw::platform::tests::host_time_advances_monotonically ... ok
[INFO] [stdout] test raw::ring::tests::a_loopback_round_trip_across_threads ... ok
[INFO] [stdout] test raw::ring::tests::channels_interleave_correctly ... ok
[INFO] [stdout] test raw::ring::tests::fractional_sample_time_floors_to_the_frame ... ok
[INFO] [stdout] test raw::ring::tests::new_ring_has_the_requested_geometry_and_is_silent ... ok
[INFO] [stdout] test raw::ring::tests::sample_time_reduces_modulo_capacity ... ok
[INFO] [stdout] test raw::ring::tests::clear_silences_the_whole_ring ... ok
[INFO] [stdout] test raw::ring::tests::negative_sample_time_is_floored_into_range ... ok
[INFO] [stdout] test raw::ring::tests::writes_wrap_at_the_ring_boundary ... ok
[INFO] [stdout] test raw::ring::tests::write_then_read_round_trips_at_the_same_sample_time ... ok
[INFO] [stdout] test raw::runtime::tests::driver_object_is_send_and_sync ... ok
[INFO] [stdout] test raw::runtime::tests::driver_object_starts_with_refcount_one ... ok
[INFO] [stdout] test raw::runtime::tests::from_ref_recovers_the_object ... ok
[INFO] [stdout] test raw::runtime::tests::from_ref_rejects_null ... ok
[INFO] [stdout] test raw::ring::tests::zero_channels_panics - should panic ... ok
[INFO] [stdout] test raw::runtime::tests::state_lock_is_mutable ... ok
[INFO] [stdout] test raw::tests::factory_dispatch_builds_a_live_driver_object ... ok
[INFO] [stdout] test raw::vtable::tests::iunknown_preamble_is_wired ... ok
[INFO] [stdout] test raw::ring::tests::zero_capacity_panics - should panic ... ok
[INFO] [stdout] test raw::runtime::tests::host_pointer_round_trips ... ok
[INFO] [stdout] test realtime::refcount::tests::add_ref_returns_incremented_count ... ok
[INFO] [stdout] test raw::runtime::tests::runtime_materialises_the_object_tree_and_identity ... ok
[INFO] [stdout] test realtime::log::tests::events_pushed_before_drop_are_all_drained ... ok
[INFO] [stdout] test realtime::refcount::tests::many_round_trips_preserve_invariants ... ok
[INFO] [stdout] test realtime::context::tests::constructor_is_callable ... ok
[INFO] [stdout] test raw::tests::factory_dispatch_drives_a_full_lifecycle_through_the_vtable ... ok
[INFO] [stdout] test realtime::refcount::tests::owning_refcount_releases_to_zero ... ok
[INFO] [stdout] test realtime::refcount::tests::release_when_zero_panics_in_debug - should panic ... FAILED
[INFO] [stdout] test realtime::ring::tests::capacity_matches_constructor_argument ... ok
[INFO] [stdout] test raw::vtable::tests::the_table_is_a_single_shared_instance ... ok
[INFO] [stdout] test realtime::ring::tests::dropping_ring_drops_remaining_items ... ok
[INFO] [stdout] test raw::vtable::tests::lifecycle_property_and_io_timing_slots_are_wired ... ok
[INFO] [stdout] test realtime::refcount::tests::release_returns_decremented_count ... ok
[INFO] [stdout] test realtime::ring::tests::fifo_order_is_preserved ... ok
[INFO] [stdout] test realtime::ring::tests::pop_when_empty_returns_none ... ok
[INFO] [stdout] test realtime::ring::tests::push_then_pop_returns_same_value ... ok
[INFO] [stdout] test realtime::ring::tests::popped_items_are_not_double_dropped ... ok
[INFO] [stdout] test realtime::ring::tests::push_when_full_returns_back_the_value ... ok
[INFO] [stdout] test realtime::ring::tests::ring_wraps_around_correctly ... ok
[INFO] [stdout] test realtime::ring::tests::new_ring_is_empty_and_not_full ... ok
[INFO] [stdout] test raw::vtable::tests::deferred_slots_are_none ... ok
[INFO] [stdout] test realtime::ring::tests::zero_capacity_panics - should panic ... ok
[INFO] [stdout] test realtime::log::tests::capacity_matches_constructor_argument ... ok
[INFO] [stdout] test realtime::log::tests::drop_flushes_events_pushed_after_the_last_poll ... ok
[INFO] [stdout] test realtime::log::tests::log_returns_false_when_queue_is_full ... ok
[INFO] [stdout] test realtime::refcount::tests::new_unowned_starts_at_zero ... ok
[INFO] [stdout] test raw::tests::raw_aliases_match_safe_wrapper_widths ... ok
[INFO] [stdout] test realtime::ring::tests::interleaved_push_and_pop_works ... ok
[INFO] [stdout] test realtime::state::tests::initialize_when_already_initialized_errors ... ok
[INFO] [stdout] test realtime::state::tests::new_cell_starts_uninitialized ... ok
[INFO] [stdout] test realtime::state::tests::start_when_already_running_errors ... ok
[INFO] [stdout] test realtime::state::tests::initialize_uninitialized_to_initialized ... ok
[INFO] [stdout] test realtime::refcount::tests::concurrent_add_ref_release_balance_to_zero ... ok
[INFO] [stdout] test realtime::state::tests::stop_requires_running ... ok
[INFO] [stdout] test realtime::refcount::tests::concurrent_add_ref_only_yields_total_count ... ok
[INFO] [stdout] test stream::tests::builder_setters_apply ... ok
[INFO] [stdout] test stream::tests::direction_property_values_match_core_audio ... ok
[INFO] [stdout] test realtime::state::tests::default_matches_new ... ok
[INFO] [stdout] test realtime::refcount::tests::default_matches_new ... ok
[INFO] [stdout] test realtime::state::tests::concurrent_initialize_has_exactly_one_winner ... ok
[INFO] [stdout] test realtime::refcount::tests::new_starts_at_one ... ok
[INFO] [stdout] test stream::tests::direction_scopes_and_opposites ... ok
[INFO] [stdout] test realtime::state::tests::full_lifecycle_round_trip ... ok
[INFO] [stdout] test stream::tests::direction_round_trips_through_property_value ... ok
[INFO] [stdout] test stream::tests::input_stream_defaults ... ok
[INFO] [stdout] test realtime::state::tests::allows_io_only_in_running ... ok
[INFO] [stdout] test stream::tests::output_stream_defaults ... ok
[INFO] [stdout] test realtime::state::tests::reset_from_any_state ... ok
[INFO] [stdout] test realtime::state::tests::stop_returns_to_initialized ... ok
[INFO] [stdout] test realtime::state::tests::start_requires_initialized ... ok
[INFO] [stdout] test realtime::ring::tests::cross_thread_push_pop_preserves_order ... ok
[INFO] [stdout] test realtime::log::tests::drainer_panic_is_swallowed_by_drop ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- realtime::refcount::tests::release_when_zero_panics_in_debug stdout ----
[INFO] [stdout] note: test did not panic as expected at src/realtime/refcount.rs:164:8
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     realtime::refcount::tests::release_when_zero_panics_in_debug
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 268 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0", kill_on_drop: false }`
[INFO] [stdout] fde3021a91a6a2bbb9490df41168ad00c931fa2a5138febf142241dfc004fcb0
