[INFO] fetching crate herdr-plugin 0.1.8...
[INFO] testing herdr-plugin-0.1.8 against 1.97.0-beta.6+cargoflags=--release for beta-1.98-release-3
[INFO] extracting crate herdr-plugin 0.1.8 into /workspace/builds/worker-2-tc1/source
[INFO] started tweaking crates.io crate herdr-plugin 0.1.8
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate herdr-plugin 0.1.8
[INFO] tweaked toml for crates.io crate herdr-plugin 0.1.8 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate herdr-plugin 0.1.8 on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate herdr-plugin 0.1.8 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.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded doctest-file v1.1.1
[INFO] [stderr]   Downloaded interprocess v2.4.2
[INFO] [stderr]   Downloaded recvmsg v1.0.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:00c5645b54fe3ce5dae1417175e3c7fb6a6646c021d554ecd63a097b8b9f3602" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e
[INFO] running `Command { std: "docker" "start" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e", 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" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e", 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" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.46
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling winnow v1.0.3
[INFO] [stderr]    Compiling memchr v2.8.2
[INFO] [stderr]    Compiling bytes v1.12.0
[INFO] [stderr]    Compiling toml_writer v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling doctest-file v1.1.1
[INFO] [stderr]    Compiling toml_parser v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling syn v2.0.118
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling socket2 v0.6.4
[INFO] [stderr]    Compiling mio v1.2.1
[INFO] [stderr]    Compiling interprocess v2.4.2
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling toml v0.9.12+spec-1.1.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling herdr-plugin v0.1.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 41.15s
[INFO] running `Command { std: "docker" "inspect" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e", 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" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling herdr-plugin v0.1.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 49.77s
[INFO] running `Command { std: "docker" "inspect" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e", 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" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/herdr_plugin-cd881cd528e94493)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test runtime::tests::socket_runtime_handle_workspace_create_uses_typed_api ... ok
[INFO] [stdout] test runtime::tests::socket_runtime_handle_sends_json_request_to_herdr ... ok
[INFO] [stdout] test runtime::tests::socket_runtime_uses_configured_event_subscriptions ... ok
[INFO] [stdout] test runtime::tests::socket_runtime_subscribes_to_socket_events_and_dispatches_them ... ok
[INFO] [stdout] test runtime::tests::socket_runtime_handle_exposes_protocol_method_groups ... ok
[INFO] [stdout] test runtime::tests::socket_runtime_blocks_until_handle_stops_it ... ok
[INFO] [stdout] test runtime::tests::runtime_handle_stop_sends_stop_command ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/agent.rs (/opt/rustwide/target/release/deps/agent-7c89c625908a4741)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test agent_list_get_read_and_explain_parse_real_shapes ... ok
[INFO] [stdout] test agent_mutating_commands_use_expected_arguments ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/app.rs (/opt/rustwide/target/release/deps/app-2afce53971e2e02d)
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test app_builder_runs_event_from_env ... ok
[INFO] [stdout] test app_new_reads_herdr_runtime_environment_into_context ... ok
[INFO] [stdout] test app_run_delegates_lifecycle_to_configured_runtime ... ok
[INFO] [stdout] test app_builder_sets_herdr_binary_path_for_context_client ... ok
[INFO] [stdout] test app_state_is_available_to_setup_and_event_handlers ... ok
[INFO] [stdout] test context_exposes_invocation_helpers_paths_and_logger ... ok
[INFO] [stdout] test config_can_load_custom_relative_toml_file ... ok
[INFO] [stdout] test env_event_source_reads_typed_runtime_event_from_env ... ok
[INFO] [stdout] test explicit_one_shot_runtime_runs_event_from_env ... ok
[INFO] [stdout] test missing_config_file_uses_default_config ... ok
[INFO] [stdout] test setup_runs_with_context_before_event_dispatch ... ok
[INFO] [stdout] test invalid_config_toml_returns_typed_runtime_error ... ok
[INFO] [stdout] test on_error_runs_when_setup_fails ... ok
[INFO] [stdout] test typed_herdr_events_implement_runtime_event_trait ... ok
[INFO] [stdout] test run_returns_typed_error_for_invalid_event_json ... ok
[INFO] [stdout] test socket_runtime_context_exposes_socket_handle_in_event_callbacks ... ok
[INFO] [stdout] test config_loads_default_toml_before_setup_and_event_dispatch ... ok
[INFO] [stdout] test app_with_client_shares_arc_client_with_handlers ... ok
[INFO] [stdout] test one_shot_runtime_context_has_no_socket_handle ... ok
[INFO] [stdout] test socket_runtime_app_run_blocks_until_handle_stops_it ... ok
[INFO] [stdout] test teardown_runs_after_event_dispatch ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/dispatch.rs (/opt/rustwide/target/release/deps/dispatch-a0cab948514644f5)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test dispatches_handlers_for_the_concrete_event_type_in_registration_order ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/events.rs (/opt/rustwide/target/release/deps/events-c86af37571064974)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test event_envelope_deserializes_tab_renamed_payload_from_herdr_shape ... ok
[INFO] [stdout] test event_payload_structs_match_workspace_tab_and_pane_info_shapes ... ok
[INFO] [stdout] test app_can_register_sdk_event_types ... ok
[INFO] [stdout] test workspace_tab_and_pane_event_names_match_herdr_schema ... ok
[INFO] [stderr]      Running tests/pane.rs (/opt/rustwide/target/release/deps/pane-d2a104ed7eb6701b)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test pane_split_swap_and_move_methods_use_expected_arguments ... FAILED
[INFO] [stdout] test pane_json_errors_are_typed ... ok
[INFO] [stdout] test plugin_pane_methods_live_on_pane_client ... ok
[INFO] [stderr] error: test failed, to rerun pass `--test pane`
[INFO] [stdout] test pane_read_methods_parse_real_shapes ... ok
[INFO] [stdout] test pane_directional_and_mutating_methods_use_expected_arguments ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- pane_split_swap_and_move_methods_use_expected_arguments stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'pane_split_swap_and_move_methods_use_expected_arguments' (1294) panicked at tests/pane.rs:219:10:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: CommandExecutionFailed { binary: "/tmp/herdr-pane-client-test-1290-1/herdr", args: ["pane", "split", "wT:p1", "--direction", "down", "--ratio", "0.5", "--cwd", "/tmp", "--env", "KEY=VALUE", "--no-focus"], source: Os { code: 26, kind: ExecutableFileBusy, message: "Text file busy" } }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x65353ae98dd8 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x65353aead78a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    2:     0x65353ae9d732 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x65353ae76676 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x65353ae90f49 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]    5:     0x65353ae0315c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x65353ae911c2 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x65353ae76732 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x65353ae6b859 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x65353ae774dd - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]   10:     0x65353aeadeac - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]   11:     0x65353aeadc82 - core[8fb95b77d25ab6c8]::result::unwrap_failed
[INFO] [stdout]   12:     0x65353ade18ba - pane[21fc5584b9442d6a]::pane_split_swap_and_move_methods_use_expected_arguments::{closure#0}
[INFO] [stdout]   13:     0x65353adeef45 - <tokio[3d0d737e2974e2b9]::runtime::scheduler::current_thread::Context>::enter::<core[8fb95b77d25ab6c8]::task::poll::Poll<()>, <tokio[3d0d737e2974e2b9]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x65353adf185c - <tokio[3d0d737e2974e2b9]::runtime::context::scoped::Scoped<tokio[3d0d737e2974e2b9]::runtime::scheduler::Context>>::set::<<tokio[3d0d737e2974e2b9]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[3d0d737e2974e2b9]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>::{closure#0}, (alloc[a7ee25936407c584]::boxed::Box<tokio[3d0d737e2974e2b9]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>)>
[INFO] [stdout]   15:     0x65353adef2a7 - <tokio[3d0d737e2974e2b9]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x65353adf47c6 - tokio[3d0d737e2974e2b9]::runtime::context::runtime::enter_runtime::<<tokio[3d0d737e2974e2b9]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x65353adec265 - <tokio[3d0d737e2974e2b9]::runtime::runtime::Runtime>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x65353ade99ac - <pane[21fc5584b9442d6a]::pane_split_swap_and_move_methods_use_expected_arguments::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x65353adf623b - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]   20:     0x65353ae03ab5 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]   21:     0x65353adfd3c4 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x65353ae06b32 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x65353ae9855f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x762d4a46607a - <unknown>
[INFO] [stdout]   25:     0x762d4a4f9534 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     pane_split_swap_and_move_methods_use_expected_arguments
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 4 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e", kill_on_drop: false }`
[INFO] [stdout] 6c459e8e56da318c7673f96f0243ebdf679090fdb75f233ae4b4d004522bc94e
