[INFO] cloning repository https://github.com/ajesipow/cached [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ajesipow/cached" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fajesipow%2Fcached", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fajesipow%2Fcached'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 041cb48bf1c1a02f8dd3a65efd9b1cfa232566d8 [INFO] testing ajesipow/cached against try#015dbcea68b7642e2acc268b5c8f3e9086fc02ff for pr-102570 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fajesipow%2Fcached" "/workspace/builds/worker-0/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-0/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/ajesipow/cached on toolchain 015dbcea68b7642e2acc268b5c8f3e9086fc02ff [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+015dbcea68b7642e2acc268b5c8f3e9086fc02ff" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/ajesipow/cached [INFO] finished tweaking git repo https://github.com/ajesipow/cached [INFO] tweaked toml for git repo https://github.com/ajesipow/cached written to /workspace/builds/worker-0/source/Cargo.toml [INFO] crate git repo https://github.com/ajesipow/cached already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+015dbcea68b7642e2acc268b5c8f3e9086fc02ff" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+015dbcea68b7642e2acc268b5c8f3e9086fc02ff" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 249a991c9974b34969889ced5a574ce566ea6a0af9fa39261d1e8048775b0ade [INFO] running `Command { std: "docker" "start" "-a" "249a991c9974b34969889ced5a574ce566ea6a0af9fa39261d1e8048775b0ade", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "249a991c9974b34969889ced5a574ce566ea6a0af9fa39261d1e8048775b0ade", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "249a991c9974b34969889ced5a574ce566ea6a0af9fa39261d1e8048775b0ade", kill_on_drop: false }` [INFO] [stdout] 249a991c9974b34969889ced5a574ce566ea6a0af9fa39261d1e8048775b0ade [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+015dbcea68b7642e2acc268b5c8f3e9086fc02ff" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 6a9ba39477e8887e1d775c493d5fb4c8b7d58ee2d3fd357840d32d5e411185d4 [INFO] running `Command { std: "docker" "start" "-a" "6a9ba39477e8887e1d775c493d5fb4c8b7d58ee2d3fd357840d32d5e411185d4", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.37 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.91 [INFO] [stderr] Compiling libc v0.2.123 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling log v0.4.16 [INFO] [stderr] Compiling memchr v2.5.0 [INFO] [stderr] Compiling async-trait v0.1.53 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling pin-project-lite v0.2.8 [INFO] [stderr] Compiling tracing-core v0.1.26 [INFO] [stderr] Compiling once_cell v1.10.0 [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling quote v1.0.18 [INFO] [stderr] Compiling socket2 v0.4.4 [INFO] [stderr] Compiling mio v0.8.2 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling tokio-macros v1.8.0 [INFO] [stderr] Compiling tracing-attributes v0.1.21 [INFO] [stderr] Compiling tokio v1.19.2 [INFO] [stderr] Compiling tracing v0.1.34 [INFO] [stderr] Compiling cached v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 29.13s [INFO] running `Command { std: "docker" "inspect" "6a9ba39477e8887e1d775c493d5fb4c8b7d58ee2d3fd357840d32d5e411185d4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6a9ba39477e8887e1d775c493d5fb4c8b7d58ee2d3fd357840d32d5e411185d4", kill_on_drop: false }` [INFO] [stdout] 6a9ba39477e8887e1d775c493d5fb4c8b7d58ee2d3fd357840d32d5e411185d4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+015dbcea68b7642e2acc268b5c8f3e9086fc02ff" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 011aefc4554222209ae7b2e7bf59a795f872ff6d5f3206fc32d7a62ae198c1e3 [INFO] running `Command { std: "docker" "start" "-a" "011aefc4554222209ae7b2e7bf59a795f872ff6d5f3206fc32d7a62ae198c1e3", kill_on_drop: false }` [INFO] [stderr] Compiling semver v1.0.9 [INFO] [stderr] Compiling rustc_version v0.4.0 [INFO] [stderr] Compiling rstest v0.12.0 [INFO] [stderr] Compiling cached v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 14.51s [INFO] running `Command { std: "docker" "inspect" "011aefc4554222209ae7b2e7bf59a795f872ff6d5f3206fc32d7a62ae198c1e3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "011aefc4554222209ae7b2e7bf59a795f872ff6d5f3206fc32d7a62ae198c1e3", kill_on_drop: false }` [INFO] [stdout] 011aefc4554222209ae7b2e7bf59a795f872ff6d5f3206fc32d7a62ae198c1e3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+015dbcea68b7642e2acc268b5c8f3e9086fc02ff" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] be4eacc7987f9defcbe6a79f03a4b82456e961baf69480ce3590b7987d469758 [INFO] running `Command { std: "docker" "start" "-a" "be4eacc7987f9defcbe6a79f03a4b82456e961baf69480ce3590b7987d469758", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.06s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cached-60baa9a15f98be4c) [INFO] [stdout] running 68 tests [INFO] [stdout] test db::test::test_removing_key_is_also_removed_from_ttl_set_main_db ... ok [INFO] [stdout] test db::test::test_clearing_db_works ... ok [INFO] [stdout] test db::test::test_contains_key_works ... ok [INFO] [stdout] test db::test::test_ttl_in_future_returns_value_db ... ok [INFO] [stdout] test db::test::test_clearing_db_works_main_db ... ok [INFO] [stdout] test db::test::test_ttl_in_future_returns_value_main_db ... ok [INFO] [stdout] test db::test::test_ttl_in_past_does_not_store_value ... ok [INFO] [stdout] test frame::header::test::test_parsing_request_header_with_too_long_key_fails ... ok [INFO] [stdout] test frame::header::test::test_parsing_response_header_with_too_long_key_fails ... ok [INFO] [stdout] test frame::header::test::test_parsing_request_header_with_valid_long_value_works ... ok [INFO] [stdout] test frame::header::test::test_parsing_request_header_with_valid_long_key_works ... ok [INFO] [stdout] test frame::header::test::test_parsing_request_header_with_valid_long_key_and_value_works ... ok [INFO] [stdout] test frame::header::test::test_parsing_response_header_with_valid_long_key_and_value_works ... ok [INFO] [stdout] test frame::header::test::test_parsing_response_header_with_too_long_value_fails ... ok [INFO] [stdout] test frame::header::test::test_parsing_response_header_with_valid_long_key_works ... ok [INFO] [stdout] test frame::header::test::test_parsing_request_header_with_too_long_value_fails ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialization_fails_for_wrong_codes::case_1 ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialization_fails_for_wrong_codes::case_3 ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialization_fails_for_wrong_codes::case_2 ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialization_fails_for_wrong_codes::case_6 ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialization_fails_for_wrong_codes::case_7 ... ok [INFO] [stdout] test primitives::test::test_op_code_serialisation ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_fails_for_wrong_codes::case_1 ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_fails_for_wrong_codes::case_2 ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_fails_for_wrong_codes::case_3 ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_fails_for_wrong_codes::case_4 ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_fails_for_wrong_codes::case_5 ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_fails_for_wrong_codes::case_6 ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_fails_for_wrong_codes::case_7 ... ok [INFO] [stdout] test primitives::test::test_status_code_deserialization_works ... ok [INFO] [stdout] test primitives::test::test_status_code_serialization ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_01 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_02 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_03 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_04 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_05 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_06 ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialization_fails_for_wrong_codes::case_5 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_07 ... ok [INFO] [stdout] test frame::header::test::test_parsing_response_header_with_valid_long_value_works ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialisation_works ... ok [INFO] [stdout] test primitives::test::test_op_code_deserialization_fails_for_wrong_codes::case_4 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_10 ... ok [INFO] [stdout] test request::test::test_conversion_from_valid_request_frame_to_request_works::case_1 ... ok [INFO] [stdout] test request::test::test_conversion_from_valid_request_frame_to_request_works::case_2 ... ok [INFO] [stdout] test request::test::test_conversion_from_valid_request_frame_to_request_works::case_3 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_08 ... ok [INFO] [stdout] test request::test::test_conversion_from_valid_request_frame_to_request_works::case_4 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_01 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_02 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_04 ... ok [INFO] [stdout] test db::test::test_ttl_elapsed_does_not_return_value_from_main_db ... ok [INFO] [stdout] test db::test::test_ttl_elapsed_does_not_return_value_from_db ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_11 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_07 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_06 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_09 ... ok [INFO] [stdout] test response::test::test_conversion_from_valid_response_frame_to_response_works::case_1 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_11 ... ok [INFO] [stdout] test response::test::test_conversion_from_valid_response_frame_to_response_works::case_2 ... ok [INFO] [stdout] test response::test::test_conversion_from_valid_response_frame_to_response_works::case_3 ... ok [INFO] [stdout] test response::test::test_conversion_from_valid_response_frame_to_response_works::case_4 ... ok [INFO] [stdout] test request::test::test_conversion_from_invalid_request_frame_to_request_fails::case_09 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_03 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_05 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_10 ... ok [INFO] [stdout] test response::test::test_conversion_from_valid_response_frame_to_response_works::case_5 ... ok [INFO] [stdout] test response::test::test_conversion_from_invalid_response_frame_to_response_fails::case_08 ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 68 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/main.rs (/opt/rustwide/target/debug/deps/main-47f6002a1959affa) [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] test test_deleting_a_key_works ... ok [INFO] [stdout] test test_deleting_a_non_existing_key_fails ... ok [INFO] [stdout] test test_flushing_works ... ok [INFO] [stdout] test test_getting_a_non_existing_key_fails ... ok [INFO] [stdout] test test_setting_a_key_with_ttl_in_the_past_works ... ok [INFO] [stdout] test test_setting_a_key_with_ttl_in_the_future_works ... ok [INFO] [stdout] test test_setting_a_key_works ... ok [INFO] [stdout] test test_setting_the_same_key_twice_fails ... ok [INFO] [stdout] test test_setting_and_getting_keys_concurrently_works ... ok [INFO] [stdout] test test_max_connections_limit ... ok [INFO] [stderr] Doc-tests cached [INFO] [stdout] test test_setting_a_key_with_ttl_in_the_future_works_and_then_expires ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s [INFO] [stdout] [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] running `Command { std: "docker" "inspect" "be4eacc7987f9defcbe6a79f03a4b82456e961baf69480ce3590b7987d469758", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "be4eacc7987f9defcbe6a79f03a4b82456e961baf69480ce3590b7987d469758", kill_on_drop: false }` [INFO] [stdout] be4eacc7987f9defcbe6a79f03a4b82456e961baf69480ce3590b7987d469758