[INFO] cloning repository https://github.com/gabaum10/heartbeat-rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/gabaum10/heartbeat-rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgabaum10%2Fheartbeat-rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgabaum10%2Fheartbeat-rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] cf8bb0b28c18c9fddb441fa927c57f24291e7492
[INFO] testing gabaum10/heartbeat-rs against 1.99.0-beta.8 for beta-1.100-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgabaum10%2Fheartbeat-rs" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/gabaum10/heartbeat-rs
[INFO] removed 0 missing tests
[INFO] finished tweaking git repo https://github.com/gabaum10/heartbeat-rs
[INFO] tweaked toml for git repo https://github.com/gabaum10/heartbeat-rs written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/gabaum10/heartbeat-rs 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 git repo https://github.com/gabaum10/heartbeat-rs 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 portable-pty v0.9.0
[INFO] [stderr]   Downloaded serial2 v0.2.38
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024
[INFO] running `Command { std: "docker" "start" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024", 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" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024" "/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" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024", 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" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling clap_lex v1.1.1
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling clap_builder v4.6.7
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling clap_derive v4.6.7
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling clap v4.6.7
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling heartbeat-rs v0.5.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.80s
[INFO] running `Command { std: "docker" "inspect" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024", 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" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling bitflags v2.13.2
[INFO] [stderr]    Compiling fastrand v2.5.0
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling heartbeat-rs v0.5.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.71s
[INFO] running `Command { std: "docker" "inspect" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024", 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" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stdout] running 70 tests
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/heartbeat_rs-9762b9d996a3769d)
[INFO] [stdout] test hook::tests::block_serializes_correctly ... ok
[INFO] [stdout] test hook::tests::no_flag_with_message_blocks_and_writes_in_flight ... ok
[INFO] [stdout] test hook::tests::approve_serializes_to_empty_string ... ok
[INFO] [stdout] test hook::tests::no_flag_empty_inbox_approves_in_drain_mode ... ok
[INFO] [stdout] test hook::tests::drain_nonexistent_inbox_approves ... ok
[INFO] [stdout] test hook::tests::idle_tick_serializes_as_block ... ok
[INFO] [stdout] test hook::tests::flag_with_empty_inbox_acknowledges_and_approves_in_drain_mode ... ok
[INFO] [stdout] test hook::tests::cursor_advances_only_on_second_tick_not_on_delivery ... ok
[INFO] [stdout] test hook::tests::flag_with_more_messages_acknowledges_and_delivers_next ... ok
[INFO] [stdout] test hook::tests::crash_window_b_agent_crash_leaves_same_orphan_signal ... ok
[INFO] [stdout] test hook::tests::no_flag_empty_inbox_idles_in_persist_mode ... ok
[INFO] [stdout] test hook::tests::crash_window_a_launcher_crash_leaves_live_orphan ... ok
[INFO] [stdout] test hook::tests::flag_with_empty_inbox_idles_in_persist_mode ... ok
[INFO] [stdout] test hook::tests::crash_window_c_stale_orphan_cursor_past_end_offset ... ok
[INFO] [stdout] test hook::tests::in_flight_removed_after_ack ... ok
[INFO] [stdout] test hook::tests::responded_without_in_flight_returns_error ... ok
[INFO] [stdout] test hook::tests::blank_line_between_entries_skipped_at_hook_level ... ok
[INFO] [stdout] test hook::tests::multi_entry_inbox_delivers_in_byte_order_then_approves ... ok
[INFO] [stdout] test in_flight::tests::is_not_stale_when_cursor_before_end_offset ... ok
[INFO] [stdout] test in_flight::tests::read_from_missing_file_returns_none ... ok
[INFO] [stdout] test in_flight::tests::entry_id_is_sha256_of_raw_line ... ok
[INFO] [stdout] test in_flight::tests::entry_id_differs_for_different_raw_lines ... ok
[INFO] [stdout] test in_flight::tests::utc_timestamp_format_is_iso8601 ... ok
[INFO] [stdout] test hook::tests::responded_without_in_flight_returns_inconsistent_state_with_io_dir ... ok
[INFO] [stdout] test in_flight::tests::corrupt_in_flight_json_read_from_returns_in_flight_corrupt ... ok
[INFO] [stdout] test in_flight::tests::is_stale_when_cursor_past_end_offset ... ok
[INFO] [stdout] test in_flight::tests::empty_in_flight_file_returns_in_flight_corrupt ... ok
[INFO] [stdout] test in_flight::tests::in_flight_file_for_places_in_same_dir ... ok
[INFO] [stdout] test inbox::tests::corrupt_offset_read_next_entry_returns_offset_corrupt ... ok
[INFO] [stdout] test inbox::tests::consumer_warn_and_fallback_explicit_match_pattern ... ok
[INFO] [stdout] test in_flight::tests::entry_id_stable_for_same_raw_line ... ok
[INFO] [stdout] test inbox::tests::empty_inbox_returns_none ... ok
[INFO] [stdout] test in_flight::tests::round_trip_write_read ... ok
[INFO] [stdout] test in_flight::tests::write_is_atomic_via_tmp_rename ... ok
[INFO] [stdout] test inbox::tests::acknowledge_is_ok_if_in_flight_already_gone ... ok
[INFO] [stdout] test inbox::tests::crash_c1_before_in_flight_write_recovers_naturally ... ok
[INFO] [stdout] test inbox::tests::crash_c2_in_flight_written_offset_not_advanced ... ok
[INFO] [stdout] test inbox::tests::corrupt_offset_acknowledge_returns_offset_corrupt ... ok
[INFO] [stdout] test inbox::tests::acknowledge_advances_offset_and_removes_in_flight ... ok
[INFO] [stdout] test inbox::tests::invalid_utf8_no_newline_cursor_stays_aligned ... ok
[INFO] [stdout] test inbox::tests::offset_with_whitespace_and_newline_parses_ok ... ok
[INFO] [stdout] test inbox::tests::offset_file_for_places_in_same_dir ... ok
[INFO] [stdout] test inbox::tests::crash_c3_after_response_before_ack_is_live_orphan ... ok
[INFO] [stdout] test in_flight::tests::is_stale_when_cursor_at_end_offset ... ok
[INFO] [stdout] test inbox::tests::single_line_with_newline ... ok
[INFO] [stdout] test recover::tests::corrupt_offset_recover_returns_offset_corrupt ... ok
[INFO] [stdout] test inbox::tests::no_ack_means_same_entry_re_read ... ok
[INFO] [stdout] test inbox::tests::byte_offset_survives_append ... ok
[INFO] [stdout] test inbox::tests::single_line_without_newline ... ok
[INFO] [stdout] test inbox::tests::json_encoded_messages_drain_in_order ... ok
[INFO] [stdout] test inbox::tests::invalid_utf8_before_newline_cursor_stays_aligned ... ok
[INFO] [stdout] test recover::tests::crash_between_ack_step1_and_step2_recovered_by_stale_orphan_path ... ok
[INFO] [stdout] test inbox::tests::blank_lines_between_messages_skipped ... ok
[INFO] [stdout] test inbox::tests::blank_lines_skipped_not_returned_as_none ... ok
[INFO] [stdout] test inbox::tests::stale_orphan_detected_by_cursor_past_end_offset ... ok
[INFO] [stdout] test inbox::tests::multiple_lines_consumed_in_order ... ok
[INFO] [stdout] test recover::tests::deadletter_moves_orphan_to_dead_letter_file ... ok
[INFO] [stdout] test recover::tests::deadletter_appends_multiple_orphans ... ok
[INFO] [stdout] test inbox::tests::json_encoded_multiline_is_decoded ... ok
[INFO] [stdout] test recover::tests::no_in_flight_returns_nothing_to_recover ... ok
[INFO] [stdout] test recover::tests::recover_errors_on_corrupt_in_flight ... ok
[INFO] [stdout] test inbox::tests::plain_text_passthrough_unchanged ... ok
[INFO] [stdout] test recover::tests::fen_n1_happy_path_no_orphan ... ok
[INFO] [stdout] test recover::tests::drop_deletes_in_flight_and_advances_cursor ... ok
[INFO] [stdout] test recover::tests::retry_resets_cursor_to_start_offset_no_duplicate ... ok
[INFO] [stdout] test recover::tests::stale_orphan_deleted_when_cursor_past_end_offset ... ok
[INFO] [stdout] test recover::tests::fen_n1_failure_path_drop_policy ... ok
[INFO] [stdout] test recover::tests::fen_cascade_drop_policy_clears_responded_before_next_session ... ok
[INFO] [stdout] test recover::tests::retry_followed_by_hook_run_re_delivers_entry_k ... ok
[INFO] [stdout] test recover::tests::retry_on_poison_entry_does_not_grow_inbox_over_5_cycles ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 70 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.43s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/heartbeat_stop-da9dbf975459d0a4)
[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] [stderr]      Running tests/cli.rs (/opt/rustwide/target/debug/deps/cli-f1a8b191c68c02a1)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test version_flag_prints_version_and_exits_zero ... ok
[INFO] [stdout] test missing_inbox_flag_exits_nonzero ... ok
[INFO] [stdout] test recover_corrupt_in_flight_exits_nonzero ... ok
[INFO] [stdout] test happy_path_deliver_ack_exit_codes_and_stdout ... ok
[INFO] [stdout] test recover_retry_then_hook_redelivers_entry_k ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests heartbeat_rs
[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" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024", kill_on_drop: false }`
[INFO] [stdout] fb082f144cf68f61991535322c55d492ea7c4efefdba7410fd4de2e83b10b024
