[INFO] fetching crate shakmaty 0.21.1...
[INFO] testing shakmaty-0.21.1 against 1.60.0 for beta-1.61-1
[INFO] extracting crate shakmaty 0.21.1 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate shakmaty 0.21.1 on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate shakmaty 0.21.1
[INFO] finished tweaking crates.io crate shakmaty 0.21.1
[INFO] tweaked toml for crates.io crate shakmaty 0.21.1 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded iai v0.1.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5f3cf214fc8542535156afc78b6c9f064a6b5195b0f0c3e18fa741ccef02579a
[INFO] running `Command { std: "docker" "start" "-a" "5f3cf214fc8542535156afc78b6c9f064a6b5195b0f0c3e18fa741ccef02579a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5f3cf214fc8542535156afc78b6c9f064a6b5195b0f0c3e18fa741ccef02579a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5f3cf214fc8542535156afc78b6c9f064a6b5195b0f0c3e18fa741ccef02579a", kill_on_drop: false }`
[INFO] [stdout] 5f3cf214fc8542535156afc78b6c9f064a6b5195b0f0c3e18fa741ccef02579a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ab6866cc6ee2a8aae17d8f31bf01f66af609c467c798653a885a1c5b63f74e3e
[INFO] running `Command { std: "docker" "start" "-a" "ab6866cc6ee2a8aae17d8f31bf01f66af609c467c798653a885a1c5b63f74e3e", kill_on_drop: false }`
[INFO] [stderr]    Compiling shakmaty v0.21.1 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling arrayvec v0.7.2
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling btoi v0.4.2
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.70s
[INFO] running `Command { std: "docker" "inspect" "ab6866cc6ee2a8aae17d8f31bf01f66af609c467c798653a885a1c5b63f74e3e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ab6866cc6ee2a8aae17d8f31bf01f66af609c467c798653a885a1c5b63f74e3e", kill_on_drop: false }`
[INFO] [stdout] ab6866cc6ee2a8aae17d8f31bf01f66af609c467c798653a885a1c5b63f74e3e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e61e8634b6e90ff8a029916bb451d0287ffc475d08f0521173431be20f31c934
[INFO] running `Command { std: "docker" "start" "-a" "e61e8634b6e90ff8a029916bb451d0287ffc475d08f0521173431be20f31c934", kill_on_drop: false }`
[INFO] [stderr]    Compiling iai v0.1.1
[INFO] [stderr]    Compiling shakmaty v0.21.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.03s
[INFO] running `Command { std: "docker" "inspect" "e61e8634b6e90ff8a029916bb451d0287ffc475d08f0521173431be20f31c934", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e61e8634b6e90ff8a029916bb451d0287ffc475d08f0521173431be20f31c934", kill_on_drop: false }`
[INFO] [stdout] e61e8634b6e90ff8a029916bb451d0287ffc475d08f0521173431be20f31c934
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0d03e4f70969ca4ad6c6225761e3cdbcb6b2fa45886c16bc515062382ff69dc8
[INFO] running `Command { std: "docker" "start" "-a" "0d03e4f70969ca4ad6c6225761e3cdbcb6b2fa45886c16bc515062382ff69dc8", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/shakmaty-77bb96e23d13f238)
[INFO] [stdout] 
[INFO] [stdout] running 43 tests
[INFO] [stdout] test attacks::tests::test_rook_attacks ... ok
[INFO] [stdout] test bitboard::tests::test_binary ... ok
[INFO] [stdout] test bitboard::tests::test_first ... ok
[INFO] [stdout] test bitboard::tests::test_from_iter ... ok
[INFO] [stdout] test bitboard::tests::test_is_empty ... ok
[INFO] [stdout] test bitboard::tests::test_lower_hex ... ok
[INFO] [stdout] test bitboard::tests::test_last ... ok
[INFO] [stdout] test bitboard::tests::test_more_than_one ... ok
[INFO] [stdout] test bitboard::tests::test_octal ... ok
[INFO] [stdout] test bitboard::tests::test_rank ... ok
[INFO] [stdout] test bitboard::tests::test_upper_hex ... ok
[INFO] [stdout] test board::tests::test_piece_at ... ok
[INFO] [stdout] test board::tests::test_promoted ... ok
[INFO] [stdout] test board::tests::test_board_transformation ... ok
[INFO] [stdout] test board::tests::test_set_piece_at ... ok
[INFO] [stdout] test fen::tests::test_invalid_fen ... ok
[INFO] [stdout] test fen::tests::test_lichess_pockets ... ok
[INFO] [stdout] test fen::tests::test_legal_ep_square ... ok
[INFO] [stdout] test fen::tests::test_lichess_promoted ... ok
[INFO] [stdout] test fen::tests::test_lichess_remaining_checks ... ok
[INFO] [stdout] test fen::tests::test_pockets ... ok
[INFO] [stdout] test fen::tests::test_remaining_checks ... ok
[INFO] [stdout] test perft::tests::test_perft ... ok
[INFO] [stdout] test position::tests::test_aligned_checkers ... ok
[INFO] [stdout] test position::tests::test_check_with_unrelated_ep_square ... ok
[INFO] [stdout] test position::tests::test_eq ... ok
[INFO] [stdout] test position::tests::test_invalid_ep_square ... ok
[INFO] [stdout] test position::tests::test_insufficient_material ... ok
[INFO] [stdout] test position::tests::test_most_known_legals ... ok
[INFO] [stdout] test position::tests::test_pinned_san_candidate ... ok
[INFO] [stdout] test position::tests::test_promotion ... ok
[INFO] [stdout] test position::tests::test_swap_turn ... ok
[INFO] [stdout] test san::tests::test_size ... ok
[INFO] [stdout] test san::tests::test_read_write ... ok
[INFO] [stdout] test square::tests::test_square ... ok
[INFO] [stdout] test types::tests::test_role_order ... ok
[INFO] [stdout] test types::tests::test_size ... ok
[INFO] [stdout] test uci::tests::test_king_captures_ummoved_rook ... ok
[INFO] [stdout] test uci::tests::test_uci_to_en_passant ... ok
[INFO] [stdout] test zobrist::tests::test_full_pockets ... ok
[INFO] [stdout] test uci::tests::test_uci_to_castles ... ok
[INFO] [stdout] test zobrist::tests::test_polyglot ... ok
[INFO] [stdout] test zobrist::tests::test_incremental ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/horde_insufficient_material.rs (/opt/rustwide/target/debug/deps/horde_insufficient_material-9dada2153126200b)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/perft.rs (/opt/rustwide/target/debug/deps/perft-34c48002e087f452)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_tricky ... ok
[INFO] [stdout] test test_random ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 7.82s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests shakmaty
[INFO] [stdout] 
[INFO] [stdout] running 85 tests
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::CENTER (line 696) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::FULL (line 611) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::LIGHT_SQUARES (line 645) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::EMPTY (line 594) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::any (line 139) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::SOUTH (line 730) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::is_empty (line 154) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::is_superset (line 278) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::EAST (line 764) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::single_square (line 364) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::relative_shift (line 75) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::flip_horizontal (line 427) ... ok
[INFO] [stdout] test src/board.rs - board::Board (line 31) ... ok
[INFO] [stdout] test src/attacks.rs - attacks::between (line 183) ... ok
[INFO] [stdout] test src/attacks.rs - attacks (line 21) ... ok
[INFO] [stdout] test src/attacks.rs - attacks::bishop_mask (line 117) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::rotate_270 (line 573) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::WEST (line 747) ... ok
[INFO] [stdout] test src/attacks.rs - attacks::aligned (line 205) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::is_subset (line 264) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::flip_anti_diagonal (line 492) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard (line 36) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::NORTH (line 713) ... ok
[INFO] [stdout] test src/position.rs - position::Chess (line 722) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::count (line 343) ... ok
[INFO] [stdout] test src/role.rs - role::Role (line 25) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::shift (line 104) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::flip_vertical (line 403) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::CORNERS (line 662) ... ok
[INFO] [stdout] test src/movelist.rs - movelist::MoveList (line 29) ... ok
[INFO] [stdout] test src/attacks.rs - attacks::ray (line 160) ... ok
[INFO] [stdout] test src/attacks.rs - attacks::rook_mask (line 81) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::carry_rippler (line 383) ... ok
[INFO] [stdout] test src/setup.rs - setup::Setup::halfmoves (line 71) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::DARK_SQUARES (line 628) ... ok
[INFO] [stdout] test src/san.rs - san (line 33) ... ok
[INFO] [stdout] test src/setup.rs - setup::Setup::fullmoves (line 85) ... ok
[INFO] [stdout] test src/perft.rs - perft::perft (line 36) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::rotate_180 (line 549) ... ok
[INFO] [stdout] test src/lib.rs - (line 33) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::BACKRANKS (line 679) ... ok
[INFO] [stdout] test src/square.rs - square::Square::distance (line 661) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::flip_diagonal (line 458) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::remove (line 195) ... ok
[INFO] [stdout] test src/role.rs - role::Role::char (line 86) ... ok
[INFO] [stdout] test src/setup.rs - setup::Castles::path (line 294) ... ok
[INFO] [stdout] test src/role.rs - role::Role::upper_char (line 106) ... ok
[INFO] [stdout] test src/san.rs - san (line 23) ... ok
[INFO] [stdout] test src/bitboard.rs - bitboard::Bitboard::rotate_90 (line 526) ... ok
[INFO] [stdout] test src/square.rs - square::Square::flip_anti_diagonal (line 577) ... ok
[INFO] [stdout] test src/fen.rs - fen::Fen::from_ascii (line 342) ... ok
[INFO] [stdout] test src/lib.rs - (line 52) ... ok
[INFO] [stdout] test src/square.rs - square::Square::flip_horizontal (line 530) ... ok
[INFO] [stdout] test src/square.rs - square::Square::file (line 444) ... ok
[INFO] [stdout] test src/san.rs - san::San::matches (line 403) ... ok
[INFO] [stdout] test src/types.rs - types::RemainingChecks (line 355) ... ok
[INFO] [stdout] test src/role.rs - role::Role::from_char (line 48) ... ok
[INFO] [stdout] test src/square.rs - square::Square::flip_diagonal (line 560) ... ok
[INFO] [stdout] test src/role.rs - role::Role::of (line 72) ... ok
[INFO] [stdout] test src/square.rs - square::Square::from_ascii (line 415) ... ok
[INFO] [stdout] test src/position.rs - position::FromSetup::from_setup (line 309) ... ok
[INFO] [stdout] test src/lib.rs - (line 23) ... ok
[INFO] [stdout] test src/fen.rs - fen (line 35) ... ok
[INFO] [stdout] test src/fen.rs - fen (line 52) ... ok
[INFO] [stdout] test src/san.rs - san (line 53) ... ok
[INFO] [stdout] test src/square.rs - square::Square::flip_vertical (line 545) ... ok
[INFO] [stdout] test src/square.rs - square::Square::rotate_90 (line 591) ... ok
[INFO] [stdout] test src/square.rs - square::Square::rank (line 459) ... ok
[INFO] [stdout] test src/square.rs - square::Square::from_coords (line 394) ... ok
[INFO] [stdout] test src/square.rs - square::Square::new (line 367) ... ok
[INFO] [stdout] test src/square.rs - square::Square::is_light (line 634) ... ok
[INFO] [stdout] test src/square.rs - square::Square::rotate_180 (line 605) ... ok
[INFO] [stdout] test src/square.rs - square::Square::coords (line 474) ... ok
[INFO] [stdout] test src/setup.rs - setup::Setup::castling_rights (line 41) ... ok
[INFO] [stdout] test src/uci.rs - uci (line 23) ... ok
[INFO] [stdout] test src/uci.rs - uci::Uci::from_chess960 (line 243) ... ok
[INFO] [stdout] test src/square.rs - square::Square::offset (line 489) ... ok
[INFO] [stdout] test src/uci.rs - uci::Uci::from_ascii (line 157) ... ok
[INFO] [stdout] test src/square.rs - square::Square::rotate_270 (line 620) ... ok
[INFO] [stdout] test src/uci.rs - uci (line 38) ... ok
[INFO] [stdout] test src/zobrist.rs - zobrist (line 27) ... ok
[INFO] [stdout] test src/square.rs - square::Square::is_dark (line 647) ... ok
[INFO] [stdout] test src/uci.rs - uci::Uci::from_standard (line 212) ... ok
[INFO] [stdout] test src/uci.rs - uci (line 53) ... ok
[INFO] [stdout] test src/zobrist.rs - zobrist::Zobrist (line 197) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 85 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.54s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0d03e4f70969ca4ad6c6225761e3cdbcb6b2fa45886c16bc515062382ff69dc8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0d03e4f70969ca4ad6c6225761e3cdbcb6b2fa45886c16bc515062382ff69dc8", kill_on_drop: false }`
[INFO] [stdout] 0d03e4f70969ca4ad6c6225761e3cdbcb6b2fa45886c16bc515062382ff69dc8