[INFO] updating cached repository songzhi/kvs
[INFO] running `"git" "fetch" "--all"`
[INFO] [stdout] Fetching origin
[INFO] [stderr] From git://github.com/songzhi/kvs
[INFO] [stderr]  * branch            HEAD       -> FETCH_HEAD
[INFO] running `"git" "clone" "work/cache/sources/gh/songzhi/kvs" "work/ex/beta-1.37-6/sources/1.36.0/gh/songzhi/kvs"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.37-6/sources/1.36.0/gh/songzhi/kvs'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/songzhi/kvs" "work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/songzhi/kvs"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/songzhi/kvs'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 933ffb47975b45484dd9c2cb2dd7f7e07e50005e
[INFO] sha for GitHub repo songzhi/kvs: 933ffb47975b45484dd9c2cb2dd7f7e07e50005e
[INFO] validating manifest of songzhi/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 songzhi/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 songzhi/kvs
[INFO] finished frobbing songzhi/kvs
[INFO] frobbed toml for songzhi/kvs written to work/ex/beta-1.37-6/sources/1.36.0/gh/songzhi/kvs/Cargo.toml
[INFO] started frobbing songzhi/kvs
[INFO] finished frobbing songzhi/kvs
[INFO] frobbed toml for songzhi/kvs written to work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/songzhi/kvs/Cargo.toml
[INFO] crate songzhi/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 songzhi/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/songzhi/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] 93c5b9b6dd941d59cf996c7193f98012ddb9dab2a17fe6f0b92f50fdc5063d47
[INFO] running `"docker" "start" "-a" "93c5b9b6dd941d59cf996c7193f98012ddb9dab2a17fe6f0b92f50fdc5063d47"`
[INFO] [stderr]    Compiling kvs v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.87s
[INFO] running `"docker" "inspect" "93c5b9b6dd941d59cf996c7193f98012ddb9dab2a17fe6f0b92f50fdc5063d47"`
[INFO] running `"docker" "rm" "-f" "93c5b9b6dd941d59cf996c7193f98012ddb9dab2a17fe6f0b92f50fdc5063d47"`
[INFO] [stdout] 93c5b9b6dd941d59cf996c7193f98012ddb9dab2a17fe6f0b92f50fdc5063d47
[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/songzhi/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] 2fa45b1548455ea96c46e0c627f6cec65a0ea36ec3077802c439ecbb51558b8b
[INFO] running `"docker" "start" "-a" "2fa45b1548455ea96c46e0c627f6cec65a0ea36ec3077802c439ecbb51558b8b"`
[INFO] [stderr]     Blocking waiting for file lock on package cache lock
[INFO] [stderr]    Compiling syn v0.15.35
[INFO] [stderr]    Compiling float-cmp v0.4.0
[INFO] [stderr]    Compiling predicates v1.0.1
[INFO] [stderr]    Compiling serde_derive v1.0.92
[INFO] [stderr]    Compiling serde v1.0.92
[INFO] [stderr]    Compiling serde_json v1.0.39
[INFO] [stderr]    Compiling escargot v0.4.0
[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 52.90s
[INFO] running `"docker" "inspect" "2fa45b1548455ea96c46e0c627f6cec65a0ea36ec3077802c439ecbb51558b8b"`
[INFO] running `"docker" "rm" "-f" "2fa45b1548455ea96c46e0c627f6cec65a0ea36ec3077802c439ecbb51558b8b"`
[INFO] [stdout] 2fa45b1548455ea96c46e0c627f6cec65a0ea36ec3077802c439ecbb51558b8b
[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/songzhi/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] a383c07e6c625aa652d7d4cf1bb9be462438894295cc61b52534ae26e1e29877
[INFO] running `"docker" "start" "-a" "a383c07e6c625aa652d7d4cf1bb9be462438894295cc61b52534ae26e1e29877"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/kvs-62cbd9c29e12260e
[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
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/kvs-5490ddfb4e0a36ab
[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
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/tests-35cb3b7c2d716273
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test cli_rm ... ok
[INFO] [stdout] test cli_no_args ... ok
[INFO] [stdout] test get_non_existent_value ... ok
[INFO] [stdout] test cli_invalid_subcommand ... ok
[INFO] [stdout] test get_stored_value ... ok
[INFO] [stdout] test overwrite_value ... ok
[INFO] [stdout] test remove_key ... ok
[INFO] [stdout] test cli_get ... ok
[INFO] [stdout] test cli_version ... ok
[INFO] [stdout] test cli_invalid_rm ... ok
[INFO] [stdout] test cli_invalid_get ... ok
[INFO] [stdout] test cli_set ... ok
[INFO] [stdout] test cli_invalid_set ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests kvs
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/kv.rs - kv::KvStore (line 9) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "a383c07e6c625aa652d7d4cf1bb9be462438894295cc61b52534ae26e1e29877"`
[INFO] running `"docker" "rm" "-f" "a383c07e6c625aa652d7d4cf1bb9be462438894295cc61b52534ae26e1e29877"`
[INFO] [stdout] a383c07e6c625aa652d7d4cf1bb9be462438894295cc61b52534ae26e1e29877