[INFO] cloning repository https://github.com/iammadab/prune
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/iammadab/prune" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiammadab%2Fprune", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiammadab%2Fprune'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] d2844ce6ca22d915f14f252b1159462bf6f21bd0
[INFO] testing iammadab/prune against 1.100.0-beta.1 for beta-1.100-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiammadab%2Fprune" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/iammadab/prune
[INFO] finished tweaking git repo https://github.com/iammadab/prune
[INFO] tweaked toml for git repo https://github.com/iammadab/prune written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/iammadab/prune on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/iammadab/prune 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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7
[INFO] running `Command { std: "docker" "start" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling zerocopy v0.8.39
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling chess-engine v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: value assigned to `score` is never read
[INFO] [stdout]    --> src/engine/search/alphabeta.rs:90:29
[INFO] [stdout]     |
[INFO] [stdout]  90 |               let mut score = i32::MIN;
[INFO] [stdout]     |                               ^^^^^^^^ this value is reassigned later and never used
[INFO] [stdout] ...
[INFO] [stdout] 105 | /                 score = -alphabeta(
[INFO] [stdout] 106 | |                     self,
[INFO] [stdout] 107 | |                     board,
[INFO] [stdout] 108 | |                     evaluator,
[INFO] [stdout] ...   |
[INFO] [stdout] 112 | |                     &mut nodes,
[INFO] [stdout] 113 | |                 );
[INFO] [stdout]     | |_________________- `score` is overwritten here before the previous value is read
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stdout]   --> src/engine/search/alphabeta.rs:11:7
[INFO] [stdout]    |
[INFO] [stdout] 11 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stdout]    |       ^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stdout]  --> src/engine/search/minimax.rs:9:7
[INFO] [stdout]   |
[INFO] [stdout] 9 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stdout]   |       ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `MinimaxSearch`
[INFO] [stdout]  --> src/main.rs:2:53
[INFO] [stdout]   |
[INFO] [stdout] 2 | use chess_engine::engine::search::{AlphaBetaSearch, MinimaxSearch};
[INFO] [stdout]   |                                                     ^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `mate` is never read
[INFO] [stdout]   --> src/bin/bench.rs:13:5
[INFO] [stdout]    |
[INFO] [stdout]  9 | struct Puzzle {
[INFO] [stdout]    |        ------ field in this struct
[INFO] [stdout] ...
[INFO] [stdout] 13 |     mate: u8,
[INFO] [stdout]    |     ^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `Puzzle` has derived impls for the traits `Clone` and `Debug`, but these are intentionally ignored during dead code analysis
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 8.36s
[INFO] running `Command { std: "docker" "inspect" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] warning: value assigned to `score` is never read
[INFO] [stdout]    --> src/engine/search/alphabeta.rs:90:29
[INFO] [stdout]     |
[INFO] [stdout]  90 |               let mut score = i32::MIN;
[INFO] [stdout]     |                               ^^^^^^^^ this value is reassigned later and never used
[INFO] [stdout] ...
[INFO] [stdout] 105 | /                 score = -alphabeta(
[INFO] [stdout] 106 | |                     self,
[INFO] [stdout] 107 | |                     board,
[INFO] [stdout] 108 | |                     evaluator,
[INFO] [stdout] ...   |
[INFO] [stdout] 112 | |                     &mut nodes,
[INFO] [stdout] 113 | |                 );
[INFO] [stdout]     | |_________________- `score` is overwritten here before the previous value is read
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stdout]   --> src/engine/search/alphabeta.rs:11:7
[INFO] [stdout]    |
[INFO] [stdout] 11 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stdout]    |       ^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stdout]  --> src/engine/search/minimax.rs:9:7
[INFO] [stdout]   |
[INFO] [stdout] 9 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stdout]   |       ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling chess-engine v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: field `mate` is never read
[INFO] [stdout]   --> src/bin/bench.rs:13:5
[INFO] [stdout]    |
[INFO] [stdout]  9 | struct Puzzle {
[INFO] [stdout]    |        ------ field in this struct
[INFO] [stdout] ...
[INFO] [stdout] 13 |     mate: u8,
[INFO] [stdout]    |     ^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `Puzzle` has derived impls for the traits `Clone` and `Debug`, but these are intentionally ignored during dead code analysis
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `MinimaxSearch`
[INFO] [stdout]  --> src/main.rs:2:53
[INFO] [stdout]   |
[INFO] [stdout] 2 | use chess_engine::engine::search::{AlphaBetaSearch, MinimaxSearch};
[INFO] [stdout]   |                                                     ^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `MinimaxSearch`
[INFO] [stdout]  --> src/main.rs:2:53
[INFO] [stdout]   |
[INFO] [stdout] 2 | use chess_engine::engine::search::{AlphaBetaSearch, MinimaxSearch};
[INFO] [stdout]   |                                                     ^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: value assigned to `score` is never read
[INFO] [stdout]    --> src/engine/search/alphabeta.rs:90:29
[INFO] [stdout]     |
[INFO] [stdout]  90 |               let mut score = i32::MIN;
[INFO] [stdout]     |                               ^^^^^^^^ this value is reassigned later and never used
[INFO] [stdout] ...
[INFO] [stdout] 105 | /                 score = -alphabeta(
[INFO] [stdout] 106 | |                     self,
[INFO] [stdout] 107 | |                     board,
[INFO] [stdout] 108 | |                     evaluator,
[INFO] [stdout] ...   |
[INFO] [stdout] 112 | |                     &mut nodes,
[INFO] [stdout] 113 | |                 );
[INFO] [stdout]     | |_________________- `score` is overwritten here before the previous value is read
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stdout]   --> src/engine/search/alphabeta.rs:11:7
[INFO] [stdout]    |
[INFO] [stdout] 11 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stdout]    |       ^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stdout]  --> src/engine/search/minimax.rs:9:7
[INFO] [stdout]   |
[INFO] [stdout] 9 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stdout]   |       ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `quiescence_recapture_fen` is never used
[INFO] [stdout]   --> src/engine/search/tests.rs:11:4
[INFO] [stdout]    |
[INFO] [stdout] 11 | fn quiescence_recapture_fen() -> &'static str {
[INFO] [stdout]    |    ^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.62s
[INFO] running `Command { std: "docker" "inspect" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: value assigned to `score` is never read
[INFO] [stderr]    --> src/engine/search/alphabeta.rs:90:29
[INFO] [stderr]     |
[INFO] [stderr]  90 |               let mut score = i32::MIN;
[INFO] [stderr]     |                               ^^^^^^^^ this value is reassigned later and never used
[INFO] [stderr] ...
[INFO] [stderr] 105 | /                 score = -alphabeta(
[INFO] [stderr] 106 | |                     self,
[INFO] [stderr] 107 | |                     board,
[INFO] [stderr] 108 | |                     evaluator,
[INFO] [stderr] ...   |
[INFO] [stderr] 112 | |                     &mut nodes,
[INFO] [stderr] 113 | |                 );
[INFO] [stderr]     | |_________________- `score` is overwritten here before the previous value is read
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_assignments)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stderr]   --> src/engine/search/alphabeta.rs:11:7
[INFO] [stderr]    |
[INFO] [stderr] 11 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stderr]    |       ^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: constant `QUIESCE_DEPTH` is never used
[INFO] [stderr]  --> src/engine/search/minimax.rs:9:7
[INFO] [stderr]   |
[INFO] [stderr] 9 | const QUIESCE_DEPTH: u32 = 4;
[INFO] [stderr]   |       ^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `chess-engine` (lib) generated 3 warnings
[INFO] [stderr] warning: field `mate` is never read
[INFO] [stderr]   --> src/bin/bench.rs:13:5
[INFO] [stderr]    |
[INFO] [stderr]  9 | struct Puzzle {
[INFO] [stderr]    |        ------ field in this struct
[INFO] [stderr] ...
[INFO] [stderr] 13 |     mate: u8,
[INFO] [stderr]    |     ^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `Puzzle` has derived impls for the traits `Clone` and `Debug`, but these are intentionally ignored during dead code analysis
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `MinimaxSearch`
[INFO] [stderr]  --> src/main.rs:2:53
[INFO] [stderr]   |
[INFO] [stderr] 2 | use chess_engine::engine::search::{AlphaBetaSearch, MinimaxSearch};
[INFO] [stderr]   |                                                     ^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: function `quiescence_recapture_fen` is never used
[INFO] [stderr]   --> src/engine/search/tests.rs:11:4
[INFO] [stderr]    |
[INFO] [stderr] 11 | fn quiescence_recapture_fen() -> &'static str {
[INFO] [stderr]    |    ^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `chess-engine` (bin "bench") generated 1 warning
[INFO] [stderr] warning: `chess-engine` (bin "chess-engine") generated 1 warning (run `cargo fix --bin "chess-engine" -p chess-engine` to apply 1 suggestion)
[INFO] [stderr] warning: `chess-engine` (bin "chess-engine" test) generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `chess-engine` (lib test) generated 4 warnings (3 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/chess-engine/8f0f4163087dc3c6/out/chess_engine-8f0f4163087dc3c6)
[INFO] [stdout] 
[INFO] [stdout] running 55 tests
[INFO] [stdout] test engine::board::tests::apply_move_clears_en_passant_on_single_push ... ok
[INFO] [stdout] test engine::board::tests::apply_move_handles_black_en_passant_capture ... ok
[INFO] [stdout] test engine::board::tests::apply_move_revokes_castling_on_rook_move ... ok
[INFO] [stdout] test engine::fen::tests::rejects_both_kings_in_check ... ok
[INFO] [stdout] test engine::fen::tests::rejects_check_on_wrong_side ... ok
[INFO] [stdout] test engine::board::tests::hash_matches_after_castling_sequence ... ok
[INFO] [stdout] test engine::eval::tests::material_eval_scores_side_to_move ... ok
[INFO] [stdout] test engine::board::tests::apply_move_handles_white_castle_kingside ... ok
[INFO] [stdout] test engine::board::tests::apply_move_handles_white_en_passant_capture ... ok
[INFO] [stdout] test engine::board::tests::apply_move_updates_side_and_piece ... ok
[INFO] [stdout] test engine::fen::tests::parses_startpos ... ok
[INFO] [stdout] test engine::board::tests::apply_move_rejects_wrong_side ... ok
[INFO] [stdout] test engine::fen::tests::allows_side_to_move_in_check ... ok
[INFO] [stdout] test engine::fen::tests::rejects_missing_king ... ok
[INFO] [stdout] test engine::fen::tests::rejects_pawn_on_last_rank ... ok
[INFO] [stdout] test engine::movegen::tests::game_status_detects_checkmate ... ok
[INFO] [stdout] test engine::board::tests::apply_move_revokes_castling_on_rook_capture ... ok
[INFO] [stdout] test engine::fen::tests::rejects_invalid_en_passant ... ok
[INFO] [stdout] test engine::board::tests::hash_matches_after_en_passant_sequence ... ok
[INFO] [stdout] test engine::movegen::tests::game_status_detects_stalemate ... ok
[INFO] [stdout] test engine::fen::tests::rejects_invalid_castling_rights ... ok
[INFO] [stdout] test engine::eval::tests::material_eval_balances_both_sides ... ok
[INFO] [stdout] test engine::movegen::tests::noisy_move_detects_capture ... ok
[INFO] [stdout] test engine::movegen::tests::noisy_move_detects_check ... ok
[INFO] [stdout] test engine::movegen::tests::generate_castling_moves ... ok
[INFO] [stdout] test engine::movegen::tests::noisy_move_detects_promotion ... ok
[INFO] [stdout] test engine::movegen::tests::generate_legal_startpos_count ... ok
[INFO] [stdout] test engine::movegen::tests::offset_square_allows_onboard ... ok
[INFO] [stdout] test engine::movegen::tests::generate_en_passant_move ... ok
[INFO] [stdout] test engine::movegen::tests::generate_legal_disallows_castling_into_check ... ok
[INFO] [stdout] test engine::movegen::tests::offset_square_rejects_offboard ... ok
[INFO] [stdout] test engine::movegen::tests::game_status_detects_ongoing ... ok
[INFO] [stdout] test engine::movegen::tests::generate_legal_disallows_castling_out_of_check ... ok
[INFO] [stdout] test engine::movegen::tests::generate_startpos_pseudo_legal_count ... ok
[INFO] [stdout] test engine::board::tests::apply_move_sets_en_passant_on_double_push ... ok
[INFO] [stdout] test engine::board::tests::apply_move_sets_en_passant_for_black_double_push ... ok
[INFO] [stdout] test engine::movegen::tests::generate_legal_disallows_castling_through_check ... ok
[INFO] [stdout] test engine::types::tests::algebraic_round_trip ... ok
[INFO] [stdout] test engine::types::tests::parse_uci_move ... ok
[INFO] [stdout] test engine::types::tests::reject_invalid_move_text ... ok
[INFO] [stdout] test engine::search::tests::prefers_mate_over_material_capture ... ok
[INFO] [stdout] test engine::search::tests::seeded_search_depth_is_deterministic ... ok
[INFO] [stdout] test engine::board::tests::apply_move_handles_black_castle_queenside ... ok
[INFO] [stdout] test engine::fen::tests::rejects_invalid_side ... ok
[INFO] [stdout] test engine::fen::tests::rejects_invalid_field_count ... ok
[INFO] [stdout] test engine::board::tests::apply_move_revokes_castling_on_king_move ... ok
[INFO] [stdout] test engine::types::tests::invalid_algebraic_returns_none ... ok
[INFO] [stdout] test engine::types::tests::parse_promotion_move ... ok
[INFO] [stdout] test engine::search::tests::alphabeta_matches_minimax_depth1 ... ok
[INFO] [stdout] test engine::search::tests::alphabeta_best_moves_subset_of_minimax_depth2_startpos ... ok
[INFO] [stdout] test engine::search::tests::iterative_deepening_best_move_matches_depth_result ... ok
[INFO] [stdout] test engine::search::tests::alphabeta_tt_keeps_best_moves_stable ... ok
[INFO] [stdout] test engine::search::tests::iterative_deepening_nodes_accounting ... ok
[INFO] [stdout] test engine::search::tests::alphabeta_depth3_includes_ba6 ... ok
[INFO] [stdout] test engine::movegen::tests::perft_startpos_depths ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.99s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/bench.rs (/opt/rustwide/target/debug/build/chess-engine/eb26d980f10d9ca0/out/bench-eb26d980f10d9ca0)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::parses_sample_puzzle_row ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/build/chess-engine/80dded8ff42de595/out/chess_engine-80dded8ff42de595)
[INFO] [stdout] 
[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] [stderr]      Running tests/uci.rs (/opt/rustwide/target/debug/build/chess-engine/3bdf1953d6f49d46/out/uci-3bdf1953d6f49d46)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test uci_reports_invalid_fen ... FAILED
[INFO] [stdout] test uci_handshake_works ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stderr] error: test failed, to rerun pass `--test uci`
[INFO] [stdout] 
[INFO] [stdout] ---- uci_reports_invalid_fen stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'uci_reports_invalid_fen' (452) panicked at tests/uci.rs:73:9:
[INFO] [stdout] engine binary not found at /opt/rustwide/target/debug/build/chess-engine/3bdf1953d6f49d46/chess-engine
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b61de2c0e11 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b61de2c0e11 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b61de2c0e11 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b61de2c0e11 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b61de2d4daa - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b61de2d4daa - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x5b61de2c50bc - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x5b61de2c50bc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x5b61de29ccd6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b61de29ccd6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x5b61de2b94a9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x5b61de255560 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x5b61de255560 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x5b61de2b9662 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x5b61de2b9662 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x5b61de29cd82 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x5b61de295a99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b61de29d98d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x5b61de2d54dc - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b61de242520 - uci[1df589be37025425]::resolve_engine_exe
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/uci.rs:73:9
[INFO] [stdout]   20:     0x5b61de242a8c - uci[1df589be37025425]::uci_reports_invalid_fen
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/uci.rs:34:15
[INFO] [stdout]   21:     0x5b61de241c97 - uci[1df589be37025425]::uci_reports_invalid_fen::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/uci.rs:33:29
[INFO] [stdout]   22:     0x5b61de248556 - <uci[1df589be37025425]::uci_reports_invalid_fen::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5b61de2489ab - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5b61de2489ab - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   25:     0x5b61de255b85 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   26:     0x5b61de255b85 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   27:     0x5b61de255b85 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   28:     0x5b61de255b85 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   29:     0x5b61de255b85 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x5b61de255b85 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   31:     0x5b61de255b85 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   32:     0x5b61de24f474 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   33:     0x5b61de24f474 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x5b61de258c12 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   35:     0x5b61de258c12 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   36:     0x5b61de258c12 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   37:     0x5b61de258c12 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   38:     0x5b61de258c12 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x5b61de258c12 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   40:     0x5b61de258c12 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b61de2c066f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   42:     0x5b61de2c066f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7c6cfa41fdfa - <unknown>
[INFO] [stdout]   44:     0x7c6cfa4b33d4 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- uci_handshake_works stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'uci_handshake_works' (451) panicked at tests/uci.rs:73:9:
[INFO] [stdout] engine binary not found at /opt/rustwide/target/debug/build/chess-engine/3bdf1953d6f49d46/chess-engine
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b61de2c0e11 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b61de2c0e11 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b61de2c0e11 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b61de2c0e11 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b61de2d4daa - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b61de2d4daa - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x5b61de2c50bc - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x5b61de2c50bc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x5b61de29ccd6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b61de29ccd6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x5b61de2b94a9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x5b61de255560 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x5b61de255560 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x5b61de2b9662 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x5b61de2b9662 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x5b61de29cd82 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x5b61de295a99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b61de29d98d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x5b61de2d54dc - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b61de242520 - uci[1df589be37025425]::resolve_engine_exe
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/uci.rs:73:9
[INFO] [stdout]   20:     0x5b61de2425bc - uci[1df589be37025425]::uci_handshake_works
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/uci.rs:7:15
[INFO] [stdout]   21:     0x5b61de241c67 - uci[1df589be37025425]::uci_handshake_works::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/uci.rs:6:25
[INFO] [stdout]   22:     0x5b61de248536 - <uci[1df589be37025425]::uci_handshake_works::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5b61de2489ab - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5b61de2489ab - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   25:     0x5b61de255b85 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   26:     0x5b61de255b85 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   27:     0x5b61de255b85 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   28:     0x5b61de255b85 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   29:     0x5b61de255b85 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x5b61de255b85 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   31:     0x5b61de255b85 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   32:     0x5b61de24f474 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   33:     0x5b61de24f474 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x5b61de258c12 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   35:     0x5b61de258c12 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   36:     0x5b61de258c12 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   37:     0x5b61de258c12 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   38:     0x5b61de258c12 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x5b61de258c12 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   40:     0x5b61de258c12 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x5b61de2c066f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   42:     0x5b61de2c066f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7c6cfa41fdfa - <unknown>
[INFO] [stdout]   44:     0x7c6cfa4b33d4 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     uci_handshake_works
[INFO] [stdout]     uci_reports_invalid_fen
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7", kill_on_drop: false }`
[INFO] [stdout] 351095b09bbdb823d899fa2ea6ed1df647c1afcccb1d31981d6ece399cc73ac7
