[INFO] updating cached repository ecsumed/wrench
[INFO] running `"git" "fetch" "--all"`
[INFO] [stdout] Fetching origin
[INFO] [stderr] From git://github.com/ecsumed/wrench
[INFO] [stderr]  * branch            HEAD       -> FETCH_HEAD
[INFO] running `"git" "clone" "work/cache/sources/gh/ecsumed/wrench" "work/ex/beta-1.38-1/sources/1.37.0/gh/ecsumed/wrench"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/1.37.0/gh/ecsumed/wrench'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/ecsumed/wrench" "work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/ecsumed/wrench"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/ecsumed/wrench'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] e291faf00d511fe1c06d16dd7a9769e6a3a22ce9
[INFO] sha for GitHub repo ecsumed/wrench: e291faf00d511fe1c06d16dd7a9769e6a3a22ce9
[INFO] validating manifest of ecsumed/wrench on toolchain 1.37.0
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of ecsumed/wrench on toolchain beta-2019-08-13
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing ecsumed/wrench
[INFO] finished frobbing ecsumed/wrench
[INFO] frobbed toml for ecsumed/wrench written to work/ex/beta-1.38-1/sources/1.37.0/gh/ecsumed/wrench/Cargo.toml
[INFO] started frobbing ecsumed/wrench
[INFO] finished frobbing ecsumed/wrench
[INFO] frobbed toml for ecsumed/wrench written to work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/ecsumed/wrench/Cargo.toml
[INFO] crate ecsumed/wrench already has a lockfile, it will not be regenerated
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing ecsumed/wrench against beta-2019-08-13 for beta-1.38-1
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-3/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/ecsumed/wrench:/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" "+beta-2019-08-13" "build" "--frozen"`
[INFO] [stdout] c2fba32bd88a0a969c5be1a43158fa3e1a5186aea0150c2b5af25eae07319e20
[INFO] running `"docker" "start" "-a" "c2fba32bd88a0a969c5be1a43158fa3e1a5186aea0150c2b5af25eae07319e20"`
[INFO] [stderr]    Compiling want v0.0.6
[INFO] [stderr]    Compiling iovec v0.1.2
[INFO] [stderr]    Compiling net2 v0.2.33
[INFO] [stderr]    Compiling num_cpus v1.9.0
[INFO] [stderr]    Compiling time v0.1.42
[INFO] [stderr]    Compiling rand v0.5.6
[INFO] [stderr]    Compiling atty v0.2.11
[INFO] [stderr]    Compiling unicode-normalization v0.1.8
[INFO] [stderr]    Compiling tokio-timer v0.2.9
[INFO] [stderr]    Compiling openssl-sys v0.9.40
[INFO] [stderr]    Compiling serde_json v1.0.37
[INFO] [stderr]    Compiling libflate v0.1.19
[INFO] [stderr]    Compiling clap v2.32.0
[INFO] [stderr]    Compiling bytes v0.4.11
[INFO] [stderr]    Compiling futures-cpupool v0.1.8
[INFO] [stderr]    Compiling mio v0.6.16
[INFO] [stderr]    Compiling openssl v0.10.16
[INFO] [stderr]    Compiling tokio-io v0.1.11
[INFO] [stderr]    Compiling http v0.1.15
[INFO] [stderr]    Compiling parking_lot_core v0.4.0
[INFO] [stderr]    Compiling phf_generator v0.7.24
[INFO] [stderr]    Compiling uuid v0.7.1
[INFO] [stderr]    Compiling phf_codegen v0.7.24
[INFO] [stderr]    Compiling parking_lot v0.7.1
[INFO] [stderr]    Compiling mime_guess v2.0.0-alpha.6
[INFO] [stderr]    Compiling crossbeam-channel v0.3.6
[INFO] [stderr]    Compiling tokio-reactor v0.1.8
[INFO] [stderr]    Compiling native-tls v0.2.2
[INFO] [stderr]    Compiling idna v0.1.5
[INFO] [stderr]    Compiling tokio-tcp v0.1.3
[INFO] [stderr]    Compiling crossbeam v0.6.0
[INFO] [stderr]    Compiling tokio-threadpool v0.1.11
[INFO] [stderr]    Compiling h2 v0.1.16
[INFO] [stderr]    Compiling url v1.7.2
[INFO] [stderr]    Compiling tokio v0.1.15
[INFO] [stderr]    Compiling serde_urlencoded v0.5.4
[INFO] [stderr]    Compiling hyper v0.12.23
[INFO] [stderr]    Compiling hyper-tls v0.3.1
[INFO] [stderr]    Compiling reqwest v0.9.9
[INFO] [stderr]    Compiling wrench v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 33s
[INFO] running `"docker" "inspect" "c2fba32bd88a0a969c5be1a43158fa3e1a5186aea0150c2b5af25eae07319e20"`
[INFO] running `"docker" "rm" "-f" "c2fba32bd88a0a969c5be1a43158fa3e1a5186aea0150c2b5af25eae07319e20"`
[INFO] [stdout] c2fba32bd88a0a969c5be1a43158fa3e1a5186aea0150c2b5af25eae07319e20
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-3/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/ecsumed/wrench:/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" "+beta-2019-08-13" "test" "--frozen" "--no-run"`
[INFO] [stdout] 027cc9fe30879187bcf39357610621263f581a70256fe12318ab87c349c13542
[INFO] running `"docker" "start" "-a" "027cc9fe30879187bcf39357610621263f581a70256fe12318ab87c349c13542"`
[INFO] [stderr]    Compiling wrench v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.33s
[INFO] running `"docker" "inspect" "027cc9fe30879187bcf39357610621263f581a70256fe12318ab87c349c13542"`
[INFO] running `"docker" "rm" "-f" "027cc9fe30879187bcf39357610621263f581a70256fe12318ab87c349c13542"`
[INFO] [stdout] 027cc9fe30879187bcf39357610621263f581a70256fe12318ab87c349c13542
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-3/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/ecsumed/wrench:/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" "+beta-2019-08-13" "test" "--frozen"`
[INFO] [stdout] 64e6fa3e815ea40d50b06b8311fb2ee95459d1f80dd4e9a77f7d321a30689be7
[INFO] running `"docker" "start" "-a" "64e6fa3e815ea40d50b06b8311fb2ee95459d1f80dd4e9a77f7d321a30689be7"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/wrench-26b16a8c995a36c2
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test bench::tests::test_bench_time_it ... ok
[INFO] [stdout] test chart::tests::it_makes_a_chart_of_default_height ... ok
[INFO] [stdout] test chart::tests::it_can_change_the_height ... ok
[INFO] [stdout] test content_length::content_length_tests::it_returns_bytes ... ok
[INFO] [stdout] 1 requests completed.
[INFO] [stdout] test stats::millisecond_tests::convert_to_ms ... ok
[INFO] [stdout] test content_length::content_length_tests::it_can_add_two_content_lengths ... ok
[INFO] [stdout] test plan::tests::test_distribution_of_workload ... ok
[INFO] [stdout] test content_length::content_length_tests::can_pretty_print_content_length ... ok
[INFO] [stdout] test stats::millisecond_tests::convert_from_ms ... ok
[INFO] [stdout] test collector::message_collection_tests::test_ends_when_all_none_are_recieved ... ok
[INFO] [stdout] 1 requests completed.
[INFO] [stdout] 1 requests completed.
[INFO] [stdout] 1 requests completed.
[INFO] [stdout] 1 requests completed.
[INFO] [stdout] test collector::message_collection_tests::test_collects_all_data_recieved ... ok
[INFO] [stdout] test stats::summary_tests::calculates_all_the_percentiles_when_n_less_than_100 ... ok
[INFO] [stdout] test stats::summary_tests::calculates_percentiles_from_an_even_number_of_facts ... ok
[INFO] [stdout] test stats::summary_tests::counts_status_codes ... ok
[INFO] [stdout] test stats::summary_tests::calculates_percentiles_from_an_odd_number_of_facts ... ok
[INFO] [stdout] test stats::summary_tests::calculates_all_the_percentiles_when_n_greater_than_100 ... ok
[INFO] [stdout] test stats::summary_tests::averages_the_durations ... ok
[INFO] [stdout] test stats::scale_array_tests::it_scale_arrays_an_array ... ok
[INFO] [stdout] test stats::summary_tests::counts_the_facts ... ok
[INFO] [stdout] test stats::summary_tests::counts_the_histogram_of_latencies ... ok
[INFO] [stdout] test stats::summary_tests::stddev_the_durations ... ok
[INFO] [stdout] test stats::summary_tests::summarizes_to_zero_if_empty ... ok
[INFO] [stdout] test stats::millisecond_tests::exchange_duration_to_ms ... ok
[INFO] [stdout] test stats::summary_tests::sums_up_the_content_lengths ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "64e6fa3e815ea40d50b06b8311fb2ee95459d1f80dd4e9a77f7d321a30689be7"`
[INFO] running `"docker" "rm" "-f" "64e6fa3e815ea40d50b06b8311fb2ee95459d1f80dd4e9a77f7d321a30689be7"`
[INFO] [stdout] 64e6fa3e815ea40d50b06b8311fb2ee95459d1f80dd4e9a77f7d321a30689be7