Dec 13 21:12:52.742 INFO testing dmexe/failsafe-rs against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 21:12:52.742 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 21:12:52.897 INFO [stdout] 2b06a59599a441a05b2458ffd6550541a8a4375abaf69933b62cb4f5aeb80ab3
Dec 13 21:12:52.900 INFO running `"docker" "start" "-a" "2b06a59599a441a05b2458ffd6550541a8a4375abaf69933b62cb4f5aeb80ab3"`
Dec 13 21:12:53.306 INFO [stderr] usermod: no changes
Dec 13 21:12:53.386 INFO [stderr]    Compiling spin v0.4.9
Dec 13 21:12:53.588 INFO [stderr]    Compiling failsafe v0.3.0 (/source)
Dec 13 21:12:54.595 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.26s
Dec 13 21:12:54.601 INFO [stderr] su: No module specific data is present
Dec 13 21:12:55.149 INFO running `"docker" "inspect" "2b06a59599a441a05b2458ffd6550541a8a4375abaf69933b62cb4f5aeb80ab3"`
Dec 13 21:12:55.299 INFO running `"docker" "rm" "-f" "2b06a59599a441a05b2458ffd6550541a8a4375abaf69933b62cb4f5aeb80ab3"`
Dec 13 21:12:55.478 INFO [stdout] 2b06a59599a441a05b2458ffd6550541a8a4375abaf69933b62cb4f5aeb80ab3
Dec 13 21:12:55.555 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 21:12:56.011 INFO [stdout] 313adfb4bd7add1247d86ccf78beb71deffb21c75c3af874142a1dd4c6dcb09e
Dec 13 21:12:56.016 INFO running `"docker" "start" "-a" "313adfb4bd7add1247d86ccf78beb71deffb21c75c3af874142a1dd4c6dcb09e"`
Dec 13 21:12:56.468 INFO [stderr] usermod: no changes
Dec 13 21:12:56.599 INFO [stderr]    Compiling tokio-timer v0.2.6
Dec 13 21:12:56.599 INFO [stderr]    Compiling tokio-io v0.1.8
Dec 13 21:12:56.599 INFO [stderr]    Compiling tokio-threadpool v0.1.8
Dec 13 21:12:59.887 INFO [stderr]    Compiling tokio-codec v0.1.0
Dec 13 21:12:59.888 INFO [stderr]    Compiling tokio-reactor v0.1.5
Dec 13 21:13:03.389 INFO [stderr]    Compiling tokio-fs v0.1.3
Dec 13 21:13:05.694 INFO [stderr]    Compiling tokio-udp v0.1.2
Dec 13 21:13:05.696 INFO [stderr]    Compiling tokio-tcp v0.1.1
Dec 13 21:13:05.697 INFO [stderr]    Compiling tokio-uds v0.2.1
Dec 13 21:13:10.069 INFO [stderr]    Compiling tokio v0.1.11
Dec 13 21:13:12.746 INFO [stderr]    Compiling failsafe v0.3.0 (/source)
Dec 13 21:13:18.103 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 21.62s
Dec 13 21:13:18.124 INFO [stderr] su: No module specific data is present
Dec 13 21:13:18.813 INFO running `"docker" "inspect" "313adfb4bd7add1247d86ccf78beb71deffb21c75c3af874142a1dd4c6dcb09e"`
Dec 13 21:13:18.945 INFO running `"docker" "rm" "-f" "313adfb4bd7add1247d86ccf78beb71deffb21c75c3af874142a1dd4c6dcb09e"`
Dec 13 21:13:19.075 INFO [stdout] 313adfb4bd7add1247d86ccf78beb71deffb21c75c3af874142a1dd4c6dcb09e
Dec 13 21:13:19.080 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 21:13:19.357 INFO [stdout] 7cc5f54e8c0a59d65e6f4a3a2462d2a124f474103769fd53679c0df9d847a8a9
Dec 13 21:13:19.361 INFO running `"docker" "start" "-a" "7cc5f54e8c0a59d65e6f4a3a2462d2a124f474103769fd53679c0df9d847a8a9"`
Dec 13 21:13:19.986 INFO [stderr] usermod: no changes
Dec 13 21:13:20.087 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 13 21:13:20.100 INFO [stderr]      Running /target/debug/deps/failsafe-a2773d0ad1cc7f26
Dec 13 21:13:20.102 INFO [stdout] 
Dec 13 21:13:20.102 INFO [stdout] running 30 tests
Dec 13 21:13:20.105 INFO [stdout] test backoff::tests::exponential_growth ... ok
Dec 13 21:13:20.106 INFO [stdout] test backoff::tests::equal_jittered_growth ... ok
Dec 13 21:13:20.106 INFO [stdout] test backoff::tests::full_jittered_growth ... ok
Dec 13 21:13:20.106 INFO [stdout] test backoff::tests::constant_growth ... ok
Dec 13 21:13:20.106 INFO [stdout] test circuit_breaker::tests::call_err ... ok
Dec 13 21:13:20.106 INFO [stdout] test circuit_breaker::tests::call_ok ... ok
Dec 13 21:13:20.106 INFO [stdout] test failure_policy::tests::consecutive_failures::fail_on_nth_attempt ... ok
Dec 13 21:13:20.106 INFO [stdout] test ema::tests::updates_are_time_invariant ... ok
Dec 13 21:13:20.106 INFO [stdout] test failure_policy::tests::consecutive_failures::reset_to_zero_on_success ... ok
Dec 13 21:13:20.108 INFO [stdout] test failure_policy::tests::consecutive_failures::reset_to_zero_on_revived ... ok
Dec 13 21:13:20.108 INFO [stdout] test failure_policy::tests::consecutive_failures::iterates_over_backoff ... ok
Dec 13 21:13:20.108 INFO [stdout] test ema::tests::reset ... ok
Dec 13 21:13:20.108 INFO [stdout] test failure_policy::tests::or_else::compose_policies ... ok
Dec 13 21:13:20.108 INFO [stdout] test ema::tests::compute ... ok
Dec 13 21:13:20.108 INFO [stdout] test circuit_breaker::tests::call_with ... ok
Dec 13 21:13:20.109 INFO [stdout] test failure_predicate::tests::use_func_as_failure_predicate ... ok
Dec 13 21:13:20.110 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::fractional_success_rate ... ok
Dec 13 21:13:20.110 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::respects_rps_threshold ... ok
Dec 13 21:13:20.111 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::fail_when_success_rate_not_met ... ok
Dec 13 21:13:20.111 INFO [stdout] test failure_policy::tests::success_rate_over_time_window::revived_resets_failures ... ok
Dec 13 21:13:20.115 INFO [stdout] test windowed_adder::tests::sliding_over_large_window ... ok
Dec 13 21:13:20.115 INFO [stdout] test windowed_adder::tests::negative_sums ... ok
Dec 13 21:13:20.115 INFO [stdout] test state_machine::tests::state_machine ... ok
Dec 13 21:13:20.116 INFO [stdout] test windowed_adder::tests::sum_when_time_stands_still ... ok
Dec 13 21:13:20.116 INFO [stdout] test windowed_adder::tests::sliding_window_when_slices_are_skipped ... ok
Dec 13 21:13:20.117 INFO [stdout] test windowed_adder::tests::sliding_over_small_window ... ok
Dec 13 21:13:20.144 INFO [stdout] test futures::tests::call_err ... ok
Dec 13 21:13:20.152 INFO [stdout] test futures::tests::call_with ... ok
Dec 13 21:13:20.212 INFO [stdout] test ema::tests::non_monotonic_timestamp ... ok
Dec 13 21:13:20.213 INFO [stdout] test futures::tests::call_ok ... ok
Dec 13 21:13:20.213 INFO [stdout] 
Dec 13 21:13:20.213 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 21:13:20.213 INFO [stdout] 
Dec 13 21:13:20.217 INFO [stderr]    Doc-tests failsafe
Dec 13 21:13:21.019 INFO [stdout] 
Dec 13 21:13:21.019 INFO [stdout] running 3 tests
Dec 13 21:13:22.830 INFO [stdout] test src/lib.rs -  (line 52) ... ok
Dec 13 21:13:22.909 INFO [stdout] test src/lib.rs -  (line 15) ... ok
Dec 13 21:13:23.491 INFO [stdout] test src/futures/mod.rs - futures (line 7) ... ok
Dec 13 21:13:23.491 INFO [stdout] 
Dec 13 21:13:23.491 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 21:13:23.491 INFO [stdout] 
Dec 13 21:13:23.520 INFO [stderr] su: No module specific data is present
Dec 13 21:13:24.188 INFO running `"docker" "inspect" "7cc5f54e8c0a59d65e6f4a3a2462d2a124f474103769fd53679c0df9d847a8a9"`
Dec 13 21:13:24.369 INFO running `"docker" "rm" "-f" "7cc5f54e8c0a59d65e6f4a3a2462d2a124f474103769fd53679c0df9d847a8a9"`
Dec 13 21:13:24.494 INFO [stdout] 7cc5f54e8c0a59d65e6f4a3a2462d2a124f474103769fd53679c0df9d847a8a9