[INFO] fetching crate proto-types 0.2.2...
[INFO] testing proto-types-0.2.2 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate proto-types 0.2.2 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate proto-types 0.2.2
[INFO] finished tweaking crates.io crate proto-types 0.2.2
[INFO] tweaked toml for crates.io crate proto-types 0.2.2 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate proto-types 0.2.2 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate proto-types 0.2.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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e070589b0b694c77d507e9947b2173c63c9dddadee40e99e4989d317b257203a
[INFO] running `Command { std: "docker" "start" "-a" "e070589b0b694c77d507e9947b2173c63c9dddadee40e99e4989d317b257203a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e070589b0b694c77d507e9947b2173c63c9dddadee40e99e4989d317b257203a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e070589b0b694c77d507e9947b2173c63c9dddadee40e99e4989d317b257203a", kill_on_drop: false }`
[INFO] [stdout] e070589b0b694c77d507e9947b2173c63c9dddadee40e99e4989d317b257203a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 248ff597388d6dbea4f36fa1008cadb986bddc15ee058d0b4a012bd500b07677
[INFO] running `Command { std: "docker" "start" "-a" "248ff597388d6dbea4f36fa1008cadb986bddc15ee058d0b4a012bd500b07677", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling bytes v1.11.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling prost-derive v0.14.3
[INFO] [stderr]    Compiling prost v0.14.3
[INFO] [stderr]    Compiling proto-types v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.91s
[INFO] running `Command { std: "docker" "inspect" "248ff597388d6dbea4f36fa1008cadb986bddc15ee058d0b4a012bd500b07677", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "248ff597388d6dbea4f36fa1008cadb986bddc15ee058d0b4a012bd500b07677", kill_on_drop: false }`
[INFO] [stdout] 248ff597388d6dbea4f36fa1008cadb986bddc15ee058d0b4a012bd500b07677
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1864121ada5a93aa31d12e9db54a4479c638e10919c021337043be2aa747ee71
[INFO] running `Command { std: "docker" "start" "-a" "1864121ada5a93aa31d12e9db54a4479c638e10919c021337043be2aa747ee71", kill_on_drop: false }`
[INFO] [stderr]    Compiling proto-types v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.97s
[INFO] running `Command { std: "docker" "inspect" "1864121ada5a93aa31d12e9db54a4479c638e10919c021337043be2aa747ee71", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1864121ada5a93aa31d12e9db54a4479c638e10919c021337043be2aa747ee71", kill_on_drop: false }`
[INFO] [stdout] 1864121ada5a93aa31d12e9db54a4479c638e10919c021337043be2aa747ee71
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bf4f8c2f6b77078782fdd75fa8a4d3469f9c5e73f59539c311d8a38df42d81d0
[INFO] running `Command { std: "docker" "start" "-a" "bf4f8c2f6b77078782fdd75fa8a4d3469f9c5e73f59539c311d8a38df42d81d0", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/proto_types-7c2b838864d5e429)
[INFO] [stdout] 
[INFO] [stdout] running 65 tests
[INFO] [stdout] test duration::duration_operations::tests::chrono_test::test_eq_ord ... ok
[INFO] [stdout] test duration::duration_operations::tests::std_test::test_add_sub ... ok
[INFO] [stdout] test duration::duration_operations::tests::chrono_test::test_add_sub ... ok
[INFO] [stdout] test duration::duration_operations::tests::std_test::test_eq_ord ... ok
[INFO] [stdout] test duration::duration_operations::tests::test_div_edge_cases ... ok
[INFO] [stdout] test duration::duration_operations::tests::test_add_sub ... ok
[INFO] [stdout] test duration::duration_operations::tests::test_mul_overflow_checks ... ok
[INFO] [stdout] test duration::duration_operations::tests::test_div_bug_fix ... ok
[INFO] [stdout] test duration::formatting::tests::test_duration_display_cases ... ok
[INFO] [stdout] test duration::formatting::tests::test_canonical_display ... ok
[INFO] [stdout] test duration::formatting::tests::test_format_if_nonzero ... ok
[INFO] [stdout] test duration::formatting::tests::test_duration_display_negative ... ok
[INFO] [stdout] test duration::formatting::tests::test_get_data_basic_units ... ok
[INFO] [stdout] test duration::duration_operations::tests::test_eq_ord ... ok
[INFO] [stdout] test duration::formatting::tests::test_get_data_greedy_decomposition ... ok
[INFO] [stdout] test duration::formatting::tests::test_get_data_negative ... ok
[INFO] [stdout] test duration::test::basic_tests ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::chrono_tests::test_chrono_naive_utc_assumption ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::chrono_tests::test_chrono_utc_roundtrip ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::test_from_str_rfc3339 ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::test_string_roundtrip ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::test_system_time_pre_epoch ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::test_system_time_roundtrip ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_from_unix_millis_positive ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_from_unix_millis_zero ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_is_future ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::chrono_tests::test_fixed_offset_conversions ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_is_past ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_is_within_future_range ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::test_display_rfc3339 ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_total_millis_basic ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_total_millis_negative_normalization ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::chrono_test::test_nano_overflow_addition ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::chrono_test::test_simple_addition ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::chrono_test::test_simple_subtraction ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::chrono_test::test_sub_saturation_min ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_is_within_past_range ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::chrono_test::test_subtraction_crossing_zero ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_round_trip_millis ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::chrono_test::test_add_saturation_max ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_total_millis_overflow ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_total_millis_boundary ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::chrono_test::test_subtraction_borrowing_nanos ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_add_saturation_with_nanos ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_nano_overflow_addition ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_simple_addition ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_sub_saturation_min ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_subtraction_borrowing_nanos ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_add_negative_duration ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_subtraction_crossing_zero ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_add_saturation_with_nanos ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_add_saturation_max ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_nano_overflow_addition ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_simple_addition ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_sub_double_negative_saturation ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_simple_subtraction ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_sub_saturation_min ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_subtraction_borrowing_nanos ... ok
[INFO] [stdout] test duration::formatting::tests::test_unit_display_formatting ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::test_subtraction_crossing_zero ... ok
[INFO] [stdout] test timestamp::timestamp_impls::tests::test_from_unix_millis_negative ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_simple_subtraction ... ok
[INFO] [stdout] test timestamp::timestamp_operations::tests::std_duration::test_add_saturation_max ... ok
[INFO] [stdout] test duration::duration_operations::tests::test_get_data_smoke_test ... ok
[INFO] [stdout] test timestamp::timestamp_conversions::tests::test_system_time_epoch ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 65 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests proto_types
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/timestamp/timestamp_impls.rs - timestamp::timestamp_impls::Timestamp::from_unix_millis (line 53) ... ok
[INFO] [stdout] test src/timestamp/timestamp_impls.rs - timestamp::timestamp_impls::Timestamp::checked_total_i64_millis (line 90) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.44s; merged doctests compilation took 0.43s
[INFO] running `Command { std: "docker" "inspect" "bf4f8c2f6b77078782fdd75fa8a4d3469f9c5e73f59539c311d8a38df42d81d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bf4f8c2f6b77078782fdd75fa8a4d3469f9c5e73f59539c311d8a38df42d81d0", kill_on_drop: false }`
[INFO] [stdout] bf4f8c2f6b77078782fdd75fa8a4d3469f9c5e73f59539c311d8a38df42d81d0