[INFO] cloning repository https://github.com/schneems/bullet_stream
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/schneems/bullet_stream" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fschneems%2Fbullet_stream", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fschneems%2Fbullet_stream'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 605e684527700973adef9a756d32c2363c9d7da7
[INFO] testing schneems/bullet_stream against try#2440211fe03bc45c89b6dc1a3df18382ce91e32b for pr-146098-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fschneems%2Fbullet_stream" "/workspace/builds/worker-6-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/schneems/bullet_stream
[INFO] finished tweaking git repo https://github.com/schneems/bullet_stream
[INFO] tweaked toml for git repo https://github.com/schneems/bullet_stream written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/schneems/bullet_stream on toolchain 2440211fe03bc45c89b6dc1a3df18382ce91e32b
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/schneems/bullet_stream 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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ee8c4435a864fa758fb5b1eaf2453f5976546f1bc8fe62b79303be2e845d918a
[INFO] running `Command { std: "docker" "start" "-a" "ee8c4435a864fa758fb5b1eaf2453f5976546f1bc8fe62b79303be2e845d918a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ee8c4435a864fa758fb5b1eaf2453f5976546f1bc8fe62b79303be2e845d918a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ee8c4435a864fa758fb5b1eaf2453f5976546f1bc8fe62b79303be2e845d918a", kill_on_drop: false }`
[INFO] [stdout] ee8c4435a864fa758fb5b1eaf2453f5976546f1bc8fe62b79303be2e845d918a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9b87337e75be9a5d42678ce6f329d965919c9af1be3fa8b97665f56f168acde1
[INFO] running `Command { std: "docker" "start" "-a" "9b87337e75be9a5d42678ce6f329d965919c9af1be3fa8b97665f56f168acde1", kill_on_drop: false }`
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling fun_run v0.6.0
[INFO] [stderr]    Compiling bullet_stream v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.60s
[INFO] running `Command { std: "docker" "inspect" "9b87337e75be9a5d42678ce6f329d965919c9af1be3fa8b97665f56f168acde1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9b87337e75be9a5d42678ce6f329d965919c9af1be3fa8b97665f56f168acde1", kill_on_drop: false }`
[INFO] [stdout] 9b87337e75be9a5d42678ce6f329d965919c9af1be3fa8b97665f56f168acde1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7f84efe60c86ede8e3af1f76d04cfef11df3e7e29b5b3368ba1de92275eb19a6
[INFO] running `Command { std: "docker" "start" "-a" "7f84efe60c86ede8e3af1f76d04cfef11df3e7e29b5b3368ba1de92275eb19a6", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_json v1.0.138
[INFO] [stderr]    Compiling semver v1.0.25
[INFO] [stderr]    Compiling camino v1.1.9
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling bit-vec v0.6.3
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling winnow v0.7.2
[INFO] [stderr]    Compiling bitflags v2.8.0
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling libc v0.2.169
[INFO] [stderr]    Compiling bstr v1.11.3
[INFO] [stderr]    Compiling syn v2.0.98
[INFO] [stderr]    Compiling getrandom v0.3.1
[INFO] [stderr]    Compiling uriparse v0.6.4
[INFO] [stderr]    Compiling bit-set v0.5.3
[INFO] [stderr]    Compiling fixedbitset v0.4.2
[INFO] [stderr]    Compiling either v1.13.0
[INFO] [stderr]    Compiling home v0.5.11
[INFO] [stderr]    Compiling once_cell v1.20.3
[INFO] [stderr]    Compiling indoc v2.0.5
[INFO] [stderr]    Compiling fs_extra v1.3.0
[INFO] [stderr]    Compiling petgraph v0.6.5
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling diff v0.1.13
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling pretty_assertions v1.4.1
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling which v6.0.3
[INFO] [stderr]    Compiling tempfile v3.16.0
[INFO] [stderr]    Compiling serde_derive v1.0.217
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling globset v0.4.15
[INFO] [stderr]    Compiling fancy-regex v0.13.0
[INFO] [stderr]    Compiling fun_run v0.6.0
[INFO] [stderr]    Compiling ascii_table v4.0.5
[INFO] [stderr]    Compiling ignore v0.4.23
[INFO] [stderr]    Compiling bullet_stream v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling serde v1.0.217
[INFO] [stderr]    Compiling cargo-platform v0.1.9
[INFO] [stderr]    Compiling serde_spanned v0.6.8
[INFO] [stderr]    Compiling toml_datetime v0.6.8
[INFO] [stderr]    Compiling toml_edit v0.22.24
[INFO] [stderr]    Compiling cargo_metadata v0.18.1
[INFO] [stderr]    Compiling toml v0.8.20
[INFO] [stderr]    Compiling libcnb-proc-macros v0.23.0
[INFO] [stderr]    Compiling libcnb-common v0.23.0
[INFO] [stderr]    Compiling libcnb-data v0.23.0
[INFO] [stderr]    Compiling libcnb-package v0.23.0
[INFO] [stderr]    Compiling libcnb-test v0.23.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 11.12s
[INFO] running `Command { std: "docker" "inspect" "7f84efe60c86ede8e3af1f76d04cfef11df3e7e29b5b3368ba1de92275eb19a6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7f84efe60c86ede8e3af1f76d04cfef11df3e7e29b5b3368ba1de92275eb19a6", kill_on_drop: false }`
[INFO] [stdout] 7f84efe60c86ede8e3af1f76d04cfef11df3e7e29b5b3368ba1de92275eb19a6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 65ba39878d6dbdb2a766854ac3ed55cac59f9010016060c7588d3a6981d86be2
[INFO] running `Command { std: "docker" "start" "-a" "65ba39878d6dbdb2a766854ac3ed55cac59f9010016060c7588d3a6981d86be2", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bullet_stream-297d9d2110b779e8)
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test ansi_escape::test::empty_line ... ok
[INFO] [stdout] test ansi_escape::test::handles_double_nested_color ... ok
[INFO] [stdout] test ansi_escape::test::handles_nested_color_at_end ... ok
[INFO] [stdout] test ansi_escape::test::handles_nested_color_in_middle ... ok
[INFO] [stdout] test ansi_escape::test::simple_case ... ok
[INFO] [stdout] test ansi_escape::test::handles_nested_color_at_start ... ok
[INFO] [stdout] test ansi_escape::test::splits_newlines ... ok
[INFO] [stdout] test ansi_escape::test::test_strip_ansi ... ok
[INFO] [stdout] test duration_format::test::test_display_duration ... ok
[INFO] [stdout] test background_printer::test::does_stop_does_not_panic ... ok
[INFO] [stdout] test test::double_h1_h2_newlines ... ok
[INFO] [stdout] test test::double_warning_step_padding ... ok
[INFO] [stdout] test test::double_h2_h2_newlines ... ok
[INFO] [stdout] test test::h3_first ... ok
[INFO] [stdout] test test::test_important ... ok
[INFO] [stdout] test test::warning_after_buildpack ... ok
[INFO] [stdout] test test::test_captures ... ok
[INFO] [stdout] test test::warning_step_padding ... ok
[INFO] [stdout] test test::background_timer ... ok
[INFO] [stdout] test test::paragraph_color_codes ... ok
[INFO] [stdout] test test::write_paragraph_empty_lines ... ok
[INFO] [stdout] test util::test::test_prefix_first_rest_lines ... ok
[INFO] [stdout] test test::test_error ... ok
[INFO] [stdout] test util::test::test_paragraph_inspect_write ... ok
[INFO] [stdout] test util::test::test_mpsc_streaming_helper ... ok
[INFO] [stdout] test write::test::plain_ending_newline ... ok
[INFO] [stdout] test util::test::test_prefix_lines ... ok
[INFO] [stdout] test write::test::test_mapped_write ... ok
[INFO] [stdout] test test::background_timer_dropped ... ok
[INFO] [stdout] test background_printer::test::test_drop_stops_timer ... ok
[INFO] [stdout] test test::test_streaming_a_command ... ok
[INFO] [stdout] test test::stream_with ... ok
[INFO] [stdout] test test::global_preserves_newline ... ok
[INFO] [stdout] test global::test::with_locked_writer_handles_panics_across_threads ... ok
[INFO] [stdout] test util::test::test_mpsc_streaming_cannot_deadlock ... ok
[INFO] [stdout] test write::test::test_time_cmd ... ok
[INFO] [stdout] test write::test::test_stream_cmd ... ok
[INFO] [stdout] test test::test_cmd ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests bullet_stream
[INFO] [stdout] 
[INFO] [stdout] running 41 tests
[INFO] [stdout] test src/global.rs - global::print::sub_time_cmd (line 558) - compile ... ok
[INFO] [stdout] test src/global.rs - global::print::sub_stream_cmd (line 509) - compile ... ok
[INFO] [stdout] test src/global.rs - global::print::sub_stream_with (line 486) - compile ... ok
[INFO] [stdout] test src/global.rs - global::set_writer (line 61) ... ok
[INFO] [stdout] test src/global.rs - global::with_locked_writer (line 123) ... ok
[INFO] [stdout] test src/global.rs - global::print::h1 (line 248) ... ok
[INFO] [stdout] test src/global.rs - global::print::plain (line 338) ... ok
[INFO] [stdout] test src/global.rs - global::print::error (line 627) ... ok
[INFO] [stdout] test src/global.rs - global::print::h2 (line 274) ... ok
[INFO] [stdout] test src/global.rs - global::print::sub_bullet (line 464) ... ok
[INFO] [stdout] test src/global.rs - global::print::h3 (line 303) ... ok
[INFO] [stdout] test src/global.rs - global::print::buildpack (line 363) ... ok
[INFO] [stdout] test src/global.rs - global::with_locked_writer (line 155) ... ok
[INFO] [stdout] test src/global.rs - global::print::warning (line 603) ... ok
[INFO] [stdout] test src/global.rs - global::print::bullet (line 444) ... ok
[INFO] [stdout] test src/global.rs - global::print::all_done (line 577) ... ok
[INFO] [stdout] test src/global.rs - global::print::header (line 390) ... ok
[INFO] [stdout] test src/global.rs - global::with_locked_writer (line 145) ... ok
[INFO] [stdout] test src/global.rs - global::print::sub_start_timer (line 527) ... ok
[INFO] [stdout] test src/lib.rs - (line 117) ... ok
[INFO] [stdout] test src/lib.rs - Print<state::SubBullet<W>>::stream_cmd (line 706) - compile ... ok
[INFO] [stdout] test src/lib.rs - Print<state::SubBullet<W>>::stream_with (line 671) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 136) ... ok
[INFO] [stdout] test src/lib.rs - Print<state::SubBullet<W>>::time_cmd (line 618) - compile ... ok
[INFO] [stdout] test src/global.rs - global::with_locked_writer (line 167) ... ok
[INFO] [stdout] test src/lib.rs - (line 39) ... ok
[INFO] [stdout] test src/lib.rs - (line 23) ... ok
[INFO] [stdout] test src/lib.rs - Print (line 100) ... ok
[INFO] [stdout] test src/lib.rs - GlobalTimer::done (line 74) ... ok
[INFO] [stdout] test src/lib.rs - state::Bullet (line 173) ... ok
[INFO] [stdout] test src/lib.rs - GlobalTimer::cancel (line 48) ... ok
[INFO] [stdout] test src/lib.rs - (line 87) ... ok
[INFO] [stdout] test src/lib.rs - state::SubBullet (line 212) ... ok
[INFO] [stdout] test src/lib.rs - GlobalTimer (line 30) ... ok
[INFO] [stdout] test src/lib.rs - (line 202) ... ok
[INFO] [stdout] test src/lib.rs - (line 170) ... ok
[INFO] [stdout] test src/lib.rs - Print<state::Background<W>>::cancel (line 462) ... ok
[INFO] [stdout] test src/lib.rs - state::Header (line 148) ... ok
[INFO] [stdout] test src/lib.rs - state::Stream (line 241) ... ok
[INFO] [stdout] test src/lib.rs - state::Background (line 272) ... ok
[INFO] [stdout] test src/style.rs - style::important (line 39) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 41 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.93s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "65ba39878d6dbdb2a766854ac3ed55cac59f9010016060c7588d3a6981d86be2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "65ba39878d6dbdb2a766854ac3ed55cac59f9010016060c7588d3a6981d86be2", kill_on_drop: false }`
[INFO] [stdout] 65ba39878d6dbdb2a766854ac3ed55cac59f9010016060c7588d3a6981d86be2