[INFO] fetching crate vampirc-uci 0.11.1... [INFO] testing vampirc-uci-0.11.1 against beta-2022-04-10 for beta-1.61-1 [INFO] extracting crate vampirc-uci 0.11.1 into /workspace/builds/worker-74/source [INFO] validating manifest of crates.io crate vampirc-uci 0.11.1 on toolchain beta-2022-04-10 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate vampirc-uci 0.11.1 [INFO] finished tweaking crates.io crate vampirc-uci 0.11.1 [INFO] tweaked toml for crates.io crate vampirc-uci 0.11.1 written to /workspace/builds/worker-74/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "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-74/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-74/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" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 9598c9c3385ef6503866ff93650916ba73a327b947eb6cc47debbb6319d339f9 [INFO] running `Command { std: "docker" "start" "-a" "9598c9c3385ef6503866ff93650916ba73a327b947eb6cc47debbb6319d339f9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "9598c9c3385ef6503866ff93650916ba73a327b947eb6cc47debbb6319d339f9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9598c9c3385ef6503866ff93650916ba73a327b947eb6cc47debbb6319d339f9", kill_on_drop: false }` [INFO] [stdout] 9598c9c3385ef6503866ff93650916ba73a327b947eb6cc47debbb6319d339f9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-74/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-74/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" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8697d9bd09de516cc5fa4117990ccdd23e18b7ad7a1fd8af78a305f692647b89 [INFO] running `Command { std: "docker" "start" "-a" "8697d9bd09de516cc5fa4117990ccdd23e18b7ad7a1fd8af78a305f692647b89", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling proc-macro2 v1.0.37 [INFO] [stderr] Compiling syn v1.0.91 [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling maplit v1.0.2 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling pest_meta v2.1.3 [INFO] [stderr] Compiling quote v1.0.18 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling pest_generator v2.1.3 [INFO] [stderr] Compiling pest_derive v2.1.0 [INFO] [stderr] Compiling vampirc-uci v0.11.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 20.95s [INFO] running `Command { std: "docker" "inspect" "8697d9bd09de516cc5fa4117990ccdd23e18b7ad7a1fd8af78a305f692647b89", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8697d9bd09de516cc5fa4117990ccdd23e18b7ad7a1fd8af78a305f692647b89", kill_on_drop: false }` [INFO] [stdout] 8697d9bd09de516cc5fa4117990ccdd23e18b7ad7a1fd8af78a305f692647b89 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-74/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-74/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" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 81c524413dd04f1433afe1d626d1c954b8e8c18a23d8947f19fa3c5a1dd0477e [INFO] running `Command { std: "docker" "start" "-a" "81c524413dd04f1433afe1d626d1c954b8e8c18a23d8947f19fa3c5a1dd0477e", kill_on_drop: false }` [INFO] [stderr] Compiling vampirc-uci v0.11.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 5.41s [INFO] [stderr] Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/vampirc_uci-132e772eadbd994f) [INFO] running `Command { std: "docker" "inspect" "81c524413dd04f1433afe1d626d1c954b8e8c18a23d8947f19fa3c5a1dd0477e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "81c524413dd04f1433afe1d626d1c954b8e8c18a23d8947f19fa3c5a1dd0477e", kill_on_drop: false }` [INFO] [stdout] 81c524413dd04f1433afe1d626d1c954b8e8c18a23d8947f19fa3c5a1dd0477e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-74/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-74/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" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 555fd7f67d635dd5c7b4d80b45c72fe57a871ba32d2c84b4932d921ee2c7021b [INFO] running `Command { std: "docker" "start" "-a" "555fd7f67d635dd5c7b4d80b45c72fe57a871ba32d2c84b4932d921ee2c7021b", kill_on_drop: false }` [INFO] [stdout] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.06s [INFO] [stdout] running 155 tests [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/vampirc_uci-132e772eadbd994f) [INFO] [stdout] test parser::tests::test_bestmove ... ok [INFO] [stdout] test parser::tests::test_bestmove_with_ponder ... ok [INFO] [stdout] test parser::tests::test_debug_off ... ok [INFO] [stdout] test parser::tests::test_debugon ... ok [INFO] [stdout] test parser::tests::test_empty_nl_parse ... ok [INFO] [stdout] test parser::tests::test_empty_nl_parse_with_unknown ... ok [INFO] [stdout] test parser::tests::test_empty_parse_with_unknown ... ok [INFO] [stdout] test parser::tests::test_debug_wrong_param ... ok [INFO] [stdout] test parser::tests::test_empty_parse ... ok [INFO] [stdout] test parser::tests::test_copyprotection ... ok [INFO] [stdout] test parser::tests::test_empty_nl_parse_strict ... ok [INFO] [stdout] test parser::tests::test_debug_on ... ok [INFO] [stdout] test parser::tests::test_complex_parse_with_unknown ... ok [INFO] [stdout] test parser::tests::test_empty_parse_strict ... ok [INFO] [stdout] test parser::tests::test_debug_cutoff ... ok [INFO] [stdout] test parser::tests::test_go_full_example ... ok [INFO] [stdout] test parser::tests::test_go_movetime ... ok [INFO] [stdout] test parser::tests::test_info_currline_no_cpu_nr ... ok [INFO] [stdout] test parser::tests::test_go_ponder ... ok [INFO] [stdout] test parser::tests::test_go_infinite ... ok [INFO] [stdout] test parser::tests::test_go_timeleft ... ok [INFO] [stdout] test parser::tests::test_info_currline_with_cpu_nr ... ok [INFO] [stdout] test parser::tests::test_info_currline_multi_cpu_nr ... ok [INFO] [stdout] test parser::tests::test_info_multi3 ... ok [INFO] [stdout] test parser::tests::test_info_multi2 ... ok [INFO] [stdout] test parser::tests::test_id ... ok [INFO] [stdout] test parser::tests::test_info_multi1 ... ok [INFO] [stdout] test parser::tests::test_info_score_cp ... ok [INFO] [stdout] test parser::tests::test_info_score_cp_lowerbound ... ok [INFO] [stdout] test parser::tests::test_info_score_mate ... ok [INFO] [stdout] test parser::tests::test_info_score_cp_upperbound ... ok [INFO] [stdout] test parser::tests::test_isready ... ok [INFO] [stdout] test parser::tests::test_no_line_at_end_multi_parse ... ok [INFO] [stdout] test parser::tests::test_lax_mode ... ok [INFO] [stdout] test parser::tests::test_no_line_at_end_parse_with_unknown_single ... ok [INFO] [stdout] test parser::tests::test_no_line_at_end_parse_with_unknown_with_unknown ... ok [INFO] [stdout] test parser::tests::test_parse_info_cpuload ... ok [INFO] [stdout] test parser::tests::test_parse_info_currmove ... ok [INFO] [stdout] test parser::tests::test_no_line_at_end_parse_with_unknown ... ok [INFO] [stdout] test parser::tests::test_nodes_searchmoves ... ok [INFO] [stdout] test parser::tests::test_parse_info_currmovenum ... ok [INFO] [stdout] test parser::tests::test_no_line_at_end_single_parse ... ok [INFO] [stdout] test parser::tests::test_no_line_at_end_single_parse_strict ... ok [INFO] [stdout] test parser::tests::test_parse_info_depth ... ok [INFO] [stdout] test parser::tests::test_parse_info_any ... ok [INFO] [stdout] test parser::tests::test_parse_go ... ok [INFO] [stdout] test parser::tests::test_parse_info_seldepth ... ok [INFO] [stdout] test parser::tests::test_parse_info_nodes ... ok [INFO] [stdout] test parser::tests::test_parse_go_eoi ... ok [INFO] [stdout] test parser::tests::test_parse_info_nps ... ok [INFO] [stdout] test parser::tests::test_parse_info_refutation ... ok [INFO] [stdout] test parser::tests::test_parse_go_with_space ... ok [INFO] [stdout] test parser::tests::test_parse_info_multipv ... ok [INFO] [stdout] test parser::tests::test_no_line_at_end_multi_parse_strict ... ok [INFO] [stdout] test parser::tests::test_parse_info_pv ... ok [INFO] [stdout] test parser::tests::test_parse_negative_duration_wtime ... ok [INFO] [stdout] test parser::tests::test_parse_info_hashfull ... ok [INFO] [stdout] test parser::tests::test_parse_info_string ... ok [INFO] [stdout] test parser::tests::test_parse_info_time ... ok [INFO] [stdout] test parser::tests::test_parse_option_check_no_default ... ok [INFO] [stdout] test parser::tests::test_parse_option_check ... ok [INFO] [stdout] test parser::tests::test_parse_option_button ... ok [INFO] [stdout] test parser::tests::test_parse_info_sbhits ... ok [INFO] [stdout] test parser::tests::test_parse_option_combo ... ok [INFO] [stdout] test parser::tests::test_parse_one_empty ... ok [INFO] [stdout] test parser::tests::test_parse_one_uci ... ok [INFO] [stdout] test parser::tests::test_parse_option_button_ignore_default ... ok [INFO] [stdout] test parser::tests::test_parse_one_unknown ... ok [INFO] [stdout] test parser::tests::test_parse_option_string_no_default ... ok [INFO] [stdout] test parser::tests::test_parse_option_spin ... ok [INFO] [stdout] test parser::tests::test_parse_signed_improperly_duration_wtime ... ok [INFO] [stdout] test parser::tests::test_parse_signed_improperly_duration_wtime_ignore ... ok [INFO] [stdout] test parser::tests::test_parse_option_spin_just_min ... ok [INFO] [stdout] test parser::tests::test_parse_option_spin_just_max ... ok [INFO] [stdout] test parser::tests::test_parse_info_tbhits ... ok [INFO] [stdout] test parser::tests::test_parse_stdin ... ignored [INFO] [stdout] test parser::tests::test_parse_option_string ... ok [INFO] [stdout] test parser::tests::test_parse_option_combo_no_default ... ok [INFO] [stdout] test parser::tests::test_parse_one_multi_commands ... ok [INFO] [stdout] test parser::tests::test_parse_one_go ... ok [INFO] [stdout] test parser::tests::test_parse_option_spin_just_default_and_max ... ok [INFO] [stdout] test parser::tests::test_parse_option_string_empty ... ok [INFO] [stdout] test parser::tests::test_parse_option_spin_no_default ... ok [INFO] [stdout] test parser::tests::test_parse_signed_positive_duration_wtime ... ok [INFO] [stdout] test parser::tests::test_parse_signed_improperly_duration_wtime_strict ... ok [INFO] [stdout] test parser::tests::test_parse_with_unknown_success ... ok [INFO] [stdout] test parser::tests::test_parse_with_unknown ... ok [INFO] [stdout] test parser::tests::test_position_endgame ... ok [INFO] [stdout] test parser::tests::test_ponderhit ... ok [INFO] [stdout] test parser::tests::test_position_fen_no_moves ... ok [INFO] [stdout] test parser::tests::test_register_name_code ... ok [INFO] [stdout] test parser::tests::test_position_startpos_no_moves ... ok [INFO] [stdout] test parser::tests::test_search_control_depth ... ok [INFO] [stdout] test parser::tests::test_register_invalid ... ok [INFO] [stdout] test parser::tests::test_set_option_bool ... ok [INFO] [stdout] test parser::tests::test_register_invalid2 ... ok [INFO] [stdout] test parser::tests::test_register_later ... ok [INFO] [stdout] test parser::tests::test_registration ... ok [INFO] [stdout] test parser::tests::test_position_startpos_as_fen ... ok [INFO] [stdout] test parser::tests::test_position_incorrect_fen ... ok [INFO] [stdout] test parser::tests::test_position_startpos ... ok [INFO] [stdout] test parser::tests::test_set_option_button ... ok [INFO] [stdout] test parser::tests::test_search_control_mate ... ok [INFO] [stdout] test parser::tests::test_quit ... ok [INFO] [stdout] test parser::tests::test_readyok ... ok [INFO] [stdout] test parser::tests::test_set_option_str ... ok [INFO] [stdout] test parser::tests::test_stop_really_stop ... ok [INFO] [stdout] test parser::tests::test_uci ... ok [INFO] [stdout] test parser::tests::test_ucinewgame ... ok [INFO] [stdout] test parser::tests::test_stop ... ok [INFO] [stdout] test parser::tests::test_set_option_int ... ok [INFO] [stdout] test uci::tests::test_byte_vec_message_creation ... ok [INFO] [stdout] test parser::tests::test_two_command_doc_example ... ok [INFO] [stdout] test tests::it_works ... ok [INFO] [stdout] test uci::tests::test_empty_go_message ... ok [INFO] [stdout] test uci::tests::test_byte_vec_message_as_ref_uci_message ... ok [INFO] [stdout] test uci::tests::test_is_unknown_false ... ok [INFO] [stdout] test uci::tests::test_is_unknown_true ... ok [INFO] [stdout] test uci::tests::test_direction_gui_bound ... ok [INFO] [stdout] test uci::tests::test_serialize_bestmove_with_options ... ok [INFO] [stdout] test uci::tests::test_negative_duration ... ok [INFO] [stdout] test uci::tests::test_serialize_bestmove ... ok [INFO] [stdout] test uci::tests::test_serialize_combo_option ... ok [INFO] [stdout] test uci::tests::test_serialize_id_author ... ok [INFO] [stdout] test uci::tests::test_serialize_info_any ... ok [INFO] [stdout] test uci::tests::test_serialize_info_currmove ... ok [INFO] [stdout] test uci::tests::test_serialize_copyprotection ... ok [INFO] [stdout] test uci::tests::test_serialize_id_name ... ok [INFO] [stdout] test uci::tests::test_serialize_info_cpuload ... ok [INFO] [stdout] test uci::tests::test_serialize_info_currline ... ok [INFO] [stdout] test uci::tests::test_serialize_info_depth ... ok [INFO] [stdout] test uci::tests::test_serialize_info_pv ... ok [INFO] [stdout] test uci::tests::test_serialize_info_score_mate_in_three ... ok [INFO] [stdout] test uci::tests::test_serialize_info_nps ... ok [INFO] [stdout] test uci::tests::test_serialize_info_seldepth ... ok [INFO] [stdout] test uci::tests::test_serialize_info_hashfull ... ok [INFO] [stdout] test uci::tests::test_serialize_info_currmovenum ... ok [INFO] [stdout] test uci::tests::test_serialize_info_tbhits_nbhits ... ok [INFO] [stdout] test uci::tests::test_serialize_registration ... ok [INFO] [stdout] test uci::tests::test_serialize_spin_option ... ok [INFO] [stdout] test uci::tests::test_serialize_string_option ... ok [INFO] [stdout] test uci::tests::test_serialize_info_score ... ok [INFO] [stdout] test uci::tests::test_serialize_empty_setoption ... ok [INFO] [stdout] test uci::tests::test_serialize_info_refutation ... ok [INFO] [stdout] test uci::tests::test_direction_engine_bound ... ok [INFO] [stdout] test uci::tests::test_byte_vec_message_as_ref_u8 ... ok [INFO] [stdout] test parser::tests::test_uciok ... ok [INFO] [stdout] test uci::tests::test_serialize_button_option ... ok [INFO] [stdout] test uci::tests::test_serialize_uciok ... ok [INFO] [stdout] test uci::tests::test_serialize_check_option ... ok [INFO] [stdout] test uci::tests::test_serialize_none_setoption ... ok [INFO] [stdout] test uci::tests::test_serialize_info_string ... ok [INFO] [stdout] test uci::tests::test_serialize_readyok ... ok [INFO] [stdout] test uci::tests::test_serialize_info_multipv ... ok [INFO] [stdout] test parser::tests::test_strict_mode - should panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 154 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.33s [INFO] [stdout] [INFO] [stderr] Doc-tests vampirc-uci [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test src/uci.rs - uci::UciMessage::serialize (line 340) ... ok [INFO] [stdout] test src/uci.rs - uci::UciOptionConfig::serialize (line 733) ... ok [INFO] [stdout] test src/parser.rs - parser::parse_with_unknown (line 84) ... ok [INFO] [stdout] test src/parser.rs - parser::parse (line 65) ... ok [INFO] [stdout] test src/parser.rs - parser::parse_strict (line 40) ... ok [INFO] [stdout] test src/parser.rs - parser::parse_one (line 111) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.97s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "555fd7f67d635dd5c7b4d80b45c72fe57a871ba32d2c84b4932d921ee2c7021b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "555fd7f67d635dd5c7b4d80b45c72fe57a871ba32d2c84b4932d921ee2c7021b", kill_on_drop: false }` [INFO] [stdout] 555fd7f67d635dd5c7b4d80b45c72fe57a871ba32d2c84b4932d921ee2c7021b