Nov 17 23:05:21.890 INFO testing shakmaty-0.11.2 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 23:05:21.890 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 17 23:05:22.251 INFO [stdout] f00a90ee88dc1f5dd3cdf4c538bfeaff4026c8ae97339412871fbe52879d4254
Nov 17 23:05:22.255 INFO running `"docker" "start" "-a" "f00a90ee88dc1f5dd3cdf4c538bfeaff4026c8ae97339412871fbe52879d4254"`
Nov 17 23:05:22.811 INFO [stderr] usermod: no changes
Nov 17 23:05:22.906 INFO [stderr]    Compiling shakmaty v0.11.2 (/source)
Nov 17 23:05:22.907 INFO [stderr]    Compiling arrayvec v0.4.7
Nov 17 23:05:22.907 INFO [stderr]    Compiling btoi v0.4.0
Nov 17 23:05:32.326 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.50s
Nov 17 23:05:32.333 INFO [stderr] su: No module specific data is present
Nov 17 23:05:32.652 INFO running `"docker" "inspect" "f00a90ee88dc1f5dd3cdf4c538bfeaff4026c8ae97339412871fbe52879d4254"`
Nov 17 23:05:32.795 INFO running `"docker" "rm" "-f" "f00a90ee88dc1f5dd3cdf4c538bfeaff4026c8ae97339412871fbe52879d4254"`
Nov 17 23:05:33.106 INFO [stdout] f00a90ee88dc1f5dd3cdf4c538bfeaff4026c8ae97339412871fbe52879d4254
Nov 17 23:05:33.108 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 17 23:05:33.505 INFO [stdout] 8cf928f4f05f4d46ab56f25cef8bd7ec6b5dee30d3a69e91b76b2cf0cbd44045
Nov 17 23:05:33.507 INFO running `"docker" "start" "-a" "8cf928f4f05f4d46ab56f25cef8bd7ec6b5dee30d3a69e91b76b2cf0cbd44045"`
Nov 17 23:05:34.327 INFO [stderr] usermod: no changes
Nov 17 23:05:34.565 INFO [stderr]    Compiling shakmaty v0.11.2 (/source)
Nov 17 23:05:39.823 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.46s
Nov 17 23:05:39.829 INFO [stderr] su: No module specific data is present
Nov 17 23:05:40.345 INFO running `"docker" "inspect" "8cf928f4f05f4d46ab56f25cef8bd7ec6b5dee30d3a69e91b76b2cf0cbd44045"`
Nov 17 23:05:40.472 INFO running `"docker" "rm" "-f" "8cf928f4f05f4d46ab56f25cef8bd7ec6b5dee30d3a69e91b76b2cf0cbd44045"`
Nov 17 23:05:40.679 INFO [stdout] 8cf928f4f05f4d46ab56f25cef8bd7ec6b5dee30d3a69e91b76b2cf0cbd44045
Nov 17 23:05:40.687 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 17 23:05:41.118 INFO [stdout] d447a30cfe4b4655cee417b803aac0c7183bdc993215093d282eccbf577e6753
Nov 17 23:05:41.120 INFO running `"docker" "start" "-a" "d447a30cfe4b4655cee417b803aac0c7183bdc993215093d282eccbf577e6753"`
Nov 17 23:05:42.687 INFO [stderr] usermod: no changes
Nov 17 23:05:42.929 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.19s
Nov 17 23:05:42.939 INFO [stderr]      Running /target/debug/deps/shakmaty-e8d7dbee7b42cf80
Nov 17 23:05:42.939 INFO [stdout] 
Nov 17 23:05:42.939 INFO [stdout] running 25 tests
Nov 17 23:05:42.946 INFO [stdout] test bitboard::tests::test_last ... ok
Nov 17 23:05:42.947 INFO [stdout] test bitboard::tests::test_is_empty ... ok
Nov 17 23:05:42.947 INFO [stdout] test bitboard::tests::test_first ... ok
Nov 17 23:05:42.947 INFO [stdout] test bitboard::tests::test_from_iter ... ok
Nov 17 23:05:42.947 INFO [stdout] test board::tests::test_promoted ... ok
Nov 17 23:05:42.947 INFO [stdout] test board::tests::test_set_piece_at ... ok
Nov 17 23:05:42.947 INFO [stdout] test fen::tests::test_invalid_fen ... ok
Nov 17 23:05:42.947 INFO [stdout] test bitboard::tests::test_rank ... ok
Nov 17 23:05:42.947 INFO [stdout] test board::tests::test_piece_at ... ok
Nov 17 23:05:42.947 INFO [stdout] test bitboard::tests::test_more_than_one ... ok
Nov 17 23:05:42.947 INFO [stdout] test fen::tests::test_non_ascii ... ok
Nov 17 23:05:42.947 INFO [stdout] test fen::tests::test_pockets ... ok
Nov 17 23:05:42.955 INFO [stdout] test fen::tests::test_remaining_checks ... ok
Nov 17 23:05:42.955 INFO [stdout] test fen::tests::test_shredder_fen ... ok
Nov 17 23:05:42.955 INFO [stdout] test perft::tests::test_perft ... ok
Nov 17 23:05:42.955 INFO [stdout] test attacks::tests::test_rook_attacks ... ok
Nov 17 23:05:42.955 INFO [stdout] test position::tests::test_insufficient_material ... ok
Nov 17 23:05:42.955 INFO [stdout] test position::tests::test_most_known_legals ... ok
Nov 17 23:05:42.955 INFO [stdout] test fen::tests::test_legal_ep_square ... ok
Nov 17 23:05:42.955 INFO [stdout] test san::tests::test_read_write ... ok
Nov 17 23:05:42.955 INFO [stdout] test position::tests::test_promotion ... ok
Nov 17 23:05:42.955 INFO [stdout] test position::tests::test_pinned_san_candidate ... ok
Nov 17 23:05:42.963 INFO [stdout] test square::tests::test_square ... ok
Nov 17 23:05:42.963 INFO [stderr]      Running /target/debug/deps/perft-fba8620c6720cf7e
Nov 17 23:05:42.963 INFO [stdout] test types::tests::test_role_order ... ok
Nov 17 23:05:42.963 INFO [stdout] test uci::tests::test_uci_to_en_passant ... ok
Nov 17 23:05:42.963 INFO [stdout] 
Nov 17 23:05:42.963 INFO [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:05:42.963 INFO [stdout] 
Nov 17 23:05:42.963 INFO [stdout] 
Nov 17 23:05:42.963 INFO [stdout] running 7 tests
Nov 17 23:05:43.115 INFO [stdout] test test_horde ... ok
Nov 17 23:05:43.859 INFO [stdout] test test_giveaway ... ok
Nov 17 23:05:45.231 INFO [stdout] test test_racingkings ... ok
Nov 17 23:05:46.751 INFO [stdout] test test_tricky ... ok
Nov 17 23:05:47.206 INFO [stdout] test test_crazyhouse ... ok
Nov 17 23:05:48.479 INFO [stdout] test test_atomic ... ok
Nov 17 23:05:56.119 INFO [stdout] test test_random ... ok
Nov 17 23:05:56.119 INFO [stderr]    Doc-tests shakmaty
Nov 17 23:05:56.119 INFO [stdout] 
Nov 17 23:05:56.119 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:05:56.119 INFO [stdout] 
Nov 17 23:05:57.483 INFO [stdout] 
Nov 17 23:05:57.483 INFO [stdout] running 40 tests
Nov 17 23:06:04.199 INFO [stdout] test src/attacks.rs - attacks::rook_mask (line 84) ... ok
Nov 17 23:06:04.499 INFO [stdout] test src/attacks.rs - attacks::between (line 190) ... ok
Nov 17 23:06:05.532 INFO [stdout] test src/attacks.rs - attacks::ray (line 164) ... ok
Nov 17 23:06:05.549 INFO [stdout] test src/attacks.rs - attacks::aligned (line 215) ... ok
Nov 17 23:06:08.445 INFO [stdout] test src/board.rs - board::Board (line 30) ... ok
Nov 17 23:06:08.550 INFO [stdout] test src/attacks.rs - attacks (line 21) ... ok
Nov 17 23:06:08.560 INFO [stdout] test src/attacks.rs - attacks::bishop_mask (line 120) ... ok
Nov 17 23:06:08.963 INFO [stdout] test src/bitboard.rs - bitboard::Bitboard (line 32) ... ok
Nov 17 23:06:13.427 INFO [stdout] test src/fen.rs - fen (line 36) ... ok
Nov 17 23:06:14.875 INFO [stdout] test src/fen.rs - fen (line 24) ... ok
Nov 17 23:06:16.112 INFO [stdout] test src/fen.rs - fen (line 45) ... ok
Nov 17 23:06:16.560 INFO [stdout] test src/fen.rs - fen::Fen::from_ascii (line 380) ... ok
Nov 17 23:06:18.919 INFO [stdout] test src/lib.rs -  (line 60) ... ok
Nov 17 23:06:19.281 INFO [stdout] test src/lib.rs -  (line 23) ... ok
Nov 17 23:06:19.371 INFO [stdout] test src/movelist.rs - movelist::MoveList (line 28) ... ok
Nov 17 23:06:19.663 INFO [stdout] test src/lib.rs -  (line 33) ... ok
Nov 17 23:06:25.548 INFO [stdout] test src/perft.rs - perft::perft (line 36) ... ok
Nov 17 23:06:26.643 INFO [stdout] test src/san.rs - san (line 23) ... ok
Nov 17 23:06:27.507 INFO [stdout] test src/san.rs - san (line 43) ... ok
Nov 17 23:06:29.415 INFO [stdout] test src/san.rs - san (line 71) ... ok
Nov 17 23:06:30.255 INFO [stdout] test src/san.rs - san::San::matches (line 374) ... ok
Nov 17 23:06:30.751 INFO [stdout] test src/setup.rs - setup::Castles::path (line 187) ... ok
Nov 17 23:06:30.767 INFO [stdout] test src/square.rs - square::Square::combine (line 490) ... ok
Nov 17 23:06:30.918 INFO [stdout] test src/square.rs - square::Square::distance (line 477) ... ok
Nov 17 23:06:36.573 INFO [stdout] test src/square.rs - square::Square::file (line 365) ... ok
Nov 17 23:06:37.140 INFO [stdout] test src/square.rs - square::Square::flip_diagonal (line 438) ... ok
Nov 17 23:06:37.999 INFO [stdout] test src/square.rs - square::Square::flip_horizontal (line 410) ... ok
Nov 17 23:06:39.239 INFO [stdout] test src/square.rs - square::Square::flip_vertical (line 424) ... ok
Nov 17 23:06:41.359 INFO [stdout] test src/square.rs - square::Square::is_dark (line 463) ... ok
Nov 17 23:06:42.040 INFO [stdout] test src/square.rs - square::Square::from_ascii (line 331) ... ok
Nov 17 23:06:42.252 INFO [stdout] test src/square.rs - square::Square::from_coords (line 312) ... ok
Nov 17 23:06:42.378 INFO [stdout] test src/square.rs - square::Square::from_index (line 280) ... ok
Nov 17 23:06:45.963 INFO [stdout] test src/square.rs - square::Square::is_light (line 450) ... ok
Nov 17 23:06:47.792 INFO [stdout] test src/square.rs - square::Square::new (line 264) ... ok
Nov 17 23:06:48.799 INFO [stdout] test src/square.rs - square::Square::rank (line 380) ... ok
Nov 17 23:06:48.815 INFO [stdout] test src/square.rs - square::Square::offset (line 395) ... ok
Nov 17 23:06:50.563 INFO [stdout] test src/uci.rs - uci (line 48) ... ok
Nov 17 23:06:50.867 INFO [stdout] test src/uci.rs - uci (line 23) ... ok
Nov 17 23:06:50.869 INFO [stdout] test src/uci.rs - uci (line 73) ... ok
Nov 17 23:06:50.976 INFO [stdout] test src/uci.rs - uci::Uci::from_ascii (line 174) ... ok
Nov 17 23:06:50.977 INFO [stdout] 
Nov 17 23:06:50.978 INFO [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:06:50.978 INFO [stdout] 
Nov 17 23:06:51.054 INFO [stderr] su: No module specific data is present
Nov 17 23:06:52.735 INFO running `"docker" "inspect" "d447a30cfe4b4655cee417b803aac0c7183bdc993215093d282eccbf577e6753"`
Nov 17 23:06:53.150 INFO running `"docker" "rm" "-f" "d447a30cfe4b4655cee417b803aac0c7183bdc993215093d282eccbf577e6753"`
Nov 17 23:06:53.508 INFO [stdout] d447a30cfe4b4655cee417b803aac0c7183bdc993215093d282eccbf577e6753