[INFO] fetching crate shipper-cli 0.3.0-rc.2...
[INFO] testing shipper-cli-0.3.0-rc.2 against beta-2026-04-21 for beta-1.96-2
[INFO] extracting crate shipper-cli 0.3.0-rc.2 into /workspace/builds/worker-5-tc2/source
[INFO] started tweaking crates.io crate shipper-cli 0.3.0-rc.2
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate shipper-cli 0.3.0-rc.2
[INFO] tweaked toml for crates.io crate shipper-cli 0.3.0-rc.2 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate shipper-cli 0.3.0-rc.2 on toolchain beta-2026-04-21
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-04-21" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate shipper-cli 0.3.0-rc.2 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" "+beta-2026-04-21" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] aff7918c82212b48ab646933ded169f39c707fd80257a53861aa00c71e4622d4
[INFO] running `Command { std: "docker" "start" "-a" "aff7918c82212b48ab646933ded169f39c707fd80257a53861aa00c71e4622d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "aff7918c82212b48ab646933ded169f39c707fd80257a53861aa00c71e4622d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aff7918c82212b48ab646933ded169f39c707fd80257a53861aa00c71e4622d4", kill_on_drop: false }`
[INFO] [stdout] aff7918c82212b48ab646933ded169f39c707fd80257a53861aa00c71e4622d4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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" "+beta-2026-04-21" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 347316d54eafe684d06ed8d61f411df4d1b59250d9de21e847487a7a3d6b27b1
[INFO] running `Command { std: "docker" "start" "-a" "347316d54eafe684d06ed8d61f411df4d1b59250d9de21e847487a7a3d6b27b1", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.184
[INFO] [stderr]    Compiling typenum v1.19.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling aws-lc-rs v1.16.2
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling rustls v0.23.38
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling cpufeatures v0.3.0
[INFO] [stderr]    Compiling rand_core v0.10.0
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling base64ct v1.8.3
[INFO] [stderr]    Compiling cmov v0.5.3
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling const-oid v0.10.2
[INFO] [stderr]    Compiling winnow v1.0.1
[INFO] [stderr]    Compiling camino v1.2.2
[INFO] [stderr]    Compiling toml_writer v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling portable-atomic v1.13.1
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling chacha20 v0.10.0
[INFO] [stderr]    Compiling shipper-cargo-failure v0.3.0-rc.2
[INFO] [stderr]    Compiling unit-prefix v0.5.2
[INFO] [stderr]    Compiling ctutils v0.4.2
[INFO] [stderr]    Compiling shipper-output-sanitizer v0.3.0-rc.2
[INFO] [stderr]    Compiling toml_parser v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling gethostname v1.1.0
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling hybrid-array v0.4.10
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling console v0.16.3
[INFO] [stderr]    Compiling which v8.0.2
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling rand v0.10.1
[INFO] [stderr]    Compiling cc v1.2.60
[INFO] [stderr]    Compiling password-hash v0.5.0
[INFO] [stderr]    Compiling indicatif v0.18.4
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling inout v0.1.4
[INFO] [stderr]    Compiling block-buffer v0.12.0
[INFO] [stderr]    Compiling crypto-common v0.2.1
[INFO] [stderr]    Compiling universal-hash v0.5.1
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling aead v0.5.2
[INFO] [stderr]    Compiling cipher v0.4.4
[INFO] [stderr]    Compiling polyval v0.6.2
[INFO] [stderr]    Compiling ghash v0.5.1
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling aes v0.8.4
[INFO] [stderr]    Compiling ctr v0.9.2
[INFO] [stderr]    Compiling pbkdf2 v0.12.2
[INFO] [stderr]    Compiling digest v0.11.2
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml_datetime v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling semver v1.0.28
[INFO] [stderr]    Compiling cargo-platform v0.3.2
[INFO] [stderr]    Compiling cmake v0.1.58
[INFO] [stderr]    Compiling aes-gcm v0.10.3
[INFO] [stderr]    Compiling hmac v0.13.0
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling toml v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling aws-lc-sys v0.39.1
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling darling_core v0.23.0
[INFO] [stderr]    Compiling zerofrom-derive v0.1.7
[INFO] [stderr]    Compiling yoke-derive v0.8.2
[INFO] [stderr]    Compiling zerovec-derive v0.11.3
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling tokio v1.51.1
[INFO] [stderr]    Compiling zerofrom v0.1.7
[INFO] [stderr]    Compiling yoke v0.8.2
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling darling_macro v0.23.0
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling clap_complete v4.6.1
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling darling v0.23.0
[INFO] [stderr]    Compiling serde_with_macros v3.18.0
[INFO] [stderr]    Compiling serde_with v3.18.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling humantime-serde v1.1.1
[INFO] [stderr]    Compiling shipper-duration v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-encrypt v0.3.0-rc.2
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling shipper-sparse-index v0.3.0-rc.2
[INFO] [stderr]    Compiling cargo_metadata v0.23.1
[INFO] [stderr]    Compiling shipper-retry v0.3.0-rc.2
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling rustls-webpki v0.103.12
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling rustls-platform-verifier v0.6.2
[INFO] [stderr]    Compiling hyper-rustls v0.27.8
[INFO] [stderr]    Compiling reqwest v0.13.2
[INFO] [stderr]    Compiling shipper-webhook v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-types v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-registry v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-config v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-core v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-cli v0.3.0-rc.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 22.74s
[INFO] running `Command { std: "docker" "inspect" "347316d54eafe684d06ed8d61f411df4d1b59250d9de21e847487a7a3d6b27b1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "347316d54eafe684d06ed8d61f411df4d1b59250d9de21e847487a7a3d6b27b1", kill_on_drop: false }`
[INFO] [stdout] 347316d54eafe684d06ed8d61f411df4d1b59250d9de21e847487a7a3d6b27b1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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" "+beta-2026-04-21" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1c6c8245c98e7189b41171796866eb3f6e3f200f40c8583a7ad27c42e2910d15
[INFO] running `Command { std: "docker" "start" "-a" "1c6c8245c98e7189b41171796866eb3f6e3f200f40c8583a7ad27c42e2910d15", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling console v0.16.3
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling predicates-core v1.0.10
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling assert_cmd v2.2.0
[INFO] [stderr]    Compiling sdd v3.0.10
[INFO] [stderr]    Compiling serial_test_derive v3.4.0
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling predicates-tree v1.0.13
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling chunked_transfer v1.5.0
[INFO] [stderr]    Compiling reqwest v0.13.2
[INFO] [stderr]    Compiling rand v0.9.3
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling scc v2.4.0
[INFO] [stderr]    Compiling ascii v1.1.0
[INFO] [stderr]    Compiling indicatif v0.18.4
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling temp-env v0.3.6
[INFO] [stderr]    Compiling tiny_http v0.12.0
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling serial_test v3.4.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling gethostname v1.1.0
[INFO] [stderr]    Compiling shipper-webhook v0.3.0-rc.2
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling insta v1.47.2
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling bstr v1.12.1
[INFO] [stderr]    Compiling shipper-types v0.3.0-rc.2
[INFO] [stderr]    Compiling predicates v3.1.4
[INFO] [stderr]    Compiling shipper-registry v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-config v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-core v0.3.0-rc.2
[INFO] [stderr]    Compiling shipper-cli v0.3.0-rc.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 14.86s
[INFO] running `Command { std: "docker" "inspect" "1c6c8245c98e7189b41171796866eb3f6e3f200f40c8583a7ad27c42e2910d15", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1c6c8245c98e7189b41171796866eb3f6e3f200f40c8583a7ad27c42e2910d15", kill_on_drop: false }`
[INFO] [stdout] 1c6c8245c98e7189b41171796866eb3f6e3f200f40c8583a7ad27c42e2910d15
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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" "+beta-2026-04-21" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d123207f6655788b36e9f15e035e1ab1d61adbe32c9bcef9f9a7f8a5dfd882df
[INFO] running `Command { std: "docker" "start" "-a" "d123207f6655788b36e9f15e035e1ab1d61adbe32c9bcef9f9a7f8a5dfd882df", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.27s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/shipper_cli-a25f5944b159003f)
[INFO] [stdout] 
[INFO] [stdout] running 106 tests
[INFO] [stdout] test output::progress::bdd_tests::bdd_given_multiple_updates_when_packages_advance_then_last_state_is_reflected ... ok
[INFO] [stdout] test output::progress::bdd_tests::bdd_given_progress_reporting_when_a_single_package_is_marked_then_state_tracks_name_and_index ... ok
[INFO] [stdout] test output::progress::proptests::fresh_reporter_initial_state ... ok
[INFO] [stdout] test output::progress::proptests::percentage_zero_before_any_work ... ok
[INFO] [stdout] test output::progress::proptests::step_count_invariant ... ok
[INFO] [stdout] test output::progress::proptests::silent_reporter_tracks_random_package_updates ... ok
[INFO] [stdout] test output::progress::proptests::percentage_always_in_range ... ok
[INFO] [stdout] test output::progress::proptests::finish_package_preserves_state ... ok
[INFO] [stdout] test output::progress::proptests::display_format_name_at_version ... ok
[INFO] [stdout] test output::progress::proptests::set_status_never_panics ... ok
[INFO] [stdout] test output::progress::proptests::total_packages_immutable ... ok
[INFO] [stdout] test output::progress::snapshot_tests::display_empty_name_and_version ... ok
[INFO] [stdout] test output::progress::snapshot_tests::display_single_package ... ok
[INFO] [stdout] test output::progress::snapshot_tests::display_multi_package_sequence ... ok
[INFO] [stdout] test output::progress::snapshot_tests::display_prerelease_version ... ok
[INFO] [stdout] test output::progress::snapshot_tests::percentage_milestones ... ok
[INFO] [stdout] test output::progress::snapshot_tests::percentage_large_workspace ... ok
[INFO] [stdout] test output::progress::snapshot_tests::percentage_zero_total ... ok
[INFO] [stdout] test output::progress::snapshot_tests::percentage_single_package ... ok
[INFO] [stdout] test output::progress::snapshot_tests::percentage_three_packages ... ok
[INFO] [stdout] test output::progress::snapshot_tests::state_after_first_package ... ok
[INFO] [stdout] test output::progress::snapshot_tests::state_full_lifecycle ... ok
[INFO] [stdout] test output::progress::snapshot_tests::state_fresh_reporter ... ok
[INFO] [stdout] test output::progress::snapshot_tests::state_zero_packages ... ok
[INFO] [stdout] test output::progress::tests::snapshot_display_format_edge_cases ... ok
[INFO] [stdout] test output::progress::snapshot_tests::state_overwrite_same_index ... ok
[INFO] [stdout] test output::progress::tests::snapshot_failed_midway_state ... ok
[INFO] [stdout] test output::progress::tests::snapshot_progress_at_0_percent ... ok
[INFO] [stdout] test output::progress::tests::snapshot_progress_at_25_percent ... ok
[INFO] [stdout] test output::progress::tests::snapshot_progress_at_100_percent ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_at_sign_in_version ... ok
[INFO] [stdout] test output::progress::tests::snapshot_progress_at_50_percent ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_numeric_name ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_single_char_name_and_version ... ok
[INFO] [stdout] test output::progress::tests::snapshot_single_package_lifecycle ... ok
[INFO] [stdout] test output::progress::tests::snapshot_progress_at_75_percent ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_newlines_in_status ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_version_with_pre_and_build ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_whitespace_in_name ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_with_build_metadata ... ok
[INFO] [stdout] test output::progress::tests::test_display_format_with_hyphenated_name ... ok
[INFO] [stdout] test output::progress::tests::test_concurrent_independent_reporters ... ok
[INFO] [stdout] test output::progress::tests::test_empty_package_name_and_version ... ok
[INFO] [stdout] test output::progress::tests::test_finish_completes_without_panic ... ok
[INFO] [stdout] test output::progress::tests::test_finish_immediately_with_packages ... ok
[INFO] [stdout] test output::progress::tests::test_finish_package_called_multiple_times ... ok
[INFO] [stdout] test output::progress::tests::test_finish_on_fresh_reporter ... ok
[INFO] [stdout] test output::progress::tests::test_finish_package_increments ... ok
[INFO] [stdout] test output::progress::tests::test_finish_package_preserves_current_name ... ok
[INFO] [stdout] test output::progress::tests::test_finish_package_without_set_package ... ok
[INFO] [stdout] test output::progress::tests::test_is_tty_returns_bool ... ok
[INFO] [stdout] test output::progress::tests::test_large_total_packages ... ok
[INFO] [stdout] test output::progress::tests::test_many_status_updates_between_packages ... ok
[INFO] [stdout] test output::progress::tests::test_multi_crate_sequential_publish ... ok
[INFO] [stdout] test output::progress::tests::test_multi_crate_status_updates_between_packages ... ok
[INFO] [stdout] test output::progress::tests::test_new_quiet_mode_disables_tty ... ok
[INFO] [stdout] test output::progress::tests::test_package_tracking_reverse_order ... ok
[INFO] [stdout] test output::progress::tests::test_package_tracking_skip_indices ... ok
[INFO] [stdout] test output::progress::tests::test_percentage_100_packages_milestones ... ok
[INFO] [stdout] test output::progress::tests::test_new_non_quiet_in_test_environment ... ok
[INFO] [stdout] test output::progress::tests::test_progress_reporter_creation ... ok
[INFO] [stdout] test output::progress::tests::test_percentage_always_in_range_exhaustive_small ... ok
[INFO] [stdout] test output::progress::tests::test_percentage_one_third_precision ... ok
[INFO] [stdout] test output::progress::tests::test_repeated_set_package_same_index ... ok
[INFO] [stdout] test output::progress::tests::test_reset_after_full_cycle ... ok
[INFO] [stdout] test output::progress::tests::test_set_package_decreasing_index ... ok
[INFO] [stdout] test output::progress::tests::test_set_package_far_beyond_total ... ok
[INFO] [stdout] test output::progress::tests::test_set_package_beyond_total ... ok
[INFO] [stdout] test output::progress::tests::test_set_package_index_zero ... ok
[INFO] [stdout] test output::progress::tests::test_set_package_formats_name_at_version ... ok
[INFO] [stdout] test output::progress::tests::test_set_package_overwrites_previous ... ok
[INFO] [stdout] test output::progress::tests::test_set_package_updates_state ... ok
[INFO] [stdout] test output::progress::tests::test_set_status_on_silent_reporter ... ok
[INFO] [stdout] test output::progress::tests::test_set_status_with_special_characters ... ok
[INFO] [stdout] test output::progress::tests::test_silent_initial_state ... ok
[INFO] [stdout] test output::progress::tests::test_silent_reporter_disables_tty ... ok
[INFO] [stdout] test output::progress::tests::test_single_package_all_operations ... ok
[INFO] [stdout] test output::progress::tests::test_state_after_partial_publish ... ok
[INFO] [stdout] test output::progress::tests::test_status_before_and_after_package ... ok
[INFO] [stdout] test output::progress::tests::test_status_transition_pending_to_completed ... ok
[INFO] [stdout] test output::progress::tests::test_status_transitions_with_intermediate_statuses ... ok
[INFO] [stdout] test output::progress::tests::test_u32_max_set_package_at_boundary ... ok
[INFO] [stdout] test output::progress::tests::test_u32_max_total_packages ... ok
[INFO] [stdout] test output::progress::tests::test_unicode_package_name ... ok
[INFO] [stdout] test output::progress::tests::test_very_long_package_name ... ok
[INFO] [stdout] test output::progress::tests::test_zero_packages_new_quiet ... ok
[INFO] [stdout] test output::progress::tests::test_zero_packages_set_package_still_works ... ok
[INFO] [stdout] test output::progress::tests::test_zero_packages_silent ... ok
[INFO] [stdout] test tests::cli_reporter_methods_are_callable ... ok
[INFO] [stdout] test output::progress::tests::test_zero_packages_set_status_and_finish ... ok
[INFO] [stdout] test tests::config_merge_with_cli_overrides ... ok
[INFO] [stdout] test tests::parse_duration_handles_valid_and_invalid_inputs ... ok
[INFO] [stdout] test tests::test_reporter_collects_all_levels ... ok
[INFO] [stdout] test tests::print_cmd_version_reports_missing_command ... ok
[INFO] [stdout] test tests::config_init_creates_file ... ok
[INFO] [stdout] test tests::config_validate_missing_file ... ok
[INFO] [stdout] test tests::config_load_from_workspace ... ok
[INFO] [stdout] test tests::config_validate_invalid_file ... ok
[INFO] [stdout] test tests::config_validate_valid_file ... ok
[INFO] [stdout] test tests::run_clean_errors_when_lock_exists_without_force ... ok
[INFO] [stdout] test tests::run_clean_force_removes_lock_and_state_files ... ok
[INFO] [stdout] test tests::global_flags_parse_after_subcommand ... ok
[INFO] [stdout] test tests::print_cmd_version_reports_non_zero_exit ... ok
[INFO] [stdout] test tests::run_doctor_restores_env_when_old_values_are_missing_or_present ... ok
[INFO] [stdout] test tests::run_doctor_supports_absolute_state_dir ... ok
[INFO] [stdout] test output::progress::proptests::full_publish_cycle_completes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 106 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.31s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/shipper_cli-147ee340ec483562)
[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/bdd_config.rs (/opt/rustwide/target/debug/deps/bdd_config-508bd71f00393960)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test config_init::given_no_config_file_when_config_init_then_shipper_toml_is_created ... ok
[INFO] [stdout] test config_init::given_config_init_with_output_then_file_is_written_to_specified_path ... ok
[INFO] [stdout] test config_validate::given_empty_shipper_toml_when_config_validate_then_defaults_are_reported ... ok
[INFO] [stdout] test config_validate::given_valid_shipper_toml_when_config_validate_then_success_is_reported ... ok
[INFO] [stdout] test config_validate::given_config_validate_with_path_then_specified_file_is_validated ... ok
[INFO] [stdout] test config_validate::given_invalid_shipper_toml_when_config_validate_then_errors_are_shown ... ok
[INFO] [stdout] test config_validate::given_invalid_values_when_config_validate_then_validation_errors_are_shown ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.27s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bdd_doctor.rs (/opt/rustwide/target/debug/deps/bdd_doctor-df717c415d5c9579)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test cargo_detection::given_cargo_is_installed_when_running_doctor_then_cargo_version_is_detected ... ok
[INFO] [stdout] test workspace_health::given_valid_workspace_when_running_doctor_then_checks_workspace_health ... ok
[INFO] [stdout] test environment_info::given_clean_environment_when_running_doctor_then_reports_environment_info ... ok
[INFO] [stdout] test workspace_health::given_nonexistent_state_dir_when_running_doctor_then_reports_will_be_created ... ok
[INFO] [stdout] test missing_token::given_no_cargo_registry_token_when_running_doctor_then_warns_about_missing_token ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bdd_error_handling.rs (/opt/rustwide/target/debug/deps/bdd_error_handling-866f8c74f02deefd)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test auth_failure::given_401_unauthorized_when_classifying_then_permanent ... ok
[INFO] [stdout] test auth_failure::given_invalid_token_when_classifying_then_permanent ... ok
[INFO] [stdout] test auth_failure::given_not_authorized_when_classifying_then_permanent ... ok
[INFO] [stdout] test invalid_manifest::given_compilation_failed_when_classifying_then_permanent ... ok
[INFO] [stdout] test invalid_manifest::given_parse_manifest_error_when_classifying_then_permanent ... ok
[INFO] [stdout] test mixed_success_failure_state::given_already_exists_when_classifying_then_permanent ... ok
[INFO] [stdout] test network_timeout::given_502_when_classifying_then_retryable ... ok
[INFO] [stdout] test network_timeout::given_connection_reset_when_classifying_then_retryable ... ok
[INFO] [stdout] test network_timeout::given_timeout_when_classifying_then_retryable ... ok
[INFO] [stdout] test rate_limiting::given_429_when_classifying_then_retryable ... ok
[INFO] [stdout] test rate_limiting::given_too_many_requests_when_classifying_then_retryable ... ok
[INFO] [stdout] test network_timeout::given_dns_error_when_classifying_then_retryable ... ok
[INFO] [stdout] test registry_unreachable::given_connection_refused_when_classifying_then_retryable ... ok
[INFO] [stdout] test registry_unreachable::given_unrecognized_error_when_classifying_then_ambiguous ... ok
[INFO] [stdout] test registry_unreachable::given_network_unreachable_when_classifying_then_retryable ... ok
[INFO] [stdout] test mixed_success_failure_state::given_backoff_config_when_computing_delay_then_capped ... ok
[INFO] [stdout] test invalid_manifest::given_missing_manifest_when_plan_then_cli_errors ... ok
[INFO] [stdout] test invalid_manifest::given_workspace_with_no_members_when_plan_then_cli_errors ... ok
[INFO] [stdout] test invalid_manifest::given_malformed_cargo_toml_when_plan_then_cli_errors ... ok
[INFO] [stdout] test registry_unreachable::given_unreachable_registry_when_preflight_then_fails ... ok
[INFO] [stdout] test auth_failure::given_auth_failure_stderr_when_publish_then_cli_reports_error ... ok
[INFO] [stdout] test rate_limiting::given_rate_limit_stderr_when_publish_then_retries_before_failing ... ok
[INFO] [stdout] test mixed_success_failure_state::given_first_succeeds_second_fails_when_publish_then_state_preserves_success ... ok
[INFO] [stdout] test mixed_success_failure_state::given_retryable_exhausted_then_receipt_shows_failed ... ok
[INFO] [stdout] test mixed_success_failure_state::given_retryable_failure_when_max_attempts_exhausted_then_nonzero_exit ... ok
[INFO] [stdout] test ambiguous_resolves_via_registry::given_ambiguous_failure_when_registry_shows_published_then_marked_published ... ok
[INFO] [stdout] test network_timeout::given_timeout_stderr_when_publish_then_retries ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 30.17s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bdd_error_recovery.rs (/opt/rustwide/target/debug/deps/bdd_error_recovery-c7f79296bdd73e03)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test failure_classification::given_timeout_error_when_classifying_then_retryable ... ok
[INFO] [stdout] test failure_classification::given_permanent_stderr_when_classifying_then_permanent ... ok
[INFO] [stdout] test failure_classification::given_retryable_stderr_when_classifying_then_retryable ... ok
[INFO] [stdout] test failure_classification::given_both_retryable_and_permanent_patterns_when_classifying_then_retryable_wins ... ok
[INFO] [stdout] test failure_classification::given_auth_failure_when_classifying_then_permanent ... ok
[INFO] [stdout] test failure_classification::given_unknown_error_when_classifying_then_ambiguous ... ok
[INFO] [stdout] test corrupted_receipt_handling::given_corrupted_receipt_from_prior_run_when_plan_then_still_works ... ok
[INFO] [stdout] test corrupted_receipt_handling::given_receipt_with_wrong_schema_when_inspect_receipt_then_fails_gracefully ... ok
[INFO] [stdout] test corrupted_receipt_handling::given_empty_receipt_when_inspect_receipt_then_fails_gracefully ... ok
[INFO] [stdout] test corrupted_receipt_handling::given_corrupted_receipt_when_inspect_receipt_then_fails_gracefully ... ok
[INFO] [stdout] test invalid_state_handling::given_truncated_state_json_when_resume_then_fails_gracefully ... ok
[INFO] [stdout] test invalid_state_handling::given_state_with_wrong_schema_when_resume_then_fails_gracefully ... ok
[INFO] [stdout] test resume_skips_completed::given_no_state_file_when_resume_then_fails ... ok
[INFO] [stdout] test invalid_state_handling::given_state_as_json_array_when_resume_then_fails_gracefully ... ok
[INFO] [stdout] test state_persistence_after_failure::given_empty_state_file_when_resume_then_reports_parse_error ... ok
[INFO] [stdout] test state_persistence_after_failure::given_corrupted_state_file_when_resume_then_reports_parse_error ... ok
[INFO] [stdout] test state_persistence_after_failure::given_state_with_mismatched_plan_id_when_publish_then_rejected ... ok
[INFO] [stdout] test resume_skips_completed::given_state_with_published_package_when_resume_then_skips_completed ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bdd_micro_backends.rs (/opt/rustwide/target/debug/deps/bdd_micro_backends-40bc9836654b98ba)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test preflight_stability::given_dependency_chain_and_no_token_when_preflight_then_stable_output ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bdd_parallel.rs (/opt/rustwide/target/debug/deps/bdd_parallel-9d78d32f738f1aa4)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test parallel_level_grouping::given_independent_crates_when_publishing_then_publishes_in_parallel_levels ... ok
[INFO] [stdout] test dependency_level_ordering::given_workspace_with_dependencies_when_publishing_then_respects_level_ordering ... ok
[INFO] [stdout] test max_concurrent_limits_parallelism::given_max_concurrent_flag_when_plan_then_accepted ... ok
[INFO] [stdout] test parallel_level_grouping::given_independent_crates_when_plan_verbose_then_shows_single_level ... ok
[INFO] [stdout] test dependency_level_ordering::given_dependencies_when_plan_verbose_then_shows_three_levels ... ok
[INFO] [stdout] test max_concurrent_limits_parallelism::given_max_concurrent_setting_when_publishing_then_limits_parallelism ... ok
[INFO] [stdout] test resume_skips_completed_levels::given_partially_published_workspace_when_resuming_then_skips_completed_levels ... ok
[INFO] [stdout] test failure_stops_subsequent_levels::given_failure_in_one_level_when_continuing_then_stops_subsequent_levels has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "d123207f6655788b36e9f15e035e1ab1d61adbe32c9bcef9f9a7f8a5dfd882df", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d123207f6655788b36e9f15e035e1ab1d61adbe32c9bcef9f9a7f8a5dfd882df", kill_on_drop: false }`
[INFO] [stdout] d123207f6655788b36e9f15e035e1ab1d61adbe32c9bcef9f9a7f8a5dfd882df
