[INFO] cloning repository https://github.com/rust-shogi-crates/shogi_core
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/rust-shogi-crates/shogi_core" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frust-shogi-crates%2Fshogi_core", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frust-shogi-crates%2Fshogi_core'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 7b2ffcdd5b66581a7b3747a04c20df890340ab9c
[INFO] testing rust-shogi-crates/shogi_core against try#db823df02fd0c2cf67b43025ac3fef3f2d743245 for pr-150681
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frust-shogi-crates%2Fshogi_core" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/rust-shogi-crates/shogi_core
[INFO] finished tweaking git repo https://github.com/rust-shogi-crates/shogi_core
[INFO] tweaked toml for git repo https://github.com/rust-shogi-crates/shogi_core written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/rust-shogi-crates/shogi_core on toolchain db823df02fd0c2cf67b43025ac3fef3f2d743245
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/rust-shogi-crates/shogi_core already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b00c202f18b4ffb376dd42e415907e84356463966dd4ed455a6a750a44c6cc60
[INFO] running `Command { std: "docker" "start" "-a" "b00c202f18b4ffb376dd42e415907e84356463966dd4ed455a6a750a44c6cc60", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b00c202f18b4ffb376dd42e415907e84356463966dd4ed455a6a750a44c6cc60", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b00c202f18b4ffb376dd42e415907e84356463966dd4ed455a6a750a44c6cc60", kill_on_drop: false }`
[INFO] [stdout] b00c202f18b4ffb376dd42e415907e84356463966dd4ed455a6a750a44c6cc60
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ee2bb3db6da4465238b06b8fe2044aa5dbea2d489258d2d983b3e65d7b6cb1ce
[INFO] running `Command { std: "docker" "start" "-a" "ee2bb3db6da4465238b06b8fe2044aa5dbea2d489258d2d983b3e65d7b6cb1ce", kill_on_drop: false }`
[INFO] [stderr]    Compiling shogi_core v0.1.5 (/opt/rustwide/workdir/shogi_core)
[INFO] [stderr]    Compiling shogi_core_c v0.0.0-unpublished (/opt/rustwide/workdir/shogi_core_c)
[INFO] [stderr]     Finished `dev` profile [unoptimized] target(s) in 1.54s
[INFO] running `Command { std: "docker" "inspect" "ee2bb3db6da4465238b06b8fe2044aa5dbea2d489258d2d983b3e65d7b6cb1ce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ee2bb3db6da4465238b06b8fe2044aa5dbea2d489258d2d983b3e65d7b6cb1ce", kill_on_drop: false }`
[INFO] [stdout] ee2bb3db6da4465238b06b8fe2044aa5dbea2d489258d2d983b3e65d7b6cb1ce
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f332e5242600cbd477e87ece894ac65cce5f6b734eaf7db536d07c34a80aaeaf
[INFO] running `Command { std: "docker" "start" "-a" "f332e5242600cbd477e87ece894ac65cce5f6b734eaf7db536d07c34a80aaeaf", kill_on_drop: false }`
[INFO] [stderr]    Compiling shogi_core v0.1.5 (/opt/rustwide/workdir/shogi_core)
[INFO] [stderr]    Compiling shogi_core_c v0.0.0-unpublished (/opt/rustwide/workdir/shogi_core_c)
[INFO] [stderr]     Finished `test` profile [unoptimized] target(s) in 1.07s
[INFO] running `Command { std: "docker" "inspect" "f332e5242600cbd477e87ece894ac65cce5f6b734eaf7db536d07c34a80aaeaf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f332e5242600cbd477e87ece894ac65cce5f6b734eaf7db536d07c34a80aaeaf", kill_on_drop: false }`
[INFO] [stdout] f332e5242600cbd477e87ece894ac65cce5f6b734eaf7db536d07c34a80aaeaf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:845e597a41426bbf2703be69acdb67d10b6de511142d05cba7bbe119c898b2c7" "/opt/rustwide/cargo-home/bin/cargo" "+db823df02fd0c2cf67b43025ac3fef3f2d743245" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2877df89e4d0d373368ba637ccb49f55d9cd091089be21e8d7cc586c0d020c62
[INFO] running `Command { std: "docker" "start" "-a" "2877df89e4d0d373368ba637ccb49f55d9cd091089be21e8d7cc586c0d020c62", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/shogi_core-e1eb6fa8b7b0dbd3)
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test bitboard::tests::shift_down_works ... ok
[INFO] [stdout] test bitboard::tests::shift_left_works ... ok
[INFO] [stdout] test bitboard::tests::shift_right_works ... ok
[INFO] [stdout] test bitboard::tests::pop_works ... ok
[INFO] [stdout] test bitboard::tests::shift_up_works ... ok
[INFO] [stdout] test color::tests::flip_works ... ok
[INFO] [stdout] test bitboard::tests::flip_works ... ok
[INFO] [stdout] test game_resolution::tests::game_resolution_is_one_byte ... ok
[INFO] [stdout] test game_resolution::tests::option_game_resolution_default_is_compatible ... ok
[INFO] [stdout] test illegal_move_kind::tests::illegal_move_kind_is_one_byte ... ok
[INFO] [stdout] test illegal_move_kind::tests::option_illegal_move_kind_default_is_compatible ... ok
[INFO] [stdout] test color::tests::array_index_works ... ok
[INFO] [stdout] test piece_kind::tests::array_index_works ... ok
[INFO] [stdout] test piece::tests::to_usi_works ... ok
[INFO] [stdout] test piece::tests::to_parts_works ... ok
[INFO] [stdout] test position::tests::to_sfen_works ... ok
[INFO] [stdout] test square::tests::array_index_works ... ok
[INFO] [stdout] test piece_kind::tests::from_u8_works ... ok
[INFO] [stdout] test mv::tests::drop_works ... ok
[INFO] [stdout] test piece_kind::tests::to_usi_works ... ok
[INFO] [stdout] test bitboard::tests::from_file_works ... ok
[INFO] [stdout] test square::tests::flip_works ... ok
[INFO] [stdout] test common::tests::write_u8_test ... ok
[INFO] [stdout] test illegal_move_kind::tests::from_works ... ok
[INFO] [stdout] test square::tests::from_u8_works ... ok
[INFO] [stdout] test square::tests::new_relative_works ... ok
[INFO] [stdout] test illegal_move_kind::tests::repr_is_correct ... ok
[INFO] [stdout] test position::tests::startpos_works ... ok
[INFO] [stdout] test square::tests::to_usi_works ... ok
[INFO] [stdout] test tests::discriminant_elision_works ... ok
[INFO] [stdout] test square::tests::new_works ... ok
[INFO] [stdout] test mv::tests::from_into_works ... ok
[INFO] [stdout] test mv::tests::normal_works ... ok
[INFO] [stdout] test common::tests::write_u16_test ... ok
[INFO] [stdout] test bitboard::tests::contains_works ... ok
[INFO] [stdout] test square::tests::shift_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.89s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/shogi_core_c-63570edc3d43a134)
[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]    Doc-tests shogi_core
[INFO] [stdout] 
[INFO] [stdout] running 50 tests
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::empty (line 21) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::Hand::added (line 30) ... ok
[INFO] [stdout] test shogi_core/src/color.rs - color::Color::NUM (line 53) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::Hand::added (line 38) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::get_file_unchecked (line 226) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::pop (line 142) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::contains (line 103) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::&'_Bitboard::not (line 504) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::flip (line 123) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::Hand::NUM_HAND_PIECES (line 182) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::is_empty (line 88) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::not (line 486) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::Hand::removed (line 66) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::single (line 41) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::Hand::new (line 18) ... ok
[INFO] [stdout] test shogi_core/src/mv.rs - mv::Move (line 136) ... ok
[INFO] [stdout] test shogi_core/src/piece.rs - piece::Piece (line 13) ... ok
[INFO] [stdout] test shogi_core/src/mv.rs - mv::CompactMove::normal (line 216) ... ok
[INFO] [stdout] test shogi_core/src/color.rs - color::Color::flip (line 24) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::PartialPosition::last_move (line 655) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::Hand::all_hand_pieces (line 167) ... ok
[INFO] [stdout] test shogi_core/src/piece_kind.rs - piece_kind::PieceKind::NUM (line 231) ... ok
[INFO] [stdout] test shogi_core/src/mv.rs - mv::Move::to (line 49) ... ok
[INFO] [stdout] test shogi_core/src/bitboard.rs - bitboard::Bitboard::count (line 72) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::PartialPosition::last_compact_move (line 666) ... ok
[INFO] [stdout] test shogi_core/src/mv.rs - mv::CompactMove::drop (line 233) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::PartialPosition::piece_kind_bitboard (line 641) ... ok
[INFO] [stdout] test shogi_core/src/mv.rs - mv::Move::from (line 34) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::Hand::is_hand_piece (line 145) ... ok
[INFO] [stdout] test shogi_core/src/hand.rs - hand::[Hand;2] (line 205) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::PartialPosition::to_sfen_owned (line 791) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::Position::piece_bitboard (line 246) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::PartialPosition::side_to_move (line 481) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::Position::moves (line 284) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::Position::to_sfen_owned (line 330) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::Position::last_compact_move (line 273) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::file (line 69) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::Position::side_to_move (line 147) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::Position::piece_at (line 193) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::PartialPosition::piece_bitboard (line 624) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::all (line 238) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::PartialPosition::piece_at (line 545) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::from_u8 (line 143) ... ok
[INFO] [stdout] test shogi_core/src/position.rs - position::Position::last_move (line 262) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::index (line 96) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::shift (line 190) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::flip (line 129) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::new_relative (line 41) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::NUM (line 225) ... ok
[INFO] [stdout] test shogi_core/src/square.rs - square::Square::rank (line 82) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.27s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2877df89e4d0d373368ba637ccb49f55d9cd091089be21e8d7cc586c0d020c62", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2877df89e4d0d373368ba637ccb49f55d9cd091089be21e8d7cc586c0d020c62", kill_on_drop: false }`
[INFO] [stdout] 2877df89e4d0d373368ba637ccb49f55d9cd091089be21e8d7cc586c0d020c62