[INFO] cloning repository https://github.com/tontinton/cachey
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/tontinton/cachey" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftontinton%2Fcachey", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftontinton%2Fcachey'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 5dda18016e8d975e4c2d6e60c0ad803a96df2cde
[INFO] testing tontinton/cachey against 1.98.0-beta.1 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ftontinton%2Fcachey" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/tontinton/cachey
[INFO] finished tweaking git repo https://github.com/tontinton/cachey
[INFO] tweaked toml for git repo https://github.com/tontinton/cachey written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/tontinton/cachey on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/tontinton/cachey 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.98.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-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da
[INFO] running `Command { std: "docker" "start" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da", 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" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da", 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" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.104
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling libc v0.2.178
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling cfg_aliases v0.2.1
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling slab v0.4.11
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling futures-io v0.3.31
[INFO] [stderr]    Compiling io-uring v0.7.11
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling compio-driver v0.7.1
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling find-msvc-tools v0.1.6
[INFO] [stderr]    Compiling scoped-tls v1.0.1
[INFO] [stderr]    Compiling async-task v4.7.1
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling cc v1.2.51
[INFO] [stderr]    Compiling zmij v1.0.7
[INFO] [stderr]    Compiling syn v2.0.112
[INFO] [stderr]    Compiling indexmap v2.12.1
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling zerocopy v0.8.31
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling concurrent-queue v2.5.0
[INFO] [stderr]    Compiling compio-fs v0.7.0
[INFO] [stderr]    Compiling parking v2.2.1
[INFO] [stderr]    Compiling serde_json v1.0.148
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling protobuf v3.7.2
[INFO] [stderr]    Compiling event-listener v5.4.1
[INFO] [stderr]    Compiling compio-buf v0.5.1
[INFO] [stderr]    Compiling socket2 v0.5.10
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling tikv-jemalloc-sys v0.6.1+5.3.0-1-ge13ca993e8ccb9ba9847cc330696e02839f328f7
[INFO] [stderr]    Compiling os_pipe v1.2.3
[INFO] [stderr]    Compiling toml_parser v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling toml_edit v0.23.10+spec-1.0.0
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling eyre v0.6.12
[INFO] [stderr]    Compiling prometheus v0.14.0
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling clap_lex v0.7.6
[INFO] [stderr]    Compiling clap_builder v4.5.53
[INFO] [stderr]    Compiling proc-macro-crate v3.4.0
[INFO] [stderr]    Compiling tracing-serde v0.2.0
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling nanorand v0.7.0
[INFO] [stderr]    Compiling event-listener-strategy v0.5.4
[INFO] [stderr]    Compiling spin v0.9.8
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling indenter v0.3.4
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling flume v0.11.1
[INFO] [stderr]    Compiling async-broadcast v0.7.2
[INFO] [stderr]    Compiling quick_cache v0.6.18
[INFO] [stderr]    Compiling dashmap v6.1.0
[INFO] [stderr]    Compiling num_cpus v1.17.0
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling humantime v2.3.0
[INFO] [stderr]    Compiling bytesize v2.3.1
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling pin-project-internal v1.1.10
[INFO] [stderr]    Compiling strum_macros v0.27.2
[INFO] [stderr]    Compiling rsmp-derive v0.1.0 (/opt/rustwide/workdir/rsmp-derive)
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling compio-log v0.1.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling pin-project v1.1.10
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling protobuf-support v3.7.2
[INFO] [stderr]    Compiling compio-macros v0.1.2
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling strum v0.27.2
[INFO] [stderr]    Compiling clap v4.5.53
[INFO] [stderr]    Compiling compio-io v0.6.0
[INFO] [stderr]    Compiling rsmp v0.1.0 (/opt/rustwide/workdir/rsmp)
[INFO] [stderr]    Compiling compio-runtime v0.7.0
[INFO] [stderr]    Compiling compio-signal v0.5.0
[INFO] [stderr]    Compiling compio-net v0.7.0
[INFO] [stderr]    Compiling compio v0.14.0
[INFO] [stderr]    Compiling tikv-jemallocator v0.6.1
[INFO] [stderr]    Compiling cachey v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4m 07s
[INFO] running `Command { std: "docker" "inspect" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da", 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" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling socket2 v0.6.1
[INFO] [stderr]    Compiling bytes v1.11.0
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling flume v0.11.1
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling io-uring v0.7.11
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling compio-driver v0.7.1
[INFO] [stderr]    Compiling compio-runtime v0.7.0
[INFO] [stderr]    Compiling compio-signal v0.5.0
[INFO] [stderr]    Compiling compio-net v0.7.0
[INFO] [stderr]    Compiling compio-fs v0.7.0
[INFO] [stderr]    Compiling compio v0.14.0
[INFO] [stderr]    Compiling tempfile v3.24.0
[INFO] [stderr]    Compiling tokio-util v0.7.17
[INFO] [stderr]    Compiling cachey v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 33.94s
[INFO] running `Command { std: "docker" "inspect" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da", 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" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.36s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cachey-3e679f45695d405a)
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stdout] test cache::tests::disk_cache::cleanup_pending_reflects_queue_length ... ok
[INFO] [stdout] test cache::tests::memory_cache::exact_match_required ... ok
[INFO] [stdout] test cache::tests::disk_cache::tracks_hits_and_misses ... ok
[INFO] [stdout] test cache::tests::disk_cache::eviction_sends_to_cleanup_channel ... ok
[INFO] [stdout] test cache::tests::memory_cache::same_file_different_ranges_coexist ... ok
[INFO] [stdout] test cache::tests::disk_cache::tracks_evictions_count_and_bytes ... ok
[INFO] [stdout] test cache::tests::memory_cache::tracks_evictions_count_and_bytes ... ok
[INFO] [stdout] test cache::tests::memory_cache::eviction_by_weight ... ok
[INFO] [stdout] test memory_semaphore::tests::acquire_release_restores_permits ... ok
[INFO] [stdout] test cache::tests::memory_cache::weight_reflects_data_size ... ok
[INFO] [stdout] test memory_semaphore::tests::bytes_to_permits_rounds_up ... ok
[INFO] [stdout] test server::tests::capture_ranges_across_chunks ... ok
[INFO] [stdout] test server::tests::capture_ranges_no_overlap_produces_empty ... ok
[INFO] [stdout] test server::tests::capture_ranges_single_chunk ... ok
[INFO] [stdout] test server::tests::read_exact_with_reused_buffer_respects_remaining ... ok
[INFO] [stdout] test server::tests::stream_file_truncates_at_eof ... ok
[INFO] [stdout] test memory_semaphore::tests::concurrent_acquire_release_maintains_invariants ... ok
[INFO] [stdout] test server::tests::stream_file_returns_exact_requested_range ... ok
[INFO] [stdout] test memory_semaphore::tests::acquire_blocks_when_insufficient_permits ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/cachey-b0dfc724eafa9f94)
[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] [stderr]      Running tests/put_and_get.rs (/opt/rustwide/target/debug/deps/put_and_get-b3fda8de28f2e377)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test put_and_get_compio ... FAILED
[INFO] [stdout] test connection_reuse_after_put has been running for over 60 seconds
[INFO] [stdout] test get_falls_back_to_disk_on_memory_miss has been running for over 60 seconds
[INFO] [stdout] test get_hits_memory_cache_before_disk has been running for over 60 seconds
[INFO] [stdout] test get_partial_file_from_disk has been running for over 60 seconds
[INFO] [stdout] test get_range_past_eof_returns_partial_data has been running for over 60 seconds
[INFO] [stdout] test health_endpoint_returns_ok has been running for over 60 seconds
[INFO] [stdout] test put_and_get_tokio has been running for over 60 seconds
[INFO] [stdout] test put_and_get_verifies_disk_cache_metrics has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da", kill_on_drop: false }`
[INFO] [stdout] d34d8e28f4fd01330a63a7a44074bf0a234fb43a018b2fb9106b98ba80f152da
