[INFO] fetching crate oxisound-pulse 0.2.1...
[INFO] testing oxisound-pulse-0.2.1 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate oxisound-pulse 0.2.1 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate oxisound-pulse 0.2.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate oxisound-pulse 0.2.1
[INFO] tweaked toml for crates.io crate oxisound-pulse 0.2.1 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate oxisound-pulse 0.2.1 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate oxisound-pulse 0.2.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf
[INFO] running `Command { std: "docker" "start" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf", 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" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf", 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" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-sink v0.3.33
[INFO] [stderr]    Compiling futures-core v0.3.33
[INFO] [stderr]    Compiling futures-io v0.3.33
[INFO] [stderr]    Compiling futures-macro v0.3.33
[INFO] [stderr]    Compiling thiserror-impl v2.0.19
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling mio v1.2.2
[INFO] [stderr]    Compiling enum-primitive-derive v0.3.0
[INFO] [stderr]    Compiling futures-channel v0.3.33
[INFO] [stderr]    Compiling ringbuf v0.5.1
[INFO] [stderr]    Compiling futures-util v0.3.33
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling thiserror v2.0.19
[INFO] [stderr]    Compiling oxisound-core v0.2.1
[INFO] [stderr]    Compiling futures-executor v0.3.33
[INFO] [stderr]    Compiling futures v0.3.33
[INFO] [stderr]    Compiling pulseaudio v0.3.1
[INFO] [stderr]    Compiling oxisound-pulse v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 25.67s
[INFO] running `Command { std: "docker" "inspect" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf", 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" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling oxisound-pulse v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 7.43s
[INFO] running `Command { std: "docker" "inspect" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf", 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" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/oxisound-pulse/1053038f8b07eae1/out/oxisound_pulse-1053038f8b07eae1)
[INFO] [stdout] 
[INFO] [stdout] running 78 tests
[INFO] [stdout] test env::tests::empty_env_var_is_treated_as_unset ... ok
[INFO] [stdout] test env::tests::pulse_runtime_path_native_before_xdg ... ok
[INFO] [stdout] test env::tests::cookie_precedence_explicit_then_xdg_then_home ... ok
[INFO] [stdout] test env::tests::load_cookie_reads_exact_bytes_and_tolerates_short_files ... ok
[INFO] [stdout] test env::tests::no_candidate_yields_device_error_listing_attempts ... ok
[INFO] [stdout] test env::tests::non_unix_entries_yield_none ... ok
[INFO] [stdout] test env::tests::pulse_runtime_path_parent_spelling_also_probed ... ok
[INFO] [stdout] test env::tests::cookie_absent_is_not_an_error ... ok
[INFO] [stdout] test env::tests::pulse_server_list_picks_first_unix_entry ... ok
[INFO] [stdout] test env::tests::pulse_server_remote_only_is_unsupported ... ok
[INFO] [stdout] test env::tests::pulse_server_unix_prefix_wins ... ok
[INFO] [stdout] test env::tests::uid_fallback_used_when_no_env_matches ... ok
[INFO] [stdout] test env::tests::xdg_runtime_dir_used_when_present ... ok
[INFO] [stdout] test format::tests::decode_ignores_trailing_partial_sample ... ok
[INFO] [stdout] test format::tests::decode_is_bounded_by_the_output_slice ... ok
[INFO] [stdout] test format::tests::encode_decode_roundtrip_within_quantisation_error ... ok
[INFO] [stdout] test format::tests::encoding_saturates_instead_of_wrapping ... ok
[INFO] [stdout] test format::tests::frame_size_scales_with_channels_and_never_zero ... ok
[INFO] [stdout] test format::tests::nan_encodes_as_silence ... ok
[INFO] [stdout] test format::tests::negotiation_explicit_request_wins_over_native ... ok
[INFO] [stdout] test format::tests::negotiation_falls_back_to_native_then_f32 ... ok
[INFO] [stdout] test format::tests::negotiation_rejects_unrepresentable_explicit_request ... ok
[INFO] [stdout] test format::tests::negotiation_walks_preferred_list_in_order ... ok
[INFO] [stdout] test format::tests::s24_negative_values_sign_extend ... ok
[INFO] [stdout] test linux::conn::tests::client_errors_map_onto_the_oxisound_taxonomy ... ok
[INFO] [stdout] test linux::conn::tests::client_name_with_interior_nul_is_rejected_before_any_socket_work ... FAILED
[INFO] [stdout] test linux::conn::tests::connect_io_errors_are_classified ... ok
[INFO] [stdout] test format::tests::byte_widths_match_core_widths ... ok
[INFO] [stdout] test env::tests::pulse_server_machine_id_prefix_is_stripped ... ok
[INFO] [stdout] test format::tests::core_roundtrip_is_stable ... ok
[INFO] [stdout] test linux::device::tests::monitor_source_is_flagged_and_stays_an_input ... ok
[INFO] [stdout] test linux::device::tests::sink_info_maps_to_an_output_descriptor ... ok
[INFO] [stdout] test linux::device::tests::unconvertible_wire_formats_map_to_none ... ok
[INFO] [stdout] test linux::conn::tests::protocol_limits_match_the_pulseaudio_crate ... ok
[INFO] [stdout] test linux::stream::tests::buffer_attrs_translate_field_for_field ... ok
[INFO] [stdout] test linux::stream::tests::channel_map_covers_every_supported_count_without_panicking ... ok
[INFO] [stdout] test linux::stream::tests::device_names_with_interior_nul_are_rejected ... ok
[INFO] [stdout] test linux::stream::tests::discard_is_bounded_by_the_snapshot_and_spares_later_writes ... ok
[INFO] [stdout] test linux::stream::tests::playback_source_parks_instead_of_signalling_eof ... ok
[INFO] [stdout] test linux::stream::tests::record_ring_keeps_partial_samples_aligned ... ok
[INFO] [stdout] test linux::stream::tests::record_sink_counts_overruns_and_marks_disconnect_on_drop ... ok
[INFO] [stdout] test linux::conn::tests::dropping_the_connection_shuts_the_socket_down_so_the_reactor_can_exit ... ok
[INFO] [stdout] test linux::stream::tests::serve_reports_emptiness_and_clears_the_starved_edge_when_it_finds_data ... ok
[INFO] [stdout] test linux::stream::tests::stream_handles_are_send ... ok
[INFO] [stdout] test linux::stream::tests::discard_flag_drops_the_client_side_backlog_at_the_next_poll ... ok
[INFO] [stdout] test linux::stream::tests::surround_layout_starts_with_the_standard_order ... ok
[INFO] [stdout] test linux::device::tests::channel_count_falls_back_to_the_channel_map ... ok
[INFO] [stdout] test linux::stream::tests::channel_map_uses_canonical_mono_and_stereo ... ok
[INFO] [stdout] test linux::device::tests::dummy_sink_is_filtered_out_of_device_info ... ok
[INFO] [stdout] test linux::device::tests::wire_format_mapping_round_trips ... ok
[INFO] [stdout] test model::tests::default_flag_propagates ... ok
[INFO] [stdout] test linux::conn::tests::handshake_round_trips_over_a_unix_socket_pair ... ok
[INFO] [stdout] test model::tests::degenerate_endpoints_are_dropped ... ok
[INFO] [stdout] test model::tests::playback_attrs_bound_the_server_side_latency ... ok
[INFO] [stdout] test model::tests::missing_native_format_yields_empty_supported_formats ... ok
[INFO] [stdout] test model::tests::monitor_source_is_an_input_and_keeps_its_pulseaudio_name ... ok
[INFO] [stdout] test model::tests::predicted_config_follows_the_negotiation_rules ... ok
[INFO] [stdout] test model::tests::predicted_config_rejects_unrepresentable_formats ... ok
[INFO] [stdout] test model::tests::record_attrs_set_fragment_size_and_defer_playback_fields ... ok
[INFO] [stdout] test linux::stream::tests::waker_slot_is_replaced_only_when_it_would_wake_a_different_task ... ok
[INFO] [stdout] test model::tests::buffer_attrs_never_produce_a_zero_length ... ok
[INFO] [stdout] test model::tests::source_maps_to_input_only ... ok
[INFO] [stdout] test model::tests::validation_rejects_out_of_range_channels_and_rates ... ok
[INFO] [stdout] test model::tests::whole_samples_rounds_down_per_format ... ok
[INFO] [stdout] test tests::default_client_name_is_stable ... ok
[INFO] [stdout] test model::tests::ring_capacity_rejects_nonsense_seconds ... ok
[INFO] [stdout] test model::tests::sink_maps_to_output_only ... ok
[INFO] [stdout] test timeout::tests::a_future_that_parks_before_completing_still_wins_the_race ... ok
[INFO] [stdout] test model::tests::ring_capacity_uses_requested_seconds ... ok
[INFO] [stdout] test tests::enumeration_never_yields_a_role_less_device ... ok
[INFO] [stdout] test model::tests::period_frames_clamps_both_ends ... ok
[INFO] [stdout] test model::tests::role_invariant_holds_across_a_mixed_list ... ok
[INFO] [stdout] test timeout::tests::ready_future_returns_its_value ... ok
[INFO] [stdout] test model::tests::ring_capacity_floors_at_the_server_chunk_size ... ok
[INFO] [stdout] test tests::pulse_device_implements_audio_device_everywhere ... ok
[INFO] [stdout] test timeout::tests::timeout_constants_are_ordered_and_non_zero ... ok
[INFO] [stdout] test timeout::tests::timed_out_future_is_dropped_and_therefore_cancelled ... ok
[INFO] [stdout] test timeout::tests::pending_future_times_out_with_the_timeout_variant ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- linux::conn::tests::client_name_with_interior_nul_is_rejected_before_any_socket_work stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'linux::conn::tests::client_name_with_interior_nul_is_rejected_before_any_socket_work' (492) panicked at src/linux/conn.rs:313:9:
[INFO] [stdout] message should say why: device error: no PulseAudio (or pipewire-pulse) socket found; tried: /run/user/0/pulse/native
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x642e65bfdc31 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x642e65c1382a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x642e65c0221c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x642e65bd85a6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x642e65bf58b9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x642e65b6f970 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x642e65bf5a72 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x642e65bd8652 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x642e65bd10b9 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x642e65bd925d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x642e65c13f5c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x642e65b2eb05 - <oxisound_pulse[48fa879d355355f9]::linux::conn::tests::client_name_with_interior_nul_is_rejected_before_any_socket_work::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x642e65b62dbb - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   13:     0x642e65b6ff95 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   14:     0x642e65b69884 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x642e65b73022 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   16:     0x642e65bfcf6f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7fd7de3b9dfa - <unknown>
[INFO] [stdout]   18:     0x7fd7de44d3d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     linux::conn::tests::client_name_with_interior_nul_is_rejected_before_any_socket_work
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 77 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf", kill_on_drop: false }`
[INFO] [stdout] d09734311b1f532002da9a00838c8ce0d52703924545e9fc09b157470f2cb5cf
