Dec 15 00:42:25.134 INFO testing puzzle-solver-0.4.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 00:42:25.134 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 00:42:25.379 INFO [stdout] 8f46e0d2421f8f197d5f134e50079b9ede4cc09bad4d4b99df3d8d227211add9
Dec 15 00:42:25.391 INFO running `"docker" "start" "-a" "8f46e0d2421f8f197d5f134e50079b9ede4cc09bad4d4b99df3d8d227211add9"`
Dec 15 00:42:25.791 INFO [stderr] usermod: no changes
Dec 15 00:42:25.836 INFO [stderr]    Compiling num-rational v0.1.42
Dec 15 00:42:27.351 INFO [stderr]    Compiling puzzle-solver v0.4.1 (/source)
Dec 15 00:42:28.220 INFO [stderr] warning: variable does not need to be mutable
Dec 15 00:42:28.220 INFO [stderr]    --> src/puzzle.rs:898:21
Dec 15 00:42:28.220 INFO [stderr]     |
Dec 15 00:42:28.220 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Dec 15 00:42:28.220 INFO [stderr]     |                     ----^
Dec 15 00:42:28.220 INFO [stderr]     |                     |
Dec 15 00:42:28.220 INFO [stderr]     |                     help: remove this `mut`
Dec 15 00:42:28.220 INFO [stderr]     |
Dec 15 00:42:28.220 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 15 00:42:28.220 INFO [stderr] 
Dec 15 00:42:28.220 INFO [stderr] warning: variable does not need to be mutable
Dec 15 00:42:28.220 INFO [stderr]    --> src/puzzle.rs:898:14
Dec 15 00:42:28.220 INFO [stderr]     |
Dec 15 00:42:28.220 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Dec 15 00:42:28.220 INFO [stderr]     |              ----^
Dec 15 00:42:28.220 INFO [stderr]     |              |
Dec 15 00:42:28.220 INFO [stderr]     |              help: remove this `mut`
Dec 15 00:42:28.220 INFO [stderr] 
Dec 15 00:42:29.628 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.82s
Dec 15 00:42:29.631 INFO [stderr] su: No module specific data is present
Dec 15 00:42:29.943 INFO running `"docker" "inspect" "8f46e0d2421f8f197d5f134e50079b9ede4cc09bad4d4b99df3d8d227211add9"`
Dec 15 00:42:30.017 INFO running `"docker" "rm" "-f" "8f46e0d2421f8f197d5f134e50079b9ede4cc09bad4d4b99df3d8d227211add9"`
Dec 15 00:42:30.139 INFO [stdout] 8f46e0d2421f8f197d5f134e50079b9ede4cc09bad4d4b99df3d8d227211add9
Dec 15 00:42:30.144 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 00:42:30.325 INFO [stdout] f80f02d601c88e108af063c281164d65a46ad60a6e079ec68600537492366d94
Dec 15 00:42:30.325 INFO running `"docker" "start" "-a" "f80f02d601c88e108af063c281164d65a46ad60a6e079ec68600537492366d94"`
Dec 15 00:42:30.731 INFO [stderr] usermod: no changes
Dec 15 00:42:30.775 INFO [stderr]    Compiling puzzle-solver v0.4.1 (/source)
Dec 15 00:42:35.523 INFO [stderr] warning: variable does not need to be mutable
Dec 15 00:42:35.523 INFO [stderr]    --> src/puzzle.rs:898:21
Dec 15 00:42:35.523 INFO [stderr]     |
Dec 15 00:42:35.526 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Dec 15 00:42:35.526 INFO [stderr]     |                     ----^
Dec 15 00:42:35.526 INFO [stderr]     |                     |
Dec 15 00:42:35.526 INFO [stderr]     |                     help: remove this `mut`
Dec 15 00:42:35.529 INFO [stderr]     |
Dec 15 00:42:35.530 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 15 00:42:35.530 INFO [stderr] 
Dec 15 00:42:35.530 INFO [stderr] warning: variable does not need to be mutable
Dec 15 00:42:35.531 INFO [stderr]    --> src/puzzle.rs:898:14
Dec 15 00:42:35.531 INFO [stderr]     |
Dec 15 00:42:35.532 INFO [stderr] 898 |         let (mut l, mut r) = slice.split_at_mut(b);
Dec 15 00:42:35.532 INFO [stderr]     |              ----^
Dec 15 00:42:35.532 INFO [stderr]     |              |
Dec 15 00:42:35.532 INFO [stderr]     |              help: remove this `mut`
Dec 15 00:42:35.533 INFO [stderr] 
Dec 15 00:42:42.505 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.76s
Dec 15 00:42:42.519 INFO [stderr] su: No module specific data is present
Dec 15 00:42:43.046 INFO running `"docker" "inspect" "f80f02d601c88e108af063c281164d65a46ad60a6e079ec68600537492366d94"`
Dec 15 00:42:43.116 INFO running `"docker" "rm" "-f" "f80f02d601c88e108af063c281164d65a46ad60a6e079ec68600537492366d94"`
Dec 15 00:42:43.237 INFO [stdout] f80f02d601c88e108af063c281164d65a46ad60a6e079ec68600537492366d94
Dec 15 00:42:43.240 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 00:42:43.478 INFO [stdout] 0cf4daa53d32e72f2360df3d29a791e060feadaa667408d10bf7b8a96349613b
Dec 15 00:42:43.481 INFO running `"docker" "start" "-a" "0cf4daa53d32e72f2360df3d29a791e060feadaa667408d10bf7b8a96349613b"`
Dec 15 00:42:43.881 INFO [stderr] usermod: no changes
Dec 15 00:42:43.933 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Dec 15 00:42:43.945 INFO [stderr]      Running /target/debug/deps/puzzle_solver-3647530db97c8bd7
Dec 15 00:42:43.947 INFO [stdout] 
Dec 15 00:42:43.947 INFO [stdout] running 13 tests
Dec 15 00:42:43.947 INFO [stdout] test constraint::alldifferent::tests::test_contradiction ... ok
Dec 15 00:42:43.947 INFO [stdout] test constraint::equality::tests::test_assign ... ok
Dec 15 00:42:43.947 INFO [stdout] test constraint::alldifferent::tests::test_elimination ... ok
Dec 15 00:42:43.947 INFO [stdout] test constraint::alldifferent::tests::test_constrain_by_value ... ok
Dec 15 00:42:43.947 INFO [stdout] test constraint::equality::tests::test_contradiction ... ok
Dec 15 00:42:43.947 INFO [stdout] test constraint::equality::tests::test_reduce_range ... ok
Dec 15 00:42:43.948 INFO [stdout] test constraint::unify::tests::test_unify_alldifferent ... ok
Dec 15 00:42:43.948 INFO [stdout] test constraint::unify::tests::test_unify_equality ... ok
Dec 15 00:42:43.948 INFO [stdout] test linexpr::tests::test_coef_zero ... ok
Dec 15 00:42:43.948 INFO [stdout] test constraint::unify::tests::test_unify_unify ... ok
Dec 15 00:42:43.948 INFO [stdout] test puzzle::tests::test_no_vars ... ok
Dec 15 00:42:43.949 INFO [stdout] test linexpr::tests::test_ops ... ok
Dec 15 00:42:43.951 INFO [stdout] test constraint::alldifferent::tests::test_contradiction_by_length ... ok
Dec 15 00:42:43.951 INFO [stdout] 
Dec 15 00:42:43.951 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:43.951 INFO [stdout] 
Dec 15 00:42:43.951 INFO [stderr]      Running /target/debug/deps/hidato-850d7947d4baafc7
Dec 15 00:42:43.956 INFO [stdout] 
Dec 15 00:42:43.956 INFO [stdout] running 1 test
Dec 15 00:42:43.977 INFO [stdout] test hidato_wikipedia ... ok
Dec 15 00:42:43.977 INFO [stdout] 
Dec 15 00:42:43.977 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:43.977 INFO [stdout] 
Dec 15 00:42:43.977 INFO [stderr]      Running /target/debug/deps/kakuro-fea223d5fa9fe9c3
Dec 15 00:42:43.979 INFO [stdout] 
Dec 15 00:42:43.979 INFO [stdout] running 1 test
Dec 15 00:42:43.992 INFO [stdout] test kakuro_wikipedia ... ok
Dec 15 00:42:43.992 INFO [stdout] 
Dec 15 00:42:43.992 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:43.992 INFO [stdout] 
Dec 15 00:42:43.993 INFO [stderr]      Running /target/debug/deps/killersudoku-2f6791770060044e
Dec 15 00:42:43.994 INFO [stdout] 
Dec 15 00:42:43.994 INFO [stdout] running 1 test
Dec 15 00:42:44.068 INFO [stdout] test killersudoku_wikipedia ... ok
Dec 15 00:42:44.068 INFO [stdout] 
Dec 15 00:42:44.068 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.068 INFO [stdout] 
Dec 15 00:42:44.068 INFO [stderr]      Running /target/debug/deps/magicsquare-5d6cd200a82bd8ff
Dec 15 00:42:44.070 INFO [stdout] 
Dec 15 00:42:44.070 INFO [stdout] running 2 tests
Dec 15 00:42:44.115 INFO [stdout] test magicsquare_3x3 ... ok
Dec 15 00:42:44.115 INFO [stdout] test magicsquare_4x4 ... ok
Dec 15 00:42:44.115 INFO [stdout] 
Dec 15 00:42:44.115 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.115 INFO [stdout] 
Dec 15 00:42:44.115 INFO [stdout] 
Dec 15 00:42:44.115 INFO [stdout] running 1 test
Dec 15 00:42:44.115 INFO [stderr]      Running /target/debug/deps/nonogram-8b5e0adf9086663f
Dec 15 00:42:44.219 INFO [stdout] test nonogram_wikipedia ... ok
Dec 15 00:42:44.219 INFO [stdout] 
Dec 15 00:42:44.219 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.219 INFO [stdout] 
Dec 15 00:42:44.219 INFO [stderr]      Running /target/debug/deps/queens-ac99cbb43d17e760
Dec 15 00:42:44.224 INFO [stdout] 
Dec 15 00:42:44.224 INFO [stdout] running 5 tests
Dec 15 00:42:44.225 INFO [stdout] test queens_4x4 ... ok
Dec 15 00:42:44.226 INFO [stdout] test queens_5x5 ... ok
Dec 15 00:42:44.244 INFO [stdout] test queens_6x6 ... ok
Dec 15 00:42:44.244 INFO [stdout] test queens_7x7 ... ok
Dec 15 00:42:44.276 INFO [stdout] test queens_8x8 ... ok
Dec 15 00:42:44.276 INFO [stdout] 
Dec 15 00:42:44.276 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.276 INFO [stdout] 
Dec 15 00:42:44.276 INFO [stderr]      Running /target/debug/deps/samuraisudoku-19eb2312a76fdf6b
Dec 15 00:42:44.280 INFO [stdout] 
Dec 15 00:42:44.280 INFO [stdout] running 1 test
Dec 15 00:42:44.378 INFO [stdout] test samuraisudoku_easy ... ok
Dec 15 00:42:44.378 INFO [stdout] 
Dec 15 00:42:44.378 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.378 INFO [stdout] 
Dec 15 00:42:44.379 INFO [stderr]      Running /target/debug/deps/sendmoremoney-44c30ccf467bd75d
Dec 15 00:42:44.380 INFO [stdout] 
Dec 15 00:42:44.380 INFO [stdout] running 2 tests
Dec 15 00:42:44.382 INFO [stdout] test sendmoremoney_carry ... ok
Dec 15 00:42:44.385 INFO [stdout] test sendmoremoney_naive ... ok
Dec 15 00:42:44.385 INFO [stdout] 
Dec 15 00:42:44.385 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.385 INFO [stdout] 
Dec 15 00:42:44.385 INFO [stderr]      Running /target/debug/deps/sudoku-a51fc33b1f09981f
Dec 15 00:42:44.387 INFO [stdout] 
Dec 15 00:42:44.387 INFO [stdout] running 2 tests
Dec 15 00:42:44.394 INFO [stdout] test sudoku_wikipedia ... ok
Dec 15 00:42:44.583 INFO [stdout] test sudoku_hardest ... ok
Dec 15 00:42:44.583 INFO [stdout] 
Dec 15 00:42:44.583 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.583 INFO [stdout] 
Dec 15 00:42:44.583 INFO [stderr]      Running /target/debug/deps/sujiko-632ca3464f30693f
Dec 15 00:42:44.585 INFO [stdout] 
Dec 15 00:42:44.585 INFO [stdout] running 1 test
Dec 15 00:42:44.588 INFO [stdout] test sujiko_simetric ... ok
Dec 15 00:42:44.588 INFO [stdout] 
Dec 15 00:42:44.588 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:44.588 INFO [stdout] 
Dec 15 00:42:44.588 INFO [stderr]      Running /target/debug/deps/takuzu-eea702516b6fabcf
Dec 15 00:42:44.590 INFO [stdout] 
Dec 15 00:42:44.590 INFO [stdout] running 4 tests
Dec 15 00:42:44.658 INFO [stdout] test takuzu_grid1 ... ok
Dec 15 00:42:44.956 INFO [stdout] test takuzu_grid3 ... ok
Dec 15 00:42:45.057 INFO [stdout] test takuzu_grid2 ... ok
Dec 15 00:42:45.538 INFO [stdout] test takuzu_grid4 ... ok
Dec 15 00:42:45.538 INFO [stdout] 
Dec 15 00:42:45.538 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:45.538 INFO [stdout] 
Dec 15 00:42:45.539 INFO [stderr]      Running /target/debug/deps/xkcd-509c0899d41f2003
Dec 15 00:42:45.540 INFO [stdout] 
Dec 15 00:42:45.540 INFO [stdout] running 1 test
Dec 15 00:42:45.546 INFO [stdout] test xkcd_knapsack ... ok
Dec 15 00:42:45.546 INFO [stdout] 
Dec 15 00:42:45.546 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:45.546 INFO [stdout] 
Dec 15 00:42:45.548 INFO [stderr]      Running /target/debug/deps/zebra-1fbe46b9e26f79b4
Dec 15 00:42:45.548 INFO [stdout] 
Dec 15 00:42:45.548 INFO [stdout] running 1 test
Dec 15 00:42:45.564 INFO [stdout] test zebra ... ok
Dec 15 00:42:45.564 INFO [stderr]    Doc-tests puzzle-solver
Dec 15 00:42:45.564 INFO [stdout] 
Dec 15 00:42:45.564 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:42:45.564 INFO [stdout] 
Dec 15 00:42:46.771 INFO [stdout] 
Dec 15 00:42:46.771 INFO [stdout] running 18 tests
Dec 15 00:42:50.991 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::intersect_candidates (line 272) ... ok
Dec 15 00:42:52.439 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new (line 97) ... ok
Dec 15 00:42:54.235 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::equals (line 324) ... ok
Dec 15 00:42:54.759 INFO [stdout] test src/constraint/unify.rs - constraint::unify::Unify::new (line 18) ... ok
Dec 15 00:42:55.039 INFO [stdout] test src/constraint/equality.rs - constraint::equality::Equality::new (line 19) ... ok
Dec 15 00:42:55.243 INFO [stdout] test src/constraint/alldifferent.rs - constraint::alldifferent::AllDifferent::new (line 17) ... ok
Dec 15 00:42:56.556 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::all_different (line 308) ... ok
Dec 15 00:42:56.924 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::insert_candidates (line 208) ... ok
Dec 15 00:43:00.326 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_var_with_candidates (line 130) ... ok
Dec 15 00:43:00.478 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_var (line 114) ... ok
Dec 15 00:43:02.275 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_vars_with_candidates_1d (line 145) ... ok
Dec 15 00:43:02.523 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::remove_candidates (line 239) ... ok
Dec 15 00:43:02.975 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::new_vars_with_candidates_2d (line 163) ... ok
Dec 15 00:43:03.019 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::set_value (line 185) ... ok
Dec 15 00:43:03.356 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::solve_all (line 408) ... ok
Dec 15 00:43:03.438 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::solve_any (line 357) ... ok
Dec 15 00:43:03.987 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::unify (line 340) ... ok
Dec 15 00:43:04.516 INFO [stdout] test src/puzzle.rs - puzzle::Puzzle::solve_unique (line 382) ... ok
Dec 15 00:43:04.516 INFO [stdout] 
Dec 15 00:43:04.516 INFO [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:43:04.516 INFO [stdout] 
Dec 15 00:43:04.534 INFO [stderr] su: No module specific data is present
Dec 15 00:43:04.841 INFO running `"docker" "inspect" "0cf4daa53d32e72f2360df3d29a791e060feadaa667408d10bf7b8a96349613b"`
Dec 15 00:43:04.951 INFO running `"docker" "rm" "-f" "0cf4daa53d32e72f2360df3d29a791e060feadaa667408d10bf7b8a96349613b"`
Dec 15 00:43:05.071 INFO [stdout] 0cf4daa53d32e72f2360df3d29a791e060feadaa667408d10bf7b8a96349613b