[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 1.37.0 for beta-1.38-1
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-5/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/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" "+1.37.0" "build" "--frozen"`
[INFO] [stdout] 0591ce496c8e94a18c9e67fffeaa92fb1c304edf0a32b4497fae445987ac290a
[INFO] running `"docker" "start" "-a" "0591ce496c8e94a18c9e67fffeaa92fb1c304edf0a32b4497fae445987ac290a"`
[INFO] [stderr]    Compiling num_cpus v1.9.0
[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 uuid v0.7.1
[INFO] [stderr]    Compiling clap v2.32.0
[INFO] [stderr]    Compiling http v0.1.15
[INFO] [stderr]    Compiling openssl v0.10.16
[INFO] [stderr]    Compiling serde_urlencoded v0.5.4
[INFO] [stderr]    Compiling parking_lot_core v0.4.0
[INFO] [stderr]    Compiling phf_generator v0.7.24
[INFO] [stderr]    Compiling futures-cpupool v0.1.8
[INFO] [stderr]    Compiling phf_codegen v0.7.24
[INFO] [stderr]    Compiling mime_guess v2.0.0-alpha.6
[INFO] [stderr]    Compiling parking_lot v0.7.1
[INFO] [stderr]    Compiling crossbeam-channel v0.3.6
[INFO] [stderr]    Compiling tokio-reactor v0.1.8
[INFO] [stderr]    Compiling crossbeam v0.6.0
[INFO] [stderr]    Compiling native-tls v0.2.2
[INFO] [stderr]    Compiling tokio-tcp v0.1.3
[INFO] [stderr]    Compiling tokio-threadpool v0.1.11
[INFO] [stderr]    Compiling h2 v0.1.16
[INFO] [stderr]    Compiling tokio v0.1.15
[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 19s
[INFO] running `"docker" "inspect" "0591ce496c8e94a18c9e67fffeaa92fb1c304edf0a32b4497fae445987ac290a"`
[INFO] running `"docker" "rm" "-f" "0591ce496c8e94a18c9e67fffeaa92fb1c304edf0a32b4497fae445987ac290a"`
[INFO] [stdout] 0591ce496c8e94a18c9e67fffeaa92fb1c304edf0a32b4497fae445987ac290a
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-5/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/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" "+1.37.0" "test" "--frozen" "--no-run"`
[INFO] [stdout] b0e917d72aa7565ac1a2e504157fbc8c834f52b17262f72f4ada2288a603d3bf
[INFO] running `"docker" "start" "-a" "b0e917d72aa7565ac1a2e504157fbc8c834f52b17262f72f4ada2288a603d3bf"`
[INFO] [stderr]    Compiling wrench v0.1.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.28s
[INFO] running `"docker" "inspect" "b0e917d72aa7565ac1a2e504157fbc8c834f52b17262f72f4ada2288a603d3bf"`
[INFO] running `"docker" "rm" "-f" "b0e917d72aa7565ac1a2e504157fbc8c834f52b17262f72f4ada2288a603d3bf"`
[INFO] [stdout] b0e917d72aa7565ac1a2e504157fbc8c834f52b17262f72f4ada2288a603d3bf
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-5/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/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" "+1.37.0" "test" "--frozen"`
[INFO] [stdout] 8a6334a9b78282a6a57557c599baac0e6f5d692765c278e2381ff10582edd737
[INFO] running `"docker" "start" "-a" "8a6334a9b78282a6a57557c599baac0e6f5d692765c278e2381ff10582edd737"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/wrench-6c96340aa4874435
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test bench::tests::test_bench_time_it ... ok
[INFO] [stdout] test chart::tests::it_can_change_the_height ... ok
[INFO] [stdout] test chart::tests::it_makes_a_chart_of_default_height ... ok
[INFO] [stdout] test stats::millisecond_tests::convert_from_ms ... ok
[INFO] [stdout] test plan::tests::test_distribution_of_workload ... ok
[INFO] [stdout] test content_length::content_length_tests::it_can_add_two_content_lengths ... ok
[INFO] [stdout] test content_length::content_length_tests::can_pretty_print_content_length ... ok
[INFO] [stdout] test content_length::content_length_tests::it_returns_bytes ... ok
[INFO] [stdout] test stats::millisecond_tests::exchange_duration_to_ms ... ok
[INFO] [stdout] test stats::scale_array_tests::it_scale_arrays_an_array ... ok
[INFO] [stdout] test stats::summary_tests::calculates_percentiles_from_an_even_number_of_facts ... ok
[INFO] [stdout] test stats::millisecond_tests::convert_to_ms ... ok
[INFO] [stdout] test stats::summary_tests::averages_the_durations ... ok
[INFO] [stdout] test collector::message_collection_tests::test_ends_when_all_none_are_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_all_the_percentiles_when_n_greater_than_100 ... ok
[INFO] [stdout] 1 requests completed.
[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::counts_status_codes ... ok
[INFO] [stdout] test stats::summary_tests::counts_the_facts ... ok
[INFO] [stdout] test stats::summary_tests::summarizes_to_zero_if_empty ... ok
[INFO] [stdout] test stats::summary_tests::stddev_the_durations ... ok
[INFO] [stdout] test stats::summary_tests::calculates_percentiles_from_an_odd_number_of_facts ... ok
[INFO] [stdout] test stats::summary_tests::counts_the_histogram_of_latencies ... 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" "8a6334a9b78282a6a57557c599baac0e6f5d692765c278e2381ff10582edd737"`
[INFO] running `"docker" "rm" "-f" "8a6334a9b78282a6a57557c599baac0e6f5d692765c278e2381ff10582edd737"`
[INFO] [stdout] 8a6334a9b78282a6a57557c599baac0e6f5d692765c278e2381ff10582edd737