Nov 18 18:00:08.799 INFO testing chess-1.0.5 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 18:00:08.800 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18:00:09.280 INFO [stdout] 8a219b5488900ccf05b6695c074a266019516a4ee35ee8597537504bd39378bd
Nov 18 18:00:09.282 INFO running `"docker" "start" "-a" "8a219b5488900ccf05b6695c074a266019516a4ee35ee8597537504bd39378bd"`
Nov 18 18:00:10.887 INFO [stderr] usermod: no changes
Nov 18 18:00:10.995 INFO [stderr]    Compiling chess v1.0.5 (/source)
Nov 18 18:00:38.226 INFO [stderr]     Finished dev [optimized + debuginfo] target(s) in 27.30s
Nov 18 18:00:38.230 INFO [stderr] su: No module specific data is present
Nov 18 18:00:39.410 INFO running `"docker" "inspect" "8a219b5488900ccf05b6695c074a266019516a4ee35ee8597537504bd39378bd"`
Nov 18 18:00:39.836 INFO running `"docker" "rm" "-f" "8a219b5488900ccf05b6695c074a266019516a4ee35ee8597537504bd39378bd"`
Nov 18 18:00:40.199 INFO [stdout] 8a219b5488900ccf05b6695c074a266019516a4ee35ee8597537504bd39378bd
Nov 18 18:00:40.205 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18:00:40.668 INFO [stdout] 4543271fa6841cf651eb7e9e4b04751c892732b24ef2b9af09bc6647be88c8e8
Nov 18 18:00:40.670 INFO running `"docker" "start" "-a" "4543271fa6841cf651eb7e9e4b04751c892732b24ef2b9af09bc6647be88c8e8"`
Nov 18 18:00:42.239 INFO [stderr] usermod: no changes
Nov 18 18:00:42.330 INFO [stderr]    Compiling chess v1.0.5 (/source)
Nov 18 18:01:02.095 INFO [stderr]     Finished dev [optimized + debuginfo] target(s) in 19.82s
Nov 18 18:01:02.095 INFO [stderr] su: No module specific data is present
Nov 18 18:01:03.129 INFO running `"docker" "inspect" "4543271fa6841cf651eb7e9e4b04751c892732b24ef2b9af09bc6647be88c8e8"`
Nov 18 18:01:03.375 INFO running `"docker" "rm" "-f" "4543271fa6841cf651eb7e9e4b04751c892732b24ef2b9af09bc6647be88c8e8"`
Nov 18 18:01:03.602 INFO [stdout] 4543271fa6841cf651eb7e9e4b04751c892732b24ef2b9af09bc6647be88c8e8
Nov 18 18:01:03.606 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18:01:03.912 INFO [stdout] dc01e465157b2cba0fef0c9f1a392a43b64a7e99ee47738f07d57e296ad48d3d
Nov 18 18:01:03.917 INFO running `"docker" "start" "-a" "dc01e465157b2cba0fef0c9f1a392a43b64a7e99ee47738f07d57e296ad48d3d"`
Nov 18 18:01:05.297 INFO [stderr] usermod: no changes
Nov 18 18:01:05.391 INFO [stderr]     Finished dev [optimized + debuginfo] target(s) in 0.06s
Nov 18 18:01:05.391 INFO [stderr]      Running /target/debug/deps/chess-b05791d9f80b1182
Nov 18 18:01:05.393 INFO [stdout] 
Nov 18 18:01:05.393 INFO [stdout] running 54 tests
Nov 18 18:01:05.715 INFO [stdout] test board::perft_15 ... ok
Nov 18 18:01:05.843 INFO [stdout] test board::perft_16 ... ok
Nov 18 18:01:05.843 INFO [stdout] test board::perft_17 ... ok
Nov 18 18:01:05.882 INFO [stdout] test board::perft_10 ... ok
Nov 18 18:01:05.955 INFO [stdout] test board::perft_19 ... ok
Nov 18 18:01:05.955 INFO [stdout] test board::perft_1 ... ok
Nov 18 18:01:06.015 INFO [stdout] test board::perft_21 ... ok
Nov 18 18:01:06.042 INFO [stdout] test board::perft_20 ... ok
Nov 18 18:01:06.054 INFO [stdout] test board::perft_22 ... ok
Nov 18 18:01:06.075 INFO [stdout] test board::perft_18 ... ok
Nov 18 18:01:06.099 INFO [stdout] test board::perft_12 ... ok
Nov 18 18:01:06.130 INFO [stdout] test board::perft_11 ... ok
Nov 18 18:01:06.139 INFO [stdout] test board::perft_25 ... ok
Nov 18 18:01:06.151 INFO [stdout] test board::perft_2 ... ok
Nov 18 18:01:06.251 INFO [stdout] test board::perft_26 ... ok
Nov 18 18:01:06.315 INFO [stdout] test board::perft_23 ... ok
Nov 18 18:01:06.359 INFO [stdout] test board::perft_24 ... ok
Nov 18 18:01:06.407 INFO [stdout] test board::perft_7 ... ok
Nov 18 18:01:06.419 INFO [stdout] test board::perft_13 ... ok
Nov 18 18:01:06.510 INFO [stdout] test board::perft_14 ... ok
Nov 18 18:01:06.610 INFO [stdout] test board::perft_5 ... ok
Nov 18 18:01:06.704 INFO [stdout] test board::perft_9 ... ok
Nov 18 18:01:06.715 INFO [stdout] test board::perft_6 ... ok
Nov 18 18:01:06.831 INFO [stdout] test movegen::movegen_perft_10 ... ok
Nov 18 18:01:06.866 INFO [stdout] test board::perft_8 ... ok
Nov 18 18:01:06.904 INFO [stdout] test movegen::movegen_perft_1 ... ok
Nov 18 18:01:06.911 INFO [stdout] test board::perft_3 ... ok
Nov 18 18:01:07.039 INFO [stdout] test board::perft_4 ... ok
Nov 18 18:01:07.103 INFO [stdout] test movegen::movegen_perft_12 ... ok
Nov 18 18:01:07.130 INFO [stdout] test movegen::movegen_perft_11 ... ok
Nov 18 18:01:07.167 INFO [stdout] test movegen::movegen_perft_17 ... ok
Nov 18 18:01:07.195 INFO [stdout] test movegen::movegen_perft_19 ... ok
Nov 18 18:01:07.254 INFO [stdout] test movegen::movegen_perft_20 ... ok
Nov 18 18:01:07.272 INFO [stdout] test movegen::movegen_perft_21 ... ok
Nov 18 18:01:07.273 INFO [stdout] test movegen::movegen_perft_22 ... ok
Nov 18 18:01:07.320 INFO [stdout] test movegen::movegen_perft_15 ... ok
Nov 18 18:01:07.322 INFO [stdout] test movegen::movegen_perft_16 ... ok
Nov 18 18:01:07.363 INFO [stdout] test movegen::movegen_perft_25 ... ok
Nov 18 18:01:07.379 INFO [stdout] test movegen::movegen_perft_26 ... ok
Nov 18 18:01:07.465 INFO [stdout] test movegen::movegen_perft_13 ... ok
Nov 18 18:01:07.475 INFO [stdout] test movegen::movegen_perft_18 ... ok
Nov 18 18:01:07.591 INFO [stdout] test movegen::movegen_perft_23 ... ok
Nov 18 18:01:07.803 INFO [stdout] test movegen::movegen_perft_2 ... ok
Nov 18 18:01:07.879 INFO [stdout] test movegen::movegen_perft_24 ... ok
Nov 18 18:01:07.927 INFO [stdout] test movegen::movegen_perft_5 ... ok
Nov 18 18:01:08.135 INFO [stdout] test movegen::movegen_perft_14 ... ok
Nov 18 18:01:08.323 INFO [stdout] test movegen::movegen_perft_6 ... ok
Nov 18 18:01:08.391 INFO [stdout] test movegen::movegen_perft_9 ... ok
Nov 18 18:01:08.391 INFO [stdout] test movegen::movegen_perft_8 ... ok
Nov 18 18:01:08.490 INFO [stdout] test movegen::movegen_perft_7 ... ok
Nov 18 18:01:08.895 INFO [stdout] test movegen::movegen_perft_3 ... ok
Nov 18 18:01:08.943 INFO [stdout] test movegen::movegen_perft_4 ... ok
Nov 18 18:01:18.147 INFO [stdout] test board::perft_kiwipete ... ok
Nov 18 18:01:24.315 INFO [stderr]    Doc-tests chess
Nov 18 18:01:24.315 INFO [stdout] test movegen::movegen_perft_kiwipete ... ok
Nov 18 18:01:24.315 INFO [stdout] 
Nov 18 18:01:24.315 INFO [stdout] test result: ok. 54 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 18:01:24.315 INFO [stdout] 
Nov 18 18:01:26.683 INFO [stdout] 
Nov 18 18:01:26.684 INFO [stdout] running 47 tests
Nov 18 18:01:30.275 INFO [stdout] test src/board.rs - board::Board::castle_rights (line 596) ... ok
Nov 18 18:01:32.244 INFO [stdout] test src/board.rs - board::Board::color_combined (line 539) ... ok
Nov 18 18:01:32.311 INFO [stdout] test src/board.rs - board::Board::enumerate_moves (line 1067) ... ok
Nov 18 18:01:32.567 INFO [stdout] test src/bitboard.rs - bitboard::EMPTY (line 31) ... ok
Nov 18 18:01:33.059 INFO [stdout] test src/board.rs - board::Board::en_passant (line 1096) ... ok
Nov 18 18:01:33.059 INFO [stdout] test src/board.rs - board::Board::clear_square (line 813) ... ok
Nov 18 18:01:33.495 INFO [stdout] test src/bitboard.rs - bitboard::BitBoard (line 11) ... ok
Nov 18 18:01:33.551 INFO [stdout] test src/board.rs - board::Board::combined (line 520) ... ok
Nov 18 18:01:37.099 INFO [stdout] test src/board.rs - board::Board::from_fen (line 346) ... ok
Nov 18 18:01:37.643 INFO [stdout] test src/board.rs - board::Board::king_square (line 561) ... ok
Nov 18 18:01:37.783 INFO [stdout] test src/board.rs - board::Board::is_sane (line 886) ... ok
Nov 18 18:01:38.120 INFO [stdout] test src/board.rs - board::Board::piece_on (line 996) ... ok
Nov 18 18:01:38.474 INFO [stdout] test src/board.rs - board::Board::make_move (line 1366) ... ok
Nov 18 18:01:38.607 INFO [stdout] test src/board.rs - board::Board::null_move (line 857) ... ok
Nov 18 18:01:38.931 INFO [stdout] test src/board.rs - board::Board::my_castle_rights (line 676) ... ok
Nov 18 18:01:39.043 INFO [stdout] test src/board.rs - board::Board::legal (line 1142) ... ok
Nov 18 18:01:41.627 INFO [stdout] test src/board.rs - board::Board::remove_their_castle_rights (line 734) ... ok
Nov 18 18:01:43.380 INFO [stdout] test src/board.rs - board::Board::pieces (line 575) ... ok
Nov 18 18:01:44.011 INFO [stdout] test src/board.rs - board::Board::side_to_move (line 664) ... ok
Nov 18 18:01:44.011 INFO [stdout] test src/board.rs - board::Board::remove_castle_rights (line 645) ... ok
Nov 18 18:01:44.627 INFO [stdout] test src/board.rs - board::Board::remove_my_castle_rights (line 697) ... ok
Nov 18 18:01:44.987 INFO [stdout] test src/board.rs - board::Board::set_piece (line 767) ... ok
Nov 18 18:01:45.227 INFO [stdout] test src/board.rs - board::Board::status (line 465) ... ok
Nov 18 18:01:45.786 INFO [stdout] test src/board.rs - board::Board::their_castle_rights (line 713) ... ok
Nov 18 18:01:48.284 INFO [stdout] test src/lib.rs -  (line 11) ... ok
Nov 18 18:01:49.523 INFO [stdout] test src/square.rs - square::Square::backward (line 199) ... ok
Nov 18 18:01:50.903 INFO [stdout] test src/square.rs - square::ALL_SQUARES (line 390) ... ok
Nov 18 18:01:50.903 INFO [stdout] test src/movegen.rs - movegen::MoveGen (line 244) ... ok
Nov 18 18:01:51.039 INFO [stdout] test src/square.rs - square::Square::from_string (line 357) ... ok
Nov 18 18:01:51.489 INFO [stdout] test src/square.rs - square::Square::default (line 16) ... ok
Nov 18 18:01:51.742 INFO [stdout] test src/square.rs - square::Square::down (line 120) ... ok
Nov 18 18:01:52.139 INFO [stdout] test src/square.rs - square::Square::forward (line 177) ... ok
Nov 18 18:01:53.999 INFO [stdout] test src/square.rs - square::Square::get_file (line 88) ... ok
Nov 18 18:01:55.824 INFO [stdout] test src/square.rs - square::Square::get_rank (line 75) ... ok
Nov 18 18:01:56.974 INFO [stdout] test src/square.rs - square::Square::new (line 35) ... ok
Nov 18 18:01:57.307 INFO [stdout] test src/square.rs - square::Square::make_square (line 54) ... ok
Nov 18 18:01:57.799 INFO [stdout] test src/square.rs - square::Square::right (line 158) ... ok
Nov 18 18:01:57.799 INFO [stdout] test src/square.rs - square::Square::left (line 139) ... ok
Nov 18 18:01:57.952 INFO [stdout] test src/square.rs - square::Square::to_int (line 329) ... ok
Nov 18 18:01:57.955 INFO [stdout] test src/square.rs - square::Square::to_index (line 343) ... ok
Nov 18 18:02:00.244 INFO [stdout] test src/square.rs - square::Square::ubackward (line 307) ... ok
Nov 18 18:02:00.691 INFO [stdout] test src/square.rs - square::Square::udown (line 237) ... ok
Nov 18 18:02:01.643 INFO [stdout] test src/square.rs - square::Square::uright (line 268) ... ok
Nov 18 18:02:01.915 INFO [stdout] test src/square.rs - square::Square::uup (line 222) ... ok
Nov 18 18:02:02.079 INFO [stdout] test src/square.rs - square::Square::uleft (line 252) ... ok
Nov 18 18:02:02.119 INFO [stdout] test src/square.rs - square::Square::uforward (line 284) ... ok
Nov 18 18:02:02.271 INFO [stdout] test src/square.rs - square::Square::up (line 101) ... ok
Nov 18 18:02:02.271 INFO [stdout] 
Nov 18 18:02:02.271 INFO [stdout] test result: ok. 47 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 18:02:02.271 INFO [stdout] 
Nov 18 18:02:02.376 INFO [stderr] su: No module specific data is present
Nov 18 18:02:03.531 INFO running `"docker" "inspect" "dc01e465157b2cba0fef0c9f1a392a43b64a7e99ee47738f07d57e296ad48d3d"`
Nov 18 18:02:03.918 INFO running `"docker" "rm" "-f" "dc01e465157b2cba0fef0c9f1a392a43b64a7e99ee47738f07d57e296ad48d3d"`
Nov 18 18:02:04.198 INFO [stdout] dc01e465157b2cba0fef0c9f1a392a43b64a7e99ee47738f07d57e296ad48d3d