[INFO] fetching crate tympan-apo 0.1.0...
[INFO] testing tympan-apo-0.1.0 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate tympan-apo 0.1.0 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate tympan-apo 0.1.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tympan-apo 0.1.0
[INFO] tweaked toml for crates.io crate tympan-apo 0.1.0 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tympan-apo 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-apo 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-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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] e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530
[INFO] running `Command { std: "docker" "start" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530", 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" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530" "/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" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530", 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" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530" "/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-apo v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1.41s
[INFO] running `Command { std: "docker" "inspect" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530", 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" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530" "/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 crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling assert_no_alloc v1.1.2
[INFO] [stderr]    Compiling tympan-apo v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 05s
[INFO] running `Command { std: "docker" "inspect" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530", 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" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530" "/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.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/tympan_apo-ce183fd34f54556c)
[INFO] [stdout] 
[INFO] [stdout] running 98 tests
[INFO] [stdout] test apo::tests::default_lock_for_process_succeeds ... ok
[INFO] [stdout] test apo::tests::associated_constants_round_trip ... ok
[INFO] [stdout] test apo::tests::process_input_is_not_silent_when_flag_is_valid ... ok
[INFO] [stdout] test apo::tests::default_unlock_is_callable ... ok
[INFO] [stdout] test apo::tests::default_output_negotiation_matches_input ... ok
[INFO] [stdout] test apo::tests::default_input_format_suggests_float32_for_int_pcm ... ok
[INFO] [stdout] test apo::tests::process_passes_through_input_flags ... ok
[INFO] [stdout] test apo::tests::process_input_exposes_samples_and_flags ... ok
[INFO] [stdout] test apo::tests::process_runs_against_a_synthetic_buffer ... ok
[INFO] [stdout] test apo::tests::variants_are_distinct ... ok
[INFO] [stdout] test buffer::tests::buffer_flag_constants_match_microsoft_values ... ok
[INFO] [stdout] test apo::tests::default_input_format_suggests_float32_for_float64 ... ok
[INFO] [stdout] test apo::tests::default_input_format_accepts_float32_at_any_rate_channels ... ok
[INFO] [stdout] test clsid::tests::debug_wraps_display ... ok
[INFO] [stdout] test clsid::tests::display_format_is_canonical ... ok
[INFO] [stdout] test buffer::tests::buffer_flags_unknown_value_round_trips ... ok
[INFO] [stdout] test buffer::tests::connection_property_empty_has_signature ... ok
[INFO] [stdout] test clsid::tests::equality_is_structural ... ok
[INFO] [stdout] test clsid::tests::from_u128_round_trips ... ok
[INFO] [stdout] test clsid::tests::nil_is_nil ... ok
[INFO] [stdout] test clsid::tests::non_nil_is_not_nil ... ok
[INFO] [stdout] test error::tests::debug_formatting_is_hex ... ok
[INFO] [stdout] test error::tests::failure_codes_classify_correctly ... ok
[INFO] [stdout] test buffer::tests::buffer_flag_predicates_classify_correctly ... ok
[INFO] [stdout] test buffer::tests::buffer_flags_default_is_invalid ... ok
[INFO] [stdout] test buffer::tests::signature_value_spells_apoc_in_be_bytes ... ok
[INFO] [stdout] test error::tests::ok_method_converts_to_result ... ok
[INFO] [stdout] test error::tests::raw_constant_values_match_microsoft_definitions ... ok
[INFO] [stdout] test error::tests::success_codes_classify_correctly ... ok
[INFO] [stdout] test format::tests::pcm_int16_44k1_stereo_has_expected_fields ... ok
[INFO] [stdout] test format::tests::pcm_int24_48k_mono_block_align_is_3 ... ok
[INFO] [stdout] test fx_properties::tests::endpoint_kind_as_str_matches_microsoft_naming ... ok
[INFO] [stdout] test format::tests::negotiation_variants_distinguish ... ok
[INFO] [stdout] test format::tests::pcm_float32_48k_mono_has_expected_fields ... ok
[INFO] [stdout] test format::tests::pcm_float64_48k_5_1_block_align_is_48 ... ok
[INFO] [stdout] test fx_properties::tests::fx_properties_key_path_is_canonical ... ok
[INFO] [stdout] test inf::tests::clsid_id_string_is_continuous_hex ... ok
[INFO] [stdout] test inf::tests::escape_inf_doubles_internal_quotes ... ok
[INFO] [stdout] test inf::tests::generated_inf_contains_required_sections ... ok
[INFO] [stdout] test inf::tests::generated_inf_embeds_clsid_and_dll_filename ... ok
[INFO] [stdout] test fx_properties::tests::fx_property_value_name_uses_brace_comma_format ... ok
[INFO] [stdout] test inf::tests::generated_inf_records_driver_version_string ... ok
[INFO] [stdout] test fx_properties::tests::pid_for_category_maps_to_legacy_triple ... ok
[INFO] [stdout] test inf::tests::generated_inf_uses_default_threading_model_both ... ok
[INFO] [stdout] test instance::tests::add_ref_release_delegate_to_refcount ... ok
[INFO] [stdout] test instance::tests::double_initialize_returns_apoerr_already_locked ... ok
[INFO] [stdout] test instance::tests::full_lifecycle_round_trip ... ok
[INFO] [stdout] test instance::tests::initialize_transitions_to_initialized ... ok
[INFO] [stdout] test clsid::tests::from_parts_matches_explicit_fields ... ok
[INFO] [stdout] test instance::tests::is_input_format_supported_uses_user_default ... ok
[INFO] [stdout] test clsid::tests::from_u128_matches_known_byte_order ... ok
[INFO] [stdout] test instance::tests::lock_failure_rolls_state_back_to_initialized ... ok
[INFO] [stdout] test instance::tests::lock_for_process_transitions_and_forwards_to_user ... ok
[INFO] [stdout] test fx_properties::tests::serialize_clsid_property_emits_vt_clsid_layout ... ok
[INFO] [stdout] test instance::tests::lock_requires_initialized ... ok
[INFO] [stdout] test fx_properties::tests::serialize_clsid_property_total_length_is_24_bytes ... ok
[INFO] [stdout] test instance::tests::locked_formats_cached_during_lock_for_process ... ok
[INFO] [stdout] test inf::tests::clsid_no_braces_strips_outer_braces ... ok
[INFO] [stdout] test instance::tests::new_starts_uninitialized_with_zero_refcount ... ok
[INFO] [stdout] test instance::tests::default_matches_new ... ok
[INFO] [stdout] test instance::tests::type_erased_dispatch_drives_full_lifecycle ... ok
[INFO] [stdout] test instance::tests::unlock_for_process_returns_to_initialized ... ok
[INFO] [stdout] test instance::tests::unlock_without_lock_fails ... ok
[INFO] [stdout] test realtime::refcount::tests::default_matches_new ... ok
[INFO] [stdout] test realtime::refcount::tests::many_round_trips_preserve_invariants ... ok
[INFO] [stdout] test instance::tests::process_after_lock_returns_user_flags_and_copies_samples ... ok
[INFO] [stdout] test realtime::context::tests::constructor_is_callable ... ok
[INFO] [stdout] test instance::tests::process_requires_locked_state ... ok
[INFO] [stdout] test realtime::refcount::tests::add_ref_returns_incremented_count ... ok
[INFO] [stdout] test realtime::refcount::tests::new_starts_at_zero ... ok
[INFO] [stdout] test realtime::refcount::tests::release_returns_decremented_count ... 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 realtime::ring::tests::dropping_ring_drops_remaining_items ... ok
[INFO] [stdout] test realtime::ring::tests::fifo_order_is_preserved ... ok
[INFO] [stdout] test realtime::refcount::tests::concurrent_add_ref_only_yields_total_count ... ok
[INFO] [stdout] test realtime::ring::tests::popped_items_are_not_double_dropped ... ok
[INFO] [stdout] test realtime::ring::tests::new_ring_is_empty_and_not_full ... ok
[INFO] [stdout] test realtime::ring::tests::push_then_pop_returns_same_value ... ok
[INFO] [stdout] test realtime::state::tests::allows_process_only_in_locked ... ok
[INFO] [stdout] test realtime::state::tests::concurrent_initialize_has_exactly_one_winner ... ok
[INFO] [stdout] test realtime::state::tests::default_matches_new ... ok
[INFO] [stdout] test realtime::ring::tests::push_when_full_returns_back_the_value ... ok
[INFO] [stdout] test realtime::state::tests::full_lifecycle_round_trip ... ok
[INFO] [stdout] test realtime::ring::tests::ring_wraps_around_correctly ... ok
[INFO] [stdout] test realtime::ring::tests::zero_capacity_panics - should panic ... ok
[INFO] [stdout] test realtime::ring::tests::interleaved_push_and_pop_works ... ok
[INFO] [stdout] test realtime::state::tests::lock_when_already_locked_errors ... ok
[INFO] [stdout] test realtime::ring::tests::pop_when_empty_returns_none ... ok
[INFO] [stdout] test realtime::state::tests::release_from_any_state_resets ... ok
[INFO] [stdout] test realtime::state::tests::unlock_returns_to_initialized ... ok
[INFO] [stdout] test realtime::state::tests::initialize_uninitialized_to_initialized ... ok
[INFO] [stdout] test realtime::state::tests::unlock_requires_locked ... ok
[INFO] [stdout] test realtime::refcount::tests::concurrent_add_ref_release_balance_to_zero ... ok
[INFO] [stdout] test realtime::state::tests::initialize_when_already_initialized_errors ... ok
[INFO] [stdout] test realtime::state::tests::lock_requires_initialized ... ok
[INFO] [stdout] test realtime::state::tests::new_cell_starts_uninitialized ... ok
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout] test realtime::ring::tests::cross_thread_push_pop_preserves_order ... 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:134:8
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     realtime::refcount::tests::release_when_zero_panics_in_debug
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 97 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530", kill_on_drop: false }`
[INFO] [stdout] e11b997de267218765e400230bba45c00a257edd1e8b44148146ba854e30e530
