[INFO] cloning repository https://github.com/gitccl/rust-kv [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/gitccl/rust-kv" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgitccl%2Frust-kv", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgitccl%2Frust-kv'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 2c78b25f0b7264a9cd910b5da22b22752d07eefc [INFO] testing gitccl/rust-kv against master#67da586efe13aa66eef576ba095e1875ba65fd20 for pr-112849 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgitccl%2Frust-kv" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/gitccl/rust-kv on toolchain 67da586efe13aa66eef576ba095e1875ba65fd20 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/gitccl/rust-kv [INFO] finished tweaking git repo https://github.com/gitccl/rust-kv [INFO] tweaked toml for git repo https://github.com/gitccl/rust-kv written to /workspace/builds/worker-4-tc1/source/Cargo.toml [INFO] crate git repo https://github.com/gitccl/rust-kv 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" "+67da586efe13aa66eef576ba095e1875ba65fd20" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded assert_cmd v2.0.7 [INFO] [stderr] Downloaded predicates v2.1.4 [INFO] [stderr] Downloaded panic-control v0.1.4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] ad2e11d9dff7cca53701115231b27046e98b3546dd48661af911da3476f220a6 [INFO] running `Command { std: "docker" "start" "-a" "ad2e11d9dff7cca53701115231b27046e98b3546dd48661af911da3476f220a6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "ad2e11d9dff7cca53701115231b27046e98b3546dd48661af911da3476f220a6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ad2e11d9dff7cca53701115231b27046e98b3546dd48661af911da3476f220a6", kill_on_drop: false }` [INFO] [stdout] ad2e11d9dff7cca53701115231b27046e98b3546dd48661af911da3476f220a6 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f8b0a78cf575ad1cad2a23d4b1eef26c178e87539200653b4666c09c24545b1d [INFO] running `Command { std: "docker" "start" "-a" "f8b0a78cf575ad1cad2a23d4b1eef26c178e87539200653b4666c09c24545b1d", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling proc-macro2 v1.0.47 [INFO] [stderr] Compiling unicode-ident v1.0.5 [INFO] [stderr] Compiling quote v1.0.21 [INFO] [stderr] Compiling libc v0.2.138 [INFO] [stderr] Compiling syn v1.0.105 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling memchr v2.5.0 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling serde_derive v1.0.150 [INFO] [stderr] Compiling smallvec v1.10.0 [INFO] [stderr] Compiling lock_api v0.4.9 [INFO] [stderr] Compiling crossbeam-utils v0.8.14 [INFO] [stderr] Compiling num-traits v0.2.15 [INFO] [stderr] Compiling memoffset v0.7.1 [INFO] [stderr] Compiling serde v1.0.150 [INFO] [stderr] Compiling log v0.4.17 [INFO] [stderr] Compiling crossbeam-epoch v0.9.13 [INFO] [stderr] Compiling num-integer v0.1.45 [INFO] [stderr] Compiling parking_lot_core v0.9.5 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling num-bigint v0.4.3 [INFO] [stderr] Compiling paste v1.0.11 [INFO] [stderr] Compiling io-lifetimes v1.0.3 [INFO] [stderr] Compiling futures-core v0.3.25 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling once_cell v1.16.0 [INFO] [stderr] Compiling num_cpus v1.15.0 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling slab v0.4.7 [INFO] [stderr] Compiling futures-task v0.3.25 [INFO] [stderr] Compiling parking_lot_core v0.8.6 [INFO] [stderr] Compiling rustix v0.36.5 [INFO] [stderr] Compiling cc v1.0.77 [INFO] [stderr] Compiling pin-project-lite v0.2.9 [INFO] [stderr] Compiling tokio v1.23.0 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling bytes v1.3.0 [INFO] [stderr] Compiling failure_derive v0.1.8 [INFO] [stderr] Compiling crc32fast v1.3.2 [INFO] [stderr] Compiling futures-util v0.3.25 [INFO] [stderr] Compiling rayon-core v1.10.1 [INFO] [stderr] Compiling gimli v0.27.0 [INFO] [stderr] Compiling serde_json v1.0.89 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling futures-sink v0.3.25 [INFO] [stderr] Compiling linux-raw-sys v0.1.4 [INFO] [stderr] Compiling unicode-xid v0.2.4 [INFO] [stderr] Compiling backtrace v0.3.67 [INFO] [stderr] Compiling miniz_oxide v0.6.2 [INFO] [stderr] Compiling rmp v0.8.11 [INFO] [stderr] Compiling crossbeam-deque v0.8.2 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling tracing-core v0.1.30 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling mio v0.8.5 [INFO] [stderr] Compiling socket2 v0.4.7 [INFO] [stderr] Compiling crossbeam-channel v0.5.6 [INFO] [stderr] Compiling object v0.30.0 [INFO] [stderr] Compiling aho-corasick v0.7.20 [INFO] [stderr] Compiling itoa v1.0.4 [INFO] [stderr] Compiling ryu v1.0.11 [INFO] [stderr] Compiling synstructure v0.12.6 [INFO] [stderr] Compiling termcolor v1.1.3 [INFO] [stderr] Compiling half v1.8.2 [INFO] [stderr] Compiling addr2line v0.19.0 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling rustc-demangle v0.1.21 [INFO] [stderr] Compiling regex-syntax v0.6.28 [INFO] [stderr] Compiling os_str_bytes v6.4.1 [INFO] [stderr] Compiling heck v0.4.0 [INFO] [stderr] Compiling clap_lex v0.3.0 [INFO] [stderr] Compiling is-terminal v0.4.1 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling parking_lot v0.11.2 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling fs2 v0.4.3 [INFO] [stderr] Compiling fxhash v0.2.1 [INFO] [stderr] Compiling either v1.8.0 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling futures-io v0.3.25 [INFO] [stderr] Compiling humantime v2.1.0 [INFO] [stderr] Compiling regex v1.7.0 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling rayon v1.6.1 [INFO] [stderr] Compiling dashmap v5.4.0 [INFO] [stderr] Compiling sled v0.34.7 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling futures-macro v0.3.25 [INFO] [stderr] Compiling enum-ordinalize v3.1.12 [INFO] [stderr] Compiling pin-project-internal v1.0.12 [INFO] [stderr] Compiling tokio-macros v1.8.2 [INFO] [stderr] Compiling educe v0.4.20 [INFO] [stderr] Compiling clap_derive v4.0.21 [INFO] [stderr] Compiling pin-project v1.0.12 [INFO] [stderr] Compiling failure v0.1.8 [INFO] [stderr] Compiling env_logger v0.9.3 [INFO] [stderr] Compiling clap v4.0.29 [INFO] [stderr] Compiling tokio-util v0.7.4 [INFO] [stderr] Compiling rmp-serde v0.15.5 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling serde_cbor v0.11.2 [INFO] [stderr] Compiling tokio-serde v0.8.0 [INFO] [stderr] Compiling rust-kv v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 23.70s [INFO] running `Command { std: "docker" "inspect" "f8b0a78cf575ad1cad2a23d4b1eef26c178e87539200653b4666c09c24545b1d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f8b0a78cf575ad1cad2a23d4b1eef26c178e87539200653b4666c09c24545b1d", kill_on_drop: false }` [INFO] [stdout] f8b0a78cf575ad1cad2a23d4b1eef26c178e87539200653b4666c09c24545b1d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 63fb4202cb3a651988538da1eb419edcbb41584c3e51c5fa6a1ff0b00faeb63e [INFO] running `Command { std: "docker" "start" "-a" "63fb4202cb3a651988538da1eb419edcbb41584c3e51c5fa6a1ff0b00faeb63e", kill_on_drop: false }` [INFO] [stderr] Compiling num-traits v0.2.15 [INFO] [stderr] Compiling serde v1.0.150 [INFO] [stderr] Compiling either v1.8.0 [INFO] [stderr] Compiling regex-syntax v0.6.28 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling indexmap v1.9.2 [INFO] [stderr] Compiling getrandom v0.2.8 [INFO] [stderr] Compiling ciborium-io v0.2.0 [INFO] [stderr] Compiling plotters-backend v0.3.4 [INFO] [stderr] Compiling rayon v1.6.1 [INFO] [stderr] Compiling itertools v0.10.5 [INFO] [stderr] Compiling predicates-core v1.0.5 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling plotters-svg v0.3.3 [INFO] [stderr] Compiling dashmap v5.4.0 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling ciborium-ll v0.2.0 [INFO] [stderr] Compiling clap_lex v0.2.4 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling textwrap v0.16.0 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling rmp v0.8.11 [INFO] [stderr] Compiling float-cmp v0.9.0 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling termtree v0.4.0 [INFO] [stderr] Compiling bstr v1.0.1 [INFO] [stderr] Compiling regex v1.7.0 [INFO] [stderr] Compiling predicates-tree v1.0.7 [INFO] [stderr] Compiling clap v3.2.23 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling plotters v0.3.4 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling criterion-plot v0.5.0 [INFO] [stderr] Compiling env_logger v0.9.3 [INFO] [stderr] Compiling predicates v2.1.4 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling serde_json v1.0.89 [INFO] [stderr] Compiling serde_cbor v0.11.2 [INFO] [stderr] Compiling rmp-serde v0.15.5 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling ciborium v0.2.0 [INFO] [stderr] Compiling anes v0.1.6 [INFO] [stderr] Compiling remove_dir_all v0.5.3 [INFO] [stderr] Compiling fastrand v1.8.0 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling assert_cmd v2.0.7 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling tempfile v3.3.0 [INFO] [stderr] Compiling tokio-serde v0.8.0 [INFO] [stderr] Compiling rust-kv v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling panic-control v0.1.4 [INFO] [stderr] Compiling criterion v0.4.0 [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 16.42s [INFO] running `Command { std: "docker" "inspect" "63fb4202cb3a651988538da1eb419edcbb41584c3e51c5fa6a1ff0b00faeb63e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "63fb4202cb3a651988538da1eb419edcbb41584c3e51c5fa6a1ff0b00faeb63e", kill_on_drop: false }` [INFO] [stdout] 63fb4202cb3a651988538da1eb419edcbb41584c3e51c5fa6a1ff0b00faeb63e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] b5f970c62847a856a7c8f8b81140da28d876222e9cf7708889590d98434df979 [INFO] running `Command { std: "docker" "start" "-a" "b5f970c62847a856a7c8f8b81140da28d876222e9cf7708889590d98434df979", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rust_kv-e7e002772eb9a1cf) [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/kv-client.rs (/opt/rustwide/target/debug/deps/kv_client-f9f118c3835e3cfc) [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/kv-server.rs (/opt/rustwide/target/debug/deps/kv_server-e556ceae4d1d5a1f) [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] [stdout] [INFO] [stderr] Running tests/cli.rs (/opt/rustwide/target/debug/deps/cli-5f2a3ceb575581db) [INFO] [stdout] running 4 tests [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] kv-server 0.1.0 [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] kv-server 0.1.0 [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] Storage engine: kvs [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] Storage engine: sled [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] Listening on: 127.0.0.1:4004 [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] Listening on: 127.0.0.1:4002 [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] kv-server 0.1.0 [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] Storage engine: sled [INFO] [stderr] [2023-06-22T23:25:36Z INFO kv_server] Listening on: 127.0.0.1:4005 [INFO] [stdout] test cli_log_configuration ... ok [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52042 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38722 [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] kv-server 0.1.0 [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] Storage engine: kvs [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] Listening on: 127.0.0.1:4002 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52042 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38722 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52048 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52048 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38730 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52056 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52056 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38730 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38732 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52066 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38732 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38744 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38744 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52066 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52072 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52072 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38754 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52084 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38754 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52084 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38760 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52094 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38760 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52094 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38774 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:52110 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38774 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] handle request from 127.0.0.1:38786 [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:52110 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO rust_kv::server] client 127.0.0.1:38786 closed [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] kv-server 0.1.0 [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] Storage engine: kvs [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] Listening on: 127.0.0.1:4004 [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] kv-server 0.1.0 [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] Storage engine: sled [INFO] [stderr] [2023-06-22T23:25:37Z INFO kv_server] Listening on: 127.0.0.1:4005 [INFO] [stderr] [2023-06-22T23:25:37Z ERROR kv_server] IO error: could not acquire lock on "/tmp/.tmpKMguuE/db": Os { code: 11, kind: WouldBlock, message: "Resource temporarily unavailable" } [INFO] [stdout] test cli_wrong_engine ... ok [INFO] [stderr] [2023-06-22T23:25:38Z INFO rust_kv::server] handle request from 127.0.0.1:52118 [INFO] [stderr] [2023-06-22T23:25:38Z INFO rust_kv::server] client 127.0.0.1:52118 closed [INFO] [stderr] [2023-06-22T23:25:38Z INFO rust_kv::server] handle request from 127.0.0.1:52130 [INFO] [stderr] [2023-06-22T23:25:38Z INFO rust_kv::server] client 127.0.0.1:52130 closed [INFO] [stdout] test cli_access_server_kvs_engine ... ok [INFO] [stdout] test cli_access_server_sled_engine ... FAILED [INFO] [stderr] error: test failed, to rerun pass `--test cli` [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- cli_access_server_sled_engine stdout ---- [INFO] [stdout] thread 'cli_access_server_sled_engine' panicked at 'Unexpected failure. [INFO] [stdout] code-1 [INFO] [stdout] stderr=```"Error: Io(Os { code: 111, kind: ConnectionRefused, message: \"Connection refused\" })\n"``` [INFO] [stdout] command=`cd "/tmp/.tmpKMguuE" && "/opt/rustwide/target/debug/kv-client" "--addr" "127.0.0.1:4005"` [INFO] [stdout] stdin=`"get key2"` [INFO] [stdout] code=1 [INFO] [stdout] stdout="" [INFO] [stdout] stderr="Error: Io(Os { code: 111, kind: ConnectionRefused, message: \"Connection refused\" })\n" [INFO] [stdout] ', /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/ops/function.rs:250:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5625b3bd1ef1 - std::backtrace_rs::backtrace::libunwind::trace::h14bc19b012153c4e [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x5625b3bd1ef1 - std::backtrace_rs::backtrace::trace_unsynchronized::hbc9aa10cf185443a [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5625b3bd1ef1 - std::sys_common::backtrace::_print_fmt::hc902810bae4e6a55 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/sys_common/backtrace.rs:65:5 [INFO] [stdout] 3: 0x5625b3bd1ef1 - ::fmt::hdedc778f0cce9ba3 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/sys_common/backtrace.rs:44:22 [INFO] [stdout] 4: 0x5625b3bf956f - core::fmt::rt::Argument::fmt::h72a88a69c8be5aef [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/fmt/rt.rs:138:9 [INFO] [stdout] 5: 0x5625b3bf956f - core::fmt::write::hbcfa49c4e0540f31 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/fmt/mod.rs:1094:21 [INFO] [stdout] 6: 0x5625b3bceb67 - std::io::Write::write_fmt::h18acf23cd92ecffb [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/io/mod.rs:1714:15 [INFO] [stdout] 7: 0x5625b3bd1d05 - std::sys_common::backtrace::_print::hfdf9478d9ba7451e [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/sys_common/backtrace.rs:47:5 [INFO] [stdout] 8: 0x5625b3bd1d05 - std::sys_common::backtrace::print::h899b5001459c9891 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/sys_common/backtrace.rs:34:9 [INFO] [stdout] 9: 0x5625b3bd39e3 - std::panicking::default_hook::{{closure}}::h6ce7a9fa337d4ae0 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:269:22 [INFO] [stdout] 10: 0x5625b3bd3700 - std::panicking::default_hook::hb4a3976d57330484 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:285:9 [INFO] [stdout] 11: 0x5625b3b5a3e2 - as core::ops::function::Fn>::call::h44ae33e5fc62e84d [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 12: 0x5625b3b5a3e2 - test::test_main::{{closure}}::heeb5020ff7cd0307 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/test/src/lib.rs:134:21 [INFO] [stdout] 13: 0x5625b3bd40de - as core::ops::function::Fn>::call::hfc4fd049a549cb23 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 14: 0x5625b3bd40de - std::panicking::rust_panic_with_hook::h9b55d6b1e057a963 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:709:13 [INFO] [stdout] 15: 0x5625b3bd3e67 - std::panicking::begin_panic_handler::{{closure}}::hbef64bb3761b3da8 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:597:13 [INFO] [stdout] 16: 0x5625b3bd2326 - std::sys_common::backtrace::__rust_end_short_backtrace::he627f204232a89a2 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/sys_common/backtrace.rs:151:18 [INFO] [stdout] 17: 0x5625b3bd3bb2 - rust_begin_unwind [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:593:5 [INFO] [stdout] 18: 0x5625b3b077a3 - core::panicking::panic_fmt::h648da198469ea5f4 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/panicking.rs:67:14 [INFO] [stdout] 19: 0x5625b3b6ed1f - core::panicking::panic_display::ha119b94680f3ce3f [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/panicking.rs:150:5 [INFO] [stdout] 20: 0x5625b3b76877 - assert_cmd::assert::AssertError::panic::h78164d7b2415e804 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_cmd-2.0.7/src/assert.rs:1036:9 [INFO] [stdout] 21: 0x5625b3b770f7 - core::ops::function::FnOnce::call_once::ha1697ab37aac3597 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x5625b3b736e3 - core::result::Result::unwrap_or_else::h01d00f90c8c90f17 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/result.rs:1428:23 [INFO] [stdout] 23: 0x5625b3b75f9a - assert_cmd::assert::Assert::success::h2199cbc3440a3b59 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_cmd-2.0.7/src/assert.rs:156:9 [INFO] [stdout] 24: 0x5625b3b0fcc6 - cli::cli_access_server::h4a59e5f5e263be15 [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:176:5 [INFO] [stdout] 25: 0x5625b3b10e7e - cli::cli_access_server_sled_engine::ha189753e6eb452e4 [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:203:5 [INFO] [stdout] 26: 0x5625b3b10e47 - cli::cli_access_server_sled_engine::{{closure}}::h7c8f13e4bf8f5eb8 [INFO] [stdout] at /opt/rustwide/workdir/tests/cli.rs:202:36 [INFO] [stdout] 27: 0x5625b3b23745 - core::ops::function::FnOnce::call_once::h1cda17c5c7a05795 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 28: 0x5625b3b5f82f - core::ops::function::FnOnce::call_once::h6bc30f66680984ea [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 29: 0x5625b3b5f82f - test::__rust_begin_short_backtrace::h9d1b819fb7088a9f [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/test/src/lib.rs:655:18 [INFO] [stdout] 30: 0x5625b3b2b1ac - test::run_test::{{closure}}::he33c05959616bf43 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/test/src/lib.rs:646:30 [INFO] [stdout] 31: 0x5625b3b2b1ac - core::ops::function::FnOnce::call_once{{vtable.shim}}::h0efb49a8157434c3 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 32: 0x5625b3b5e7c9 - as core::ops::function::FnOnce>::call_once::he0f271a83d677b94 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 33: 0x5625b3b5e7c9 - as core::ops::function::FnOnce<()>>::call_once::h1659f8ebd02d03f3 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 34: 0x5625b3b5e7c9 - std::panicking::try::do_call::h813b98abe8a1f8c0 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:500:40 [INFO] [stdout] 35: 0x5625b3b5e7c9 - std::panicking::try::h885e718b66367fac [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:464:19 [INFO] [stdout] 36: 0x5625b3b5e7c9 - std::panic::catch_unwind::h90cca2ccc80a126a [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panic.rs:142:14 [INFO] [stdout] 37: 0x5625b3b5e7c9 - test::run_test_in_process::hdd049b79d49b124b [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/test/src/lib.rs:678:27 [INFO] [stdout] 38: 0x5625b3b5e7c9 - test::run_test::run_test_inner::{{closure}}::he854e2e6886327bf [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/test/src/lib.rs:572:39 [INFO] [stdout] 39: 0x5625b3b254f8 - test::run_test::run_test_inner::{{closure}}::hf97180155b2806bb [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/test/src/lib.rs:599:37 [INFO] [stdout] 40: 0x5625b3b254f8 - std::sys_common::backtrace::__rust_begin_short_backtrace::h3b0a6bc3e66eed40 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/sys_common/backtrace.rs:135:18 [INFO] [stdout] 41: 0x5625b3b2b3df - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hde1aad51bdcfbc9c [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/thread/mod.rs:529:17 [INFO] [stdout] 42: 0x5625b3b2b3df - as core::ops::function::FnOnce<()>>::call_once::h08b261b7b808318e [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 43: 0x5625b3b2b3df - std::panicking::try::do_call::h1788313a80cc5f82 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:500:40 [INFO] [stdout] 44: 0x5625b3b2b3df - std::panicking::try::h130f12a8109721d8 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panicking.rs:464:19 [INFO] [stdout] 45: 0x5625b3b2b3df - std::panic::catch_unwind::h0478d33b1b2a7979 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/panic.rs:142:14 [INFO] [stdout] 46: 0x5625b3b2b3df - std::thread::Builder::spawn_unchecked_::{{closure}}::h4da82aacc4498de6 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/thread/mod.rs:528:30 [INFO] [stdout] 47: 0x5625b3b2b3df - core::ops::function::FnOnce::call_once{{vtable.shim}}::hd7b2c4b1ed0b9ce5 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 48: 0x5625b3bd9755 - as core::ops::function::FnOnce>::call_once::h8a6d893de3fbe198 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 49: 0x5625b3bd9755 - as core::ops::function::FnOnce>::call_once::hdfd4a760783b8422 [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 50: 0x5625b3bd9755 - std::sys::unix::thread::Thread::new::thread_start::hbf63fe4c32dea9ed [INFO] [stdout] at /rustc/67da586efe13aa66eef576ba095e1875ba65fd20/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 51: 0x7f06450a9b43 - [INFO] [stdout] 52: 0x7f064513abb4 - __clone [INFO] [stdout] 53: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] cli_access_server_sled_engine [INFO] [stdout] [INFO] [stdout] test result: FAILED. 3 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.15s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "b5f970c62847a856a7c8f8b81140da28d876222e9cf7708889590d98434df979", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b5f970c62847a856a7c8f8b81140da28d876222e9cf7708889590d98434df979", kill_on_drop: false }` [INFO] [stdout] b5f970c62847a856a7c8f8b81140da28d876222e9cf7708889590d98434df979