Dec 14 21:10:43.652 INFO testing rvs-0.4.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 21:10:43.653 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 21:10:43.897 INFO [stdout] 18b9485548edd7a9610ff2b3fff4d277934882547cc7d8bd90ab1107aebe9f43
Dec 14 21:10:43.899 INFO running `"docker" "start" "-a" "18b9485548edd7a9610ff2b3fff4d277934882547cc7d8bd90ab1107aebe9f43"`
Dec 14 21:10:44.460 INFO [stderr] usermod: no changes
Dec 14 21:10:44.498 INFO [stderr]    Compiling rvs-parser v0.4.0
Dec 14 21:10:48.305 INFO [stderr]    Compiling rvs v0.4.1 (/source)
Dec 14 21:10:51.043 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.57s
Dec 14 21:10:51.054 INFO [stderr] su: No module specific data is present
Dec 14 21:10:52.275 INFO running `"docker" "inspect" "18b9485548edd7a9610ff2b3fff4d277934882547cc7d8bd90ab1107aebe9f43"`
Dec 14 21:10:52.543 INFO running `"docker" "rm" "-f" "18b9485548edd7a9610ff2b3fff4d277934882547cc7d8bd90ab1107aebe9f43"`
Dec 14 21:10:52.833 INFO [stdout] 18b9485548edd7a9610ff2b3fff4d277934882547cc7d8bd90ab1107aebe9f43
Dec 14 21:10:52.839 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 21:10:53.253 INFO [stdout] 2e8ec8c0e2a6acbd6f0bfda352ab6ca37b4d8dd9a5c53ca62aaca5f217153383
Dec 14 21:10:53.263 INFO running `"docker" "start" "-a" "2e8ec8c0e2a6acbd6f0bfda352ab6ca37b4d8dd9a5c53ca62aaca5f217153383"`
Dec 14 21:10:53.865 INFO [stderr] usermod: no changes
Dec 14 21:10:53.912 INFO [stderr]    Compiling rvs v0.4.1 (/source)
Dec 14 21:11:08.882 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.00s
Dec 14 21:11:08.892 INFO [stderr] su: No module specific data is present
Dec 14 21:11:09.696 INFO running `"docker" "inspect" "2e8ec8c0e2a6acbd6f0bfda352ab6ca37b4d8dd9a5c53ca62aaca5f217153383"`
Dec 14 21:11:09.943 INFO running `"docker" "rm" "-f" "2e8ec8c0e2a6acbd6f0bfda352ab6ca37b4d8dd9a5c53ca62aaca5f217153383"`
Dec 14 21:11:10.287 INFO [stdout] 2e8ec8c0e2a6acbd6f0bfda352ab6ca37b4d8dd9a5c53ca62aaca5f217153383
Dec 14 21:11:10.295 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 21:11:10.799 INFO [stdout] b1da8e8411abac169c21a19381c40858fd3c2c7adbaeb37e46d8fd3d59c0ce09
Dec 14 21:11:10.801 INFO running `"docker" "start" "-a" "b1da8e8411abac169c21a19381c40858fd3c2c7adbaeb37e46d8fd3d59c0ce09"`
Dec 14 21:11:12.367 INFO [stderr] usermod: no changes
Dec 14 21:11:12.467 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 14 21:11:12.483 INFO [stderr]      Running /target/debug/deps/rvs-9973f098c28c7f58
Dec 14 21:11:12.483 INFO [stdout] 
Dec 14 21:11:12.483 INFO [stdout] running 4 tests
Dec 14 21:11:12.495 INFO [stdout] test types::range::tests::range::full_range ... ignored
Dec 14 21:11:12.495 INFO [stdout] test types::range::tests::range::basic ... ok
Dec 14 21:11:12.495 INFO [stdout] test types::range::tests::range::max_max ... ok
Dec 14 21:11:12.495 INFO [stdout] test types::weighted::tests::test_populate_pool ... ok
Dec 14 21:11:12.495 INFO [stdout] 
Dec 14 21:11:12.495 INFO [stdout] test result: ok. 3 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.495 INFO [stdout] 
Dec 14 21:11:12.495 INFO [stderr]      Running /target/debug/deps/display-8a97897c45eaf3c6
Dec 14 21:11:12.496 INFO [stdout] 
Dec 14 21:11:12.496 INFO [stdout] running 2 tests
Dec 14 21:11:12.496 INFO [stdout] test precendence ... ok
Dec 14 21:11:12.496 INFO [stdout] test multiple ... ok
Dec 14 21:11:12.496 INFO [stdout] 
Dec 14 21:11:12.496 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.496 INFO [stdout] 
Dec 14 21:11:12.498 INFO [stderr]      Running /target/debug/deps/done-58a543c50688f17b
Dec 14 21:11:12.499 INFO [stdout] 
Dec 14 21:11:12.499 INFO [stdout] running 3 tests
Dec 14 21:11:12.500 INFO [stdout] test done_causes_advance_to_next_subexpr ... ok
Dec 14 21:11:12.500 INFO [stdout] test always_done ... ok
Dec 14 21:11:12.515 INFO [stdout] test done_defaults_to_false ... ok
Dec 14 21:11:12.515 INFO [stdout] 
Dec 14 21:11:12.515 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.515 INFO [stdout] 
Dec 14 21:11:12.519 INFO [stdout] 
Dec 14 21:11:12.519 INFO [stdout] running 1 test
Dec 14 21:11:12.519 INFO [stdout] test type_arguments ... ok
Dec 14 21:11:12.519 INFO [stdout] 
Dec 14 21:11:12.519 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.519 INFO [stdout] 
Dec 14 21:11:12.519 INFO [stderr]      Running /target/debug/deps/lazyness-c175291e2e179d86
Dec 14 21:11:12.527 INFO [stderr]      Running /target/debug/deps/once-f44cb9ff01829f18
Dec 14 21:11:12.527 INFO [stdout] 
Dec 14 21:11:12.527 INFO [stdout] running 2 tests
Dec 14 21:11:12.527 INFO [stdout] test done_defaults_to_false ... ok
Dec 14 21:11:12.533 INFO [stdout] test yields_constant_value_and_always_done ... ok
Dec 14 21:11:12.533 INFO [stderr]      Running /target/debug/deps/operations-77df2250f14a69ff
Dec 14 21:11:12.533 INFO [stdout] 
Dec 14 21:11:12.534 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.534 INFO [stdout] 
Dec 14 21:11:12.534 INFO [stdout] 
Dec 14 21:11:12.534 INFO [stdout] running 7 tests
Dec 14 21:11:12.534 INFO [stdout] test overflow_add ... ok
Dec 14 21:11:12.534 INFO [stdout] test overflow_shl ... ok
Dec 14 21:11:12.539 INFO [stdout] test overflow_neg ... ok
Dec 14 21:11:12.539 INFO [stdout] test yields_sum ... ok
Dec 14 21:11:12.539 INFO [stdout] test overflow_sub ... ok
Dec 14 21:11:12.547 INFO [stdout] test overflow_mul ... ok
Dec 14 21:11:12.547 INFO [stdout] test overflow_shr ... ok
Dec 14 21:11:12.547 INFO [stdout] 
Dec 14 21:11:12.547 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.547 INFO [stdout] 
Dec 14 21:11:12.547 INFO [stdout] 
Dec 14 21:11:12.547 INFO [stdout] running 1 test
Dec 14 21:11:12.547 INFO [stdout] test basic ... ok
Dec 14 21:11:12.547 INFO [stdout] 
Dec 14 21:11:12.547 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.547 INFO [stdout] 
Dec 14 21:11:12.547 INFO [stdout] 
Dec 14 21:11:12.547 INFO [stdout] running 2 tests
Dec 14 21:11:12.547 INFO [stderr]      Running /target/debug/deps/parse-f103b0054992988c
Dec 14 21:11:12.547 INFO [stderr]      Running /target/debug/deps/pattern-4ca8aa28a664bbcd
Dec 14 21:11:12.559 INFO [stdout] test selects_another_subexpr_when_current_subexpr_done ... ok
Dec 14 21:11:12.559 INFO [stdout] test yields_a_repeating_pattern ... ok
Dec 14 21:11:12.559 INFO [stdout] 
Dec 14 21:11:12.559 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.559 INFO [stdout] 
Dec 14 21:11:12.559 INFO [stderr]      Running /target/debug/deps/range-0e4b29c59f5e35b7
Dec 14 21:11:12.567 INFO [stdout] 
Dec 14 21:11:12.567 INFO [stdout] running 3 tests
Dec 14 21:11:12.567 INFO [stdout] test done_after_each_next ... ok
Dec 14 21:11:12.567 INFO [stdout] test reverse_limits ... ok
Dec 14 21:11:12.574 INFO [stdout] test equal_limits ... ok
Dec 14 21:11:12.574 INFO [stdout] 
Dec 14 21:11:12.574 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.574 INFO [stdout] 
Dec 14 21:11:12.575 INFO [stderr]      Running /target/debug/deps/readme-37126152cf01d8ae
Dec 14 21:11:12.579 INFO [stdout] 
Dec 14 21:11:12.579 INFO [stdout] running 1 test
Dec 14 21:11:12.601 INFO [stdout] test readme ... ok
Dec 14 21:11:12.601 INFO [stdout] 
Dec 14 21:11:12.601 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.601 INFO [stdout] 
Dec 14 21:11:12.611 INFO [stderr]      Running /target/debug/deps/repl-2ddb8e04e8a76110
Dec 14 21:11:12.616 INFO [stdout] 
Dec 14 21:11:12.616 INFO [stdout] running 1 test
Dec 14 21:11:12.631 INFO [stderr]      Running /target/debug/deps/sample_with_replacement-850d2b711524b81e
Dec 14 21:11:12.631 INFO [stdout] test basic ... ok
Dec 14 21:11:12.631 INFO [stdout] 
Dec 14 21:11:12.631 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.631 INFO [stdout] 
Dec 14 21:11:12.636 INFO [stdout] 
Dec 14 21:11:12.636 INFO [stdout] running 3 tests
Dec 14 21:11:12.637 INFO [stdout] test done_when_sub_expr_done ... ok
Dec 14 21:11:12.637 INFO [stdout] test selects_another_subexpr_when_current_subexpr_done ... ok
Dec 14 21:11:12.643 INFO [stdout] test basic ... ok
Dec 14 21:11:12.643 INFO [stdout] 
Dec 14 21:11:12.643 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.643 INFO [stdout] 
Dec 14 21:11:12.643 INFO [stderr]      Running /target/debug/deps/sample_without_replacement-122a2c8f4cf45ffc
Dec 14 21:11:12.645 INFO [stdout] 
Dec 14 21:11:12.645 INFO [stdout] running 4 tests
Dec 14 21:11:12.669 INFO [stdout] test done_when_all_done2 ... ok
Dec 14 21:11:12.669 INFO [stdout] test done_when_all_done ... ok
Dec 14 21:11:12.674 INFO [stdout] test yields_each_value_once_per_cycle ... ok
Dec 14 21:11:12.674 INFO [stdout] test selects_another_subexpr_when_current_subexpr_done ... ok
Dec 14 21:11:12.674 INFO [stdout] 
Dec 14 21:11:12.674 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.674 INFO [stdout] 
Dec 14 21:11:12.674 INFO [stderr]      Running /target/debug/deps/sequence-a2351f64c4dd3d3a
Dec 14 21:11:12.676 INFO [stdout] 
Dec 14 21:11:12.676 INFO [stdout] running 9 tests
Dec 14 21:11:12.695 INFO [stdout] test first_last ... ok
Dec 14 21:11:12.695 INFO [stdout] test increment_skips_last ... ok
Dec 14 21:11:12.695 INFO [stdout] test last ... ok
Dec 14 21:11:12.695 INFO [stdout] test first_last_increment ... ok
Dec 14 21:11:12.707 INFO [stdout] test negative_increment_skips_last ... ok
Dec 14 21:11:12.707 INFO [stdout] test zero_last ... ok
Dec 14 21:11:12.707 INFO [stdout] test decrement ... ok
Dec 14 21:11:12.707 INFO [stdout] test args_evaluated_every_cycle ... ok
Dec 14 21:11:12.767 INFO [stdout] test zero_increment ... ok
Dec 14 21:11:12.767 INFO [stderr]      Running /target/debug/deps/variables_in_expressions-79db1b17e99e8d21
Dec 14 21:11:12.767 INFO [stdout] 
Dec 14 21:11:12.767 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.767 INFO [stdout] 
Dec 14 21:11:12.771 INFO [stdout] 
Dec 14 21:11:12.771 INFO [stdout] running 6 tests
Dec 14 21:11:12.807 INFO [stderr]      Running /target/debug/deps/weighted_sample_with_replacement-a5a8deb196efd94e
Dec 14 21:11:12.807 INFO [stdout] test next ... ok
Dec 14 21:11:12.807 INFO [stdout] test copy_pattern ... ok
Dec 14 21:11:12.807 INFO [stdout] test next_done ... ok
Dec 14 21:11:12.807 INFO [stdout] test prev ... ok
Dec 14 21:11:12.807 INFO [stdout] test copy ... ok
Dec 14 21:11:12.807 INFO [stdout] test next_pattern ... ok
Dec 14 21:11:12.807 INFO [stdout] 
Dec 14 21:11:12.807 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.807 INFO [stdout] 
Dec 14 21:11:12.807 INFO [stdout] 
Dec 14 21:11:12.807 INFO [stdout] running 3 tests
Dec 14 21:11:12.811 INFO [stdout] test selects_another_subexpr_when_current_subexpr_done ... ok
Dec 14 21:11:12.811 INFO [stdout] test distribution ... ok
Dec 14 21:11:12.811 INFO [stdout] test done_when_sub_expr_done ... ok
Dec 14 21:11:12.811 INFO [stdout] 
Dec 14 21:11:12.811 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.811 INFO [stdout] 
Dec 14 21:11:12.811 INFO [stderr]      Running /target/debug/deps/weighted_sample_without_replacement-a4ad7d3a83b7f42f
Dec 14 21:11:12.811 INFO [stdout] 
Dec 14 21:11:12.811 INFO [stdout] running 1 test
Dec 14 21:11:12.815 INFO [stdout] test distribution ... ok
Dec 14 21:11:12.815 INFO [stdout] 
Dec 14 21:11:12.815 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:12.815 INFO [stdout] 
Dec 14 21:11:12.815 INFO [stderr]    Doc-tests rvs
Dec 14 21:11:14.059 INFO [stdout] 
Dec 14 21:11:14.059 INFO [stdout] running 0 tests
Dec 14 21:11:14.059 INFO [stdout] 
Dec 14 21:11:14.059 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 21:11:14.059 INFO [stdout] 
Dec 14 21:11:14.073 INFO [stderr] su: No module specific data is present
Dec 14 21:11:15.120 INFO running `"docker" "inspect" "b1da8e8411abac169c21a19381c40858fd3c2c7adbaeb37e46d8fd3d59c0ce09"`
Dec 14 21:11:15.416 INFO running `"docker" "rm" "-f" "b1da8e8411abac169c21a19381c40858fd3c2c7adbaeb37e46d8fd3d59c0ce09"`
Dec 14 21:11:15.772 INFO [stdout] b1da8e8411abac169c21a19381c40858fd3c2c7adbaeb37e46d8fd3d59c0ce09