[INFO] updating cached repository cmsd2/kvs
[INFO] running `"git" "fetch" "--all"`
[INFO] [stdout] Fetching origin
[INFO] [stderr] From git://github.com/cmsd2/kvs
[INFO] [stderr]  * branch            HEAD       -> FETCH_HEAD
[INFO] running `"git" "clone" "work/cache/sources/gh/cmsd2/kvs" "work/ex/beta-1.37-6/sources/1.36.0/gh/cmsd2/kvs"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.37-6/sources/1.36.0/gh/cmsd2/kvs'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/cmsd2/kvs" "work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/cmsd2/kvs"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/cmsd2/kvs'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 2406049ea928ba216a43c4d79143aee00ecb627c
[INFO] sha for GitHub repo cmsd2/kvs: 2406049ea928ba216a43c4d79143aee00ecb627c
[INFO] validating manifest of cmsd2/kvs on toolchain 1.36.0
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.36.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of cmsd2/kvs on toolchain beta-2019-07-23
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-07-23" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing cmsd2/kvs
[INFO] finished frobbing cmsd2/kvs
[INFO] frobbed toml for cmsd2/kvs written to work/ex/beta-1.37-6/sources/1.36.0/gh/cmsd2/kvs/Cargo.toml
[INFO] started frobbing cmsd2/kvs
[INFO] finished frobbing cmsd2/kvs
[INFO] frobbed toml for cmsd2/kvs written to work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/cmsd2/kvs/Cargo.toml
[INFO] crate cmsd2/kvs already has a lockfile, it will not be regenerated
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.36.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-07-23" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing cmsd2/kvs against 1.36.0 for beta-1.37-6
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-6/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/gh/cmsd2/kvs:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "build" "--frozen"`
[INFO] [stdout] b277982eb888124a7932d92e20a9e0c99c56ff7af33dfb2d0f308f052173531e
[INFO] running `"docker" "start" "-a" "b277982eb888124a7932d92e20a9e0c99c56ff7af33dfb2d0f308f052173531e"`
[INFO] [stderr]    Compiling synstructure v0.10.2
[INFO] [stderr]    Compiling failure_derive v0.1.5
[INFO] [stderr]    Compiling failure v0.1.5
[INFO] [stderr]    Compiling kvs v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.45s
[INFO] running `"docker" "inspect" "b277982eb888124a7932d92e20a9e0c99c56ff7af33dfb2d0f308f052173531e"`
[INFO] running `"docker" "rm" "-f" "b277982eb888124a7932d92e20a9e0c99c56ff7af33dfb2d0f308f052173531e"`
[INFO] [stdout] b277982eb888124a7932d92e20a9e0c99c56ff7af33dfb2d0f308f052173531e
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-6/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/gh/cmsd2/kvs:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "test" "--frozen" "--no-run"`
[INFO] [stdout] b04aac7e640d23292b03e94a5ff675530eabff3aa67c830a8318c9e888765e91
[INFO] running `"docker" "start" "-a" "b04aac7e640d23292b03e94a5ff675530eabff3aa67c830a8318c9e888765e91"`
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] [stderr]    Compiling float-cmp v0.4.0
[INFO] [stderr]    Compiling predicates v1.0.1
[INFO] [stderr]    Compiling assert_cmd v0.11.1
[INFO] [stderr]    Compiling kvs v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.27s
[INFO] running `"docker" "inspect" "b04aac7e640d23292b03e94a5ff675530eabff3aa67c830a8318c9e888765e91"`
[INFO] running `"docker" "rm" "-f" "b04aac7e640d23292b03e94a5ff675530eabff3aa67c830a8318c9e888765e91"`
[INFO] [stdout] b04aac7e640d23292b03e94a5ff675530eabff3aa67c830a8318c9e888765e91
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-6/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/gh/cmsd2/kvs:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "test" "--frozen"`
[INFO] [stdout] 93e8ee43a824a113ace28a1275cf490cf20d592fcea073441a834e5a5a1e2b16
[INFO] running `"docker" "start" "-a" "93e8ee43a824a113ace28a1275cf490cf20d592fcea073441a834e5a5a1e2b16"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/tests-a6bac944c444918a
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test cli_invalid_subcommand ... ok
[INFO] [stdout] test cli_invalid_get ... ok
[INFO] [stdout] test cli_rm_non_existent_key ... ok
[INFO] [stdout] test cli_no_args ... ok
[INFO] [stdout] test cli_invalid_rm ... ok
[INFO] [stdout] test cli_version ... ok
[INFO] [stdout] test cli_get_non_existent_key ... ok
[INFO] [stdout] test get_stored_value ... ok
[INFO] [stdout] test overwrite_value ... ok
[INFO] [stdout] test cli_invalid_set ... ok
[INFO] [stdout] test remove_key ... ok
[INFO] [stdout] test remove_non_existent_key ... ok
[INFO] [stdout] test cli_get_stored ... ok
[INFO] [stdout] test get_non_existent_value ... ok
[INFO] [stdout] test cli_set ... ok
[INFO] [stdout] test cli_rm_stored ... ok
[INFO] [stdout] test compaction ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "93e8ee43a824a113ace28a1275cf490cf20d592fcea073441a834e5a5a1e2b16"`
[INFO] running `"docker" "rm" "-f" "93e8ee43a824a113ace28a1275cf490cf20d592fcea073441a834e5a5a1e2b16"`
[INFO] [stdout] 93e8ee43a824a113ace28a1275cf490cf20d592fcea073441a834e5a5a1e2b16