[INFO] cloning repository https://github.com/wensheng/kitlib
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/wensheng/kitlib" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwensheng%2Fkitlib", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwensheng%2Fkitlib'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 48b6ea7d2062bb55aac0489a85f7629d9efcc9c0
[INFO] testing wensheng/kitlib against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwensheng%2Fkitlib" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/wensheng/kitlib
[INFO] finished tweaking git repo https://github.com/wensheng/kitlib
[INFO] tweaked toml for git repo https://github.com/wensheng/kitlib written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/wensheng/kitlib 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 git repo https://github.com/wensheng/kitlib 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-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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] 556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4
[INFO] running `Command { std: "docker" "start" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4", 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" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4" "/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" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4", 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" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling kitlib v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 2.85s
[INFO] running `Command { std: "docker" "inspect" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4", 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" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4" "/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 rustix v1.1.4
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling bitflags v2.13.0
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling fastrand v2.4.1
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling kitlib v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 7.13s
[INFO] running `Command { std: "docker" "inspect" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4", 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" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4" "/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.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/kitlib/65e595cc65593bf3/out/kitlib-65e595cc65593bf3)
[INFO] [stdout] 
[INFO] [stdout] running 37 tests
[INFO] [stdout] test capture::tests::capture_msg_frame_carries_dimensions_and_buffer ... ok
[INFO] [stdout] test session::tests::parse_ignores_unknown_fields_and_reads_optional_fields ... ok
[INFO] [stdout] test session::tests::parse_requires_core_fields ... ok
[INFO] [stdout] test session::tests::store_resolve_removes_stale_or_unparseable_files ... ok
[INFO] [stdout] test capture::tests::rgba_frame_len_is_width_times_height_times_four ... ok
[INFO] [stdout] test session::tests::kill_by_name_reports_missing_without_error ... ok
[INFO] [stdout] test session::tests::is_alive_and_resolve_attach_when_pid_and_display_socket_exist ... ok
[INFO] [stdout] test capture::tests::capture_one_reads_from_xvfb_when_available ... ok
[INFO] [stdout] test starter::tests::starter_config_keeps_requested_values ... ok
[INFO] [stdout] test session::tests::store_write_read_list_and_remove_are_isolated_to_store_dir ... ok
[INFO] [stdout] test session::tests::is_alive_requires_a_display_socket_even_for_live_pid ... ok
[INFO] [stdout] test session::tests::write_state_contents_omits_absent_optional_fields ... ok
[INFO] [stdout] test capture::tests::capture_one_reports_missing_display ... ok
[INFO] [stdout] test capture::tests::run_capture_sends_a_frame_from_xvfb_when_available ... ok
[INFO] [stdout] test capture::tests::run_capture_stops_when_display_cannot_be_opened ... ok
[INFO] [stdout] test session::tests::valid_name_rejects_unsafe_names ... ok
[INFO] [stdout] test wm::tests::attach_does_not_own_xvfb_or_jwm_children ... ok
[INFO] [stdout] test starter::tests::invalid_session_name_fails_before_spawning_processes ... ok
[INFO] [stdout] test session::tests::lookup_live_returns_none_for_dead_or_missing_sessions ... ok
[INFO] [stdout] test session::tests::valid_name_accepts_safe_names ... ok
[INFO] [stdout] test wm::tests::pulse_audio_env_is_plain_borrowed_configuration ... ok
[INFO] [stdout] test xinput::tests::scroll_direction_maps_to_x11_buttons ... ok
[INFO] [stdout] test wm::tests::find_free_display_returns_preferred_when_range_is_empty ... ok
[INFO] [stdout] test wm::tests::set_detach_prevents_drop_from_killing_owned_children ... ok
[INFO] [stdout] test xinput::tests::interpolation_rounds_to_nearest_pixel ... ok
[INFO] [stdout] test xinput::tests::xinput_formats_display_environment ... ok
[INFO] [stdout] test wm::tests::exec_on_display_tracks_reaps_and_sets_environment ... FAILED
[INFO] [stdout] test session::tests::kill_by_name_kills_recorded_process_and_removes_file ... ok
[INFO] [stdout] test starter::tests::start_session_removes_state_when_late_step_fails ... ok
[INFO] [stdout] test session::tests::top_level_functions_use_default_runtime_store ... ok
[INFO] [stdout] test starter::tests::start_session_refuses_existing_live_session_without_replace ... ok
[INFO] [stdout] test starter::tests::start_session_creates_state_and_detaches_fake_tools ... ok
[INFO] [stdout] test xinput::tests::xinput_methods_invoke_xdotool_with_expected_arguments ... ok
[INFO] [stdout] test wm::tests::new_session_and_start_jwm_record_audio_and_config ... ok
[INFO] [stdout] test wm::tests::new_spawns_owned_xvfb_and_drop_cleans_it_up ... ok
[INFO] [stdout] test wm::tests::input_wrappers_forward_to_xinput ... ok
[INFO] [stdout] test xinput::tests::xinput_reports_missing_xdotool ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- wm::tests::exec_on_display_tracks_reaps_and_sets_environment stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'wm::tests::exec_on_display_tracks_reaps_and_sets_environment' (425) panicked at src/wm.rs:413:10:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: "Failed to exec 'printf 'DISPLAY=%s PULSE_SINK=%s PULSE_SERVER=%s\\n' \"$DISPLAY\" \"$PULSE_SINK\" \"$PULSE_SERVER\" >> '/tmp/.tmpdxiKVo/exec.log'': No such file or directory (os error 2)"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5874860351e1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x58748604a11a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x587486039bec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x58748600e286 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x58748602c419 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x587485fc41c0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x58748602c5d2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x58748600e332 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x587486006b09 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x58748600f30d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x58748604a84c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x58748604a622 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x587485f9df14 - <kitlib[f0759db6c83d0900]::wm::tests::exec_on_display_tracks_reaps_and_sets_environment::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x587485fb760b - 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]   14:     0x587485fc47e5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   15:     0x587485fbe0d4 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   16:     0x587485fc7872 - <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]   17:     0x5874860344ff - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   18:     0x7bdf51f7fdfa - <unknown>
[INFO] [stdout]   19:     0x7bdf520133d4 - clone
[INFO] [stdout]   20:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     wm::tests::exec_on_display_tracks_reaps_and_sets_environment
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 36 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.26s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4", kill_on_drop: false }`
[INFO] [stdout] 556a8757a674b876d27c9bd7f6903e298d1bc20d65c33716eae6aecd9cae70c4
