Dec 15 19:11:49.527 INFO testing chess-2.0.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 19:11:49.527 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 15 19:11:50.016 INFO [stdout] e10170aa91f906c3f72870ce726e9bc0d3fca88cd54b1953e9304dc80dc69a96
Dec 15 19:11:50.018 INFO running `"docker" "start" "-a" "e10170aa91f906c3f72870ce726e9bc0d3fca88cd54b1953e9304dc80dc69a96"`
Dec 15 19:11:52.462 INFO [stderr] usermod: no changes
Dec 15 19:11:52.611 INFO [stderr]    Compiling libc v0.2.45
Dec 15 19:11:57.036 INFO [stderr]    Compiling rand v0.4.3
Dec 15 19:12:02.026 INFO [stderr]    Compiling chess v2.0.1 (/source)
Dec 15 19:12:03.355 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 19:12:03.355 INFO [stderr]    --> src/gen_tables/king.rs:96:5
Dec 15 19:12:03.355 INFO [stderr]     |
Dec 15 19:12:03.355 INFO [stderr] 96  | /     write!(
Dec 15 19:12:03.355 INFO [stderr] 97  | |         f,
Dec 15 19:12:03.355 INFO [stderr] 98  | |         "const CASTLE_MOVES: BitBoard = BitBoard({});\n",
Dec 15 19:12:03.355 INFO [stderr] 99  | |         gen_castle_moves().to_size(0)
Dec 15 19:12:03.355 INFO [stderr] 100 | |     );
Dec 15 19:12:03.355 INFO [stderr]     | |______^
Dec 15 19:12:03.355 INFO [stderr]     |
Dec 15 19:12:03.355 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Dec 15 19:12:03.355 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 19:12:03.355 INFO [stderr]     = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 15 19:12:03.355 INFO [stderr] 
Dec 15 19:12:04.218 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 19:12:04.218 INFO [stderr]    --> src/gen_tables/pawns.rs:115:5
Dec 15 19:12:04.219 INFO [stderr]     |
Dec 15 19:12:04.219 INFO [stderr] 115 | /     write!(
Dec 15 19:12:04.219 INFO [stderr] 116 | |         f,
Dec 15 19:12:04.219 INFO [stderr] 117 | |         "const PAWN_SOURCE_DOUBLE_MOVES: BitBoard = BitBoard({0});\n",
Dec 15 19:12:04.220 INFO [stderr] 118 | |         gen_source_double_moves().to_size(0)
Dec 15 19:12:04.220 INFO [stderr] 119 | |     );
Dec 15 19:12:04.220 INFO [stderr]     | |______^
Dec 15 19:12:04.221 INFO [stderr]     |
Dec 15 19:12:04.221 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 19:12:04.221 INFO [stderr]     = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 15 19:12:04.222 INFO [stderr] 
Dec 15 19:12:04.222 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 19:12:04.222 INFO [stderr]    --> src/gen_tables/pawns.rs:121:5
Dec 15 19:12:04.223 INFO [stderr]     |
Dec 15 19:12:04.223 INFO [stderr] 121 | /     write!(
Dec 15 19:12:04.223 INFO [stderr] 122 | |         f,
Dec 15 19:12:04.224 INFO [stderr] 123 | |         "const PAWN_DEST_DOUBLE_MOVES: BitBoard = BitBoard({0});\n",
Dec 15 19:12:04.224 INFO [stderr] 124 | |         gen_dest_double_moves().to_size(0)
Dec 15 19:12:04.224 INFO [stderr] 125 | |     );
Dec 15 19:12:04.224 INFO [stderr]     | |______^
Dec 15 19:12:04.225 INFO [stderr]     |
Dec 15 19:12:04.225 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 19:12:04.225 INFO [stderr]     = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 15 19:12:04.226 INFO [stderr] 
Dec 15 19:12:26.172 INFO [stderr]     Finished dev [optimized + debuginfo] target(s) in 33.68s
Dec 15 19:12:26.175 INFO [stderr] su: No module specific data is present
Dec 15 19:12:27.429 INFO running `"docker" "inspect" "e10170aa91f906c3f72870ce726e9bc0d3fca88cd54b1953e9304dc80dc69a96"`
Dec 15 19:12:27.741 INFO running `"docker" "rm" "-f" "e10170aa91f906c3f72870ce726e9bc0d3fca88cd54b1953e9304dc80dc69a96"`
Dec 15 19:12:28.071 INFO [stdout] e10170aa91f906c3f72870ce726e9bc0d3fca88cd54b1953e9304dc80dc69a96
Dec 15 19:12:28.075 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 15 19:12:28.549 INFO [stdout] 8335767c7658a09d3ed10eb2096b732a1e684214405f0fa6fc28136c5743c8d8
Dec 15 19:12:28.551 INFO running `"docker" "start" "-a" "8335767c7658a09d3ed10eb2096b732a1e684214405f0fa6fc28136c5743c8d8"`
Dec 15 19:12:31.447 INFO [stderr] usermod: no changes
Dec 15 19:12:31.531 INFO [stderr]    Compiling chess v2.0.1 (/source)
Dec 15 19:12:48.570 INFO [stderr]     Finished dev [optimized + debuginfo] target(s) in 17.10s
Dec 15 19:12:48.574 INFO [stderr] su: No module specific data is present
Dec 15 19:12:49.686 INFO running `"docker" "inspect" "8335767c7658a09d3ed10eb2096b732a1e684214405f0fa6fc28136c5743c8d8"`
Dec 15 19:12:49.964 INFO running `"docker" "rm" "-f" "8335767c7658a09d3ed10eb2096b732a1e684214405f0fa6fc28136c5743c8d8"`
Dec 15 19:12:50.343 INFO [stdout] 8335767c7658a09d3ed10eb2096b732a1e684214405f0fa6fc28136c5743c8d8
Dec 15 19:12:50.348 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 15 19:12:50.908 INFO [stdout] 44bd9ff73c9f7200f26cc960adc8fa25137f8c40f7b25bb4c1f784093fe76d59
Dec 15 19:12:50.910 INFO running `"docker" "start" "-a" "44bd9ff73c9f7200f26cc960adc8fa25137f8c40f7b25bb4c1f784093fe76d59"`
Dec 15 19:12:53.498 INFO [stderr] usermod: no changes
Dec 15 19:12:53.611 INFO [stderr]     Finished dev [optimized + debuginfo] target(s) in 0.08s
Dec 15 19:12:53.611 INFO [stderr]      Running /target/debug/deps/chess-5a791f8c356d5758
Dec 15 19:12:53.611 INFO [stdout] 
Dec 15 19:12:53.611 INFO [stdout] running 54 tests
Dec 15 19:12:53.919 INFO [stdout] test board::perft_10 ... ok
Dec 15 19:12:54.011 INFO [stdout] test board::perft_11 ... ok
Dec 15 19:12:54.039 INFO [stdout] test board::perft_15 ... ok
Dec 15 19:12:54.083 INFO [stdout] test board::perft_12 ... ok
Dec 15 19:12:54.108 INFO [stdout] test board::perft_16 ... ok
Dec 15 19:12:54.296 INFO [stdout] test board::perft_20 ... ok
Dec 15 19:12:54.308 INFO [stdout] test board::perft_18 ... ok
Dec 15 19:12:54.388 INFO [stdout] test board::perft_21 ... ok
Dec 15 19:12:54.435 INFO [stdout] test board::perft_19 ... ok
Dec 15 19:12:54.437 INFO [stdout] test board::perft_17 ... ok
Dec 15 19:12:54.455 INFO [stdout] test board::perft_22 ... ok
Dec 15 19:12:54.467 INFO [stdout] test board::perft_25 ... ok
Dec 15 19:12:54.499 INFO [stdout] test board::perft_2 ... ok
Dec 15 19:12:54.511 INFO [stdout] test board::perft_1 ... ok
Dec 15 19:12:54.512 INFO [stdout] test board::perft_26 ... ok
Dec 15 19:12:54.605 INFO [stdout] test board::perft_23 ... ok
Dec 15 19:12:54.631 INFO [stdout] test board::perft_13 ... ok
Dec 15 19:12:54.686 INFO [stdout] test board::perft_24 ... ok
Dec 15 19:12:54.895 INFO [stdout] test board::perft_14 ... ok
Dec 15 19:12:54.931 INFO [stdout] test board::perft_5 ... ok
Dec 15 19:12:55.019 INFO [stdout] test board::perft_6 ... ok
Dec 15 19:12:55.031 INFO [stdout] test board::perft_9 ... ok
Dec 15 19:12:55.143 INFO [stdout] test board::perft_7 ... ok
Dec 15 19:12:55.144 INFO [stdout] test board::perft_8 ... ok
Dec 15 19:12:55.263 INFO [stdout] test board::perft_3 ... ok
Dec 15 19:12:55.395 INFO [stdout] test movegen::movegen::movegen_perft_1 ... ok
Dec 15 19:12:55.439 INFO [stdout] test movegen::movegen::movegen_perft_10 ... ok
Dec 15 19:12:55.511 INFO [stdout] test board::perft_4 ... ok
Dec 15 19:12:55.601 INFO [stdout] test movegen::movegen::movegen_perft_11 ... ok
Dec 15 19:12:55.727 INFO [stdout] test movegen::movegen::movegen_perft_17 ... ok
Dec 15 19:12:55.743 INFO [stdout] test movegen::movegen::movegen_perft_15 ... ok
Dec 15 19:12:55.766 INFO [stdout] test movegen::movegen::movegen_perft_12 ... ok
Dec 15 19:12:55.819 INFO [stdout] test movegen::movegen::movegen_perft_18 ... ok
Dec 15 19:12:55.839 INFO [stdout] test movegen::movegen::movegen_perft_21 ... ok
Dec 15 19:12:55.840 INFO [stdout] test movegen::movegen::movegen_perft_19 ... ok
Dec 15 19:12:55.843 INFO [stdout] test movegen::movegen::movegen_perft_22 ... ok
Dec 15 19:12:55.880 INFO [stdout] test movegen::movegen::movegen_perft_20 ... ok
Dec 15 19:12:55.882 INFO [stdout] test movegen::movegen::movegen_perft_16 ... ok
Dec 15 19:12:55.889 INFO [stdout] test movegen::movegen::movegen_perft_25 ... ok
Dec 15 19:12:55.925 INFO [stdout] test movegen::movegen::movegen_perft_23 ... ok
Dec 15 19:12:55.971 INFO [stdout] test movegen::movegen::movegen_perft_26 ... ok
Dec 15 19:12:56.135 INFO [stdout] test movegen::movegen::movegen_perft_24 ... ok
Dec 15 19:12:56.255 INFO [stdout] test movegen::movegen::movegen_perft_2 ... ok
Dec 15 19:12:56.671 INFO [stdout] test movegen::movegen::movegen_perft_6 ... ok
Dec 15 19:12:56.767 INFO [stdout] test movegen::movegen::movegen_perft_14 ... ok
Dec 15 19:12:56.783 INFO [stdout] test movegen::movegen::movegen_perft_5 ... ok
Dec 15 19:12:56.891 INFO [stdout] test movegen::movegen::movegen_perft_3 ... ok
Dec 15 19:12:57.155 INFO [stdout] test movegen::movegen::movegen_perft_9 ... ok
Dec 15 19:12:57.175 INFO [stdout] test movegen::movegen::movegen_perft_7 ... ok
Dec 15 19:12:57.203 INFO [stdout] test movegen::movegen::movegen_perft_13 ... ok
Dec 15 19:12:57.227 INFO [stdout] test movegen::movegen::movegen_perft_4 ... ok
Dec 15 19:12:57.335 INFO [stdout] test movegen::movegen::movegen_perft_8 ... ok
Dec 15 19:13:07.355 INFO [stdout] test board::perft_kiwipete ... ok
Dec 15 19:13:11.138 INFO [stdout] test movegen::movegen::movegen_perft_kiwipete ... ok
Dec 15 19:13:11.138 INFO [stdout] 
Dec 15 19:13:11.139 INFO [stdout] test result: ok. 54 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 19:13:11.139 INFO [stdout] 
Dec 15 19:13:11.139 INFO [stderr]    Doc-tests chess
Dec 15 19:13:13.702 INFO [stdout] 
Dec 15 19:13:13.702 INFO [stdout] running 48 tests
Dec 15 19:13:23.736 INFO [stdout] test src/board.rs - board::Board::combined (line 490) ... ok
Dec 15 19:13:23.743 INFO [stdout] test src/board.rs - board::Board::enumerate_moves (line 1042) ... ok
Dec 15 19:13:23.752 INFO [stdout] test src/board.rs - board::Board::color_combined (line 509) ... ok
Dec 15 19:13:23.783 INFO [stdout] test src/board.rs - board::Board::en_passant (line 1064) ... ok
Dec 15 19:13:23.927 INFO [stdout] test src/bitboard.rs - bitboard::BitBoard (line 11) ... ok
Dec 15 19:13:24.015 INFO [stdout] test src/board.rs - board::Board::castle_rights (line 562) ... ok
Dec 15 19:13:24.016 INFO [stdout] test src/bitboard.rs - bitboard::EMPTY (line 31) ... ok
Dec 15 19:13:24.016 INFO [stdout] test src/board.rs - board::Board::clear_square (line 768) ... ok
Dec 15 19:13:34.111 INFO [stdout] test src/board.rs - board::Board::legal (line 1110) ... ok
Dec 15 19:13:34.272 INFO [stdout] test src/board.rs - board::Board::king_square (line 529) ... ok
Dec 15 19:13:34.467 INFO [stdout] test src/board.rs - board::Board::null_move (line 811) ... ok
Dec 15 19:13:34.795 INFO [stdout] test src/board.rs - board::Board::is_sane (line 838) ... ok
Dec 15 19:13:34.951 INFO [stdout] test src/board.rs - board::Board::make_move_new (line 1364) ... ok
Dec 15 19:13:34.971 INFO [stdout] test src/board.rs - board::Board::my_castle_rights (line 638) ... ok
Dec 15 19:13:34.987 INFO [stdout] test src/board.rs - board::Board::make_move (line 1384) ... ok
Dec 15 19:13:35.363 INFO [stdout] test src/board.rs - board::Board::from_fen (line 275) ... ok
Dec 15 19:13:43.324 INFO [stdout] test src/board.rs - board::Board::piece_on (line 968) ... ok
Dec 15 19:13:44.167 INFO [stdout] test src/board.rs - board::Board::pieces (line 543) ... ok
Dec 15 19:13:44.419 INFO [stdout] test src/board.rs - board::Board::remove_their_castle_rights (line 696) ... ok
Dec 15 19:13:44.803 INFO [stdout] test src/board.rs - board::Board::remove_castle_rights (line 608) ... ok
Dec 15 19:13:45.483 INFO [stdout] test src/board.rs - board::Board::set_piece (line 722) ... ok
Dec 15 19:13:45.543 INFO [stdout] test src/board.rs - board::Board::side_to_move (line 626) ... ok
Dec 15 19:13:45.635 INFO [stdout] test src/board.rs - board::Board::remove_my_castle_rights (line 659) ... ok
Dec 15 19:13:46.175 INFO [stdout] test src/board.rs - board::Board::status (line 436) ... ok
Dec 15 19:13:51.860 INFO [stdout] test src/board.rs - board::Board::their_castle_rights (line 675) ... ok
Dec 15 19:13:53.755 INFO [stdout] test src/lib.rs -  (line 11) ... ok
Dec 15 19:13:54.767 INFO [stdout] test src/movegen/movegen.rs - movegen::movegen::MoveGen (line 176) ... ok
Dec 15 19:13:55.297 INFO [stdout] test src/square.rs - square::Square::backward (line 200) ... ok
Dec 15 19:13:55.935 INFO [stdout] test src/square.rs - square::ALL_SQUARES (line 400) ... ok
Dec 15 19:13:55.939 INFO [stdout] test src/square.rs - square::Square::default (line 16) ... ok
Dec 15 19:13:56.908 INFO [stdout] test src/square.rs - square::Square::down (line 118) ... ok
Dec 15 19:13:57.199 INFO [stdout] test src/square.rs - square::Square::forward (line 178) ... ok
Dec 15 19:14:01.161 INFO [stdout] test src/square.rs - square::Square::get_file (line 86) ... ok
Dec 15 19:14:02.211 INFO [stdout] test src/square.rs - square::Square::from_string (line 357) ... ok
Dec 15 19:14:03.435 INFO [stdout] test src/square.rs - square::Square::get_rank (line 73) ... ok
Dec 15 19:14:04.216 INFO [stdout] test src/square.rs - square::Square::make_square (line 52) ... ok
Dec 15 19:14:04.216 INFO [stdout] test src/square.rs - square::Square::left (line 137) ... ok
Dec 15 19:14:04.719 INFO [stdout] test src/square.rs - square::Square::new (line 33) ... ok
Dec 15 19:14:04.719 INFO [stdout] test src/square.rs - square::Square::to_index (line 343) ... ok
Dec 15 19:14:06.323 INFO [stdout] test src/square.rs - square::Square::right (line 156) ... ok
Dec 15 19:14:09.565 INFO [stdout] test src/square.rs - square::Square::ubackward (line 307) ... ok
Dec 15 19:14:10.046 INFO [stdout] test src/square.rs - square::Square::to_int (line 329) ... ok
Dec 15 19:14:10.860 INFO [stdout] test src/square.rs - square::Square::up (line 99) ... ok
Dec 15 19:14:11.332 INFO [stdout] test src/square.rs - square::Square::uforward (line 284) ... ok
Dec 15 19:14:11.431 INFO [stdout] test src/square.rs - square::Square::udown (line 237) ... ok
Dec 15 19:14:11.679 INFO [stdout] test src/square.rs - square::Square::uleft (line 252) ... ok
Dec 15 19:14:11.783 INFO [stdout] test src/square.rs - square::Square::uright (line 268) ... ok
Dec 15 19:14:12.239 INFO [stdout] test src/square.rs - square::Square::uup (line 222) ... ok
Dec 15 19:14:12.239 INFO [stdout] 
Dec 15 19:14:12.239 INFO [stdout] test result: ok. 48 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 19:14:12.239 INFO [stdout] 
Dec 15 19:14:12.337 INFO [stderr] su: No module specific data is present
Dec 15 19:14:12.857 INFO running `"docker" "inspect" "44bd9ff73c9f7200f26cc960adc8fa25137f8c40f7b25bb4c1f784093fe76d59"`
Dec 15 19:14:13.219 INFO running `"docker" "rm" "-f" "44bd9ff73c9f7200f26cc960adc8fa25137f8c40f7b25bb4c1f784093fe76d59"`
Dec 15 19:14:13.767 INFO [stdout] 44bd9ff73c9f7200f26cc960adc8fa25137f8c40f7b25bb4c1f784093fe76d59