Dec 06 01:28:10.892 INFO testing dmexe/failsafe-rs against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 01:28:10.892 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 06 01:28:11.064 INFO [stdout] 9dfc68893afc24f3a1f5b7df220fcad1c1f8ae0b5ce5cccdd9f39ee3e3311455
Dec 06 01:28:11.066 INFO running `"docker" "start" "-a" "9dfc68893afc24f3a1f5b7df220fcad1c1f8ae0b5ce5cccdd9f39ee3e3311455"`
Dec 06 01:28:11.441 INFO [stderr] usermod: no changes
Dec 06 01:28:11.520 INFO [stderr]    Compiling spin v0.4.9
Dec 06 01:28:11.679 INFO [stderr]    Compiling failsafe v0.3.0 (/source)
Dec 06 01:28:12.718 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.25s
Dec 06 01:28:12.728 INFO [stderr] su: No module specific data is present
Dec 06 01:28:13.336 INFO running `"docker" "inspect" "9dfc68893afc24f3a1f5b7df220fcad1c1f8ae0b5ce5cccdd9f39ee3e3311455"`
Dec 06 01:28:13.616 INFO running `"docker" "rm" "-f" "9dfc68893afc24f3a1f5b7df220fcad1c1f8ae0b5ce5cccdd9f39ee3e3311455"`
Dec 06 01:28:13.936 INFO [stdout] 9dfc68893afc24f3a1f5b7df220fcad1c1f8ae0b5ce5cccdd9f39ee3e3311455
Dec 06 01:28:13.942 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 06 01:28:14.346 INFO [stdout] 768557f9c12ccfda2f8bcffec19f373277ff762ae539e726e8bd1ec78e14bb75
Dec 06 01:28:14.348 INFO running `"docker" "start" "-a" "768557f9c12ccfda2f8bcffec19f373277ff762ae539e726e8bd1ec78e14bb75"`
Dec 06 01:28:16.040 INFO [stderr] usermod: no changes
Dec 06 01:28:16.177 INFO [stderr]    Compiling mio v0.6.15
Dec 06 01:28:16.188 INFO [stderr]    Compiling tokio-timer v0.2.6
Dec 06 01:28:16.188 INFO [stderr]    Compiling tokio-io v0.1.8
Dec 06 01:28:16.199 INFO [stderr]    Compiling tokio-threadpool v0.1.8
Dec 06 01:28:19.275 INFO [stderr]    Compiling tokio-codec v0.1.0
Dec 06 01:28:21.417 INFO [stderr]    Compiling tokio-reactor v0.1.5
Dec 06 01:28:21.428 INFO [stderr]    Compiling mio-uds v0.6.6
Dec 06 01:28:21.430 INFO [stderr]    Compiling tokio-fs v0.1.3
Dec 06 01:28:24.519 INFO [stderr]    Compiling tokio-tcp v0.1.1
Dec 06 01:28:24.522 INFO [stderr]    Compiling tokio-uds v0.2.1
Dec 06 01:28:24.523 INFO [stderr]    Compiling tokio-udp v0.1.2
Dec 06 01:28:26.514 INFO [stderr]    Compiling tokio v0.1.11
Dec 06 01:28:29.246 INFO [stderr]    Compiling failsafe v0.3.0 (/source)
Dec 06 01:28:33.315 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.25s
Dec 06 01:28:33.326 INFO [stderr] su: No module specific data is present
Dec 06 01:28:33.806 INFO running `"docker" "inspect" "768557f9c12ccfda2f8bcffec19f373277ff762ae539e726e8bd1ec78e14bb75"`
Dec 06 01:28:33.994 INFO running `"docker" "rm" "-f" "768557f9c12ccfda2f8bcffec19f373277ff762ae539e726e8bd1ec78e14bb75"`
Dec 06 01:28:34.264 INFO [stdout] 768557f9c12ccfda2f8bcffec19f373277ff762ae539e726e8bd1ec78e14bb75
Dec 06 01:28:34.268 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +906deae0790bd18681b937fe9a141a3c26cf1855-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 06 01:28:34.517 INFO [stdout] 26413331d73c83a23ef63afb84e6af3688c668b0b2a4b5ef350ec53f80c2b40b
Dec 06 01:28:34.519 INFO running `"docker" "start" "-a" "26413331d73c83a23ef63afb84e6af3688c668b0b2a4b5ef350ec53f80c2b40b"`
Dec 06 01:28:34.940 INFO [stderr] usermod: no changes
Dec 06 01:28:35.013 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 06 01:28:35.015 INFO [stderr]      Running /target/debug/deps/failsafe-71e2fd353b921623
Dec 06 01:28:35.016 INFO [stdout] 
Dec 06 01:28:35.017 INFO [stdout] running 30 tests
Dec 06 01:28:35.017 INFO [stdout] test backoff::tests::constant_growth ... ok
Dec 06 01:28:35.017 INFO [stdout] test backoff::tests::equal_jittered_growth ... ok
Dec 06 01:28:35.018 INFO [stdout] test backoff::tests::full_jittered_growth ... ok
Dec 06 01:28:35.018 INFO [stdout] test backoff::tests::exponential_growth ... ok
Dec 06 01:28:35.018 INFO [stdout] test circuit_breaker::tests::call_with ... ok
Dec 06 01:28:35.018 INFO [stdout] test ema::tests::compute ... ok
Dec 06 01:28:35.018 INFO [stdout] test ema::tests::updates_are_time_invariant ... ok
Dec 06 01:28:35.018 INFO [stdout] test ema::tests::reset ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::consecutive_failures::iterates_over_backoff ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::consecutive_failures::reset_to_zero_on_success ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::consecutive_failures::fail_on_nth_attempt ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::or_else::compose_policies ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::consecutive_failures::reset_to_zero_on_revived ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::fail_when_success_rate_not_met ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::respects_rps_threshold ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::revived_resets_failures ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::fractional_success_rate ... ok
Dec 06 01:28:35.018 INFO [stdout] test failure_predicate::tests::use_func_as_failure_predicate ... ok
Dec 06 01:28:35.019 INFO [stdout] test state_machine::tests::state_machine ... ok
Dec 06 01:28:35.019 INFO [stdout] test windowed_adder::tests::negative_sums ... ok
Dec 06 01:28:35.019 INFO [stdout] test windowed_adder::tests::sliding_over_large_window ... ok
Dec 06 01:28:35.019 INFO [stdout] test windowed_adder::tests::sliding_window_when_slices_are_skipped ... ok
Dec 06 01:28:35.019 INFO [stdout] test windowed_adder::tests::sliding_over_small_window ... ok
Dec 06 01:28:35.019 INFO [stdout] test windowed_adder::tests::sum_when_time_stands_still ... ok
Dec 06 01:28:35.020 INFO [stdout] test circuit_breaker::tests::call_err ... ok
Dec 06 01:28:35.021 INFO [stdout] test circuit_breaker::tests::call_ok ... ok
Dec 06 01:28:35.024 INFO [stdout] test futures::tests::call_err ... ok
Dec 06 01:28:35.024 INFO [stdout] test futures::tests::call_with ... ok
Dec 06 01:28:35.071 INFO [stdout] test ema::tests::non_monotonic_timestamp ... ok
Dec 06 01:28:35.123 INFO [stdout] test futures::tests::call_ok ... ok
Dec 06 01:28:35.123 INFO [stdout] 
Dec 06 01:28:35.123 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 01:28:35.123 INFO [stdout] 
Dec 06 01:28:35.124 INFO [stderr]    Doc-tests failsafe
Dec 06 01:28:35.616 INFO [stdout] 
Dec 06 01:28:35.616 INFO [stdout] running 3 tests
Dec 06 01:28:36.701 INFO [stdout] test src/lib.rs -  (line 52) ... ok
Dec 06 01:28:37.222 INFO [stdout] test src/lib.rs -  (line 15) ... ok
Dec 06 01:28:37.262 INFO [stdout] test src/futures/mod.rs - futures (line 7) ... ok
Dec 06 01:28:37.262 INFO [stdout] 
Dec 06 01:28:37.263 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 01:28:37.263 INFO [stdout] 
Dec 06 01:28:37.279 INFO [stderr] su: No module specific data is present
Dec 06 01:28:37.776 INFO running `"docker" "inspect" "26413331d73c83a23ef63afb84e6af3688c668b0b2a4b5ef350ec53f80c2b40b"`
Dec 06 01:28:38.030 INFO running `"docker" "rm" "-f" "26413331d73c83a23ef63afb84e6af3688c668b0b2a4b5ef350ec53f80c2b40b"`
Dec 06 01:28:38.332 INFO [stdout] 26413331d73c83a23ef63afb84e6af3688c668b0b2a4b5ef350ec53f80c2b40b