[INFO] crate vampirc-uci 0.10.1 is already in cache
[INFO] testing vampirc-uci-0.10.1 against try#03a1ea71b075ab964b5278bc6e74cd6c52c36ee0 for pr-74409
[INFO] extracting crate vampirc-uci 0.10.1 into /workspace/builds/worker-10/source
[INFO] validating manifest of crates.io crate vampirc-uci 0.10.1 on toolchain 03a1ea71b075ab964b5278bc6e74cd6c52c36ee0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking crates.io crate vampirc-uci 0.10.1
[INFO] finished tweaking crates.io crate vampirc-uci 0.10.1
[INFO] tweaked toml for crates.io crate vampirc-uci 0.10.1 written to /workspace/builds/worker-10/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "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" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env@sha256:d9fbb4e2287ab3795bdefaf705efb7541a8875c13bce71e067d6b01dc5ed759b" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 05f3309f19a66fb1158ef431a8076179440b2901787546172e6d5917114f8507
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "05f3309f19a66fb1158ef431a8076179440b2901787546172e6d5917114f8507", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "05f3309f19a66fb1158ef431a8076179440b2901787546172e6d5917114f8507", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05f3309f19a66fb1158ef431a8076179440b2901787546172e6d5917114f8507", kill_on_drop: false }`
[INFO] [stdout] 05f3309f19a66fb1158ef431a8076179440b2901787546172e6d5917114f8507
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:d9fbb4e2287ab3795bdefaf705efb7541a8875c13bce71e067d6b01dc5ed759b" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] aa62b8ca00ec2c84c9426e054dd93188cdeccc074d32b920436d10bc99df94aa
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "aa62b8ca00ec2c84c9426e054dd93188cdeccc074d32b920436d10bc99df94aa", kill_on_drop: false }`
[INFO] [stderr]    Compiling ucd-trie v0.1.3
[INFO] [stderr]    Compiling syn v1.0.35
[INFO] [stderr]    Compiling pest v2.1.3
[INFO] [stderr]    Compiling pest_meta v2.1.3
[INFO] [stderr]    Compiling pest_generator v2.1.3
[INFO] [stderr]    Compiling pest_derive v2.1.0
[INFO] [stderr]    Compiling vampirc-uci v0.10.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.48s
[INFO] running `Command { std: "docker" "inspect" "aa62b8ca00ec2c84c9426e054dd93188cdeccc074d32b920436d10bc99df94aa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aa62b8ca00ec2c84c9426e054dd93188cdeccc074d32b920436d10bc99df94aa", kill_on_drop: false }`
[INFO] [stdout] aa62b8ca00ec2c84c9426e054dd93188cdeccc074d32b920436d10bc99df94aa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:d9fbb4e2287ab3795bdefaf705efb7541a8875c13bce71e067d6b01dc5ed759b" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 27939d52ff28f84d1bc50ad66a2dcd1c6c015b6c684d121d2ec2e019cb64ee7b
[INFO] running `Command { std: "docker" "start" "-a" "27939d52ff28f84d1bc50ad66a2dcd1c6c015b6c684d121d2ec2e019cb64ee7b", kill_on_drop: false }`
[INFO] [stderr]    Compiling vampirc-uci v0.10.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 7.54s
[INFO] running `Command { std: "docker" "inspect" "27939d52ff28f84d1bc50ad66a2dcd1c6c015b6c684d121d2ec2e019cb64ee7b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "27939d52ff28f84d1bc50ad66a2dcd1c6c015b6c684d121d2ec2e019cb64ee7b", kill_on_drop: false }`
[INFO] [stdout] 27939d52ff28f84d1bc50ad66a2dcd1c6c015b6c684d121d2ec2e019cb64ee7b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:d9fbb4e2287ab3795bdefaf705efb7541a8875c13bce71e067d6b01dc5ed759b" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2f1f22118000ef08c77eb6ac2f47ae55825c3325dcd67cb6ad28ecc4709b472b
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "2f1f22118000ef08c77eb6ac2f47ae55825c3325dcd67cb6ad28ecc4709b472b", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.71s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/vampirc_uci-31ac7fccc36802f3
[INFO] [stdout] 
[INFO] [stdout] running 146 tests
[INFO] [stdout] test parser::tests::test_copyprotection ... ok
[INFO] [stdout] test parser::tests::test_bestmove ... 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_strict ... ok
[INFO] [stdout] test parser::tests::test_debug_wrong_param ... ok
[INFO] [stdout] test parser::tests::test_debug_on ... ok
[INFO] [stdout] test parser::tests::test_go_movetime ... ok
[INFO] [stdout] test parser::tests::test_go_ponder ... ok
[INFO] [stdout] test parser::tests::test_info_currline_multi_cpu_nr ... ok
[INFO] [stdout] test parser::tests::test_empty_nl_parse_with_unknown ... ok
[INFO] [stdout] test parser::tests::test_debug_cutoff ... ok
[INFO] [stdout] test parser::tests::test_bestmove_with_ponder ... ok
[INFO] [stdout] test parser::tests::test_empty_parse_strict ... ok
[INFO] [stdout] test parser::tests::test_info_currline_no_cpu_nr ... ok
[INFO] [stdout] test parser::tests::test_id ... ok
[INFO] [stdout] test parser::tests::test_info_currline_with_cpu_nr ... ok
[INFO] [stdout] test parser::tests::test_go_timeleft ... ok
[INFO] [stdout] test parser::tests::test_info_multi1 ... ok
[INFO] [stdout] test parser::tests::test_debug_off ... ok
[INFO] [stdout] test parser::tests::test_info_multi3 ... ok
[INFO] [stdout] test parser::tests::test_info_score_cp ... ok
[INFO] [stdout] test parser::tests::test_no_line_at_end_parse_with_unknown_with_unknown ... 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_nodes_searchmoves ... ok
[INFO] [stdout] test parser::tests::test_parse_go ... ok
[INFO] [stdout] test parser::tests::test_parse_info_any ... 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_parse_info_currmovenum ... ok
[INFO] [stdout] test parser::tests::test_parse_info_depth ... ok
[INFO] [stdout] test parser::tests::test_parse_info_hashfull ... ok
[INFO] [stdout] test parser::tests::test_parse_info_multipv ... ok
[INFO] [stdout] test parser::tests::test_empty_parse ... ok
[INFO] [stdout] test parser::tests::test_go_infinite ... ok
[INFO] [stdout] test parser::tests::test_empty_parse_with_unknown ... ok
[INFO] [stdout] test parser::tests::test_no_line_at_end_multi_parse_strict ... ok
[INFO] [stdout] test parser::tests::test_go_full_example ... ok
[INFO] [stdout] test parser::tests::test_info_multi2 ... ok
[INFO] [stdout] test parser::tests::test_parse_info_nps ... ok
[INFO] [stdout] test parser::tests::test_info_score_cp_lowerbound ... ok
[INFO] [stdout] test parser::tests::test_info_score_cp_upperbound ... ok
[INFO] [stdout] test parser::tests::test_parse_info_nodes ... ok
[INFO] [stdout] test parser::tests::test_no_line_at_end_parse_with_unknown ... ok
[INFO] [stdout] test parser::tests::test_isready ... ok
[INFO] [stdout] test parser::tests::test_parse_info_time ... 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_lax_mode ... ok
[INFO] [stdout] test parser::tests::test_no_line_at_end_parse_with_unknown_single ... ok
[INFO] [stdout] test parser::tests::test_parse_option_button ... ok
[INFO] [stdout] test parser::tests::test_parse_option_combo_no_default ... ok
[INFO] [stdout] test parser::tests::test_parse_option_spin ... ok
[INFO] [stdout] test parser::tests::test_parse_option_spin_just_default_and_max ... ok
[INFO] [stdout] test parser::tests::test_parse_option_spin_just_max ... ok
[INFO] [stdout] test parser::tests::test_no_line_at_end_multi_parse ... ok
[INFO] [stdout] test parser::tests::test_parse_info_string ... ok
[INFO] [stdout] test parser::tests::test_parse_option_check_no_default ... ok
[INFO] [stdout] test parser::tests::test_parse_info_pv ... ok
[INFO] [stdout] test parser::tests::test_parse_option_string ... ok
[INFO] [stdout] test parser::tests::test_parse_stdin ... ignored
[INFO] [stdout] test parser::tests::test_parse_option_spin_no_default ... ok
[INFO] [stdout] test parser::tests::test_parse_info_tbhits ... ok
[INFO] [stdout] test parser::tests::test_parse_option_string_no_default ... ok
[INFO] [stdout] test parser::tests::test_parse_option_combo ... ok
[INFO] [stdout] test parser::tests::test_parse_with_unknown_success ... ok
[INFO] [stdout] test parser::tests::test_parse_option_check ... ok
[INFO] [stdout] test parser::tests::test_parse_with_unknown ... ok
[INFO] [stdout] test parser::tests::test_parse_option_button_ignore_default ... ok
[INFO] [stdout] test parser::tests::test_position_endgame ... ok
[INFO] [stdout] test parser::tests::test_position_incorrect_fen ... ok
[INFO] [stdout] test parser::tests::test_position_fen_no_moves ... ok
[INFO] [stdout] test parser::tests::test_quit ... ok
[INFO] [stdout] test parser::tests::test_register_invalid ... ok
[INFO] [stdout] test parser::tests::test_readyok ... ok
[INFO] [stdout] test parser::tests::test_register_invalid2 ... ok
[INFO] [stdout] test parser::tests::test_register_name_code ... ok
[INFO] [stdout] test parser::tests::test_register_later ... ok
[INFO] [stdout] test parser::tests::test_registration ... ok
[INFO] [stdout] test parser::tests::test_search_control_depth ... ok
[INFO] [stdout] test parser::tests::test_search_control_mate ... ok
[INFO] [stdout] test parser::tests::test_set_option_bool ... ok
[INFO] [stdout] test parser::tests::test_parse_one_uci ... ok
[INFO] [stdout] test parser::tests::test_set_option_int ... ok
[INFO] [stdout] test parser::tests::test_set_option_button ... ok
[INFO] [stdout] test parser::tests::test_set_option_str ... ok
[INFO] [stdout] test parser::tests::test_stop ... ok
[INFO] [stdout] test parser::tests::test_ponderhit ... ok
[INFO] [stdout] test parser::tests::test_position_startpos ... ok
[INFO] [stdout] test parser::tests::test_two_command_doc_example ... ok
[INFO] [stdout] test parser::tests::test_ucinewgame ... ok
[INFO] [stdout] test parser::tests::test_position_startpos_as_fen ... ok
[INFO] [stdout] test parser::tests::test_uci ... ok
[INFO] [stdout] test parser::tests::test_position_startpos_no_moves ... ok
[INFO] [stdout] test uci::tests::test_byte_vec_message_as_ref_u8 ... ok
[INFO] [stdout] test uci::tests::test_byte_vec_message_creation ... ok
[INFO] [stdout] test uci::tests::test_byte_vec_message_as_ref_uci_message ... ok
[INFO] [stdout] test uci::tests::test_empty_go_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_serialize_bestmove ... ok
[INFO] [stdout] test uci::tests::test_serialize_bestmove_with_options ... ok
[INFO] [stdout] test uci::tests::test_serialize_button_option ... ok
[INFO] [stdout] test uci::tests::test_serialize_check_option ... ok
[INFO] [stdout] test uci::tests::test_serialize_combo_option ... ok
[INFO] [stdout] test uci::tests::test_serialize_copyprotection ... ok
[INFO] [stdout] test uci::tests::test_serialize_empty_setoption ... ok
[INFO] [stdout] test uci::tests::test_serialize_id_author ... ok
[INFO] [stdout] test uci::tests::test_serialize_id_name ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_any ... 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_currmove ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_currmovenum ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_depth ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_hashfull ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_multipv ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_nps ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_pv ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_refutation ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_score ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_score_mate_in_three ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_seldepth ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_string ... ok
[INFO] [stdout] test uci::tests::test_serialize_info_tbhits_nbhits ... ok
[INFO] [stdout] test uci::tests::test_serialize_none_setoption ... ok
[INFO] [stdout] test uci::tests::test_serialize_readyok ... 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 parser::tests::test_parse_option_spin_just_min ... ok
[INFO] [stdout] test parser::tests::test_parse_option_string_empty ... ok
[INFO] [stdout] test parser::tests::test_parse_one_unknown ... ok
[INFO] [stdout] test parser::tests::test_parse_one_empty ... ok
[INFO] [stdout] test parser::tests::test_info_score_mate ... ok
[INFO] [stdout] test parser::tests::test_parse_info_refutation ... ok
[INFO] [stdout] test parser::tests::test_uciok ... ok
[INFO] [stdout] test tests::it_works ... ok
[INFO] [stdout] test uci::tests::test_direction_gui_bound ... ok
[INFO] [stdout] test uci::tests::test_direction_engine_bound ... ok
[INFO] [stdout] test parser::tests::test_parse_info_seldepth ... ok
[INFO] [stdout] test parser::tests::test_parse_info_sbhits ... ok
[INFO] [stdout] test parser::tests::test_stop_really_stop ... ok
[INFO] [stdout] test uci::tests::test_serialize_uciok ... ok
[INFO] [stdout] test parser::tests::test_strict_mode ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 145 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests vampirc-uci
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/parser.rs - parser::parse (line 66) ... ok
[INFO] [stdout] test src/uci.rs - uci::UciMessage::serialize (line 340) ... ok
[INFO] [stdout] test src/parser.rs - parser::parse_strict (line 41) ... ok
[INFO] [stdout] test src/parser.rs - parser::parse_one (line 111) ... ok
[INFO] [stdout] test src/uci.rs - uci::UciOptionConfig::serialize (line 733) ... ok
[INFO] [stdout] test src/parser.rs - parser::parse_with_unknown (line 85) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2f1f22118000ef08c77eb6ac2f47ae55825c3325dcd67cb6ad28ecc4709b472b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2f1f22118000ef08c77eb6ac2f47ae55825c3325dcd67cb6ad28ecc4709b472b", kill_on_drop: false }`
[INFO] [stdout] 2f1f22118000ef08c77eb6ac2f47ae55825c3325dcd67cb6ad28ecc4709b472b