Dec 02 05:10:33.377 INFO testing MortenLohne/rasher against 1.30.1 for beta-1.31-5
Dec 02 05:10:33.377 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 05:10:33.663 INFO [stdout] bcf8228ee2d9f4947a94ca3ea28136d6c4a3072a82dddb607fd4397d69b45d60
Dec 02 05:10:33.668 INFO running `"docker" "start" "-a" "bcf8228ee2d9f4947a94ca3ea28136d6c4a3072a82dddb607fd4397d69b45d60"`
Dec 02 05:10:34.255 INFO [stderr] usermod: no changes
Dec 02 05:10:34.371 INFO [stderr]    Compiling ordered-float v0.5.0
Dec 02 05:10:34.371 INFO [stderr]    Compiling chrono v0.3.0
Dec 02 05:10:36.947 INFO [stderr]    Compiling log4rs v0.7.0
Dec 02 05:10:39.122 INFO [stderr]    Compiling rasher v0.1.0 (/source)
Dec 02 05:10:49.284 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.00s
Dec 02 05:10:49.291 INFO [stderr] su: No module specific data is present
Dec 02 05:10:49.623 INFO running `"docker" "inspect" "bcf8228ee2d9f4947a94ca3ea28136d6c4a3072a82dddb607fd4397d69b45d60"`
Dec 02 05:10:49.922 INFO running `"docker" "rm" "-f" "bcf8228ee2d9f4947a94ca3ea28136d6c4a3072a82dddb607fd4397d69b45d60"`
Dec 02 05:10:50.204 INFO [stdout] bcf8228ee2d9f4947a94ca3ea28136d6c4a3072a82dddb607fd4397d69b45d60
Dec 02 05:10:50.211 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 05:10:50.530 INFO [stdout] 444fc144b993937d768fdff9887cfb0d714c2bba402e2bce0f2a6eff780dd7cb
Dec 02 05:10:50.537 INFO running `"docker" "start" "-a" "444fc144b993937d768fdff9887cfb0d714c2bba402e2bce0f2a6eff780dd7cb"`
Dec 02 05:10:51.075 INFO [stderr] usermod: no changes
Dec 02 05:10:51.178 INFO [stderr]    Compiling env_logger v0.4.3
Dec 02 05:10:52.795 INFO [stderr]    Compiling quickcheck v0.5.0
Dec 02 05:10:55.755 INFO [stderr]    Compiling rasher v0.1.0 (/source)
Dec 02 05:11:08.203 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.10s
Dec 02 05:11:08.209 INFO [stderr] su: No module specific data is present
Dec 02 05:11:09.143 INFO running `"docker" "inspect" "444fc144b993937d768fdff9887cfb0d714c2bba402e2bce0f2a6eff780dd7cb"`
Dec 02 05:11:09.361 INFO running `"docker" "rm" "-f" "444fc144b993937d768fdff9887cfb0d714c2bba402e2bce0f2a6eff780dd7cb"`
Dec 02 05:11:09.644 INFO [stdout] 444fc144b993937d768fdff9887cfb0d714c2bba402e2bce0f2a6eff780dd7cb
Dec 02 05:11:09.648 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 05:11:10.107 INFO [stdout] 2a4b7fe89634469b13b5de2cd9f91237a63d67a4c52d020172fa2b5a0755be9f
Dec 02 05:11:10.109 INFO running `"docker" "start" "-a" "2a4b7fe89634469b13b5de2cd9f91237a63d67a4c52d020172fa2b5a0755be9f"`
Dec 02 05:11:11.820 INFO [stderr] usermod: no changes
Dec 02 05:11:11.943 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Dec 02 05:11:11.952 INFO [stderr]      Running /target/debug/deps/rasher-a4c1bcbdb24e3417
Dec 02 05:11:11.959 INFO [stdout] 
Dec 02 05:11:11.959 INFO [stdout] running 97 tests
Dec 02 05:11:11.973 INFO [stdout] test tests::bitboard_tests::antidiagonals_preserve_pieces ... ok
Dec 02 05:11:11.973 INFO [stdout] test tests::bitboard_tests::first_piece ... ok
Dec 02 05:11:11.973 INFO [stdout] test tests::bitboard_tests::file ... ok
Dec 02 05:11:11.973 INFO [stdout] test tests::bitboard_tests::diagonal_neighbours ... ok
Dec 02 05:11:11.973 INFO [stdout] test tests::bitboard_tests::from_to_iterator ... ok
Dec 02 05:11:11.979 INFO [stdout] test tests::bitboard_tests::iterator ... ok
Dec 02 05:11:11.979 INFO [stdout] test tests::bitboard_tests::diagonals_preserve_pieces ... ok
Dec 02 05:11:11.979 INFO [stdout] test tests::bitboard_tests::pawn_attacks_both_ways ... ok
Dec 02 05:11:11.979 INFO [stdout] test tests::bitboard_tests::iterator_iterates_all ... ok
Dec 02 05:11:11.979 INFO [stdout] test tests::bitboard_tests::long_diagonal ... ok
Dec 02 05:11:11.979 INFO [stdout] test tests::bitboard_tests::rank ... ok
Dec 02 05:11:11.979 INFO [stdout] test tests::bitboard_tests::rotation_315_preserves_pieces ... ok
Dec 02 05:11:11.983 INFO [stdout] test tests::bitboard_tests::square_squares ... ok
Dec 02 05:11:11.983 INFO [stdout] test tests::bitboard_tests::long_antidiagonal ... ok
Dec 02 05:11:11.983 INFO [stdout] test tests::bitboard_tests::rotate_45 ... ok
Dec 02 05:11:12.019 INFO [stdout] test tests::bitboard_tests::rotate ... ok
Dec 02 05:11:12.019 INFO [stdout] test tests::bitboard_tests::rotation_45_preserves_pieces ... ok
Dec 02 05:11:12.019 INFO [stdout] test tests::board_tests::from_alg_test ... ok
Dec 02 05:11:12.019 INFO [stdout] test tests::bitboard_tests::rotate_45_back ... ok
Dec 02 05:11:12.019 INFO [stdout] test tests::mcts_tests::block_pawn ... ignored
Dec 02 05:11:12.019 INFO [stdout] test tests::mcts_tests::capture_to_promote ... ignored
Dec 02 05:11:12.019 INFO [stdout] test tests::mcts_tests::knight_fork_test ... ignored
Dec 02 05:11:12.019 INFO [stdout] test tests::mcts_tests::underpromote ... ignored
Dec 02 05:11:12.019 INFO [stdout] test tests::move_gen_tests::capture_from_check ... ok
Dec 02 05:11:12.040 INFO [stdout] test tests::crazyhouse_move_gen_tests::crazyhouse_moves_test ... ok
Dec 02 05:11:12.040 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test2_long ... ignored
Dec 02 05:11:12.043 INFO [stdout] test tests::bitboard_tests::rotate_315_back ... ok
Dec 02 05:11:12.043 INFO [stdout] test tests::crazyhouse_move_gen_tests::block_check_with_crazyhouse_move_test ... ok
Dec 02 05:11:12.043 INFO [stdout] test tests::crazyhouse_move_gen_tests::available_moves_at_start ... ok
Dec 02 05:11:12.043 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test3_long ... ignored
Dec 02 05:11:12.043 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test4_long ... ignored
Dec 02 05:11:12.095 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test1 ... ok
Dec 02 05:11:12.095 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test6_long ... ignored
Dec 02 05:11:14.975 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test5 ... ok
Dec 02 05:11:16.183 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test7 ... ok
Dec 02 05:11:16.207 INFO [stdout] test tests::move_gen_tests::is_pinned_to_piece_test ... ok
Dec 02 05:11:16.251 INFO [stdout] test tests::move_gen_tests::king_in_check_test ... ok
Dec 02 05:11:16.283 INFO [stdout] test tests::move_gen_tests::respond_to_checks ... ok
Dec 02 05:11:16.435 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test6 ... ok
Dec 02 05:11:16.435 INFO [stdout] test tests::move_gen_tests::starting_position_perf_test_long ... ignored
Dec 02 05:11:16.451 INFO [stdout] test tests::move_gen_tests::test_piece_at ... ok
Dec 02 05:11:16.451 INFO [stdout] test tests::move_gen_tests::test_square ... ok
Dec 02 05:11:16.463 INFO [stdout] test tests::score_tests::score_ordering_test ... ok
Dec 02 05:11:16.529 INFO [stdout] test tests::sjadam_board_tests::hash_stays_equal ... ok
Dec 02 05:11:16.547 INFO [stdout] test tests::sjadam_board_tests::pawn_moves_can_repeat ... ok
Dec 02 05:11:16.571 INFO [stdout] test tests::sjadam_board_tests::repetitions_are_drawn ... ok
Dec 02 05:11:16.587 INFO [stdout] test tests::sjadam_board_tests::repetitions_do_not_preserve_hash ... ok
Dec 02 05:11:16.591 INFO [stdout] test tests::sjadam_move_gen_tests::bishop_moves ... ok
Dec 02 05:11:16.628 INFO [stdout] test tests::sjadam_move_gen_tests::can_take_king_while_checked ... ok
Dec 02 05:11:16.813 INFO [stdout] test tests::move_gen_tests::en_passant_test ... ok
Dec 02 05:11:18.295 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test2 ... ok
Dec 02 05:11:18.323 INFO [stdout] test tests::sjadam_move_gen_tests::correct_move_gen_start_pos ... ok
Dec 02 05:11:18.375 INFO [stdout] test tests::sjadam_move_gen_tests::jump_over_opponent ... ok
Dec 02 05:11:18.399 INFO [stdout] test tests::sjadam_move_gen_tests::no_moves_on_back_rank ... ok
Dec 02 05:11:18.431 INFO [stdout] test tests::sjadam_move_gen_tests::no_stalemate_test ... ok
Dec 02 05:11:25.011 INFO [stdout] test tests::move_gen_tests::castling_test ... ok
Dec 02 05:11:27.607 INFO [stdout] test tests::move_gen_tests::starting_position_perf_test ... ok
Dec 02 05:11:29.588 INFO [stdout] test tests::crazyhouse_move_gen_tests::starting_position_perf_test ... ok
Dec 02 05:11:37.975 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test4 ... ok
Dec 02 05:12:04.126 INFO [stdout] test tests::move_gen_tests::correct_move_gen_test3 ... ok
Dec 02 05:12:16.631 INFO [stdout] test tests::sjadam_move_gen_tests::castling_en_passant_perf_test ... test tests::sjadam_move_gen_tests::castling_en_passant_perf_test has been running for over 60 seconds
Dec 02 05:12:16.823 INFO [stdout] test tests::sjadam_move_gen_tests::castling_en_passant_perf_test_2 ... test tests::sjadam_move_gen_tests::castling_en_passant_perf_test_2 has been running for over 60 seconds
Dec 02 05:12:18.449 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_3 ... test tests::sjadam_move_gen_tests::perf_test_3 has been running for over 60 seconds
Dec 02 05:12:25.019 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_4 ... test tests::sjadam_move_gen_tests::perf_test_4 has been running for over 60 seconds
Dec 02 05:12:27.599 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_5 ... test tests::sjadam_move_gen_tests::perf_test_5 has been running for over 60 seconds
Dec 02 05:12:29.598 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_6 ... test tests::sjadam_move_gen_tests::perf_test_6 has been running for over 60 seconds
Dec 02 05:12:37.967 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_7 ... test tests::sjadam_move_gen_tests::perf_test_7 has been running for over 60 seconds
Dec 02 05:13:04.131 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_8 ... test tests::sjadam_move_gen_tests::perf_test_8 has been running for over 60 seconds
Dec 02 05:13:08.474 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_4 ... ok
Dec 02 05:13:08.483 INFO [stdout] test tests::sjadam_move_gen_tests::possible_sjadam_squares ... ok
Dec 02 05:13:08.507 INFO [stdout] test tests::sjadam_move_gen_tests::sjadam_move_to_promote_pawn ... ok
Dec 02 05:13:24.479 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_3 ... ok
Dec 02 05:13:24.479 INFO [stdout] test tests::sjadam_move_gen_tests::startpos_perf_test_long ... ignored
Dec 02 05:13:24.500 INFO [stdout] test tests::sjadam_tactics_tests::can_move_in_draw_position ... ok
Dec 02 05:13:24.706 INFO [stdout] test tests::sjadam_tactics_tests::promote_pawn_to_mate ... ok
Dec 02 05:13:30.867 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_6 ... ok
Dec 02 05:13:32.553 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate1 ... ok
Dec 02 05:13:34.339 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate10 ... ok
Dec 02 05:13:36.086 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate11 ... ok
Dec 02 05:13:40.751 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate12 ... ok
Dec 02 05:13:45.135 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate13 ... ok
Dec 02 05:13:46.184 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_7 ... ok
Dec 02 05:13:46.359 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate14 ... ok
Dec 02 05:13:49.339 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate16 ... ok
Dec 02 05:13:52.691 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate17 ... ok
Dec 02 05:13:53.755 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate15 ... ok
Dec 02 05:13:54.663 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate2 ... ok
Dec 02 05:13:57.019 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate18 ... ok
Dec 02 05:13:57.827 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_5 ... ok
Dec 02 05:13:58.495 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate6 ... ok
Dec 02 05:13:59.651 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate7 ... ok
Dec 02 05:14:00.531 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate8 ... ok
Dec 02 05:14:00.859 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate9 ... ok
Dec 02 05:14:02.191 INFO [stdout] test tests::sjadam_tactics_tests::sjadammate3 ... ok
Dec 02 05:14:08.511 INFO [stdout] test tests::sjadam_move_gen_tests::startpos_perf_test ... test tests::sjadam_move_gen_tests::startpos_perf_test has been running for over 60 seconds
Dec 02 05:14:10.555 INFO [stdout] test tests::tactics_tests::basic_tactics_test ... ok
Dec 02 05:14:22.707 INFO [stdout] test tests::sjadam_move_gen_tests::castling_en_passant_perf_test ... ok
Dec 02 05:14:22.707 INFO [stdout] test tests::tactics_tests::multipv_mates_test_long ... ignored
Dec 02 05:14:22.707 INFO [stdout] test tests::uci_tests::parse_go_test ... ok
Dec 02 05:14:24.143 INFO [stdout] test tests::sjadam_move_gen_tests::perf_test_8 ... ok
Dec 02 05:14:24.707 INFO [stdout] test tests::sjadam_tactics_tests::repetitions_score_0 ... test tests::sjadam_tactics_tests::repetitions_score_0 has been running for over 60 seconds
Dec 02 05:14:24.722 INFO [stdout] test tests::tactics_tests::multipv_mates_test ... ok
Dec 02 05:14:28.615 INFO [stdout] test tests::tactics_tests::multipv_mates_test2 ... ok
Dec 02 05:14:45.087 INFO [stdout] test tests::sjadam_move_gen_tests::castling_en_passant_perf_test_2 ... ok
Dec 02 05:14:49.881 INFO [stdout] test tests::tactics_tests::mate_in_two_test ... ok
Dec 02 05:14:54.255 INFO [stdout] test tests::sjadam_move_gen_tests::startpos_perf_test ... ok
Dec 02 05:15:14.652 INFO [stdout] test tests::sjadam_tactics_tests::repetitions_score_0 ... ok
Dec 02 05:15:14.652 INFO [stdout] 
Dec 02 05:15:14.652 INFO [stdout] test result: ok. 86 passed; 0 failed; 11 ignored; 0 measured; 0 filtered out
Dec 02 05:15:14.652 INFO [stdout] 
Dec 02 05:15:14.654 INFO [stderr] su: No module specific data is present
Dec 02 05:15:15.487 INFO running `"docker" "inspect" "2a4b7fe89634469b13b5de2cd9f91237a63d67a4c52d020172fa2b5a0755be9f"`
Dec 02 05:15:15.757 INFO running `"docker" "rm" "-f" "2a4b7fe89634469b13b5de2cd9f91237a63d67a4c52d020172fa2b5a0755be9f"`
Dec 02 05:15:16.064 INFO [stdout] 2a4b7fe89634469b13b5de2cd9f91237a63d67a4c52d020172fa2b5a0755be9f
