[INFO] fetching crate cached 0.30.0... [INFO] testing cached-0.30.0 against beta-2022-02-22 for beta-1.60-1 [INFO] extracting crate cached 0.30.0 into /workspace/builds/worker-50/source [INFO] validating manifest of crates.io crate cached 0.30.0 on toolchain beta-2022-02-22 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate cached 0.30.0 [INFO] finished tweaking crates.io crate cached 0.30.0 [INFO] tweaked toml for crates.io crate cached 0.30.0 written to /workspace/builds/worker-50/source/Cargo.toml [INFO] crate crates.io crate cached 0.30.0 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded cached_proc_macro v0.9.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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" "+beta-2022-02-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 25394fad43e68e04f996c759fb67748c8e18138a88ff2c29de3f22233237fe61 [INFO] running `Command { std: "docker" "start" "-a" "25394fad43e68e04f996c759fb67748c8e18138a88ff2c29de3f22233237fe61", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "25394fad43e68e04f996c759fb67748c8e18138a88ff2c29de3f22233237fe61", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "25394fad43e68e04f996c759fb67748c8e18138a88ff2c29de3f22233237fe61", kill_on_drop: false }` [INFO] [stdout] 25394fad43e68e04f996c759fb67748c8e18138a88ff2c29de3f22233237fe61 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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" "+beta-2022-02-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8b6708f73186eaf39991d8efc79477e542ae62c51c201b51d1fca3c5e2d88367 [INFO] running `Command { std: "docker" "start" "-a" "8b6708f73186eaf39991d8efc79477e542ae62c51c201b51d1fca3c5e2d88367", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.30 [INFO] [stderr] Compiling syn v1.0.80 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling proc-macro-hack v0.5.19 [INFO] [stderr] Compiling futures-core v0.3.17 [INFO] [stderr] Compiling futures-task v0.3.17 [INFO] [stderr] Compiling futures-channel v0.3.17 [INFO] [stderr] Compiling proc-macro-nested v0.1.7 [INFO] [stderr] Compiling ident_case v1.0.1 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling futures-sink v0.3.17 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling futures-io v0.3.17 [INFO] [stderr] Compiling slab v0.4.5 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling async-trait v0.1.51 [INFO] [stderr] Compiling event-listener v2.5.1 [INFO] [stderr] Compiling cached_proc_macro_types v0.1.0 [INFO] [stderr] Compiling once_cell v1.8.0 [INFO] [stderr] Compiling async-mutex v1.4.0 [INFO] [stderr] Compiling async-rwlock v1.3.0 [INFO] [stderr] Compiling futures-macro v0.3.17 [INFO] [stderr] Compiling futures-util v0.3.17 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling darling_core v0.13.1 [INFO] [stderr] Compiling darling_macro v0.13.1 [INFO] [stderr] Compiling darling v0.13.1 [INFO] [stderr] Compiling cached_proc_macro v0.9.0 [INFO] [stderr] Compiling futures-executor v0.3.17 [INFO] [stderr] Compiling futures v0.3.17 [INFO] [stderr] Compiling cached v0.30.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 16.41s [INFO] running `Command { std: "docker" "inspect" "8b6708f73186eaf39991d8efc79477e542ae62c51c201b51d1fca3c5e2d88367", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8b6708f73186eaf39991d8efc79477e542ae62c51c201b51d1fca3c5e2d88367", kill_on_drop: false }` [INFO] [stdout] 8b6708f73186eaf39991d8efc79477e542ae62c51c201b51d1fca3c5e2d88367 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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" "+beta-2022-02-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8b3be2c3241b334b46190a9544922b2ec5653682aa4a56458427c923de8e590d [INFO] running `Command { std: "docker" "start" "-a" "8b3be2c3241b334b46190a9544922b2ec5653682aa4a56458427c923de8e590d", kill_on_drop: false }` [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling libc v0.2.103 [INFO] [stderr] Compiling cache-padded v1.1.1 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling waker-fn v1.1.0 [INFO] [stderr] Compiling fastrand v1.5.0 [INFO] [stderr] Compiling parking v2.0.0 [INFO] [stderr] Compiling async-task v4.0.3 [INFO] [stderr] Compiling atomic-waker v1.0.0 [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling tokio v1.12.0 [INFO] [stderr] Compiling async-lock v2.4.0 [INFO] [stderr] Compiling ctor v0.1.21 [INFO] [stderr] Compiling tokio-macros v1.5.0 [INFO] [stderr] Compiling async-attributes v1.1.2 [INFO] [stderr] Compiling smartstring v0.2.9 [INFO] [stderr] Compiling concurrent-queue v1.2.2 [INFO] [stderr] Compiling futures-lite v1.12.0 [INFO] [stderr] Compiling async-channel v1.6.1 [INFO] [stderr] Compiling value-bag v1.0.0-alpha.7 [INFO] [stderr] Compiling async-executor v1.4.1 [INFO] [stderr] Compiling blocking v1.0.2 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling socket2 v0.4.2 [INFO] [stderr] Compiling polling v2.1.0 [INFO] [stderr] Compiling kv-log-macro v1.0.7 [INFO] [stderr] Compiling async-io v1.6.0 [INFO] [stderr] Compiling async-global-executor v2.0.2 [INFO] [stderr] Compiling async-std v1.10.0 [INFO] [stderr] Compiling cached v0.30.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 30.39s [INFO] running `Command { std: "docker" "inspect" "8b3be2c3241b334b46190a9544922b2ec5653682aa4a56458427c923de8e590d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8b3be2c3241b334b46190a9544922b2ec5653682aa4a56458427c923de8e590d", kill_on_drop: false }` [INFO] [stdout] 8b3be2c3241b334b46190a9544922b2ec5653682aa4a56458427c923de8e590d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-50/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" "+beta-2022-02-22" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 930266ab31e81d74e52776a383a7664a19822f5948310d0ec745399ae0207054 [INFO] running `Command { std: "docker" "start" "-a" "930266ab31e81d74e52776a383a7664a19822f5948310d0ec745399ae0207054", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.15s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/cached-034b91d7c116ba87) [INFO] [stdout] [INFO] [stdout] running 39 tests [INFO] [stdout] test stores::sized::tests::clear ... ok [INFO] [stdout] test stores::sized::tests::get_or_set_with ... ok [INFO] [stdout] test stores::sized::tests::reset ... ok [INFO] [stdout] test stores::sized::tests::size_cache_racing_keys_eviction_regression ... ok [INFO] [stdout] test stores::sized::tests::sized_cache ... ok [INFO] [stdout] test stores::sized::tests::sized_cache_get_mut ... ok [INFO] [stdout] test stores::sized::tests::try_new ... ok [INFO] [stdout] test stores::sized::tests::remove ... ok [INFO] [stdout] test stores::timed::tests::clear ... ok [INFO] [stdout] test stores::sized::tests::test_async_trait ... ok [INFO] [stdout] test stores::tests::hashmap ... ok [INFO] [stdout] test stores::timed_sized::tests::clear ... ok [INFO] [stdout] test stores::timed::tests::remove ... ok [INFO] [stdout] test stores::timed::tests::reset ... ok [INFO] [stdout] test stores::unbound::tests::basic_cache ... ok [INFO] [stdout] test stores::unbound::tests::reset ... ok [INFO] [stdout] test stores::unbound::tests::remove ... ok [INFO] [stdout] test stores::unbound::tests::clear ... ok [INFO] [stdout] test stores::timed_sized::tests::reset ... ok [INFO] [stdout] test stores::unbound::tests::get_or_set_with ... ok [INFO] [stdout] test stores::timed_sized::tests::try_new ... ok [INFO] [stdout] test stores::timed_sized::tests::remove ... ok [INFO] [stdout] test stores::timed::tests::flush_expired ... ok [INFO] [stdout] test stores::timed::tests::get_expired ... ok [INFO] [stdout] test stores::timed::tests::insert_expired ... ok [INFO] [stdout] test stores::timed::tests::remove_expired ... ok [INFO] [stdout] test stores::timed::tests::get_mut_expired ... ok [INFO] [stdout] test stores::timed_sized::tests::get_expired ... ok [INFO] [stdout] test stores::timed_sized::tests::insert_expired ... ok [INFO] [stdout] test stores::timed_sized::tests::get_mut_expired ... ok [INFO] [stdout] test stores::timed_sized::tests::remove_expired ... ok [INFO] [stdout] test stores::timed::tests::get_or_set_with ... ok [INFO] [stdout] test stores::timed::tests::timed_cache_refresh ... ok [INFO] [stdout] test stores::timed_sized::tests::flush_expired ... ok [INFO] [stdout] test stores::timed_sized::tests::test_async_trait_timed_sized ... ok [INFO] [stdout] test stores::timed_sized::tests::timed_cache_refresh ... ok [INFO] [stdout] test stores::timed_sized::tests::get_or_set_with ... ok [INFO] [stdout] test stores::timed::tests::timed_cache ... ok [INFO] [stdout] test stores::timed_sized::tests::timed_sized_cache ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.04s [INFO] [stdout] [INFO] [stderr] Running tests/cached.rs (/opt/rustwide/target/debug/deps/cached-9246ecd334b22375) [INFO] [stdout] [INFO] [stdout] running 40 tests [INFO] [stdout] test test_cached_return_flag ... ok [INFO] [stdout] test test_cached_return_flag_option ... ok [INFO] [stdout] test test_cached_return_flag_result ... ok [INFO] [stdout] test cache_result_key ... ok [INFO] [stdout] test cache_result_no_default ... ok [INFO] [stdout] test test_cached_smartstring ... ok [INFO] [stdout] test test_cached_smartstring_from_str ... ok [INFO] [stdout] test test_can_fail ... ok [INFO] [stdout] test test_mutable_args_str ... ok [INFO] [stdout] test test_mutable_args_once ... ok [INFO] [stdout] test test_mutable_args ... ok [INFO] [stdout] test test_once_for_priming ... ok [INFO] [stdout] test test_proc_cached_result ... ok [INFO] [stdout] test test_proc_cached_option ... ok [INFO] [stdout] test test_sized_cache ... ok [INFO] [stdout] test test_string_cache ... ok [INFO] [stdout] test test_unbound_cache ... ok [INFO] [stdout] test test_cached_sync_writes ... ok [INFO] [stdout] test test_only_cached_once_per_second ... ok [INFO] [stdout] test test_only_cached_option_once_per_second ... ok [INFO] [stdout] test test_only_cached_option_once ... ok [INFO] [stdout] test test_only_cached_result_once ... ok [INFO] [stdout] test test_only_cached_result_once_per_second ... ok [INFO] [stdout] test test_only_cached_option_once_per_second_a ... ok [INFO] [stdout] test test_only_cached_option_once_a ... ok [INFO] [stdout] test test_only_cached_once_per_second_sync_writes ... ok [INFO] [stdout] test test_only_cached_once_per_second_a ... ok [INFO] [stdout] test test_only_cached_result_once_a ... ok [INFO] [stdout] test test_only_cached_result_once_per_second_a ... ok [INFO] [stdout] test test_cached_sync_writes_a ... ok [INFO] [stdout] test test_cached_timed_refresh ... ok [INFO] [stdout] test test_cached_timed_sized_refresh ... ok [INFO] [stdout] test test_cached_timed_sized_refresh_prime ... ok [INFO] [stdout] test test_cached_timed_sized_prime ... ok [INFO] [stdout] test test_racing_duplicate_keys_do_not_duplicate_sized_cache_ordering ... ok [INFO] [stdout] test test_proc_timed_sized_cache ... ok [INFO] [stdout] test test_timed_cache_key ... ok [INFO] [stdout] test test_timed_cache ... ok [INFO] [stdout] test test_timed_sized_cache ... ok [INFO] [stdout] test test_sized_cache_key ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 15.01s [INFO] [stdout] [INFO] [stderr] Doc-tests cached [INFO] [stdout] [INFO] [stdout] running 21 tests [INFO] [stdout] test src/lib.rs - (line 477) ... ignored [INFO] [stdout] test src/lib.rs - (line 134) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 149) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 101) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 214) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 235) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 54) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 167) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 376) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 255) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 189) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 451) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 508) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 69) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 421) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 118) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 397) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 40) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 296) ... ok [INFO] [stdout] test src/lib.rs - (line 317) ... ok [INFO] [stdout] test src/lib.rs - (line 275) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 20 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.98s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "930266ab31e81d74e52776a383a7664a19822f5948310d0ec745399ae0207054", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "930266ab31e81d74e52776a383a7664a19822f5948310d0ec745399ae0207054", kill_on_drop: false }` [INFO] [stdout] 930266ab31e81d74e52776a383a7664a19822f5948310d0ec745399ae0207054