[INFO] cloning repository https://github.com/nuvic/kvs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/nuvic/kvs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fnuvic%2Fkvs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fnuvic%2Fkvs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 64a3e8bc2a2ffb24b3412bae8c9427d4eeb95590
[INFO] testing nuvic/kvs against try#a7ee93192a766fb0dafa23def7154fc03cfcfc3e for pr-146989
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fnuvic%2Fkvs" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/nuvic/kvs
[INFO] finished tweaking git repo https://github.com/nuvic/kvs
[INFO] tweaked toml for git repo https://github.com/nuvic/kvs written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/nuvic/kvs on toolchain a7ee93192a766fb0dafa23def7154fc03cfcfc3e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/nuvic/kvs 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" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 62601d6f10d963320c2ccb91bcc9181c5f02d7c734ad3a1561055cc4a99912af
[INFO] running `Command { std: "docker" "start" "-a" "62601d6f10d963320c2ccb91bcc9181c5f02d7c734ad3a1561055cc4a99912af", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "62601d6f10d963320c2ccb91bcc9181c5f02d7c734ad3a1561055cc4a99912af", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "62601d6f10d963320c2ccb91bcc9181c5f02d7c734ad3a1561055cc4a99912af", kill_on_drop: false }`
[INFO] [stdout] 62601d6f10d963320c2ccb91bcc9181c5f02d7c734ad3a1561055cc4a99912af
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 851c4fc425d3b6289638f5298f2ad436631411964aaaf53ad61060803888f9e6
[INFO] running `Command { std: "docker" "start" "-a" "851c4fc425d3b6289638f5298f2ad436631411964aaaf53ad61060803888f9e6", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.174
[INFO] [stderr]    Compiling anstyle-query v1.1.3
[INFO] [stderr]    Compiling rustix v1.0.8
[INFO] [stderr]    Compiling predicates-core v1.0.9
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling assert_cmd v2.0.17
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling serde_json v1.0.141
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling syn v2.0.104
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling anstream v0.6.19
[INFO] [stderr]    Compiling predicates-tree v1.0.12
[INFO] [stderr]    Compiling clap_builder v4.5.41
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling tempfile v3.20.0
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling predicates v3.1.3
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling clap_derive v4.5.41
[INFO] [stderr]    Compiling thiserror-impl v2.0.12
[INFO] [stderr]    Compiling thiserror v2.0.12
[INFO] [stderr]    Compiling clap v4.5.41
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling kvs v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 24.72s
[INFO] running `Command { std: "docker" "inspect" "851c4fc425d3b6289638f5298f2ad436631411964aaaf53ad61060803888f9e6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "851c4fc425d3b6289638f5298f2ad436631411964aaaf53ad61060803888f9e6", kill_on_drop: false }`
[INFO] [stdout] 851c4fc425d3b6289638f5298f2ad436631411964aaaf53ad61060803888f9e6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 946650ba3db653176e3e7579e2ce301713b8c4517f72a343e421e57541bb2677
[INFO] running `Command { std: "docker" "start" "-a" "946650ba3db653176e3e7579e2ce301713b8c4517f72a343e421e57541bb2677", kill_on_drop: false }`
[INFO] [stderr]    Compiling kvs v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.45s
[INFO] running `Command { std: "docker" "inspect" "946650ba3db653176e3e7579e2ce301713b8c4517f72a343e421e57541bb2677", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "946650ba3db653176e3e7579e2ce301713b8c4517f72a343e421e57541bb2677", kill_on_drop: false }`
[INFO] [stdout] 946650ba3db653176e3e7579e2ce301713b8c4517f72a343e421e57541bb2677
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] e16f13a5cc45a9d42f703a18df61d52a5bf1b1f85519dd9c8c484fb8b76b4f8d
[INFO] running `Command { std: "docker" "start" "-a" "e16f13a5cc45a9d42f703a18df61d52a5bf1b1f85519dd9c8c484fb8b76b4f8d", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.13s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kvs-83c3ca135dca97a2)
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running unittests src/bin/kvs.rs (/opt/rustwide/target/debug/deps/kvs-55d1d4c4f791bd14)
[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] [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/tests.rs (/opt/rustwide/target/debug/deps/tests-82c4c705006290e3)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test remove_key ... ok
[INFO] [stdout] test overwrite_value ... ok
[INFO] [stdout] test remove_non_existent_key ... ok
[INFO] [stdout] test get_non_existent_value ... ok
[INFO] [stdout] test get_stored_value ... ok
[INFO] [stdout] test cli_invalid_subcommand ... ok
[INFO] [stdout] test cli_get_stored ... ok
[INFO] [stdout] test cli_version ... ok
[INFO] [stdout] test cli_get_non_existent_key ... ok
[INFO] [stdout] test cli_no_args ... ok
[INFO] [stdout] test cli_invalid_get ... ok
[INFO] [stdout] test cli_rm_non_existent_key ... ok
[INFO] [stdout] test cli_set ... ok
[INFO] [stdout] test cli_invalid_set ... ok
[INFO] [stdout] test cli_rm_stored ... ok
[INFO] [stdout] test cli_invalid_rm ... ok
[INFO] [stdout] test compaction ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.56s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests kvs
[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" "e16f13a5cc45a9d42f703a18df61d52a5bf1b1f85519dd9c8c484fb8b76b4f8d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e16f13a5cc45a9d42f703a18df61d52a5bf1b1f85519dd9c8c484fb8b76b4f8d", kill_on_drop: false }`
[INFO] [stdout] e16f13a5cc45a9d42f703a18df61d52a5bf1b1f85519dd9c8c484fb8b76b4f8d