[INFO] fetching crate qubit-clock 0.2.0...
[INFO] testing qubit-clock-0.2.0 against 1.95.0 for beta-1.96-2
[INFO] extracting crate qubit-clock 0.2.0 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate qubit-clock 0.2.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate qubit-clock 0.2.0
[INFO] tweaked toml for crates.io crate qubit-clock 0.2.0 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate qubit-clock 0.2.0 on toolchain 1.95.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate qubit-clock 0.2.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.95.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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" "+1.95.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1b80c25e8d5a0cb859b190221fa844cf106d6c34a9305e616f9ad229555c4cee
[INFO] running `Command { std: "docker" "start" "-a" "1b80c25e8d5a0cb859b190221fa844cf106d6c34a9305e616f9ad229555c4cee", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1b80c25e8d5a0cb859b190221fa844cf106d6c34a9305e616f9ad229555c4cee", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1b80c25e8d5a0cb859b190221fa844cf106d6c34a9305e616f9ad229555c4cee", kill_on_drop: false }`
[INFO] [stdout] 1b80c25e8d5a0cb859b190221fa844cf106d6c34a9305e616f9ad229555c4cee
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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" "+1.95.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d6226db040bf463be20df9328d76d7728555c5979582348cf36dfa579b44dbe4
[INFO] running `Command { std: "docker" "start" "-a" "d6226db040bf463be20df9328d76d7728555c5979582348cf36dfa579b44dbe4", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling siphasher v1.0.2
[INFO] [stderr]    Compiling libc v0.2.184
[INFO] [stderr]    Compiling chrono-tz v0.10.4
[INFO] [stderr]    Compiling phf_shared v0.12.1
[INFO] [stderr]    Compiling phf v0.12.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling qubit-clock v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 18.94s
[INFO] running `Command { std: "docker" "inspect" "d6226db040bf463be20df9328d76d7728555c5979582348cf36dfa579b44dbe4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d6226db040bf463be20df9328d76d7728555c5979582348cf36dfa579b44dbe4", kill_on_drop: false }`
[INFO] [stdout] d6226db040bf463be20df9328d76d7728555c5979582348cf36dfa579b44dbe4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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" "+1.95.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 52420c19a50b2c64a198ed886a045822273ee0a304cbcbfa77744bc337c64811
[INFO] running `Command { std: "docker" "start" "-a" "52420c19a50b2c64a198ed886a045822273ee0a304cbcbfa77744bc337c64811", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling chrono-tz v0.10.4
[INFO] [stderr]    Compiling qubit-clock v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 17.73s
[INFO] running `Command { std: "docker" "inspect" "52420c19a50b2c64a198ed886a045822273ee0a304cbcbfa77744bc337c64811", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "52420c19a50b2c64a198ed886a045822273ee0a304cbcbfa77744bc337c64811", kill_on_drop: false }`
[INFO] [stdout] 52420c19a50b2c64a198ed886a045822273ee0a304cbcbfa77744bc337c64811
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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" "+1.95.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c817310fdd743a931b2f3defa358fa577b1ad314f120b23a899250d70a90dff7
[INFO] running `Command { std: "docker" "start" "-a" "c817310fdd743a931b2f3defa358fa577b1ad314f120b23a899250d70a90dff7", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/qubit_clock-25052abc49679a7a)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stderr]      Running tests/clock_tests.rs (/opt/rustwide/target/debug/deps/clock_tests-c6e78b261ff00fca)
[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 test_clock_millis_and_time_consistency ... ok
[INFO] [stdout] test test_clock_send_sync ... ok
[INFO] [stdout] test test_clock_time_returns_valid_datetime ... ok
[INFO] [stdout] test test_clock_trait_object ... ok
[INFO] [stdout] test test_clock_millis_returns_positive ... ok
[INFO] [stdout] test test_clock_time_progresses ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/controllable_clock_tests.rs (/opt/rustwide/target/debug/deps/controllable_clock_tests-c8537e9a65e8f086)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_controllable_clock_add_duration_multiple_times ... ok
[INFO] [stdout] test test_controllable_clock_add_duration_positive ... ok
[INFO] [stdout] test test_controllable_clock_set_time ... ok
[INFO] [stdout] test test_controllable_clock_trait_object ... ok
[INFO] [stdout] test test_controllable_clock_reset_after_set_time ... ok
[INFO] [stdout] test test_controllable_clock_set_time_multiple_times ... ok
[INFO] [stdout] test test_controllable_clock_add_duration_negative ... ok
[INFO] [stdout] test test_controllable_clock_complex_scenario ... ok
[INFO] [stdout] test test_controllable_clock_reset ... ok
[INFO] [stderr]      Running tests/meter_tests.rs (/opt/rustwide/target/debug/deps/meter_tests-ec1ef2d75c25979e)
[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] [stdout] 
[INFO] [stdout] running 95 tests
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_large_values ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_hours_minutes_seconds ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_hours_and_seconds_only ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_minutes_and_seconds ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_negative ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_seconds_with_fraction ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_zero ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_nanos_less_than_microsecond ... ok
[INFO] [stdout] test meter::format_tests::test_format_speed_different_units ... ok
[INFO] [stdout] test meter::format_tests::test_format_speed_negative_values ... ok
[INFO] [stdout] test meter::format_tests::test_format_speed_rounding ... ok
[INFO] [stdout] test meter::format_tests::test_format_speed_special_values ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_clock_accessors ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_millis_less_than_second ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_conversion_saturates_on_positive_overflow ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_nanos_milliseconds ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_nanos_seconds_and_above ... ok
[INFO] [stdout] test meter::format_tests::test_format_speed_normal_values ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_nanos_zero ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_formatted_speed_per_second_zero_time ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_is_running_states ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_minutes ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_micros ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_nanos_not_started ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_nanos_microseconds ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_formatted_speed_per_minute_zero_time ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_nanos_running ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_default_trait ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_is_stopped_states ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_new ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_readable_duration_nanoseconds ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_precision_comparison_with_millis ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_conversion_saturates_on_negative_overflow ... ok
[INFO] [stdout] test meter::format_tests::test_format_duration_nanos_negative ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_reset ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_multiple_start_calls ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_speed_per_minute_zero_time ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_restart ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_speed_per_second_zero_time ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_start_and_stop ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_start_now ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_very_short_duration ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_with_clock ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_with_clock_started ... ok
[INFO] [stdout] test meter::time_meter_tests::test_clock_accessors ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_nanos_stopped ... ok
[INFO] [stdout] test meter::time_meter_tests::test_duration ... ok
[INFO] [stdout] test meter::time_meter_tests::test_default_trait ... ok
[INFO] [stdout] test meter::time_meter_tests::test_edge_case_large_count ... ok
[INFO] [stdout] test meter::time_meter_tests::test_edge_case_zero_count ... ok
[INFO] [stdout] test meter::time_meter_tests::test_formatted_speed_per_minute ... ok
[INFO] [stdout] test meter::time_meter_tests::test_formatted_speed_per_minute_zero_time ... ok
[INFO] [stdout] test meter::time_meter_tests::test_formatted_speed_per_second_zero_time ... ok
[INFO] [stdout] test meter::time_meter_tests::test_is_running_states ... ok
[INFO] [stdout] test meter::time_meter_tests::test_formatted_speed_per_second ... ok
[INFO] [stdout] test meter::time_meter_tests::test_is_stopped_states ... ok
[INFO] [stdout] test meter::time_meter_tests::test_millis_not_started ... ok
[INFO] [stdout] test meter::time_meter_tests::test_millis_running ... ok
[INFO] [stdout] test meter::time_meter_tests::test_millis_stopped ... ok
[INFO] [stdout] test meter::time_meter_tests::test_millis_uses_current_time_when_running ... ok
[INFO] [stdout] test meter::time_meter_tests::test_is_running_with_end_time_set ... ok
[INFO] [stdout] test meter::time_meter_tests::test_millis_when_not_started ... ok
[INFO] [stdout] test meter::time_meter_tests::test_millis_with_mock_clock ... ok
[INFO] [stdout] test meter::time_meter_tests::test_minutes ... ok
[INFO] [stdout] test meter::time_meter_tests::test_multiple_start_calls ... ok
[INFO] [stdout] test meter::time_meter_tests::test_new ... ok
[INFO] [stdout] test meter::time_meter_tests::test_readable_duration ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_conversion_accuracy ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_millis ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_duration ... ok
[INFO] [stdout] test meter::time_meter_tests::test_seconds ... ok
[INFO] [stdout] test meter::time_meter_tests::test_speed_calculation_with_fractional_seconds ... ok
[INFO] [stdout] test meter::time_meter_tests::test_speed_per_minute ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_readable_duration_milliseconds ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_real_time_measurement ... ok
[INFO] [stdout] test meter::time_meter_tests::test_speed_per_second_zero_time ... ok
[INFO] [stdout] test meter::time_meter_tests::test_start_and_stop ... ok
[INFO] [stdout] test meter::time_meter_tests::test_speed_per_second ... ok
[INFO] [stdout] test meter::time_meter_tests::test_speed_per_minute_zero_time ... ok
[INFO] [stdout] test meter::time_meter_tests::test_start_now ... ok
[INFO] [stdout] test meter::time_meter_tests::test_with_clock_started ... ok
[INFO] [stdout] test meter::time_meter_tests::test_with_clock ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_real_time_without_stop ... ok
[INFO] [stdout] test meter::time_meter_tests::test_reset ... ok
[INFO] [stdout] test meter::time_meter_tests::test_restart ... ok
[INFO] [stdout] test meter::time_meter_tests::test_real_time_measurement ... ok
[INFO] [stdout] test meter::time_meter_tests::test_real_time_without_stop ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_formatted_speed_per_second ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_formatted_speed_per_minute ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_edge_case_large_count ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_edge_case_zero_count ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_seconds ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_speed_per_minute ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_speed_per_second ... ok
[INFO] [stdout] test meter::nano_time_meter_tests::test_speed_calculation_with_fractional_seconds ... ok
[INFO] [stderr]      Running tests/mock_tests.rs (/opt/rustwide/target/debug/deps/mock_tests-a6516822641c44af)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 95 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.63s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test test_mock_clock_add_millis_every_time ... ok
[INFO] [stdout] test test_mock_clock_advance_millis ... ok
[INFO] [stdout] test test_mock_clock_add_millis_once ... ok
[INFO] [stdout] test test_mock_clock_clone ... ok
[INFO] [stdout] test test_mock_clock_debug ... ok
[INFO] [stdout] test test_mock_clock_default ... ok
[INFO] [stdout] test test_mock_clock_add_millis_negative ... ok
[INFO] [stdout] test test_mock_clock_new ... ok
[INFO] [stdout] test test_mock_clock_in_thread ... ok
[INFO] [stdout] test test_mock_clock_add_duration ... ok
[INFO] [stdout] test test_mock_clock_reset_after_set_time ... ok
[INFO] [stdout] test test_mock_clock_set_time_multiple ... ok
[INFO] [stdout] test test_mock_clock_complex_scenario ... ok
[INFO] [stdout] test test_mock_clock_reset_clears_add_every_time ... ok
[INFO] [stdout] test test_mock_clock_reset ... ok
[INFO] [stdout] test test_mock_clock_set_and_clear_auto_advance ... ok
[INFO] [stdout] test test_mock_clock_multiple_threads ... ok
[INFO] [stdout] test test_mock_clock_set_time ... ok
[INFO] [stdout] test test_mock_clock_send_sync ... ok
[INFO] [stdout] test test_mock_clock_progresses_after_set_time ... ok
[INFO] [stdout] test test_mock_clock_progresses_naturally ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/monotonic_tests.rs (/opt/rustwide/target/debug/deps/monotonic_tests-15722abb0cfd8828)
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test test_monotonic_clock_consistency ... ok
[INFO] [stdout] test test_monotonic_clock_debug ... ok
[INFO] [stdout] test test_monotonic_clock_millis ... ok
[INFO] [stdout] test test_monotonic_clock_in_thread ... ok
[INFO] [stdout] test test_monotonic_clock_new ... ok
[INFO] [stdout] test test_monotonic_clock_time ... ok
[INFO] [stdout] test test_monotonic_clock_send_sync ... ok
[INFO] [stdout] test test_monotonic_clock_default ... ok
[INFO] [stdout] test test_monotonic_clock_elapsed ... ok
[INFO] [stdout] test test_monotonic_clock_clone ... ok
[INFO] [stdout] test test_monotonic_clock_independent_instances ... ok
[INFO] [stdout] test test_monotonic_clock_monotonic_millis ... ok
[INFO] [stdout] test test_monotonic_clock_long_running ... ok
[INFO] [stdout] test test_monotonic_clock_elapsed_time ... ok
[INFO] [stdout] test test_monotonic_clock_monotonicity ... ok
[INFO] [stdout] test test_monotonic_clock_multiple_threads ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_nano_clock_higher_precision_than_millis ... ok
[INFO] [stdout] test test_nano_clock_nanos_returns_positive ... ok
[INFO] [stdout] test test_nano_clock_nanos_and_time_precise_consistency ... ok
[INFO] [stdout] test test_nano_clock_time_precise_handles_negative_nanos ... ok
[INFO] [stdout] test test_nano_clock_time_precise_out_of_range_falls_back_to_unix_epoch ... ok
[INFO] [stdout] test test_nano_clock_time_precise_returns_valid_datetime ... ok
[INFO] [stdout] test test_nano_clock_trait_object ... ok
[INFO] [stderr]      Running tests/nano_clock_tests.rs (/opt/rustwide/target/debug/deps/nano_clock_tests-bb25434308052e8e)
[INFO] [stdout] test test_nano_clock_monotonicity ... ok
[INFO] [stdout] test test_nano_clock_precision ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/nano_monotonic_tests.rs (/opt/rustwide/target/debug/deps/nano_monotonic_tests-f1f4fc623d1d71ee)
[INFO] [stdout] running 19 tests
[INFO] [stdout] test test_nano_monotonic_clock_debug ... ok
[INFO] [stdout] test test_nano_monotonic_clock_default ... ok
[INFO] [stdout] test test_nano_monotonic_clock_nanos ... ok
[INFO] [stdout] test test_nano_monotonic_clock_send_sync ... ok
[INFO] [stdout] test test_nano_monotonic_clock_in_thread ... ok
[INFO] [stdout] test test_nano_monotonic_clock_new ... ok
[INFO] [stdout] test test_nano_monotonic_clock_time ... ok
[INFO] [stdout] test test_nano_monotonic_clock_time_precise ... ok
[INFO] [stdout] test test_nano_monotonic_clock_nanos_millis_consistency ... ok
[INFO] [stdout] test test_nano_monotonic_clock_millis ... ok
[INFO] [stdout] test test_nano_monotonic_clock_precision ... ok
[INFO] [stdout] test test_nano_monotonic_clock_multiple_threads ... ok
[INFO] [stdout] test test_nano_monotonic_clock_elapsed ... ok
[INFO] [stdout] test test_nano_monotonic_clock_clone ... ok
[INFO] [stdout] test test_nano_monotonic_clock_independent_instances ... ok
[INFO] [stdout] test test_nano_monotonic_clock_monotonic_nanos ... ok
[INFO] [stdout] test test_nano_monotonic_clock_comparison_with_millis ... ok
[INFO] [stdout] test test_nano_monotonic_clock_elapsed_time ... ok
[INFO] [stdout] test test_nano_monotonic_clock_monotonicity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/system_tests.rs (/opt/rustwide/target/debug/deps/system_tests-1c583af448f384cd)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test test_system_clock_clone ... ok
[INFO] [stdout] test test_system_clock_copy ... ok
[INFO] [stdout] test test_system_clock_consistency ... ok
[INFO] [stdout] test test_system_clock_debug ... ok
[INFO] [stdout] test test_system_clock_default ... ok
[INFO] [stdout] test test_system_clock_multiple_instances ... ok
[INFO] [stdout] test test_system_clock_millis ... ok
[INFO] [stdout] test test_system_clock_in_thread ... ok
[INFO] [stdout] test test_system_clock_send_sync ... ok
[INFO] [stdout] test test_system_clock_time ... ok
[INFO] [stdout] test test_system_clock_new ... ok
[INFO] [stdout] test test_system_clock_multiple_threads ... ok
[INFO] [stdout] test test_system_clock_progresses ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/zoned_clock_tests.rs (/opt/rustwide/target/debug/deps/zoned_clock_tests-bc1b7891be27ae26)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_zoned_clock_default_local_time_edge_cases ... ok
[INFO] [stderr]      Running tests/zoned_tests.rs (/opt/rustwide/target/debug/deps/zoned_tests-aa3c3a8516c0960b)
[INFO] [stdout] test test_zoned_clock_daylight_saving_time ... ok
[INFO] [stdout] test test_zoned_clock_default_local_time_preserves_timestamp ... ok
[INFO] [stdout] test test_zoned_clock_default_local_time_implementation ... ok
[INFO] [stdout] test test_zoned_clock_different_timezones ... ok
[INFO] [stdout] test test_zoned_clock_default_local_time_with_different_timezones ... ok
[INFO] [stdout] test test_zoned_clock_timezone ... ok
[INFO] [stdout] test test_zoned_clock_trait_object ... ok
[INFO] [stdout] test test_zoned_clock_local_time ... ok
[INFO] [stdout] test test_zoned_clock_utc_time_consistency ... ok
[INFO] [stdout] test test_zoned_clock_with_system_clock ... 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] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test test_zoned_daylight_saving_time ... ok
[INFO] [stdout] test test_zoned_clone ... ok
[INFO] [stdout] test test_zoned_implements_clock ... ok
[INFO] [stdout] test test_zoned_implements_zoned_clock ... ok
[INFO] [stdout] test test_zoned_debug ... ok
[INFO] [stdout] test test_zoned_preserves_controllable_clock_interface ... ok
[INFO] [stdout] test test_zoned_new ... ok
[INFO] [stdout] test test_zoned_send_sync ... ok
[INFO] [stdout] test test_zoned_with_different_timezones ... ok
[INFO] [stdout] test test_zoned_with_monotonic_clock ... ok
[INFO] [stdout] test test_zoned_with_system_clock ... ok
[INFO] [stdout] test test_zoned_inner ... ok
[INFO] [stdout] test test_zoned_into_inner ... ok
[INFO] [stdout] test test_zoned_deref_to_inner_clock ... ok
[INFO] [stdout] test test_zoned_trait_object ... ok
[INFO] [stdout] test test_zoned_with_mock_clock ... ok
[INFO] [stdout] test test_zoned_in_thread ... ok
[INFO] [stdout] test test_zoned_timezone_conversion ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests qubit_clock
[INFO] [stdout] 
[INFO] [stdout] running 91 tests
[INFO] [stdout] test src/meter/format.rs - meter::format::format_duration_millis (line 36) ... ok
[INFO] [stdout] test src/controllable_clock.rs - controllable_clock::ControllableClock (line 34) ... ok
[INFO] [stdout] test src/controllable_clock.rs - controllable_clock::ControllableClock::add_duration (line 90) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter (line 62) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::clock (line 600) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::clock_mut (line 619) ... ok
[INFO] [stdout] test src/clock.rs - clock::Clock::millis (line 59) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::formatted_speed_per_minute (line 531) ... ok
[INFO] [stdout] test src/clock.rs - clock::Clock::time (line 79) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::formatted_speed_per_second (line 501) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::is_stopped (line 579) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::micros (line 270) ... ok
[INFO] [stdout] test src/meter/mod.rs - meter (line 36) ... ok
[INFO] [stdout] test src/lib.rs - (line 81) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::duration (line 377) ... ok
[INFO] [stdout] test src/lib.rs - (line 43) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::reset (line 189) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::nanos (line 242) ... ok
[INFO] [stdout] test src/meter/format.rs - meter::format::format_duration_nanos (line 102) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::readable_duration (line 400) ... ok
[INFO] [stdout] test src/controllable_clock.rs - controllable_clock::ControllableClock::reset (line 112) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::restart (line 209) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::is_running (line 556) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::start (line 149) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::minutes (line 346) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::with_clock (line 101) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<NanoMonotonicClock>::new (line 645) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::stop (line 169) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::with_clock_started (line 129) ... ok
[INFO] [stdout] test src/lib.rs - (line 54) ... ok
[INFO] [stdout] test src/controllable_clock.rs - controllable_clock::ControllableClock::set_time (line 68) ... ok
[INFO] [stdout] test src/clock.rs - clock::Clock (line 35) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::clock_mut (line 587) ... ok
[INFO] [stdout] test src/meter/format.rs - meter::format::format_speed (line 157) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::clock (line 568) ... ok
[INFO] [stdout] test src/lib.rs - (line 102) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::formatted_speed_per_minute (line 499) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::formatted_speed_per_second (line 469) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::is_running (line 524) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::duration (line 345) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::minutes (line 315) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::readable_duration (line 368) ... ok
[INFO] [stdout] test src/lib.rs - (line 119) ... ok
[INFO] [stdout] test src/meter/mod.rs - meter (line 22) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::stop (line 190) ... ok
[INFO] [stdout] test src/lib.rs - (line 65) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::with_clock (line 122) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<MonotonicClock>::new (line 612) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<MonotonicClock>::start_now (line 631) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::is_stopped (line 547) ... ok
[INFO] [stdout] test src/mock.rs - mock::MockClock (line 43) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<NanoMonotonicClock>::start_now (line 664) ... ok
[INFO] [stdout] test src/mock.rs - mock::MockClock::add_millis (line 132) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::millis (line 296) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::start (line 170) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::with_clock_started (line 150) ... ok
[INFO] [stdout] test src/mock.rs - mock::MockClock::clear_auto_advance (line 214) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::restart (line 230) ... ok
[INFO] [stdout] test src/monotonic.rs - monotonic::MonotonicClock::new (line 91) ... ok
[INFO] [stdout] test src/nano_clock.rs - nano_clock::NanoClock (line 33) ... ok
[INFO] [stdout] test src/mock.rs - mock::MockClock::set_auto_advance_millis (line 192) ... ok
[INFO] [stdout] test src/mock.rs - mock::MockClock::advance_millis (line 168) ... ok
[INFO] [stdout] test src/nano_clock.rs - nano_clock::NanoClock::nanos (line 63) ... ok
[INFO] [stdout] test src/nano_clock.rs - nano_clock::NanoClock::time_precise (line 85) ... ok
[INFO] [stdout] test src/monotonic.rs - monotonic::MonotonicClock::elapsed (line 116) ... ok
[INFO] [stdout] test src/nano_monotonic.rs - nano_monotonic::NanoMonotonicClock (line 42) ... ok
[INFO] [stdout] test src/nano_monotonic.rs - nano_monotonic::NanoMonotonicClock::new (line 83) ... ok
[INFO] [stdout] test src/system.rs - system::SystemClock (line 40) ... ok
[INFO] [stdout] test src/monotonic.rs - monotonic::MonotonicClock::monotonic_millis (line 142) ... ok
[INFO] [stdout] test src/mock.rs - mock::MockClock::new (line 100) ... ok
[INFO] [stdout] test src/system.rs - system::SystemClock::new (line 64) ... ok
[INFO] [stdout] test src/zoned.rs - zoned::Zoned (line 37) ... ok
[INFO] [stdout] test src/nano_monotonic.rs - nano_monotonic::NanoMonotonicClock::monotonic_nanos (line 136) ... ok
[INFO] [stdout] test src/zoned.rs - zoned::Zoned<C>::into_inner (line 137) ... ok
[INFO] [stdout] test src/nano_monotonic.rs - nano_monotonic::NanoMonotonicClock::elapsed (line 110) ... ok
[INFO] [stdout] test src/zoned.rs - zoned::Zoned<C>::inner (line 115) ... ok
[INFO] [stdout] test src/zoned_clock.rs - zoned_clock::ZonedClock::local_time (line 71) ... ok
[INFO] [stdout] test src/zoned.rs - zoned::Zoned<C>::new (line 95) ... ok
[INFO] [stdout] test src/zoned_clock.rs - zoned_clock::ZonedClock::timezone (line 50) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::reset (line 210) ... ok
[INFO] [stdout] test src/zoned.rs - zoned::Zoned (line 49) ... ok
[INFO] [stdout] test src/zoned_clock.rs - zoned_clock::ZonedClock (line 29) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter (line 72) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::millis (line 260) ... ok
[INFO] [stdout] test src/monotonic.rs - monotonic::MonotonicClock (line 53) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::seconds (line 321) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::speed_per_second (line 428) ... ok
[INFO] [stdout] test src/meter/nano_time_meter.rs - meter::nano_time_meter::NanoTimeMeter<C>::speed_per_minute (line 465) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::speed_per_minute (line 433) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::speed_per_second (line 396) ... ok
[INFO] [stdout] test src/meter/time_meter.rs - meter::time_meter::TimeMeter<C>::seconds (line 290) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 91 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.10s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 3.32s; merged doctests compilation took 1.20s
[INFO] running `Command { std: "docker" "inspect" "c817310fdd743a931b2f3defa358fa577b1ad314f120b23a899250d70a90dff7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c817310fdd743a931b2f3defa358fa577b1ad314f120b23a899250d70a90dff7", kill_on_drop: false }`
[INFO] [stdout] c817310fdd743a931b2f3defa358fa577b1ad314f120b23a899250d70a90dff7
