Nov 18 02:58:04.679 INFO testing puzzle-solver-0.4.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 02:58:04.680 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 02:58:05.156 INFO [stdout] 498d796f05dd715ecd3f0d8b9c158477b9fe4aa9f74419ec68277dcb08c0ca5f
Nov 18 02:58:05.158 INFO running `"docker" "start" "-a" "498d796f05dd715ecd3f0d8b9c158477b9fe4aa9f74419ec68277dcb08c0ca5f"`
Nov 18 02:58:06.503 INFO [stderr] usermod: no changes
Nov 18 02:58:06.607 INFO [stderr]    Compiling num-rational v0.1.42
Nov 18 02:58:08.107 INFO [stderr]    Compiling puzzle-solver v0.4.1 (/source)
Nov 18 02:58:08.987 INFO [stderr] warning: variable does not need to be mutable
Nov 18 02:58:08.987 INFO [stderr]    --> src/puzzle.rs:898:21
Nov 18 02:58:08.987 INFO [stderr]     |
Nov 18 02:58:08.987 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Nov 18 02:58:08.987 INFO [stderr]     |                     ----^
Nov 18 02:58:08.987 INFO [stderr]     |                     |
Nov 18 02:58:08.987 INFO [stderr]     |                     help: remove this `mut`
Nov 18 02:58:08.987 INFO [stderr]     |
Nov 18 02:58:08.987 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Nov 18 02:58:08.987 INFO [stderr] 
Nov 18 02:58:08.987 INFO [stderr] warning: variable does not need to be mutable
Nov 18 02:58:08.987 INFO [stderr]    --> src/puzzle.rs:898:14
Nov 18 02:58:08.987 INFO [stderr]     |
Nov 18 02:58:08.987 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Nov 18 02:58:08.987 INFO [stderr]     |              ----^
Nov 18 02:58:08.987 INFO [stderr]     |              |
Nov 18 02:58:08.987 INFO [stderr]     |              help: remove this `mut`
Nov 18 02:58:08.987 INFO [stderr] 
Nov 18 02:58:10.265 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.73s
Nov 18 02:58:10.266 INFO [stderr] su: No module specific data is present
Nov 18 02:58:10.504 INFO running `"docker" "inspect" "498d796f05dd715ecd3f0d8b9c158477b9fe4aa9f74419ec68277dcb08c0ca5f"`
Nov 18 02:58:10.564 INFO running `"docker" "rm" "-f" "498d796f05dd715ecd3f0d8b9c158477b9fe4aa9f74419ec68277dcb08c0ca5f"`
Nov 18 02:58:10.707 INFO [stdout] 498d796f05dd715ecd3f0d8b9c158477b9fe4aa9f74419ec68277dcb08c0ca5f
Nov 18 02:58:10.714 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 02:58:11.125 INFO [stdout] 97536a379a41fa99fd6ae9b6aab7aa4152e778c1900b9cb8810aa053130fdadf
Nov 18 02:58:11.129 INFO running `"docker" "start" "-a" "97536a379a41fa99fd6ae9b6aab7aa4152e778c1900b9cb8810aa053130fdadf"`
Nov 18 02:58:12.179 INFO [stderr] usermod: no changes
Nov 18 02:58:12.251 INFO [stderr]    Compiling puzzle-solver v0.4.1 (/source)
Nov 18 02:58:14.747 INFO [stderr] warning: variable does not need to be mutable
Nov 18 02:58:14.747 INFO [stderr]    --> src/puzzle.rs:898:21
Nov 18 02:58:14.747 INFO [stderr]     |
Nov 18 02:58:14.747 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Nov 18 02:58:14.747 INFO [stderr]     |                     ----^
Nov 18 02:58:14.747 INFO [stderr]     |                     |
Nov 18 02:58:14.747 INFO [stderr]     |                     help: remove this `mut`
Nov 18 02:58:14.747 INFO [stderr]     |
Nov 18 02:58:14.747 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Nov 18 02:58:14.747 INFO [stderr] 
Nov 18 02:58:14.747 INFO [stderr] warning: variable does not need to be mutable
Nov 18 02:58:14.747 INFO [stderr]    --> src/puzzle.rs:898:14
Nov 18 02:58:14.748 INFO [stderr]     |
Nov 18 02:58:14.748 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Nov 18 02:58:14.748 INFO [stderr]     |              ----^
Nov 18 02:58:14.748 INFO [stderr]     |              |
Nov 18 02:58:14.748 INFO [stderr]     |              help: remove this `mut`
Nov 18 02:58:14.748 INFO [stderr] 
Nov 18 02:58:23.275 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.06s
Nov 18 02:58:23.279 INFO [stderr] su: No module specific data is present
Nov 18 02:58:23.568 INFO running `"docker" "inspect" "97536a379a41fa99fd6ae9b6aab7aa4152e778c1900b9cb8810aa053130fdadf"`
Nov 18 02:58:23.709 INFO running `"docker" "rm" "-f" "97536a379a41fa99fd6ae9b6aab7aa4152e778c1900b9cb8810aa053130fdadf"`
Nov 18 02:58:23.807 INFO [stdout] 97536a379a41fa99fd6ae9b6aab7aa4152e778c1900b9cb8810aa053130fdadf
Nov 18 02:58:23.813 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 02:58:24.011 INFO [stdout] b790d75e5d4adcb17839088907532d43709d994953ac3ecb95149434cbe6e7df
Nov 18 02:58:24.013 INFO running `"docker" "start" "-a" "b790d75e5d4adcb17839088907532d43709d994953ac3ecb95149434cbe6e7df"`
Nov 18 02:58:24.531 INFO [stderr] usermod: no changes
Nov 18 02:58:24.574 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Nov 18 02:58:24.586 INFO [stderr]      Running /target/debug/deps/puzzle_solver-a4d16fc3fcf597e9
Nov 18 02:58:24.588 INFO [stdout] 
Nov 18 02:58:24.588 INFO [stdout] running 13 tests
Nov 18 02:58:24.590 INFO [stdout] test constraint::alldifferent::tests::test_constrain_by_value ... ok
Nov 18 02:58:24.590 INFO [stdout] test constraint::alldifferent::tests::test_elimination ... ok
Nov 18 02:58:24.590 INFO [stdout] test constraint::alldifferent::tests::test_contradiction_by_length ... ok
Nov 18 02:58:24.590 INFO [stdout] test constraint::alldifferent::tests::test_contradiction ... ok
Nov 18 02:58:24.590 INFO [stdout] test constraint::unify::tests::test_unify_unify ... ok
Nov 18 02:58:24.590 INFO [stdout] test linexpr::tests::test_coef_zero ... ok
Nov 18 02:58:24.590 INFO [stdout] test linexpr::tests::test_ops ... ok
Nov 18 02:58:24.590 INFO [stdout] test puzzle::tests::test_no_vars ... ok
Nov 18 02:58:24.590 INFO [stdout] test constraint::equality::tests::test_assign ... ok
Nov 18 02:58:24.590 INFO [stdout] test constraint::equality::tests::test_contradiction ... ok
Nov 18 02:58:24.592 INFO [stdout] test constraint::equality::tests::test_reduce_range ... ok
Nov 18 02:58:24.592 INFO [stdout] test constraint::unify::tests::test_unify_alldifferent ... ok
Nov 18 02:58:24.592 INFO [stdout] test constraint::unify::tests::test_unify_equality ... ok
Nov 18 02:58:24.592 INFO [stdout] 
Nov 18 02:58:24.592 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:24.592 INFO [stdout] 
Nov 18 02:58:24.593 INFO [stderr]      Running /target/debug/deps/hidato-59e1664042fdb808
Nov 18 02:58:24.595 INFO [stdout] 
Nov 18 02:58:24.595 INFO [stdout] running 1 test
Nov 18 02:58:24.617 INFO [stdout] test hidato_wikipedia ... ok
Nov 18 02:58:24.617 INFO [stdout] 
Nov 18 02:58:24.617 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:24.617 INFO [stdout] 
Nov 18 02:58:24.618 INFO [stderr]      Running /target/debug/deps/kakuro-2255093837d8d87a
Nov 18 02:58:24.620 INFO [stdout] 
Nov 18 02:58:24.620 INFO [stdout] running 1 test
Nov 18 02:58:24.637 INFO [stdout] test kakuro_wikipedia ... ok
Nov 18 02:58:24.637 INFO [stdout] 
Nov 18 02:58:24.637 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:24.637 INFO [stdout] 
Nov 18 02:58:24.637 INFO [stderr]      Running /target/debug/deps/killersudoku-ad8695d33981b6b7
Nov 18 02:58:24.639 INFO [stdout] 
Nov 18 02:58:24.639 INFO [stdout] running 1 test
Nov 18 02:58:24.715 INFO [stdout] test killersudoku_wikipedia ... ok
Nov 18 02:58:24.715 INFO [stdout] 
Nov 18 02:58:24.715 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:24.715 INFO [stdout] 
Nov 18 02:58:24.715 INFO [stderr]      Running /target/debug/deps/magicsquare-ee4887c769de3bf0
Nov 18 02:58:24.717 INFO [stdout] 
Nov 18 02:58:24.717 INFO [stdout] running 2 tests
Nov 18 02:58:24.763 INFO [stdout] test magicsquare_3x3 ... ok
Nov 18 02:58:24.763 INFO [stdout] test magicsquare_4x4 ... ok
Nov 18 02:58:24.763 INFO [stdout] 
Nov 18 02:58:24.763 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:24.763 INFO [stdout] 
Nov 18 02:58:24.776 INFO [stderr]      Running /target/debug/deps/nonogram-94166c7448223894
Nov 18 02:58:24.776 INFO [stdout] 
Nov 18 02:58:24.776 INFO [stdout] running 1 test
Nov 18 02:58:24.897 INFO [stdout] test nonogram_wikipedia ... ok
Nov 18 02:58:24.897 INFO [stdout] 
Nov 18 02:58:24.897 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:24.897 INFO [stdout] 
Nov 18 02:58:24.898 INFO [stderr]      Running /target/debug/deps/queens-8618f0a38594984f
Nov 18 02:58:24.900 INFO [stdout] 
Nov 18 02:58:24.900 INFO [stdout] running 5 tests
Nov 18 02:58:24.903 INFO [stdout] test queens_5x5 ... ok
Nov 18 02:58:24.907 INFO [stdout] test queens_4x4 ... ok
Nov 18 02:58:24.931 INFO [stdout] test queens_6x6 ... ok
Nov 18 02:58:24.939 INFO [stdout] test queens_7x7 ... ok
Nov 18 02:58:24.971 INFO [stderr]      Running /target/debug/deps/samuraisudoku-958bf1352202d402
Nov 18 02:58:24.971 INFO [stdout] test queens_8x8 ... ok
Nov 18 02:58:24.971 INFO [stdout] 
Nov 18 02:58:24.971 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:24.971 INFO [stdout] 
Nov 18 02:58:24.971 INFO [stdout] 
Nov 18 02:58:24.971 INFO [stdout] running 1 test
Nov 18 02:58:25.073 INFO [stdout] test samuraisudoku_easy ... ok
Nov 18 02:58:25.073 INFO [stdout] 
Nov 18 02:58:25.073 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:25.073 INFO [stdout] 
Nov 18 02:58:25.074 INFO [stderr]      Running /target/debug/deps/sendmoremoney-a371d4215b4eb5df
Nov 18 02:58:25.075 INFO [stdout] 
Nov 18 02:58:25.075 INFO [stdout] running 2 tests
Nov 18 02:58:25.078 INFO [stdout] test sendmoremoney_carry ... ok
Nov 18 02:58:25.080 INFO [stdout] test sendmoremoney_naive ... ok
Nov 18 02:58:25.080 INFO [stdout] 
Nov 18 02:58:25.080 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:25.080 INFO [stdout] 
Nov 18 02:58:25.080 INFO [stderr]      Running /target/debug/deps/sudoku-e99034ecf6cd80e0
Nov 18 02:58:25.082 INFO [stdout] 
Nov 18 02:58:25.082 INFO [stdout] running 2 tests
Nov 18 02:58:25.086 INFO [stdout] test sudoku_wikipedia ... ok
Nov 18 02:58:25.245 INFO [stdout] test sudoku_hardest ... ok
Nov 18 02:58:25.245 INFO [stderr]      Running /target/debug/deps/sujiko-2bb2225a699aa69b
Nov 18 02:58:25.245 INFO [stdout] 
Nov 18 02:58:25.245 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:25.245 INFO [stdout] 
Nov 18 02:58:25.245 INFO [stdout] 
Nov 18 02:58:25.245 INFO [stdout] running 1 test
Nov 18 02:58:25.256 INFO [stdout] test sujiko_simetric ... ok
Nov 18 02:58:25.256 INFO [stderr]      Running /target/debug/deps/takuzu-40d18b6570cdddb7
Nov 18 02:58:25.256 INFO [stdout] 
Nov 18 02:58:25.256 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:25.256 INFO [stdout] 
Nov 18 02:58:25.256 INFO [stdout] 
Nov 18 02:58:25.256 INFO [stdout] running 4 tests
Nov 18 02:58:25.292 INFO [stdout] test takuzu_grid1 ... ok
Nov 18 02:58:25.569 INFO [stdout] test takuzu_grid2 ... ok
Nov 18 02:58:25.607 INFO [stdout] test takuzu_grid3 ... ok
Nov 18 02:58:26.059 INFO [stdout] test takuzu_grid4 ... ok
Nov 18 02:58:26.059 INFO [stdout] 
Nov 18 02:58:26.059 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:26.059 INFO [stdout] 
Nov 18 02:58:26.061 INFO [stdout] 
Nov 18 02:58:26.061 INFO [stderr]      Running /target/debug/deps/xkcd-1ca39bd3b0906681
Nov 18 02:58:26.061 INFO [stdout] running 1 test
Nov 18 02:58:26.068 INFO [stderr]      Running /target/debug/deps/zebra-26fdb36847cd25f0
Nov 18 02:58:26.068 INFO [stdout] test xkcd_knapsack ... ok
Nov 18 02:58:26.068 INFO [stdout] 
Nov 18 02:58:26.068 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:26.068 INFO [stdout] 
Nov 18 02:58:26.072 INFO [stdout] 
Nov 18 02:58:26.072 INFO [stdout] running 1 test
Nov 18 02:58:26.076 INFO [stdout] test zebra ... ok
Nov 18 02:58:26.076 INFO [stderr]    Doc-tests puzzle-solver
Nov 18 02:58:26.076 INFO [stdout] 
Nov 18 02:58:26.076 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:26.076 INFO [stdout] 
Nov 18 02:58:27.075 INFO [stdout] 
Nov 18 02:58:27.075 INFO [stdout] running 18 tests
Nov 18 02:58:31.527 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::all_different (line 308) ... ok
Nov 18 02:58:33.093 INFO [stdout] test src/constraint/unify.rs - constraint::unify::Unify::new (line 18) ... ok
Nov 18 02:58:33.167 INFO [stdout] test src/constraint/equality.rs - constraint::equality::Equality::new (line 19) ... ok
Nov 18 02:58:33.683 INFO [stdout] test src/constraint/alldifferent.rs - constraint::alldifferent::AllDifferent::new (line 17) ... ok
Nov 18 02:58:33.832 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::insert_candidates (line 208) ... ok
Nov 18 02:58:33.847 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new (line 97) ... ok
Nov 18 02:58:34.515 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::intersect_candidates (line 272) ... ok
Nov 18 02:58:35.071 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::equals (line 324) ... ok
Nov 18 02:58:39.180 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_var (line 114) ... ok
Nov 18 02:58:39.589 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_var_with_candidates (line 130) ... ok
Nov 18 02:58:39.783 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_vars_with_candidates_2d (line 163) ... ok
Nov 18 02:58:39.871 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::set_value (line 185) ... ok
Nov 18 02:58:40.419 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_vars_with_candidates_1d (line 145) ... ok
Nov 18 02:58:40.633 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::solve_all (line 408) ... ok
Nov 18 02:58:40.633 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::solve_any (line 357) ... ok
Nov 18 02:58:40.880 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::remove_candidates (line 239) ... ok
Nov 18 02:58:41.924 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::unify (line 340) ... ok
Nov 18 02:58:41.967 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::solve_unique (line 382) ... ok
Nov 18 02:58:41.967 INFO [stdout] 
Nov 18 02:58:41.967 INFO [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:58:41.967 INFO [stdout] 
Nov 18 02:58:41.986 INFO [stderr] su: No module specific data is present
Nov 18 02:58:42.310 INFO running `"docker" "inspect" "b790d75e5d4adcb17839088907532d43709d994953ac3ecb95149434cbe6e7df"`
Nov 18 02:58:42.397 INFO running `"docker" "rm" "-f" "b790d75e5d4adcb17839088907532d43709d994953ac3ecb95149434cbe6e7df"`
Nov 18 02:58:42.489 INFO [stdout] b790d75e5d4adcb17839088907532d43709d994953ac3ecb95149434cbe6e7df