[INFO] fetching crate corvid_time 0.1.2...
[INFO] testing corvid_time-0.1.2 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate corvid_time 0.1.2 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate corvid_time 0.1.2
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate corvid_time 0.1.2
[INFO] tweaked toml for crates.io crate corvid_time 0.1.2 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate corvid_time 0.1.2 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate corvid_time 0.1.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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f
[INFO] running `Command { std: "docker" "start" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f", 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" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f", 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" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling corvid_fixed v0.1.2
[INFO] [stderr]    Compiling corvid_time v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1.11s
[INFO] running `Command { std: "docker" "inspect" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f", 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" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling unty v0.0.4
[INFO] [stderr]    Compiling corvid_hash v0.1.2
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling bincode v2.0.1
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling corvid_wire v0.1.2
[INFO] [stderr]    Compiling corvid_time v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 6.21s
[INFO] running `Command { std: "docker" "inspect" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f", 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" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/corvid_time/8d2827fb56891d3f/out/corvid_time-8d2827fb56891d3f)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]      Running tests/alpha.rs (/opt/rustwide/target/release/build/corvid_time/fed6e4726557c22b/out/alpha-fed6e4726557c22b)
[INFO] [stdout] test ticks::tests::a_count_of_ticks_lands_that_far_past_where_it_started ... ok
[INFO] [stdout] test ticks::tests::a_count_that_would_run_off_the_end_stops_at_it ... 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] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test alpha_is_the_exact_ratio_of_two_integers ... ok
[INFO] [stdout] test alpha_climbs_within_a_period_and_is_exactly_zero_on_the_boundary ... ok
[INFO] [stdout] test alpha_walks_from_zero_to_one_between_ticks ... ok
[INFO] [stdout] test alpha_tracks_an_independent_accumulator_across_ragged_frames ... ok
[INFO] [stderr]      Running tests/clock.rs (/opt/rustwide/target/release/build/corvid_time/1caf99613bf947e2/out/clock-1caf99613bf947e2)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test a_stepping_clock_still_takes_a_nudge ... ok
[INFO] [stdout] test cloning_a_clock_duplicates_the_time_it_is_holding ... ok
[INFO] [stdout] test a_fresh_still_clock_has_no_time_in_it ... ok
[INFO] [stdout] test what_a_clock_reports_about_itself ... ok
[INFO] [stdout] test a_still_clock_hands_back_what_was_queued_once ... ok
[INFO] [stdout] test a_clock_can_be_held_as_a_trait_object ... ok
[INFO] [stdout] test a_stepping_clock_drives_exactly_one_tick_per_call ... ok
[INFO] [stdout] test a_clock_is_not_copy_because_reading_one_consumes_it ... ok
[INFO] [stdout] test a_stepping_clock_returns_exactly_one_period_per_call ... ok
[INFO] [stderr]      Running tests/slow.rs (/opt/rustwide/target/release/build/corvid_time/24cb91444e21e990/out/slow-24cb91444e21e990)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test a_four_second_span_still_answers_an_alpha ... ok
[INFO] [stdout] test the_longest_span_is_slower_than_any_rate_can_name ... ok
[INFO] [stdout] test alpha_climbs_with_the_accumulator_at_every_span ... ok
[INFO] [stdout] test an_absurd_elapsed_against_the_longest_span_neither_panics_nor_wraps ... ok
[INFO] [stderr]      Running tests/step.rs (/opt/rustwide/target/release/build/corvid_time/accffb53ef8e2482/out/step-accffb53ef8e2482)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stderr]      Running tests/tick.rs (/opt/rustwide/target/release/build/corvid_time/bf240b5c865f7482/out/tick-bf240b5c865f7482)
[INFO] [stdout] test no_floating_point_anywhere_in_the_crate ... ok
[INFO] [stdout] test exact_multiples_do_not_drift ... ok
[INFO] [stdout] test dropped_counts_every_tick_the_ceiling_refused ... ok
[INFO] [stdout] test a_step_remembers_the_rate_it_was_built_from ... ok
[INFO] [stdout] test ragged_advances_deliver_the_whole_elapsed_time ... ok
[INFO] [stdout] test a_stalled_advance_cannot_overflow_the_accumulator ... ok
[INFO] [stdout] test the_catchup_ceiling_is_what_bounds_one_advance ... ok
[INFO] [stdout] test the_dropped_counter_saturates_rather_than_wrapping ... ok
[INFO] [stdout] test a_catchup_of_zero_would_stop_the_simulation_so_it_is_raised_to_one ... ok
[INFO] [stdout] test a_period_split_into_pieces_is_still_one_tick ... ok
[INFO] [stdout] test keeping_up_drops_nothing ... ok
[INFO] [stdout] test a_thousand_periods_are_a_thousand_ticks ... ok
[INFO] [stdout] test a_stalled_process_drops_ticks_rather_than_banking_them ... ok
[INFO] [stdout] test the_remainder_below_a_period_survives_a_stall ... ok
[INFO] [stdout] test zero_elapsed_is_zero_ticks ... ok
[INFO] [stdout] test the_second_after_a_stall_is_an_ordinary_second ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test a_tick_counts_from_zero ... ok
[INFO] [stdout] test a_span_digests_as_its_nanoseconds ... ok
[INFO] [stdout] test a_period_is_a_whole_number_of_nanoseconds ... ok
[INFO] [stdout] test a_tick_displays_as_its_number ... ok
[INFO] [stdout] test adjacent_ticks_digest_differently ... ok
[INFO] [stdout] test an_absurd_rate_still_has_a_period ... ok
[INFO] [stdout] test ticks_order_by_number ... ok
[INFO] [stdout] test since_measures_forward_and_is_zero_backward ... ok
[INFO] [stdout] test the_cradle_rate_is_fifteen_hertz ... ok
[INFO] [stdout] test the_ends_saturate_rather_than_wrapping ... ok
[INFO] [stdout] test the_residual_of_a_period_is_one_nanosecond_per_second_per_leftover ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/wire.rs (/opt/rustwide/target/release/build/corvid_time/7062328d3d4f681e/out/wire-7062328d3d4f681e)
[INFO] [stderr]    Doc-tests corvid_time
[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] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/../README.md - (line 7) ... ok
[INFO] [stdout] test src/step.rs - step::Step (line 29) ... ok
[INFO] [stdout] test src/span.rs - span::TickSpan (line 59) ... ok
[INFO] [stdout] test src/span.rs - span::TickSpan::from_millis (line 133) ... ok
[INFO] [stdout] test src/tick.rs - tick::Tick (line 18) ... ok
[INFO] [stdout] test src/clock.rs - clock::Clock (line 98) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.52s; merged doctests compilation took 0.43s
[INFO] running `Command { std: "docker" "inspect" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f", kill_on_drop: false }`
[INFO] [stdout] 9e8696127b6f4fd1cd87401cea0861871be598bb79c37e8c9356028c0369344f
