Dec 15 05:46:16.424 INFO testing littlewing-0.5.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 05:46:16.424 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 05:46:16.783 INFO [stdout] 228782d801814ff88ec9fc2e5721a23eb0b2bd3c0fa7528013d76b774734cb61
Dec 15 05:46:16.788 INFO running `"docker" "start" "-a" "228782d801814ff88ec9fc2e5721a23eb0b2bd3c0fa7528013d76b774734cb61"`
Dec 15 05:46:17.594 INFO [stderr] usermod: no changes
Dec 15 05:46:17.707 INFO [stderr]    Compiling littlewing v0.5.0 (/source)
Dec 15 05:46:27.628 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.03s
Dec 15 05:46:27.634 INFO [stderr] su: No module specific data is present
Dec 15 05:46:28.080 INFO running `"docker" "inspect" "228782d801814ff88ec9fc2e5721a23eb0b2bd3c0fa7528013d76b774734cb61"`
Dec 15 05:46:28.209 INFO running `"docker" "rm" "-f" "228782d801814ff88ec9fc2e5721a23eb0b2bd3c0fa7528013d76b774734cb61"`
Dec 15 05:46:28.271 INFO [stdout] 228782d801814ff88ec9fc2e5721a23eb0b2bd3c0fa7528013d76b774734cb61
Dec 15 05:46:28.273 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 05:46:28.450 INFO [stdout] 774ecd44f4ef82a8a63c7ee603aa3b6bf8f7284875ae3bbe807dce5826d49334
Dec 15 05:46:28.452 INFO running `"docker" "start" "-a" "774ecd44f4ef82a8a63c7ee603aa3b6bf8f7284875ae3bbe807dce5826d49334"`
Dec 15 05:46:29.036 INFO [stderr] usermod: no changes
Dec 15 05:46:29.111 INFO [stderr]    Compiling littlewing v0.5.0 (/source)
Dec 15 05:46:36.854 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.79s
Dec 15 05:46:36.862 INFO [stderr] su: No module specific data is present
Dec 15 05:46:37.308 INFO running `"docker" "inspect" "774ecd44f4ef82a8a63c7ee603aa3b6bf8f7284875ae3bbe807dce5826d49334"`
Dec 15 05:46:37.401 INFO running `"docker" "rm" "-f" "774ecd44f4ef82a8a63c7ee603aa3b6bf8f7284875ae3bbe807dce5826d49334"`
Dec 15 05:46:37.511 INFO [stdout] 774ecd44f4ef82a8a63c7ee603aa3b6bf8f7284875ae3bbe807dce5826d49334
Dec 15 05:46:37.515 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 05:46:37.718 INFO [stdout] f6a3d4281ee4db18eecddbfbb73b9391b2bb57fd732a31f33417a21c7e21aeb4
Dec 15 05:46:37.724 INFO running `"docker" "start" "-a" "f6a3d4281ee4db18eecddbfbb73b9391b2bb57fd732a31f33417a21c7e21aeb4"`
Dec 15 05:46:38.126 INFO [stderr] usermod: no changes
Dec 15 05:46:38.215 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 15 05:46:38.229 INFO [stderr]      Running /target/debug/deps/littlewing-2feb3a86609b280c
Dec 15 05:46:38.236 INFO [stdout] 
Dec 15 05:46:38.236 INFO [stdout] running 60 tests
Dec 15 05:46:38.239 INFO [stdout] test bitboard::tests::test_shift ... ok
Dec 15 05:46:38.243 INFO [stdout] test bitboard::tests::test_iterator ... ok
Dec 15 05:46:38.254 INFO [stdout] test dumb7fill::tests::test_dumb7fill ... ok
Dec 15 05:46:38.275 INFO [stdout] test common::tests::test_piece_masks ... ok
Dec 15 05:46:38.791 INFO [stdout] test attack::tests::test_piece_attacks ... ok
Dec 15 05:46:38.806 INFO [stdout] test eval::tests::test_open_files ... ok
Dec 15 05:46:38.809 INFO [stdout] test eval::tests::test_closed_files ... ok
Dec 15 05:46:38.810 INFO [stdout] test eval::tests::test_half_open_files ... ok
Dec 15 05:46:38.811 INFO [stdout] test piece::tests::test_piece ... ok
Dec 15 05:46:38.835 INFO [stdout] test piece_move::tests::test_move_castle_kind ... ok
Dec 15 05:46:38.839 INFO [stdout] test piece_move::tests::test_move_is_castle ... ok
Dec 15 05:46:38.883 INFO [stdout] test attack::tests::test_rook_attacks ... ok
Dec 15 05:46:38.899 INFO [stdout] test piece_move::tests::test_move_is_promotion ... ok
Dec 15 05:46:38.903 INFO [stdout] test piece_move::tests::test_move_promotion_kind ... ok
Dec 15 05:46:38.920 INFO [stdout] test attack::tests::test_bishop_attacks ... ok
Dec 15 05:46:39.215 INFO [stdout] test game::tests::test_tt_resize ... ok
Dec 15 05:46:39.231 INFO [stdout] test eval::tests::test_draw ... ok
Dec 15 05:46:39.421 INFO [stdout] test fen::tests::test_from_fen ... ok
Dec 15 05:46:39.459 INFO [stdout] test piece_move_generator::tests::test_is_legal_move ... ok
Dec 15 05:46:39.539 INFO [stdout] test piece_move_generator::tests::test_capture ... ok
Dec 15 05:46:39.609 INFO [stdout] test piece_move_generator::tests::test_make_move_update_halfmoves_count ... ok
Dec 15 05:46:39.859 INFO [stdout] test piece_move_generator::tests::test_moves_order_when_best_move_is_bad_capture ... ok
Dec 15 05:46:40.111 INFO [stdout] test piece_move_generator::tests::test_moves_order ... ok
Dec 15 05:46:40.459 INFO [stdout] test piece_move_generator::tests::test_make_move_hash ... ok
Dec 15 05:46:40.481 INFO [stdout] test piece_move_generator::tests::test_moves_order_when_best_move_is_quiet_move ... ok
Dec 15 05:46:40.482 INFO [stdout] test fen::tests::test_to_fen ... ok
Dec 15 05:46:40.580 INFO [stdout] test piece_move_generator::tests::test_moves_order_with_best_and_killer_moves ... ok
Dec 15 05:46:40.599 INFO [stdout] test piece_move_list::tests::test_moves_ordering ... ok
Dec 15 05:46:40.623 INFO [stdout] test eval::tests::test_see ... ok
Dec 15 05:46:40.623 INFO [stdout] test piece_move_list::tests::test_next_stage ... ok
Dec 15 05:46:40.625 INFO [stdout] test piece_move_generator::tests::test_make_undo_move ... ok
Dec 15 05:46:40.626 INFO [stdout] test piece_square_table::tests::test_pst ... ok
Dec 15 05:46:40.626 INFO [stdout] test positions::tests::test_position_castling_rights ... ok
Dec 15 05:46:40.626 INFO [stdout] test positions::tests::test_size_of_position ... ok
Dec 15 05:46:40.967 INFO [stdout] test piece_move_generator::tests::test_next_move ... ok
Dec 15 05:46:41.035 INFO [stdout] test piece_move_notation::tests::test_move_from_can ... ok
Dec 15 05:46:41.047 INFO [stdout] test piece_move_generator::tests::test_mvv_lva ... ok
Dec 15 05:46:41.111 INFO [stdout] test piece_move_generator::tests::test_next_capture ... ok
Dec 15 05:46:41.199 INFO [stdout] test piece_move_notation::tests::test_move_to_san ... ok
Dec 15 05:46:41.216 INFO [stdout] test search::tests::test_bug_promotion ... ok
Dec 15 05:46:41.299 INFO [stdout] test search::tests::test_is_mate ... ok
Dec 15 05:46:41.307 INFO [stdout] test piece_move_generator::tests::test_generate_moves ... ok
Dec 15 05:46:41.331 INFO [stdout] test search::tests::test_fifty_move_rule ... ok
Dec 15 05:46:41.519 INFO [stdout] test search::tests::test_stalemate ... ok
Dec 15 05:46:41.615 INFO [stdout] test search::tests::test_search_node ... ok
Dec 15 05:46:41.627 INFO [stdout] test square::tests::test_flip ... ok
Dec 15 05:46:41.627 INFO [stdout] test square::tests::test_from_coord ... ok
Dec 15 05:46:41.627 INFO [stdout] test square::tests::test_to_coord ... ok
Dec 15 05:46:41.627 INFO [stdout] test transposition::tests::test_size_of_transposition ... ok
Dec 15 05:46:41.863 INFO [stdout] test search::tests::test_threefold_repetition ... ok
Dec 15 05:46:41.943 INFO [stdout] test transposition_table::tests::test_transposition_table_in_threads ... ok
Dec 15 05:46:42.033 INFO [stdout] test transposition_table::tests::test_transposition_table ... ok
Dec 15 05:46:42.039 INFO [stdout] test zobrist::tests::test_new ... ok
Dec 15 05:46:42.112 INFO [stdout] test transposition_table::tests::test_transposition_table_size ... ok
Dec 15 05:46:42.296 INFO [stdout] test search::tests::test_repetitions ... ok
Dec 15 05:46:42.367 INFO [stdout] test search::tests::test_search ... ok
Dec 15 05:46:43.979 INFO [stdout] test search::tests::test_perft ... ok
Dec 15 05:46:44.719 INFO [stdout] test piece_move_generator::tests::test_make_undo_move_hash ... ok
Dec 15 05:46:46.339 INFO [stdout] test search::tests::test_null_move_pruning ... ok
Dec 15 05:47:03.402 INFO [stdout] test protocols::cli::tests::test_undo ... ok
Dec 15 05:47:03.402 INFO [stdout] 
Dec 15 05:47:03.402 INFO [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:47:03.402 INFO [stdout] 
Dec 15 05:47:03.411 INFO [stderr]      Running /target/debug/deps/littlewing-7e4b203063f0da57
Dec 15 05:47:03.414 INFO [stdout] 
Dec 15 05:47:03.414 INFO [stdout] running 0 tests
Dec 15 05:47:03.414 INFO [stdout] 
Dec 15 05:47:03.414 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:47:03.414 INFO [stdout] 
Dec 15 05:47:03.414 INFO [stderr]      Running /target/debug/deps/wac-62f617bec8430f83
Dec 15 05:47:03.420 INFO [stdout] 
Dec 15 05:47:03.420 INFO [stdout] running 1 test
Dec 15 05:47:12.243 INFO [stdout] test test_wac ... ok
Dec 15 05:47:12.243 INFO [stdout] 
Dec 15 05:47:12.243 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:47:12.243 INFO [stdout] 
Dec 15 05:47:12.251 INFO [stderr]    Doc-tests littlewing
Dec 15 05:47:15.743 INFO [stdout] 
Dec 15 05:47:15.743 INFO [stdout] running 1 test
Dec 15 05:47:26.343 INFO [stdout] test src/lib.rs -  (line 6) ... ok
Dec 15 05:47:26.343 INFO [stdout] 
Dec 15 05:47:26.343 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:47:26.343 INFO [stdout] 
Dec 15 05:47:26.366 INFO [stderr] su: No module specific data is present
Dec 15 05:47:27.723 INFO running `"docker" "inspect" "f6a3d4281ee4db18eecddbfbb73b9391b2bb57fd732a31f33417a21c7e21aeb4"`
Dec 15 05:47:27.979 INFO running `"docker" "rm" "-f" "f6a3d4281ee4db18eecddbfbb73b9391b2bb57fd732a31f33417a21c7e21aeb4"`
Dec 15 05:47:28.218 INFO [stdout] f6a3d4281ee4db18eecddbfbb73b9391b2bb57fd732a31f33417a21c7e21aeb4