[INFO] cloning repository https://github.com/LebranceBW/KvStore [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/LebranceBW/KvStore" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FLebranceBW%2FKvStore", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FLebranceBW%2FKvStore'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 84a1b0a435196234fafeb64e7b939aabcde08466 [INFO] testing LebranceBW/KvStore against 1.97.0-beta.6 for beta-1.98-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FLebranceBW%2FKvStore" "/workspace/builds/worker-0-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc1/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/LebranceBW/KvStore [INFO] finished tweaking git repo https://github.com/LebranceBW/KvStore [INFO] tweaked toml for git repo https://github.com/LebranceBW/KvStore written to /workspace/builds/worker-0-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/LebranceBW/KvStore on toolchain 1.97.0-beta.6 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/LebranceBW/KvStore 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.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded remove_dir_all v0.5.3 [INFO] [stderr] Downloaded walkdir v2.3.2 [INFO] [stderr] Downloaded tempfile v3.2.0 [INFO] [stderr] Downloaded redox_syscall v0.2.9 [INFO] [stderr] Downloaded rand_core v0.6.3 [INFO] [stderr] Downloaded unicode-xid v0.2.2 [INFO] [stderr] Downloaded quote v1.0.9 [INFO] [stderr] Downloaded instant v0.1.9 [INFO] [stderr] Downloaded parking_lot_core v0.8.3 [INFO] [stderr] Downloaded rand v0.8.4 [INFO] [stderr] Downloaded ansi_term v0.11.0 [INFO] [stderr] Downloaded panic-control v0.1.4 [INFO] [stderr] Downloaded downcast v0.10.0 [INFO] [stderr] Downloaded proc-macro2 v1.0.27 [INFO] [stderr] Downloaded unicode-width v0.1.8 [INFO] [stderr] Downloaded smallvec v1.6.1 [INFO] [stderr] Downloaded simple_logger v1.11.0 [INFO] [stderr] Downloaded predicates-tree v1.0.2 [INFO] [stderr] Downloaded wasm-bindgen-shared v0.2.74 [INFO] [stderr] Downloaded parking_lot v0.11.1 [INFO] [stderr] Downloaded plotters-svg v0.3.1 [INFO] [stderr] Downloaded owned-alloc v0.2.0 [INFO] [stderr] Downloaded either v1.6.1 [INFO] [stderr] Downloaded crossbeam-queue v0.3.2 [INFO] [stderr] Downloaded predicates-core v1.0.2 [INFO] [stderr] Downloaded lock_api v0.4.4 [INFO] [stderr] Downloaded criterion-plot v0.4.3 [INFO] [stderr] Downloaded ppv-lite86 v0.2.10 [INFO] [stderr] Downloaded version_check v0.9.3 [INFO] [stderr] Downloaded crossbeam-epoch v0.9.5 [INFO] [stderr] Downloaded colored v1.9.3 [INFO] [stderr] Downloaded itoa v0.4.7 [INFO] [stderr] Downloaded cast v0.2.7 [INFO] [stderr] Downloaded treeline v0.1.0 [INFO] [stderr] Downloaded fragile v1.0.0 [INFO] [stderr] Downloaded crossbeam v0.8.1 [INFO] [stderr] Downloaded strsim v0.8.0 [INFO] [stderr] Downloaded float-cmp v0.8.0 [INFO] [stderr] Downloaded oorandom v11.1.3 [INFO] [stderr] Downloaded wasm-bindgen-macro v0.2.74 [INFO] [stderr] Downloaded plotters-backend v0.3.2 [INFO] [stderr] Downloaded rand_hc v0.3.1 [INFO] [stderr] Downloaded heck v0.3.3 [INFO] [stderr] Downloaded memoffset v0.6.4 [INFO] [stderr] Downloaded autocfg v1.0.1 [INFO] [stderr] Downloaded textwrap v0.11.0 [INFO] [stderr] Downloaded getrandom v0.2.3 [INFO] [stderr] Downloaded crossbeam-utils v0.8.5 [INFO] [stderr] Downloaded crc32fast v1.2.1 [INFO] [stderr] Downloaded predicates v1.0.8 [INFO] [stderr] Downloaded wasm-bindgen-macro-support v0.2.74 [INFO] [stderr] Downloaded wasm-bindgen-backend v0.2.74 [INFO] [stderr] Downloaded csv-core v0.1.10 [INFO] [stderr] Downloaded semver v1.0.3 [INFO] [stderr] Downloaded assert_cmd v0.11.1 [INFO] [stderr] Downloaded escargot v0.4.0 [INFO] [stderr] Downloaded structopt-derive v0.4.15 [INFO] [stderr] Downloaded num-integer v0.1.44 [INFO] [stderr] Downloaded serde_cbor v0.11.1 [INFO] [stderr] Downloaded log v0.4.14 [INFO] [stderr] Downloaded anyhow v1.0.41 [INFO] [stderr] Downloaded crossbeam-deque v0.8.0 [INFO] [stderr] Downloaded structopt v0.3.22 [INFO] [stderr] Downloaded unicode-segmentation v1.8.0 [INFO] [stderr] Downloaded num-traits v0.2.14 [INFO] [stderr] Downloaded mockall_derive v0.9.1 [INFO] [stderr] Downloaded wasi v0.10.2+wasi-snapshot-preview1 [INFO] [stderr] Downloaded mockall v0.9.1 [INFO] [stderr] Downloaded memchr v2.4.0 [INFO] [stderr] Downloaded half v1.7.1 [INFO] [stderr] Downloaded lockfree v0.5.1 [INFO] [stderr] Downloaded serde_derive v1.0.126 [INFO] [stderr] Downloaded rayon-core v1.9.1 [INFO] [stderr] Downloaded serde v1.0.126 [INFO] [stderr] Downloaded crossbeam-channel v0.5.1 [INFO] [stderr] Downloaded aho-corasick v0.7.18 [INFO] [stderr] Downloaded itertools v0.10.1 [INFO] [stderr] Downloaded js-sys v0.3.51 [INFO] [stderr] Downloaded serde_json v1.0.64 [INFO] [stderr] Downloaded criterion v0.3.4 [INFO] [stderr] Downloaded regex-automata v0.1.10 [INFO] [stderr] Downloaded itertools v0.9.0 [INFO] [stderr] Downloaded bumpalo v3.7.0 [INFO] [stderr] Downloaded difference v2.0.0 [INFO] [stderr] Downloaded clap v2.33.3 [INFO] [stderr] Downloaded chrono v0.4.19 [INFO] [stderr] Downloaded rayon v1.5.1 [INFO] [stderr] Downloaded wasm-bindgen v0.2.74 [INFO] [stderr] Downloaded syn v1.0.73 [INFO] [stderr] Downloaded regex v1.5.4 [INFO] [stderr] Downloaded regex-syntax v0.6.25 [INFO] [stderr] Downloaded bstr v0.2.16 [INFO] [stderr] Downloaded sled v0.34.6 [INFO] [stderr] Downloaded libc v0.2.98 [INFO] [stderr] Downloaded web-sys v0.3.51 [INFO] [stderr] Downloaded csv v1.1.6 [INFO] [stderr] Downloaded plotters v0.3.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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] 1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40 [INFO] running `Command { std: "docker" "start" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40", 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" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40", 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" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling libc v0.2.98 [INFO] [stderr] Compiling proc-macro2 v1.0.27 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling syn v1.0.73 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling crossbeam-epoch v0.9.5 [INFO] [stderr] Compiling memchr v2.4.0 [INFO] [stderr] Compiling bitflags v1.2.1 [INFO] [stderr] Compiling serde_derive v1.0.126 [INFO] [stderr] Compiling rayon-core v1.9.1 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling instant v0.1.9 [INFO] [stderr] Compiling unicode-segmentation v1.8.0 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling predicates-core v1.0.2 [INFO] [stderr] Compiling smallvec v1.6.1 [INFO] [stderr] Compiling crc32fast v1.2.1 [INFO] [stderr] Compiling unicode-width v0.1.8 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling crossbeam-queue v0.3.2 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling memoffset v0.6.4 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling heck v0.3.3 [INFO] [stderr] Compiling rayon v1.5.1 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling lock_api v0.4.4 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling treeline v0.1.0 [INFO] [stderr] Compiling difference v2.0.0 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling ansi_term v0.11.0 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling parking_lot_core v0.8.3 [INFO] [stderr] Compiling crossbeam-deque v0.8.0 [INFO] [stderr] Compiling serde_json v1.0.64 [INFO] [stderr] Compiling anyhow v1.0.41 [INFO] [stderr] Compiling fxhash v0.2.1 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling colored v1.9.3 [INFO] [stderr] Compiling fs2 v0.4.3 [INFO] [stderr] Compiling predicates-tree v1.0.2 [INFO] [stderr] Compiling parking_lot v0.11.1 [INFO] [stderr] Compiling downcast v0.10.0 [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling owned-alloc v0.2.0 [INFO] [stderr] Compiling fragile v1.0.0 [INFO] [stderr] Compiling itoa v0.4.7 [INFO] [stderr] Compiling lockfree v0.5.1 [INFO] [stderr] Compiling crossbeam v0.8.1 [INFO] [stderr] Compiling sled v0.34.6 [INFO] [stderr] Compiling float-cmp v0.8.0 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling simple_logger v1.11.0 [INFO] [stderr] Compiling predicates v1.0.8 [INFO] [stderr] Compiling mockall_derive v0.9.1 [INFO] [stderr] Compiling structopt-derive v0.4.15 [INFO] [stderr] Compiling structopt v0.3.22 [INFO] [stderr] Compiling mockall v0.9.1 [INFO] [stderr] Compiling kvs v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 34.88s [INFO] running `Command { std: "docker" "inspect" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40", 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" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stderr] Compiling semver v1.0.3 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling escargot v0.4.0 [INFO] [stderr] Compiling plotters-backend v0.3.2 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling itertools v0.9.0 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling half v1.7.1 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling itertools v0.10.1 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling remove_dir_all v0.5.3 [INFO] [stderr] Compiling panic-control v0.1.4 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling serde_cbor v0.11.1 [INFO] [stderr] Compiling plotters-svg v0.3.1 [INFO] [stderr] Compiling bstr v0.2.16 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling plotters v0.3.1 [INFO] [stderr] Compiling rustc_version v0.4.0 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling csv v1.1.6 [INFO] [stderr] Compiling cast v0.2.7 [INFO] [stderr] Compiling assert_cmd v0.11.1 [INFO] [stderr] Compiling criterion-plot v0.4.3 [INFO] [stderr] Compiling tempfile v3.2.0 [INFO] [stderr] Compiling criterion v0.3.4 [INFO] [stderr] Compiling kvs v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 14.42s [INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: criterion v0.3.4 [INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 1` [INFO] running `Command { std: "docker" "inspect" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40", 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" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.26s [INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: criterion v0.3.4 [INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 1` [INFO] [stderr] Running unittests src/bin/kvs.rs (/opt/rustwide/target/debug/deps/kvs-ba6ce78d06af0a88) [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 unittests src/bin/kvs-client.rs (/opt/rustwide/target/debug/deps/kvs_client-46ea763cfb2cfc70) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stderr] Running unittests src/bin/kvs-server.rs (/opt/rustwide/target/debug/deps/kvs_server-153d259a9df7815d) [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/cli.rs (/opt/rustwide/target/debug/deps/cli-621e0e6388778401) [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] 2026-07-14 02:48:01,427 INFO [kvs_server] Listened at 127.0.0.1:4004, powered by kvs, version: 0.1.0 [INFO] [stdout] 2026-07-14 02:48:01,429 INFO [kvs_server] Listened at 127.0.0.1:4002, powered by sled, version: 0.1.0 [INFO] [stdout] 2026-07-14 02:48:01,429 INFO [kvs_server] Listened at 127.0.0.1:4005, powered by sled, version: 0.1.0 [INFO] [stdout] test server_cli_version ... ok [INFO] [stdout] test client_cli_version ... ok [INFO] [stdout] test client_cli_no_args ... ok [INFO] [stdout] test client_cli_invalid_rm ... ok [INFO] [stdout] test client_cli_invalid_subcommand ... ok [INFO] [stdout] test client_cli_invalid_get ... ok [INFO] [stdout] test client_cli_invalid_set ... ok [INFO] [stdout] 2026-07-14 02:48:01,502 DEBUG [sled::pagecache::snapshot] no previous snapshot found [INFO] [stdout] 2026-07-14 02:48:01,502 DEBUG [sled::pagecache::iterator] ordering before clearing tears: {}, max_header_stable_lsn: 0 [INFO] [stdout] 2026-07-14 02:48:01,502 DEBUG [sled::pagecache::iterator] in clean_tail_tears, found missing item in tail: None and we'll scan segments {} above lowest lsn 0 [INFO] [stdout] 2026-07-14 02:48:01,502 DEBUG [sled::pagecache::iterator] unable to load new segment: Io(Custom { kind: Other, error: "no segments remaining to iterate over" }) [INFO] [stdout] 2026-07-14 02:48:01,502 DEBUG [sled::pagecache::iterator] filtering out segments after detected tear at (lsn, lid) -1 [INFO] [stdout] 2026-07-14 02:48:01,502 DEBUG [sled::pagecache::iterator] unable to load new segment: Io(Custom { kind: Other, error: "no segments remaining to iterate over" }) [INFO] [stdout] 2026-07-14 02:48:01,502 DEBUG [sled::pagecache::segment] SA starting with tip 0 stable -1 free {} [INFO] [stdout] 2026-07-14 02:48:01,503 DEBUG [sled::pagecache::iobuf] starting log for a totally fresh system [INFO] [stdout] 2026-07-14 02:48:01,503 DEBUG [sled::pagecache::segment] segment accountant returning offset: 0 for lsn 0 on deck: {} [INFO] [stdout] 2026-07-14 02:48:01,503 DEBUG [sled::pagecache::iobuf] starting IoBufs with next_lsn: 0 next_lid: 0 [INFO] [stdout] 2026-07-14 02:48:01,503 DEBUG [sled::pagecache::iobuf] storing lsn 0 in beginning of buffer [INFO] [stdout] 2026-07-14 02:48:01,503 DEBUG [sled::pagecache] load_snapshot loading pages from 0..0 [INFO] [stdout] 2026-07-14 02:48:01,503 DEBUG [sled::meta] allocated pid 3 for root of new_tree [95, 95, 115, 108, 101, 100, 95, 95, 100, 101, 102, 97, 117, 108, 116] [INFO] [stdout] 2026-07-14 02:48:01,503 DEBUG [sled::pagecache::iobuf] advancing offset within the current segment from 0 to 71 [INFO] [stdout] 2026-07-14 02:48:01,567 DEBUG [sled::pagecache::snapshot] no previous snapshot found [INFO] [stdout] 2026-07-14 02:48:01,567 DEBUG [sled::pagecache::iterator] ordering before clearing tears: {}, max_header_stable_lsn: 0 [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::iterator] in clean_tail_tears, found missing item in tail: None and we'll scan segments {} above lowest lsn 0 [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::iterator] unable to load new segment: Io(Custom { kind: Other, error: "no segments remaining to iterate over" }) [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::iterator] filtering out segments after detected tear at (lsn, lid) -1 [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::iterator] unable to load new segment: Io(Custom { kind: Other, error: "no segments remaining to iterate over" }) [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::segment] SA starting with tip 0 stable -1 free {} [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::iobuf] starting log for a totally fresh system [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::segment] segment accountant returning offset: 0 for lsn 0 on deck: {} [INFO] [stdout] 2026-07-14 02:48:01,568 DEBUG [sled::pagecache::iobuf] starting IoBufs with next_lsn: 0 next_lid: 0 [INFO] [stdout] 2026-07-14 02:48:01,569 DEBUG [sled::pagecache::iobuf] storing lsn 0 in beginning of buffer [INFO] [stdout] 2026-07-14 02:48:01,569 DEBUG [sled::pagecache] load_snapshot loading pages from 0..0 [INFO] [stdout] 2026-07-14 02:48:01,569 DEBUG [sled::meta] allocated pid 3 for root of new_tree [95, 95, 115, 108, 101, 100, 95, 95, 100, 101, 102, 97, 117, 108, 116] [INFO] [stdout] 2026-07-14 02:48:01,594 DEBUG [sled::pagecache::iobuf] wrote lsns 0-70 to disk at offsets 0-70, maxed false complete_len 71 [INFO] [stdout] 2026-07-14 02:48:01,594 DEBUG [sled::pagecache::iobuf] mark_interval(0, 71) [INFO] [stdout] 2026-07-14 02:48:01,594 DEBUG [sled::pagecache::iobuf] new highest interval: 0 - 70 [INFO] [stdout] 2026-07-14 02:48:02,003 DEBUG [sled::pagecache::iobuf] advancing offset within the current segment from 71 to 96 [INFO] [stdout] 2026-07-14 02:48:02,009 DEBUG [sled::pagecache::iobuf] wrote lsns 71-95 to disk at offsets 71-95, maxed false complete_len 25 [INFO] [stdout] 2026-07-14 02:48:02,009 DEBUG [sled::pagecache::iobuf] mark_interval(71, 25) [INFO] [stdout] 2026-07-14 02:48:02,009 DEBUG [sled::pagecache::iobuf] new highest interval: 71 - 95 [INFO] [stdout] 2026-07-14 02:48:02,070 DEBUG [sled::pagecache::iobuf] advancing offset within the current segment from 0 to 96 [INFO] [stdout] 2026-07-14 02:48:02,072 DEBUG [sled::pagecache::iobuf] wrote lsns 0-95 to disk at offsets 0-95, maxed false complete_len 96 [INFO] [stdout] 2026-07-14 02:48:02,072 DEBUG [sled::pagecache::iobuf] mark_interval(0, 96) [INFO] [stdout] 2026-07-14 02:48:02,072 DEBUG [sled::pagecache::iobuf] new highest interval: 0 - 95 [INFO] [stdout] 2026-07-14 02:48:02,429 INFO [kvs::server] Accept connection from client: 127.0.0.1:51430 [INFO] [stdout] 2026-07-14 02:48:02,429 INFO [kvs::server] Client: 127.0.0.1:51430 disconnected [INFO] [stdout] 2026-07-14 02:48:02,430 DEBUG [kvs::server] [client->server] {"Set":{"key":"key1","value":"value1"}} [INFO] [stdout] 2026-07-14 02:48:02,430 DEBUG [kvs::server] command: Set { key: "key1", value: "value1" } [INFO] [stdout] 2026-07-14 02:48:02,430 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] test cli_log_configuration ... ok [INFO] [stdout] 2026-07-14 02:48:02,431 INFO [kvs::server] Accept connection from client: 127.0.0.1:60988 [INFO] [stdout] 2026-07-14 02:48:02,431 INFO [kvs::server] Client: 127.0.0.1:60988 disconnected [INFO] [stdout] 2026-07-14 02:48:02,431 DEBUG [kvs::server] [client->server] {"Set":{"key":"key1","value":"value1"}} [INFO] [stdout] 2026-07-14 02:48:02,431 DEBUG [kvs::server] command: Set { key: "key1", value: "value1" } [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [sled::pagecache::iobuf] advancing offset within the current segment from 96 to 117 [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [sled::pagecache::iobuf] wrote lsns 96-116 to disk at offsets 96-116, maxed false complete_len 21 [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [sled::pagecache::iobuf] mark_interval(96, 21) [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [sled::pagecache::iobuf] new highest interval: 96 - 116 [INFO] [stdout] 2026-07-14 02:48:02,432 INFO [kvs::server] Accept connection from client: 127.0.0.1:51432 [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [sled::pagecache::iobuf] make_stable(116) returning [INFO] [stdout] 2026-07-14 02:48:02,432 INFO [kvs::server] Client: 127.0.0.1:51432 disconnected [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [kvs::server] [client->server] {"Get":{"key":"key1"}} [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [kvs::server] command: Get { key: "key1" } [INFO] [stdout] 2026-07-14 02:48:02,432 DEBUG [kvs::server] [server->client] Ok("value1") [INFO] [stdout] 2026-07-14 02:48:02,434 INFO [kvs::server] Accept connection from client: 127.0.0.1:60994 [INFO] [stdout] 2026-07-14 02:48:02,434 INFO [kvs::server] Accept connection from client: 127.0.0.1:51448 [INFO] [stdout] 2026-07-14 02:48:02,434 INFO [kvs::server] Client: 127.0.0.1:60994 disconnected [INFO] [stdout] 2026-07-14 02:48:02,434 INFO [kvs::server] Client: 127.0.0.1:51448 disconnected [INFO] [stdout] 2026-07-14 02:48:02,434 DEBUG [kvs::server] [client->server] {"Set":{"key":"key1","value":"value2"}} [INFO] [stdout] 2026-07-14 02:48:02,434 DEBUG [kvs::server] [client->server] {"Get":{"key":"key1"}} [INFO] [stdout] 2026-07-14 02:48:02,434 DEBUG [kvs::server] command: Set { key: "key1", value: "value2" } [INFO] [stdout] 2026-07-14 02:48:02,434 DEBUG [kvs::server] command: Get { key: "key1" } [INFO] [stdout] 2026-07-14 02:48:02,434 DEBUG [kvs::server] [server->client] Ok("value1") [INFO] [stdout] 2026-07-14 02:48:02,434 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] 2026-07-14 02:48:02,436 INFO [kvs::server] Accept connection from client: 127.0.0.1:51462 [INFO] [stdout] 2026-07-14 02:48:02,436 INFO [kvs::server] Client: 127.0.0.1:51462 disconnected [INFO] [stdout] 2026-07-14 02:48:02,436 INFO [kvs::server] Accept connection from client: 127.0.0.1:32776 [INFO] [stdout] 2026-07-14 02:48:02,436 INFO [kvs::server] Client: 127.0.0.1:32776 disconnected [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [kvs::server] [client->server] {"Get":{"key":"key1"}} [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [kvs::server] command: Get { key: "key1" } [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [kvs::server] [client->server] {"Set":{"key":"key1","value":"value2"}} [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [kvs::server] command: Set { key: "key1", value: "value2" } [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [kvs::server] [server->client] Ok("value2") [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [sled::pagecache::iobuf] advancing offset within the current segment from 117 to 138 [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [sled::pagecache::iobuf] wrote lsns 117-137 to disk at offsets 117-137, maxed false complete_len 21 [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [sled::pagecache::iobuf] mark_interval(117, 21) [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [sled::pagecache::iobuf] new highest interval: 117 - 137 [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [sled::pagecache::iobuf] make_stable(137) returning [INFO] [stdout] 2026-07-14 02:48:02,437 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] 2026-07-14 02:48:02,439 INFO [kvs::server] Accept connection from client: 127.0.0.1:32780 [INFO] [stdout] 2026-07-14 02:48:02,439 INFO [kvs::server] Client: 127.0.0.1:32780 disconnected [INFO] [stdout] 2026-07-14 02:48:02,439 DEBUG [kvs::server] [client->server] {"Get":{"key":"key1"}} [INFO] [stdout] 2026-07-14 02:48:02,439 DEBUG [kvs::server] command: Get { key: "key1" } [INFO] [stdout] 2026-07-14 02:48:02,439 DEBUG [kvs::server] [server->client] Ok("value2") [INFO] [stdout] 2026-07-14 02:48:02,441 INFO [kvs::server] Accept connection from client: 127.0.0.1:32784 [INFO] [stdout] 2026-07-14 02:48:02,441 INFO [kvs::server] Client: 127.0.0.1:32784 disconnected [INFO] [stdout] 2026-07-14 02:48:02,441 DEBUG [kvs::server] [client->server] {"Get":{"key":"key2"}} [INFO] [stdout] 2026-07-14 02:48:02,441 DEBUG [kvs::server] command: Get { key: "key2" } [INFO] [stdout] 2026-07-14 02:48:02,441 DEBUG [kvs::server] [server->client] Ok("Key: key2 not found") [INFO] [stdout] 2026-07-14 02:48:02,443 INFO [kvs::server] Accept connection from client: 127.0.0.1:32790 [INFO] [stdout] 2026-07-14 02:48:02,443 INFO [kvs::server] Client: 127.0.0.1:32790 disconnected [INFO] [stdout] 2026-07-14 02:48:02,444 DEBUG [kvs::server] [client->server] {"Rm":{"key":"key2"}} [INFO] [stdout] 2026-07-14 02:48:02,444 DEBUG [kvs::server] command: Rm { key: "key2" } [INFO] [stdout] 2026-07-14 02:48:02,444 DEBUG [kvs::server] [server->client] Error("Key: key2 not found.") [INFO] [stdout] 2026-07-14 02:48:02,446 INFO [kvs::server] Accept connection from client: 127.0.0.1:32792 [INFO] [stdout] 2026-07-14 02:48:02,446 INFO [kvs::server] Client: 127.0.0.1:32792 disconnected [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [kvs::server] [client->server] {"Set":{"key":"key2","value":"value3"}} [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [kvs::server] command: Set { key: "key2", value: "value3" } [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [sled::pagecache::iobuf] advancing offset within the current segment from 138 to 159 [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [sled::pagecache::iobuf] wrote lsns 138-158 to disk at offsets 138-158, maxed false complete_len 21 [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [sled::pagecache::iobuf] mark_interval(138, 21) [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [sled::pagecache::iobuf] new highest interval: 138 - 158 [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [sled::pagecache::iobuf] make_stable(158) returning [INFO] [stdout] 2026-07-14 02:48:02,446 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] 2026-07-14 02:48:02,449 INFO [kvs::server] Accept connection from client: 127.0.0.1:32806 [INFO] [stdout] 2026-07-14 02:48:02,449 DEBUG [kvs::server] [client->server] {"Rm":{"key":"key1"}} [INFO] [stdout] 2026-07-14 02:48:02,449 DEBUG [kvs::server] command: Rm { key: "key1" } [INFO] [stdout] 2026-07-14 02:48:02,449 DEBUG [sled::pagecache::iobuf] advancing offset within the current segment from 159 to 173 [INFO] [stdout] 2026-07-14 02:48:02,449 INFO [kvs::server] Client: 127.0.0.1:32806 disconnected [INFO] [stdout] 2026-07-14 02:48:02,449 DEBUG [sled::pagecache::iobuf] wrote lsns 159-172 to disk at offsets 159-172, maxed false complete_len 14 [INFO] [stdout] 2026-07-14 02:48:02,449 DEBUG [sled::pagecache::iobuf] mark_interval(159, 14) [INFO] [stdout] 2026-07-14 02:48:02,449 DEBUG [sled::pagecache::iobuf] new highest interval: 159 - 172 [INFO] [stdout] 2026-07-14 02:48:02,449 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] 2026-07-14 02:48:02,452 INFO [kvs_server] Retrieving last work. engine: sled [INFO] [stdout] 2026-07-14 02:48:02,452 INFO [kvs_server] Listened at 127.0.0.1:4005, powered by sled, version: 0.1.0 [INFO] [stderr] [INFO] [stderr] thread 'main' (2410) panicked at src/bin/kvs-server.rs:63:54: [INFO] [stderr] Failed to create a sled engine.: IO error: could not acquire lock on "/tmp/.tmpHL2UOm/db": Os { code: 11, kind: WouldBlock, message: "Resource temporarily unavailable" } [INFO] [stderr] stack backtrace: [INFO] [stdout] 2026-07-14 02:48:02,482 INFO [kvs_server] Listened at 127.0.0.1:4002, powered by kvs, version: 0.1.0 [INFO] [stderr] 0: 0x5681370f8d58 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stderr] 1: 0x5681370f8d58 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stderr] 2: 0x5681370f8d58 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9 [INFO] [stderr] 3: 0x5681370f8d58 - <::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26 [INFO] [stderr] 4: 0x5681371100aa - ::fmt [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76 [INFO] [stderr] 5: 0x5681371100aa - core[8fb95b77d25ab6c8]::fmt::write [INFO] [stderr] 6: 0x5681370fdde2 - std[10d71ac2c42b111e]::io::default_write_fmt:: [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11 [INFO] [stderr] 7: 0x5681370fdde2 - ::write_fmt [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13 [INFO] [stderr] 8: 0x5681370df016 - ::print [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9 [INFO] [stderr] 9: 0x5681370df016 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0} [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27 [INFO] [stderr] 10: 0x5681370f2ba1 - std[10d71ac2c42b111e]::panicking::default_hook [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:319:9 [INFO] [stderr] 11: 0x5681370f2d5b - std[10d71ac2c42b111e]::panicking::panic_with_hook [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:825:13 [INFO] [stderr] 12: 0x5681370df0d2 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0} [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13 [INFO] [stderr] 13: 0x5681370d41c9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18 [INFO] [stderr] 14: 0x5681370dfb7d - __rustc[3be9ba60078d4c86]::rust_begin_unwind [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5 [INFO] [stderr] 15: 0x56813711086c - core[8fb95b77d25ab6c8]::panicking::panic_fmt [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14 [INFO] [stderr] 16: 0x5681371105b2 - core[8fb95b77d25ab6c8]::result::unwrap_failed [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1867:5 [INFO] [stderr] 17: 0x568136da5255 - >::expect [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1185:23 [INFO] [stderr] 18: 0x568136d97c63 - kvs_server[74a36e21d7c34d12]::main [INFO] [stderr] at /opt/rustwide/workdir/src/bin/kvs-server.rs:63:54 [INFO] [stderr] 19: 0x568136d9ccdb - >::call_once [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5 [INFO] [stderr] 20: 0x568136d93d6e - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18 [INFO] [stderr] 21: 0x568136d94dc1 - std[10d71ac2c42b111e]::rt::lang_start::<()>::{closure#0} [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/rt.rs:206:18 [INFO] [stderr] 22: 0x5681370f1af7 - <&dyn core[8fb95b77d25ab6c8]::ops::function::Fn<(), Output = i32> + core[8fb95b77d25ab6c8]::panic::unwind_safe::RefUnwindSafe + core[8fb95b77d25ab6c8]::marker::Sync as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:287:21 [INFO] [stderr] 23: 0x5681370f1af7 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<&dyn core[8fb95b77d25ab6c8]::ops::function::Fn<(), Output = i32> + core[8fb95b77d25ab6c8]::panic::unwind_safe::RefUnwindSafe + core[8fb95b77d25ab6c8]::marker::Sync, i32> [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40 [INFO] [stderr] 24: 0x5681370f1af7 - std[10d71ac2c42b111e]::panicking::catch_unwind:: + core[8fb95b77d25ab6c8]::panic::unwind_safe::RefUnwindSafe + core[8fb95b77d25ab6c8]::marker::Sync> [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19 [INFO] [stderr] 25: 0x5681370f1af7 - std[10d71ac2c42b111e]::panic::catch_unwind::<&dyn core[8fb95b77d25ab6c8]::ops::function::Fn<(), Output = i32> + core[8fb95b77d25ab6c8]::panic::unwind_safe::RefUnwindSafe + core[8fb95b77d25ab6c8]::marker::Sync, i32> [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14 [INFO] [stderr] 26: 0x5681370f1af7 - std[10d71ac2c42b111e]::rt::lang_start_internal::{closure#0} [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/rt.rs:175:24 [INFO] [stderr] 27: 0x5681370f1af7 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call:: [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40 [INFO] [stderr] 28: 0x5681370f1af7 - std[10d71ac2c42b111e]::panicking::catch_unwind:: [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19 [INFO] [stderr] 29: 0x5681370f1af7 - std[10d71ac2c42b111e]::panic::catch_unwind:: [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14 [INFO] [stderr] 30: 0x5681370f1af7 - std[10d71ac2c42b111e]::rt::lang_start_internal [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/rt.rs:171:5 [INFO] [stderr] 31: 0x568136d92d47 - std[10d71ac2c42b111e]::rt::lang_start::<()> [INFO] [stderr] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/rt.rs:205:5 [INFO] [stderr] 32: 0x568136d9d18e - main [INFO] [stderr] 33: 0x77526051b1ca - [INFO] [stderr] 34: 0x77526051b28b - __libc_start_main [INFO] [stderr] 35: 0x568136d90f75 - _start [INFO] [stderr] 36: 0x0 - [INFO] [stdout] 2026-07-14 02:48:02,512 INFO [kvs::server] Accept connection from client: 127.0.0.1:51466 [INFO] [stdout] 2026-07-14 02:48:02,512 INFO [kvs::server] Client: 127.0.0.1:51466 disconnected [INFO] [stdout] 2026-07-14 02:48:02,512 DEBUG [kvs::server] [client->server] {"Get":{"key":"key2"}} [INFO] [stdout] 2026-07-14 02:48:02,512 DEBUG [kvs::server] command: Get { key: "key2" } [INFO] [stdout] 2026-07-14 02:48:02,512 DEBUG [kvs::server] [server->client] Ok("Key: key2 not found") [INFO] [stdout] 2026-07-14 02:48:02,520 INFO [kvs::server] Accept connection from client: 127.0.0.1:51482 [INFO] [stdout] 2026-07-14 02:48:02,520 INFO [kvs::server] Client: 127.0.0.1:51482 disconnected [INFO] [stdout] 2026-07-14 02:48:02,520 DEBUG [kvs::server] [client->server] {"Rm":{"key":"key2"}} [INFO] [stdout] 2026-07-14 02:48:02,520 DEBUG [kvs::server] command: Rm { key: "key2" } [INFO] [stdout] 2026-07-14 02:48:02,520 DEBUG [kvs::server] [server->client] Error("Key: key2 not found.") [INFO] [stdout] 2026-07-14 02:48:02,527 INFO [kvs::server] Accept connection from client: 127.0.0.1:51492 [INFO] [stdout] 2026-07-14 02:48:02,527 INFO [kvs::server] Client: 127.0.0.1:51492 disconnected [INFO] [stdout] 2026-07-14 02:48:02,527 DEBUG [kvs::server] [client->server] {"Set":{"key":"key2","value":"value3"}} [INFO] [stdout] 2026-07-14 02:48:02,527 DEBUG [kvs::server] command: Set { key: "key2", value: "value3" } [INFO] [stdout] 2026-07-14 02:48:02,527 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] 2026-07-14 02:48:02,530 INFO [kvs::server] Accept connection from client: 127.0.0.1:51496 [INFO] [stdout] 2026-07-14 02:48:02,530 INFO [kvs::server] Client: 127.0.0.1:51496 disconnected [INFO] [stdout] 2026-07-14 02:48:02,530 DEBUG [kvs::server] [client->server] {"Rm":{"key":"key1"}} [INFO] [stdout] 2026-07-14 02:48:02,530 DEBUG [kvs::server] command: Rm { key: "key1" } [INFO] [stdout] 2026-07-14 02:48:02,530 DEBUG [kvs::server] [server->client] Ok("") [INFO] [stdout] 2026-07-14 02:48:02,532 INFO [kvs_server] Retrieving last work. engine: kvs [INFO] [stdout] 2026-07-14 02:48:02,532 INFO [kvs_server] Listened at 127.0.0.1:4004, powered by kvs, version: 0.1.0 [INFO] [stdout] test cli_access_server_sled_engine ... FAILED [INFO] [stdout] test cli_wrong_engine ... ok [INFO] [stdout] 2026-07-14 02:48:03,533 INFO [kvs::server] Accept connection from client: 127.0.0.1:51506 [INFO] [stdout] 2026-07-14 02:48:03,533 INFO [kvs::server] Client: 127.0.0.1:51506 disconnected [INFO] [stdout] 2026-07-14 02:48:03,533 DEBUG [kvs::server] [client->server] {"Get":{"key":"key2"}} [INFO] [stdout] 2026-07-14 02:48:03,533 DEBUG [kvs::server] command: Get { key: "key2" } [INFO] [stdout] 2026-07-14 02:48:03,534 DEBUG [kvs::server] [server->client] Ok("value3") [INFO] [stdout] 2026-07-14 02:48:03,536 INFO [kvs::server] Accept connection from client: 127.0.0.1:51522 [INFO] [stdout] 2026-07-14 02:48:03,536 INFO [kvs::server] Client: 127.0.0.1:51522 disconnected [INFO] [stdout] 2026-07-14 02:48:03,536 DEBUG [kvs::server] [client->server] {"Get":{"key":"key1"}} [INFO] [stdout] 2026-07-14 02:48:03,536 DEBUG [kvs::server] command: Get { key: "key1" } [INFO] [stdout] 2026-07-14 02:48:03,536 DEBUG [kvs::server] [server->client] Ok("Key: key1 not found") [INFO] [stdout] test cli_access_server_kvs_engine ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- cli_access_server_sled_engine stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'cli_access_server_sled_engine' (2331) panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assert_cmd-0.11.1/src/assert.rs:154:13: [INFO] [stdout] Unexpected failure. [INFO] [stdout] code-255 [INFO] [stdout] stderr=```Connection refused (os error 111) [INFO] [stdout] ``` [INFO] [stdout] command=`cd "/tmp/.tmpHL2UOm" && "/opt/rustwide/target/debug/kvs-client" "get" "key2" "--addr" "127.0.0.1:4005"` [INFO] [stdout] code=255 [INFO] [stdout] stdout=`````` [INFO] [stdout] stderr=```Connection refused (os error 111) [INFO] [stdout] ``` [INFO] [stdout] [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x62dcc2719198 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x62dcc2719198 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x62dcc2719198 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x62dcc2719198 - <::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x62dcc272edba - ::fmt [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x62dcc272edba - core[8fb95b77d25ab6c8]::fmt::write [INFO] [stdout] 6: 0x62dcc271ed52 - std[10d71ac2c42b111e]::io::default_write_fmt::> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x62dcc271ed52 - as std[10d71ac2c42b111e]::io::Write>::write_fmt [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x62dcc26f65b6 - ::print [INFO] [stderr] error: test failed, to rerun pass `--test cli` [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x62dcc26f65b6 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x62dcc2710c79 - std[10d71ac2c42b111e]::panicking::default_hook [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x62dcc264f0ec - core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9 [INFO] [stdout] 12: 0x62dcc264f0ec - test[213991da798b1c03]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x62dcc2710e32 - core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9 [INFO] [stdout] 14: 0x62dcc2710e32 - std[10d71ac2c42b111e]::panicking::panic_with_hook [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x62dcc26f6672 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x62dcc26eb649 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x62dcc26f738d - __rustc[3be9ba60078d4c86]::rust_begin_unwind [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x62dcc272f54c - core[8fb95b77d25ab6c8]::panicking::panic_fmt [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x62dcc26bdc17 - ::success [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assert_cmd-0.11.1/src/assert.rs:154:13 [INFO] [stdout] 20: 0x62dcc262ab57 - cli[c88e01fe6aa3f8c0]::cli_access_server [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:318:10 [INFO] [stdout] 21: 0x62dcc262e99e - cli[c88e01fe6aa3f8c0]::cli_access_server_sled_engine [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:338:5 [INFO] [stdout] 22: 0x62dcc2628517 - cli[c88e01fe6aa3f8c0]::cli_access_server_sled_engine::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:337:35 [INFO] [stdout] 23: 0x62dcc2637446 - >::call_once [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x62dcc26421cb - core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x62dcc26421cb - test[213991da798b1c03]::__rust_begin_short_backtrace::, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18 [INFO] [stdout] 26: 0x62dcc264fa45 - test[213991da798b1c03]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74 [INFO] [stdout] 27: 0x62dcc264fa45 - as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 28: 0x62dcc264fa45 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40 [INFO] [stdout] 29: 0x62dcc264fa45 - std[10d71ac2c42b111e]::panicking::catch_unwind::, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19 [INFO] [stdout] 30: 0x62dcc264fa45 - std[10d71ac2c42b111e]::panic::catch_unwind::, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14 [INFO] [stdout] 31: 0x62dcc264fa45 - test[213991da798b1c03]::run_test_in_process [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27 [INFO] [stdout] 32: 0x62dcc264fa45 - test[213991da798b1c03]::run_test::{closure#0} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43 [INFO] [stdout] 33: 0x62dcc2649354 - test[213991da798b1c03]::run_test::{closure#1} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41 [INFO] [stdout] 34: 0x62dcc2649354 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 35: 0x62dcc2652ac2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 36: 0x62dcc2652ac2 - ::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 37: 0x62dcc2652ac2 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40 [INFO] [stdout] 38: 0x62dcc2652ac2 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19 [INFO] [stdout] 39: 0x62dcc2652ac2 - std[10d71ac2c42b111e]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14 [INFO] [stdout] 40: 0x62dcc2652ac2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 41: 0x62dcc2652ac2 - ::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 42: 0x62dcc271873f - + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9 [INFO] [stdout] 43: 0x62dcc271873f - ::new::thread_start [INFO] [stdout] at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 44: 0x782e1c6b0aa4 - [INFO] [stdout] 45: 0x782e1c73da64 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] cli_access_server_sled_engine [INFO] [stdout] [INFO] [stdout] test result: FAILED. 10 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.12s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40", kill_on_drop: false }` [INFO] [stdout] 1a70e83f3118f8ca1748e50a784ed57c15dd431be5f84a6c7c3ea82f981c7e40