[INFO] fetching crate shiplog-ids 0.6.0...
[INFO] testing shiplog-ids-0.6.0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate shiplog-ids 0.6.0 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate shiplog-ids 0.6.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate shiplog-ids 0.6.0
[INFO] tweaked toml for crates.io crate shiplog-ids 0.6.0 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate shiplog-ids 0.6.0 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 crates.io crate shiplog-ids 0.6.0 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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8
[INFO] running `Command { std: "docker" "start" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8", 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" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8" "/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" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8", 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" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling typenum v1.20.0
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling hybrid-array v0.4.11
[INFO] [stderr]    Compiling crypto-common v0.2.1
[INFO] [stderr]    Compiling block-buffer v0.12.0
[INFO] [stderr]    Compiling digest v0.11.3
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling shiplog-ids v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 8.38s
[INFO] running `Command { std: "docker" "inspect" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8", 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" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8" "/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 getrandom v0.4.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling zmij v1.0.20
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling console v0.16.3
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling rand v0.9.4
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling zerocopy-derive v0.8.39
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling zerocopy v0.8.39
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling insta v1.47.2
[INFO] [stderr]    Compiling shiplog-ids v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 26.57s
[INFO] running `Command { std: "docker" "inspect" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8", 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" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/shiplog_ids-8d56e7da16b696a1)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test tests::event_id_varies_with_parts ... ok
[INFO] [stdout] test tests::event_id_is_valid_sha256_hex ... ok
[INFO] [stdout] test tests::run_id_starts_with_prefix ... ok
[INFO] [stdout] test tests::multi_part_uses_newline_separator_not_prefix ... ok
[INFO] [stdout] test tests::part_boundary_matters ... ok
[INFO] [stdout] test tests::workstream_id_deterministic ... ok
[INFO] [stdout] test tests::single_part_matches_known_sha256 ... ok
[INFO] [stdout] test tests::display_matches_inner ... ok
[INFO] [stdout] test tests::event_id_deterministic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/adversarial.rs (/opt/rustwide/target/debug/deps/adversarial-67ab0c8c59ccb06d)
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stdout] test empty_parts_produces_valid_id ... ok
[INFO] [stdout] test order_matters ... ok
[INFO] [stdout] test run_id_uniqueness ... ok
[INFO] [stdout] test unicode_parts ... ok
[INFO] [stdout] test determinism_across_calls ... ok
[INFO] [stdout] test run_id_now_has_prefix ... ok
[INFO] [stdout] test single_empty_string_part ... ok
[INFO] [stdout] test newline_in_parts ... ok
[INFO] [stdout] test different_parts_differ ... ok
[INFO] [stdout] test null_bytes_in_parts ... ok
[INFO] [stdout] test parts_containing_separator_may_collide ... ok
[INFO] [stdout] test run_id_empty_prefix ... ok
[INFO] [stdout] test workstream_id_differs_from_event_id_same_parts ... ok
[INFO] [stdout] test serde_round_trip_event_id ... ok
[INFO] [stdout] test display_matches_inner_string ... ok
[INFO] [stdout] test serde_round_trip_workstream_id ... ok
[INFO] [stdout] test workstream_id_determinism ... ok
[INFO] [stdout] test many_parts ... ok
[INFO] [stdout] test very_long_single_part ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/boundary.rs (/opt/rustwide/target/debug/deps/boundary-468fcd1e0ac488e8)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test display_matches_inner_for_all_types ... ok
[INFO] [stdout] test event_id_from_no_parts ... ok
[INFO] [stdout] test case_sensitivity ... ok
[INFO] [stdout] test empty_parts_vs_no_parts ... ok
[INFO] [stdout] test event_id_from_multiple_empty_strings ... ok
[INFO] [stdout] test consecutive_integers ... ok
[INFO] [stdout] test event_id_from_single_empty_string ... ok
[INFO] [stdout] test event_id_with_newlines_in_parts ... ok
[INFO] [stdout] test event_id_with_mixed_special_chars ... ok
[INFO] [stdout] test event_id_with_emoji ... ok
[INFO] [stdout] test run_id_long_prefix ... ok
[INFO] [stdout] test leading_space_difference ... ok
[INFO] [stdout] test part_boundary_collision_resistance ... ok
[INFO] [stdout] test part_boundary_collision_resistance_empty_vs_content ... ok
[INFO] [stdout] test trailing_space_difference ... ok
[INFO] [stdout] test workstream_id_from_empty_parts ... ok
[INFO] [stdout] test single_character_difference ... ok
[INFO] [stdout] test run_id_special_chars_in_prefix ... ok
[INFO] [stdout] test similar_numeric_strings ... ok
[INFO] [stdout] test event_id_with_null_bytes ... ok
[INFO] [stdout] test run_id_empty_prefix ... ok
[INFO] [stdout] test event_id_with_unicode ... ok
[INFO] [stdout] test event_id_with_many_parts ... ok
[INFO] [stdout] test event_id_long_input_is_deterministic ... ok
[INFO] [stdout] test workstream_id_with_very_long_part ... ok
[INFO] [stdout] test event_id_with_very_long_single_part ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/determinism.rs (/opt/rustwide/target/debug/deps/determinism-58dfd7cf22444bd1)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test workstream_id_independent_of_call_order ... ok
[INFO] [stdout] test event_id_independent_of_call_order ... ok
[INFO] [stdout] test event_and_workstream_id_share_same_hash_for_same_parts ... ok
[INFO] [stdout] test event_id_deterministic_across_100_iterations ... ok
[INFO] [stdout] test workstream_id_deterministic_across_100_iterations ... ok
[INFO] [stdout] test event_id_deterministic_with_varied_inputs ... ok
[INFO] [stdout] test workstream_id_deterministic_with_varied_inputs ... ok
[INFO] [stdout] test event_id_independent_of_system_time ... ok
[INFO] [stdout] test workstream_id_independent_of_system_time ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/format_stability.rs (/opt/rustwide/target/debug/deps/format_stability-8e357cdda80719ae)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test event_id_long_parts ... ok
[INFO] [stdout] test event_id_json_serialization ... ok
[INFO] [stdout] test run_id_json_serialization ... ok
[INFO] [stdout] test event_id_whitespace_parts ... ok
[INFO] [stdout] test run_id_display_known_value ... ok
[INFO] [stdout] test event_id_special_chars ... ok
[INFO] [stdout] test workstream_id_json_serialization ... ok
[INFO] [stdout] test workstream_id_unicode ... ok
[INFO] [stdout] test workstream_id_empty_parts ... ok
[INFO] [stdout] test run_id_display_empty_prefix ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/property_tests.rs (/opt/rustwide/target/debug/deps/property_tests-370b6e61f1129da7)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test event_id_case_sensitivity ... ok
[INFO] [stdout] test event_id_whitespace_sensitivity ... ok
[INFO] [stdout] test event_id_empty_parts_allowed ... ok
[INFO] [stdout] test event_id_part_boundary_matters ... ok
[INFO] [stdout] test prop_run_id_serde_roundtrip ... ok
[INFO] [stdout] test prop_run_id_display_matches_inner ... ok
[INFO] [stdout] test prop_run_id_suffix_format ... ok
[INFO] [stdout] test prop_workstream_id_display_matches_inner ... ok
[INFO] [stdout] test prop_run_id_prefix ... ok
[INFO] [stdout] test prop_event_id_matches_sha256_regex ... ok
[INFO] [stdout] test prop_event_id_hex_format ... ok
[INFO] [stdout] test prop_event_id_decodes_to_32_bytes ... ok
[INFO] [stdout] test prop_workstream_id_matches_sha256_regex ... ok
[INFO] [stdout] test prop_event_and_workstream_same_hash ... ok
[INFO] [stdout] test prop_workstream_id_serde_roundtrip ... ok
[INFO] [stdout] test prop_event_id_part_order_matters ... ok
[INFO] [stdout] test prop_workstream_id_hex_format ... ok
[INFO] [stdout] test prop_workstream_id_determinism ... ok
[INFO] [stdout] test prop_event_id_determinism ... ok
[INFO] [stdout] test prop_event_id_extra_part_changes_hash ... ok
[INFO] [stdout] test prop_event_id_display_matches_inner ... ok
[INFO] [stdout] test prop_workstream_id_uniqueness ... ok
[INFO] [stdout] test prop_event_id_serde_roundtrip ... ok
[INFO] [stdout] test prop_event_id_uniqueness ... ok
[INFO] [stdout] test prop_run_id_uniqueness ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.87s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stderr]      Running tests/snapshot.rs (/opt/rustwide/target/debug/deps/snapshot-fbb45d5701c8bcc5)
[INFO] [stdout] test event_id_review ... ok
[INFO] [stdout] test workstream_id_single_part ... ok
[INFO] [stdout] test event_id_empty_parts ... ok
[INFO] [stdout] test event_id_single_part ... ok
[INFO] [stdout] test workstream_id_repo_based ... ok
[INFO] [stdout] test event_id_unicode_parts ... ok
[INFO] [stdout] test workstream_id_custom_label ... ok
[INFO] [stdout] test event_id_typical_pr ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/stability.rs (/opt/rustwide/target/debug/deps/stability-ef2bbdfc9ba588f8)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test event_id_known_sha256_abc ... ok
[INFO] [stdout] test ids_are_lowercase_hex_64_chars ... ok
[INFO] [stdout] test event_id_deterministic_across_calls ... ok
[INFO] [stdout] test event_id_known_sha256_empty ... ok
[INFO] [stdout] test workstream_id_deterministic_across_calls ... ok
[INFO] [stdout] test event_and_workstream_same_parts_same_hash ... ok
[INFO] [stdout] test event_id_known_typical_pr ... ok
[INFO] [stdout] test workstream_id_known_repo ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/stress.rs (/opt/rustwide/target/debug/deps/stress-84c0ba0dcaa3197c)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test concurrent_event_id_determinism ... ok
[INFO] [stdout] test concurrent_event_ids_unique_across_inputs ... ok
[INFO] [stdout] test concurrent_run_id_uniqueness ... ok
[INFO] [stdout] test concurrent_workstream_id_determinism ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests shiplog_ids
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/lib.rs - WorkstreamId::from_parts (line 109) ... ok
[INFO] [stdout] test src/lib.rs - RunId (line 65) ... ok
[INFO] [stdout] test src/lib.rs - WorkstreamId (line 45) ... ok
[INFO] [stdout] test src/lib.rs - EventId (line 21) ... ok
[INFO] [stdout] test src/lib.rs - EventId::from_parts (line 91) ... ok
[INFO] [stdout] test src/lib.rs - RunId::now (line 126) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.50s; merged doctests compilation took 0.48s
[INFO] running `Command { std: "docker" "inspect" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8", kill_on_drop: false }`
[INFO] [stdout] c401c38762aa1dc5677067cfe765fe267d0804e0279aa127cd15a954b40dc6a8
