[INFO] fetching crate governor 0.4.2... [INFO] testing governor-0.4.2 against 1.59.0 for beta-1.60-1 [INFO] extracting crate governor 0.4.2 into /workspace/builds/worker-53/source [INFO] validating manifest of crates.io crate governor 0.4.2 on toolchain 1.59.0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate governor 0.4.2 [INFO] finished tweaking crates.io crate governor 0.4.2 [INFO] tweaked toml for crates.io crate governor 0.4.2 written to /workspace/builds/worker-53/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] c7095d903a7415d87e52660e405d51eac0897314d48e9e4fbd2710f345ff92af [INFO] running `Command { std: "docker" "start" "-a" "c7095d903a7415d87e52660e405d51eac0897314d48e9e4fbd2710f345ff92af", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "c7095d903a7415d87e52660e405d51eac0897314d48e9e4fbd2710f345ff92af", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c7095d903a7415d87e52660e405d51eac0897314d48e9e4fbd2710f345ff92af", kill_on_drop: false }` [INFO] [stdout] c7095d903a7415d87e52660e405d51eac0897314d48e9e4fbd2710f345ff92af [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/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" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] dbd2b4b3f806565753d72e55a25747d458b1d4ab590fcd37981d7e22c69963f1 [INFO] running `Command { std: "docker" "start" "-a" "dbd2b4b3f806565753d72e55a25747d458b1d4ab590fcd37981d7e22c69963f1", kill_on_drop: false }` [INFO] [stderr] Compiling futures-core v0.3.21 [INFO] [stderr] Compiling syn v1.0.86 [INFO] [stderr] Compiling futures-channel v0.3.21 [INFO] [stderr] Compiling futures-sink v0.3.21 [INFO] [stderr] Compiling no-std-compat v0.4.1 [INFO] [stderr] Compiling futures-timer v3.0.2 [INFO] [stderr] Compiling nonzero_ext v0.3.0 [INFO] [stderr] Compiling raw-cpuid v10.2.0 [INFO] [stderr] Compiling getrandom v0.2.5 [INFO] [stderr] Compiling parking_lot_core v0.9.1 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling parking_lot v0.12.0 [INFO] [stderr] Compiling quanta v0.9.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling dashmap v5.1.0 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling futures-macro v0.3.21 [INFO] [stderr] Compiling futures-util v0.3.21 [INFO] [stderr] Compiling futures-executor v0.3.21 [INFO] [stderr] Compiling futures v0.3.21 [INFO] [stderr] Compiling governor v0.4.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2m 47s [INFO] running `Command { std: "docker" "inspect" "dbd2b4b3f806565753d72e55a25747d458b1d4ab590fcd37981d7e22c69963f1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "dbd2b4b3f806565753d72e55a25747d458b1d4ab590fcd37981d7e22c69963f1", kill_on_drop: false }` [INFO] [stdout] dbd2b4b3f806565753d72e55a25747d458b1d4ab590fcd37981d7e22c69963f1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/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" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] fc22ab573327e9eaa1790bfa088d603e600cb5c748aa42a0a7d9d751ce264b3f [INFO] running `Command { std: "docker" "start" "-a" "fc22ab573327e9eaa1790bfa088d603e600cb5c748aa42a0a7d9d751ce264b3f", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling plotters-backend v0.3.2 [INFO] [stderr] Compiling crossbeam-queue v0.3.4 [INFO] [stderr] Compiling half v1.8.2 [INFO] [stderr] Compiling bit-vec v0.6.3 [INFO] [stderr] Compiling quick-error v2.0.1 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling all_asserts v2.3.0 [INFO] [stderr] Compiling nom v5.1.2 [INFO] [stderr] Compiling itertools v0.10.3 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling clap v2.34.0 [INFO] [stderr] Compiling tempfile v3.3.0 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling cast v0.2.7 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling serde_derive v1.0.136 [INFO] [stderr] Compiling rand_xorshift v0.3.0 [INFO] [stderr] Compiling bstr v0.2.17 [INFO] [stderr] Compiling plotters-svg v0.3.1 [INFO] [stderr] Compiling bit-set v0.5.2 [INFO] [stderr] Compiling serde_cbor v0.11.2 [INFO] [stderr] Compiling rusty-fork v0.3.0 [INFO] [stderr] Compiling plotters v0.3.1 [INFO] [stderr] Compiling csv v1.1.6 [INFO] [stderr] Compiling crossbeam v0.8.1 [INFO] [stderr] Compiling proptest v1.0.0 [INFO] [stderr] Compiling criterion-plot v0.4.4 [INFO] [stderr] Compiling tynm v0.1.6 [INFO] [stderr] Compiling criterion v0.3.5 [INFO] [stderr] Compiling governor v0.4.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 18.78s [INFO] running `Command { std: "docker" "inspect" "fc22ab573327e9eaa1790bfa088d603e600cb5c748aa42a0a7d9d751ce264b3f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fc22ab573327e9eaa1790bfa088d603e600cb5c748aa42a0a7d9d751ce264b3f", kill_on_drop: false }` [INFO] [stdout] fc22ab573327e9eaa1790bfa088d603e600cb5c748aa42a0a7d9d751ce264b3f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-53/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" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] a11a533c77a1d8c58a4daf89c95d6cb5218aa5b5e49a3f8e2b0c984f941bff35 [INFO] running `Command { std: "docker" "start" "-a" "a11a533c77a1d8c58a4daf89c95d6cb5218aa5b5e49a3f8e2b0c984f941bff35", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.21s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/governor-878306f32118adb8) [INFO] [stdout] [INFO] [stdout] running 22 tests [INFO] [stdout] test clock::test::duration_addition_coverage ... ok [INFO] [stdout] test clock::with_std::test::system_clock_impls_coverage ... ok [INFO] [stdout] test clock::quanta::test::quanta_impls_coverage ... ok [INFO] [stdout] test gcra::test::cover_count_derives ... ok [INFO] [stdout] test clock::with_std::test::instant_impls_coverage ... ok [INFO] [stdout] test gcra::test::gcra_derives ... ok [INFO] [stdout] test clock::quanta::test::quanta_upkeep_impls_coverage ... ok [INFO] [stdout] test gcra::test::notuntil_impls ... ok [INFO] [stdout] test jitter::test::jitter_impl_coverage ... ok [INFO] [stdout] test jitter::test::uniform_sampler_coverage ... ok [INFO] [stdout] test middleware::test::middleware_impl_derives ... ok [INFO] [stdout] test nanos::test::nanos_arith_coverage ... ok [INFO] [stdout] test nanos::test::nanos_impls ... ok [INFO] [stdout] test quota::test::period_error_cases ... ok [INFO] [stdout] test state::direct::future::test::insufficient_capacity_impl_coverage ... ok [INFO] [stdout] test state::direct::test::not_keyed_impls_coverage ... ok [INFO] [stdout] test quota::test::time_multiples ... ok [INFO] [stdout] test state::in_memory::test::in_memory_state_impls ... ok [INFO] [stdout] test state::test::ratelimiter_impl_coverage ... ok [INFO] [stdout] test gcra::test::roundtrips_quota ... ok [INFO] [stdout] test state::in_memory::test::stresstest_collisions ... ok [INFO] [stderr] Running tests/direct.rs (/opt/rustwide/target/debug/deps/direct-2a43ca4bb44aa265) [INFO] [stdout] test clock::test::fake_clock_parallel_advances ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.13s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test accepts_first_cell ... ok [INFO] [stdout] test all_1_identical_to_1 ... ok [INFO] [stdout] test correct_wait_time ... ok [INFO] [stdout] test all_capacity_check_rejects_excess ... ok [INFO] [stdout] test never_allows_more_than_capacity_all ... ok [INFO] [stdout] test rejects_too_many ... ok [INFO] [stdout] test rejects_too_many_all ... ok [INFO] [stdout] test actual_threadsafety ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s [INFO] [stdout] [INFO] [stderr] Running tests/future.rs (/opt/rustwide/target/debug/deps/future-41caac42e027e03b) [INFO] [stdout] [INFO] [stdout] running 9 tests [INFO] [stdout] test errors_on_exceeded_capacity ... ok [INFO] [stdout] test proceeds ... ok [INFO] [stdout] test proceeds_n ... ok [INFO] [stdout] test proceeds_keyed ... ok [INFO] [stdout] test pauses ... ok [INFO] [stdout] test pauses_n ... ok [INFO] [stdout] test pauses_keyed ... ok [INFO] [stdout] test multiple ... ok [INFO] [stdout] test multiple_keyed ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.05s [INFO] [stdout] [INFO] [stderr] Running tests/keyed_dashmap.rs (/opt/rustwide/target/debug/deps/keyed_dashmap-a0cd671dfac96e7c) [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test expiration ... ok [INFO] [stdout] test accepts_first_cell ... ok [INFO] [stdout] test rejects_too_many ... ok [INFO] [stdout] test dashmap_length ... ok [INFO] [stdout] test actual_threadsafety ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/keyed_hashmap.rs (/opt/rustwide/target/debug/deps/keyed_hashmap-45f8ff544277dd0f) [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test accepts_first_cell ... ok [INFO] [stdout] test rejects_too_many ... ok [INFO] [stdout] test expiration ... ok [INFO] [stdout] test hashmap_length ... ok [INFO] [stdout] test actual_threadsafety ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/memory_leaks.rs (/opt/rustwide/target/debug/deps/memory_leaks-27aba7dcaeb8dfed) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test memleak_gcra ... ok [INFO] [stdout] test memleak_gcra_multi ... ok [INFO] [stdout] test memleak_keyed ... ok [INFO] [stdout] test memleak_gcra_threaded ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.91s [INFO] [stdout] [INFO] [stderr] Running tests/middleware.rs (/opt/rustwide/target/debug/deps/middleware-6a01964cc1c614da) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test changes_allowed_type ... ok [INFO] [stdout] test mymw_derives ... ok [INFO] [stdout] test state_information ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/proptests.rs (/opt/rustwide/target/debug/deps/proptests-259a83a5121263f8) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test cover_count_derives ... ok [INFO] [stdout] test accurate_not_until ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.91s [INFO] [stdout] [INFO] [stderr] Running tests/sinks.rs (/opt/rustwide/target/debug/deps/sinks-e7804d7e2fe943dc) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test auxilliary_sink_methods ... ok [INFO] [stdout] test sink_with_jitter ... ok [INFO] [stdout] test sink ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s [INFO] [stdout] [INFO] [stderr] Running tests/streams.rs (/opt/rustwide/target/debug/deps/streams-1d268b3147357295) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test stream ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s [INFO] [stdout] [INFO] [stderr] Doc-tests governor [INFO] [stdout] [INFO] [stdout] running 23 tests [INFO] [stdout] test src/clock.rs - clock (line 10) ... ok [INFO] [stdout] test src/_guide.rs - _guide (line 33) ... ok [INFO] [stdout] test src/jitter.rs - jitter::Jitter::up_to (line 77) ... ok [INFO] [stdout] test src/clock.rs - clock::Duration::saturating_sub (line 100) ... ok [INFO] [stdout] test src/jitter.rs - jitter::Jitter (line 30) ... ok [INFO] [stdout] test src/_guide.rs - _guide (line 61) ... ok [INFO] [stdout] test src/state/direct/streams.rs - state::direct::streams::RatelimitedStream::get_ref (line 133) ... ok [INFO] [stdout] test src/quota.rs - quota::Quota::with_period (line 110) ... ok [INFO] [stdout] test src/clock.rs - clock::Duration::duration_since (line 87) ... ok [INFO] [stdout] test src/quota.rs - quota::Quota (line 36) ... ok [INFO] [stdout] test src/clock.rs - clock::FakeRelativeClock::eq (line 155) ... ok [INFO] [stdout] test src/_guide.rs - _guide (line 45) ... ok [INFO] [stdout] test src/lib.rs - (line 15) ... ok [INFO] [stdout] test src/jitter.rs - jitter::Jitter (line 47) ... ok [INFO] [stdout] test src/middleware.rs - middleware (line 37) ... ok [INFO] [stdout] test src/quota.rs - quota::Quota (line 51) ... ok [INFO] [stdout] test src/middleware.rs - middleware::RateLimitingMiddleware (line 138) ... ok [INFO] [stdout] test src/_guide.rs - _guide (line 75) ... ok [INFO] [stdout] test src/_guide.rs - _guide (line 156) ... ok [INFO] [stdout] test src/state/direct/sinks.rs - state::direct::sinks::RatelimitedSink::get_mut (line 133) ... ok [INFO] [stdout] test src/state/direct/streams.rs - state::direct::streams::RatelimitedStream::into_inner (line 165) ... ok [INFO] [stdout] test src/state/direct/streams.rs - state::direct::streams::RatelimitedStream::get_mut (line 148) ... ok [INFO] [stdout] test src/_guide.rs - _guide (line 118) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.98s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "a11a533c77a1d8c58a4daf89c95d6cb5218aa5b5e49a3f8e2b0c984f941bff35", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a11a533c77a1d8c58a4daf89c95d6cb5218aa5b5e49a3f8e2b0c984f941bff35", kill_on_drop: false }` [INFO] [stdout] a11a533c77a1d8c58a4daf89c95d6cb5218aa5b5e49a3f8e2b0c984f941bff35