[INFO] fetching crate oris-kernel 0.2.13...
[INFO] testing oris-kernel-0.2.13 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate oris-kernel 0.2.13 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate oris-kernel 0.2.13
[INFO] finished tweaking crates.io crate oris-kernel 0.2.13
[INFO] tweaked toml for crates.io crate oris-kernel 0.2.13 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate oris-kernel 0.2.13 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate oris-kernel 0.2.13 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded zmij v1.0.20
[INFO] [stderr]   Downloaded redox_syscall v0.7.1
[INFO] [stderr]   Downloaded libc v0.2.181
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] beb0989c498352ba3fcfa127bf644cd413eaebbe612d598ceab35ed850063103
[INFO] running `Command { std: "docker" "start" "-a" "beb0989c498352ba3fcfa127bf644cd413eaebbe612d598ceab35ed850063103", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "beb0989c498352ba3fcfa127bf644cd413eaebbe612d598ceab35ed850063103", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "beb0989c498352ba3fcfa127bf644cd413eaebbe612d598ceab35ed850063103", kill_on_drop: false }`
[INFO] [stdout] beb0989c498352ba3fcfa127bf644cd413eaebbe612d598ceab35ed850063103
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8b38ad37b349a3c3ed194dbc549fb3665119791f0ca37226c279f335f513bca9
[INFO] running `Command { std: "docker" "start" "-a" "8b38ad37b349a3c3ed194dbc549fb3665119791f0ca37226c279f335f513bca9", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling libc v0.2.181
[INFO] [stderr]    Compiling zmij v1.0.20
[INFO] [stderr]    Compiling schemars v0.8.22
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling schemars_derive v0.8.22
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling oris-kernel v0.2.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 18.60s
[INFO] running `Command { std: "docker" "inspect" "8b38ad37b349a3c3ed194dbc549fb3665119791f0ca37226c279f335f513bca9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8b38ad37b349a3c3ed194dbc549fb3665119791f0ca37226c279f335f513bca9", kill_on_drop: false }`
[INFO] [stdout] 8b38ad37b349a3c3ed194dbc549fb3665119791f0ca37226c279f335f513bca9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 06762a561b4a7ad302090af049a069193866b3604798205efa6a365c22112ba2
[INFO] running `Command { std: "docker" "start" "-a" "06762a561b4a7ad302090af049a069193866b3604798205efa6a365c22112ba2", kill_on_drop: false }`
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling oris-kernel v0.2.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.47s
[INFO] running `Command { std: "docker" "inspect" "06762a561b4a7ad302090af049a069193866b3604798205efa6a365c22112ba2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "06762a561b4a7ad302090af049a069193866b3604798205efa6a365c22112ba2", kill_on_drop: false }`
[INFO] [stdout] 06762a561b4a7ad302090af049a069193866b3604798205efa6a365c22112ba2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 117d78e812876c94da157847b0f4a327eca1d8443f615d168dbf94f0f9c6742b
[INFO] running `Command { std: "docker" "start" "-a" "117d78e812876c94da157847b0f4a327eca1d8443f615d168dbf94f0f9c6742b", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/oris_kernel-f66c6d8c902d2438)
[INFO] [stdout] 
[INFO] [stdout] running 71 tests
[INFO] [stdout] test kernel::determinism_guard::tests::guard_verify_traps_spawn ... ok
[INFO] [stdout] test kernel::determinism_guard::tests::guard_replay_traps_clock ... ok
[INFO] [stdout] test kernel::determinism_guard::tests::verify_event_stream_hash_mismatch_fails ... ok
[INFO] [stdout] test kernel::determinism_guard::tests::guard_normal_allows_clock ... ok
[INFO] [stdout] test kernel::driver::tests::effect_sink_captures_state_write_and_complete ... ok
[INFO] [stdout] test kernel::driver::tests::action_result_failure_returns_failed_and_single_terminal_event ... ok
[INFO] [stdout] test kernel::driver::tests::interrupt_saves_snapshot_before_returning_blocked ... ok
[INFO] [stdout] test kernel::driver::tests::kernel_replay_mode_determinism_guard_traps_clock ... ok
[INFO] [stdout] test kernel::driver::tests::replay_no_side_effects ... ok
[INFO] [stdout] test kernel::driver::tests::replay_state_equivalence ... ok
[INFO] [stdout] test kernel::driver::tests::retry_exhausted_has_single_terminal_failed_event ... ok
[INFO] [stdout] test kernel::driver::tests::retry_then_success_has_single_terminal_success_event ... ok
[INFO] [stdout] test kernel::driver::tests::run_loop_replays_only_tail_after_loading_latest_snapshot ... ok
[INFO] [stdout] test kernel::determinism_guard::tests::event_stream_hash_deterministic ... ok
[INFO] [stdout] test kernel::driver::tests::run_timeline_after_complete_has_events_and_json ... ok
[INFO] [stdout] test kernel::driver::tests::run_until_blocked_complete ... ok
[INFO] [stdout] test kernel::driver::tests::run_until_blocked_failure_recovery ... ok
[INFO] [stdout] test kernel::driver::tests::run_until_blocked_retry_then_success ... ok
[INFO] [stdout] test kernel::execution_log::tests::from_sequenced_state_updated_has_step_id ... ok
[INFO] [stdout] test kernel::driver::tests::run_until_blocked_then_resume ... ok
[INFO] [stdout] test kernel::execution_log::tests::scan_execution_log_returns_canonical_entries ... ok
[INFO] [stdout] test kernel::execution_log::tests::from_sequenced_completed_has_no_step_id ... ok
[INFO] [stdout] test kernel::execution_step::tests::execution_step_input_signal_empty_name_invalid ... ok
[INFO] [stdout] test kernel::execution_suspension::tests::running_to_suspended_transition ... ok
[INFO] [stdout] test kernel::execution_suspension::tests::suspended_to_waiting_input ... ok
[INFO] [stdout] test kernel::execution_step::tests::step_fn_impls_execution_step ... ok
[INFO] [stdout] test kernel::execution_suspension::tests::waiting_input_to_running_resume ... ok
[INFO] [stdout] test kernel::interrupt::tests::load_for_run_filters ... ok
[INFO] [stdout] test kernel::interrupt::tests::delete_removes_interrupt ... ok
[INFO] [stdout] test kernel::execution_step::tests::execution_step_input_resume_validates ... ok
[INFO] [stdout] test kernel::execution_step::tests::execution_step_input_signal_non_empty_name_validates ... ok
[INFO] [stdout] test kernel::kernel_mode::tests::record_does_not_trap ... ok
[INFO] [stdout] test kernel::kernel_mode::tests::verify_traps ... ok
[INFO] [stdout] test kernel::execution_step::tests::execution_step_input_initial_validates ... ok
[INFO] [stdout] test kernel::kernel_mode::tests::replay_traps ... ok
[INFO] [stdout] test kernel::policy::tests::retry_with_backoff_exponential_increases ... ok
[INFO] [stdout] test kernel::policy::tests::permanent_error_returns_fail ... ok
[INFO] [stdout] test kernel::policy::tests::retry_with_backoff_rate_limited_uses_retry_after_ms ... ok
[INFO] [stdout] test kernel::replay_cursor::tests::replay_from_checkpoint_applies_only_tail ... ok
[INFO] [stdout] test kernel::execution_suspension::tests::new_suspension_is_running ... ok
[INFO] [stdout] test kernel::policy::tests::retry_with_backoff_transient_retries_then_fails ... ok
[INFO] [stdout] test kernel::driver::tests::run_until_blocked_persists_latest_snapshot_on_completion ... ok
[INFO] [stdout] test kernel::replay_cursor::tests::replay_from_scratch_reconstructs_state ... ok
[INFO] [stdout] test kernel::interrupt::tests::save_and_load_interrupt ... ok
[INFO] [stdout] test kernel::interrupt_resolver::tests::resolver_routes_by_source ... ok
[INFO] [stdout] test kernel::kernel_mode::tests::normal_does_not_trap ... ok
[INFO] [stdout] test kernel::replay_cursor::tests::replay_step_yields_state_after_each_event ... ok
[INFO] [stdout] test kernel::replay_resume::tests::resume_idempotent_twice ... ok
[INFO] [stdout] test kernel::replay_resume::tests::resume_injects_decision ... ok
[INFO] [stdout] test kernel::replay_resume::tests::verify_idempotent_returns_true ... ok
[INFO] [stdout] test kernel::execution_suspension::tests::invalid_transition_running_to_waiting ... ok
[INFO] [stdout] test kernel::replay_verifier::tests::tool_checksum_returns_same_for_same_calls ... ok
[INFO] [stdout] test kernel::replay_verifier::tests::verify_interrupt_consistency_ok ... ok
[INFO] [stdout] test kernel::replay_verifier::tests::verify_interrupt_consistency_unmatched_interrupt ... ok
[INFO] [stdout] test kernel::replay_verifier::tests::verify_returns_ok_when_run_not_found ... ok
[INFO] [stdout] test kernel::replay_verifier::tests::verify_state_hash_mismatch ... ok
[INFO] [stdout] test kernel::replay_verifier::tests::verify_tool_checksum_mismatch ... ok
[INFO] [stdout] test kernel::runtime_effect::tests::effect_sink_can_count ... ok
[INFO] [stdout] test kernel::runner::tests::run_until_blocked_async_completes_no_deadlock ... ok
[INFO] [stdout] test kernel::runner::tests::run_until_blocked_async_completes_within_timeout ... ok
[INFO] [stdout] test kernel::execution_log::tests::execution_log_converts_to_kernel_trace_event ... ok
[INFO] [stdout] test kernel::runner::tests::run_until_blocked_async_twice_no_hang ... ok
[INFO] [stdout] test kernel::execution_log::tests::scan_execution_log_with_state_hashes_populates_hashes ... ok
[INFO] [stdout] test kernel::runner::tests::run_until_blocked_sync_completes ... ok
[INFO] [stdout] test kernel::runtime_effect::tests::noop_effect_sink_accepts_all ... ok
[INFO] [stdout] test kernel::runtime_effect::tests::runtime_effect_llm_call_roundtrip ... ok
[INFO] [stdout] test kernel::timeline::tests::timeline_from_events_matches_order_and_final_status ... ok
[INFO] [stdout] test kernel::timeline_fork::tests::clone_timeline_replays_entire_run ... ok
[INFO] [stdout] test kernel::timeline::tests::timeline_json_roundtrip ... ok
[INFO] [stdout] test kernel::timeline_fork::tests::fork_injects_alternate_event ... ok
[INFO] [stdout] test kernel::driver::tests::replay_from_snapshot_applies_tail_only ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 71 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests oris_kernel
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "117d78e812876c94da157847b0f4a327eca1d8443f615d168dbf94f0f9c6742b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "117d78e812876c94da157847b0f4a327eca1d8443f615d168dbf94f0f9c6742b", kill_on_drop: false }`
[INFO] [stdout] 117d78e812876c94da157847b0f4a327eca1d8443f615d168dbf94f0f9c6742b