[INFO] fetching crate clapi 0.1.2...
[INFO] testing clapi-0.1.2 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate clapi 0.1.2 into /workspace/builds/worker-58/source
[INFO] validating manifest of crates.io crate clapi 0.1.2 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 clapi 0.1.2
[INFO] finished tweaking crates.io crate clapi 0.1.2
[INFO] tweaked toml for crates.io crate clapi 0.1.2 written to /workspace/builds/worker-58/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-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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] f1e31fe3ff2b26871b69f8723a89e00201cf2226588040fd16ffe6cdc363cd3a
[INFO] running `Command { std: "docker" "start" "-a" "f1e31fe3ff2b26871b69f8723a89e00201cf2226588040fd16ffe6cdc363cd3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f1e31fe3ff2b26871b69f8723a89e00201cf2226588040fd16ffe6cdc363cd3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f1e31fe3ff2b26871b69f8723a89e00201cf2226588040fd16ffe6cdc363cd3a", kill_on_drop: false }`
[INFO] [stdout] f1e31fe3ff2b26871b69f8723a89e00201cf2226588040fd16ffe6cdc363cd3a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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] dba032a9a9bfb4935072c779c565d973f929e77ed3b3f75a676db8ae7026842d
[INFO] running `Command { std: "docker" "start" "-a" "dba032a9a9bfb4935072c779c565d973f929e77ed3b3f75a676db8ae7026842d", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling syn v1.0.91
[INFO] [stderr]    Compiling clapi_internal v0.1.0
[INFO] [stderr]    Compiling clapi v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.93s
[INFO] running `Command { std: "docker" "inspect" "dba032a9a9bfb4935072c779c565d973f929e77ed3b3f75a676db8ae7026842d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dba032a9a9bfb4935072c779c565d973f929e77ed3b3f75a676db8ae7026842d", kill_on_drop: false }`
[INFO] [stdout] dba032a9a9bfb4935072c779c565d973f929e77ed3b3f75a676db8ae7026842d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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] 31a4250c39af3feb5b70597d62d2ab5ac976a18b1c6aaaa222d390cea90c227e
[INFO] running `Command { std: "docker" "start" "-a" "31a4250c39af3feb5b70597d62d2ab5ac976a18b1c6aaaa222d390cea90c227e", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling serde_test v1.0.136
[INFO] [stderr]    Compiling clapi v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 23.77s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/clapi-127fb121afdb1e23)
[INFO] running `Command { std: "docker" "inspect" "31a4250c39af3feb5b70597d62d2ab5ac976a18b1c6aaaa222d390cea90c227e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "31a4250c39af3feb5b70597d62d2ab5ac976a18b1c6aaaa222d390cea90c227e", kill_on_drop: false }`
[INFO] [stdout] 31a4250c39af3feb5b70597d62d2ab5ac976a18b1c6aaaa222d390cea90c227e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-58/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] 3a3e86cc3c66d00d8bbef0afcce347f07469d9f8c51c6ed000fea7b9377b1aec
[INFO] running `Command { std: "docker" "start" "-a" "3a3e86cc3c66d00d8bbef0afcce347f07469d9f8c51c6ed000fea7b9377b1aec", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.25s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/clapi-127fb121afdb1e23)
[INFO] [stdout] 
[INFO] [stdout] running 97 tests
[INFO] [stdout] test arg_count::tests::any_test ... ok
[INFO] [stdout] test arg_count::tests::exactly_test ... ok
[INFO] [stdout] test arg_count::tests::into_value_count_test ... ok
[INFO] [stdout] test arg_count::tests::more_than_test ... ok
[INFO] [stdout] test arg_count::tests::less_than_test ... ok
[INFO] [stdout] test arg_count::tests::one_test ... ok
[INFO] [stdout] test arg_count::tests::display_test ... ok
[INFO] [stdout] test arg_count::tests::value_count_test ... ok
[INFO] [stdout] test arg_count::tests::none_test ... ok
[INFO] [stdout] test arg_count::tests::contains_test ... ok
[INFO] [stdout] test args::tests::arg_convert_all_test ... ok
[INFO] [stdout] test args::tests::arg_convert_test ... ok
[INFO] [stdout] test args::tests::arg_test ... ok
[INFO] [stdout] test args::tests::argument_indexer_test ... ok
[INFO] [stdout] test args::tests::arg_min_max_values_test ... ok
[INFO] [stdout] test args::tests::argument_list_indexer_test ... ok
[INFO] [stdout] test args::tests::arg_name_with_whitespaces_test ... ok
[INFO] [stdout] test args::tests::argument_list_test ... ok
[INFO] [stdout] test args::tests::argument_list_with_default_values_and_exact_args_test ... ok
[INFO] [stdout] test args::tests::get_raw_args_as_type_error_test ... ok
[INFO] [stdout] test args::tests::get_raw_args_test ... ok
[INFO] [stdout] test args::tests::get_raw_args_as_type_test ... ok
[INFO] [stdout] test args::tests::set_values_test ... ok
[INFO] [stdout] test command::tests::args_test ... ok
[INFO] [stdout] test command::tests::children_test ... ok
[INFO] [stdout] test command::tests::command_name_with_whitespaces_test ... ok
[INFO] [stdout] test command::tests::command_test1 ... ok
[INFO] [stdout] test command::tests::handle_test ... ok
[INFO] [stdout] test command::tests::option_test ... ok
[INFO] [stdout] test command_line::tests::into_arg_iterator_test1 ... ok
[INFO] [stdout] test command_line::tests::into_arg_iterator_test2 ... ok
[INFO] [stdout] test command_line::tests::into_arg_iterator_test3 ... ok
[INFO] [stdout] test context::tests::context_test ... ok
[INFO] [stdout] test context::tests::context_builder_test ... ok
[INFO] [stdout] test option::tests::alias_test ... ok
[INFO] [stdout] test option::tests::args_test ... ok
[INFO] [stdout] test option::tests::description_test ... ok
[INFO] [stdout] test option::tests::global_option_test ... ok
[INFO] [stdout] test option::tests::is_hidden_test ... ok
[INFO] [stdout] test option::tests::allow_multiple_test ... ok
[INFO] [stdout] test arg_count::tests::into_value_count_panic_test1 - should panic ... ok
[INFO] [stdout] test option::tests::is_required_test ... ok
[INFO] [stdout] test arg_count::tests::into_value_count_panic_test2 - should panic ... ok
[INFO] [stdout] test option::tests::option_alias_with_whitespaces_test ... ok
[INFO] [stdout] test arg_count::tests::into_value_count_panic_test3 - should panic ... ok
[INFO] [stdout] test option::tests::option_list_indexer_test ... ok
[INFO] [stdout] test option::tests::option_name_with_whitespaces_test ... ok
[INFO] [stdout] test option::tests::options_add_duplicated_test ... ok
[INFO] [stdout] test option::tests::options_add_test ... ok
[INFO] [stdout] test option::tests::options_contains_test ... ok
[INFO] [stdout] test args::tests::arg_empty_name_test - should panic ... ok
[INFO] [stdout] test option::tests::options_get_args_test ... ok
[INFO] [stdout] test option::tests::options_get_test ... ok
[INFO] [stdout] test option::tests::require_assign_test ... ok
[INFO] [stdout] test args::tests::argument_list_with_default_values_and_variable_args_test - should panic ... ok
[INFO] [stdout] test parse_result::tests::parse_required_global_option_test ... ok
[INFO] [stdout] test parse_result::tests::parse_result_allow_multiple_test ... ok
[INFO] [stdout] test args::tests::argument_list_with_default_values_test - should panic ... ok
[INFO] [stdout] test parse_result::tests::parse_result_arg_default_values_test1 ... ok
[INFO] [stdout] test args::tests::argument_list_with_variable_args_test - should panic ... ok
[INFO] [stdout] test parse_result::tests::parse_global_option_test ... ok
[INFO] [stdout] test command::tests::command_empty_name_test - should panic ... ok
[INFO] [stdout] test parse_result::tests::parse_result_multiple_args_test ... ok
[INFO] [stdout] test parse_result::tests::parse_result_eoa_test ... ok
[INFO] [stdout] test command::tests::duplicated_command_test - should panic ... ok
[INFO] [stdout] test parse_result::tests::parse_result_option_bool_flag_test ... ok
[INFO] [stdout] test parse_result::tests::parse_result_command_test ... ok
[INFO] [stdout] test parse_result::tests::parse_result_option_default_values_test1 ... ok
[INFO] [stdout] test parse_result::tests::parse_result_options_test ... ok
[INFO] [stdout] test parse_result::tests::parse_result_error_kind_test ... ok
[INFO] [stdout] test command::tests::duplicated_option_test1 - should panic ... ok
[INFO] [stdout] test command::tests::duplicated_option_test2 - should panic ... ok
[INFO] [stdout] test command::tests::duplicated_option_test3 - should panic ... ok
[INFO] [stdout] test parse_result::tests::value_of_as_test ... ok
[INFO] [stdout] test parse_result::tests::parse_result_variable_arg_count_test1 ... ok
[INFO] [stdout] test parse_result::tests::parse_result_subcommand_test ... ok
[INFO] [stdout] test parse_result::tests::value_of_option_test ... ok
[INFO] [stdout] test parse_result::tests::value_of_option_as_test ... ok
[INFO] [stdout] test parse_result::tests::value_of_test ... ok
[INFO] [stdout] test parse_result::tests::parse_result_required_option_test ... ok
[INFO] [stdout] test parse_result::tests::values_of_as_test ... ok
[INFO] [stdout] test context::tests::invalid_alias_prefix_test - should panic ... ok
[INFO] [stdout] test parse_result::tests::values_of_option_as_test ... ok
[INFO] [stdout] test parse_result::tests::values_of_option_test ... ok
[INFO] [stdout] test context::tests::invalid_assign_chars_test - should panic ... ok
[INFO] [stdout] test context::tests::invalid_name_prefix_test - should panic ... ok
[INFO] [stdout] test context::tests::invalid_delimiter_test - should panic ... ok
[INFO] [stdout] test parse_result::tests::values_of_test ... ok
[INFO] [stdout] test option::tests::option_empty_alias_test - should panic ... ok
[INFO] [stdout] test option::tests::option_empty_name_test - should panic ... ok
[INFO] [stdout] test suggestion::tests::compute_levenshtein_distance_test ... ok
[INFO] [stdout] test tokenizer::tests::invalid_expression_test ... ok
[INFO] [stdout] test tokenizer::tests::tokenize_test ... ok
[INFO] [stdout] test tokenizer::tests::split_with_spaces_test ... ok
[INFO] [stdout] test tokenizer::tests::tokenize_test2 ... ok
[INFO] [stdout] test parse_result::tests::parse_result_arg_default_values_test2 - should panic ... ok
[INFO] [stdout] test parse_result::tests::parse_result_option_default_values_test2 - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 97 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests clapi
[INFO] [stdout] 
[INFO] [stdout] running 58 tests
[INFO] [stdout] test src/app_macros.rs - app_macros::run_app (line 551) ... ignored
[INFO] [stdout] test src/command.rs - command::Command::parse_args (line 448) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 60) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 132) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - (line 17) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 97) - compile ... ok
[INFO] [stderr] error: test failed, to rerun pass '--doc'
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]   process didn't exit successfully: `rustdoc --edition=2021 --crate-type lib --crate-name clapi --test /opt/rustwide/workdir/src/lib.rs -L dependency=/opt/rustwide/target/debug/deps -L dependency=/opt/rustwide/target/debug/deps --extern clapi=/opt/rustwide/target/debug/deps/libclapi-dad0389adc9c0c39.rlib --extern clapi_internal=/opt/rustwide/target/debug/deps/libclapi_internal-54744f1cd4c3cb9f.so --extern serde_json=/opt/rustwide/target/debug/deps/libserde_json-1aaede3659088810.rlib --extern serde_test=/opt/rustwide/target/debug/deps/libserde_test-e547674516180349.rlib -C embed-bitcode=no --error-format human` (signal: 9, SIGKILL: kill)
[INFO] running `Command { std: "docker" "inspect" "3a3e86cc3c66d00d8bbef0afcce347f07469d9f8c51c6ed000fea7b9377b1aec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3a3e86cc3c66d00d8bbef0afcce347f07469d9f8c51c6ed000fea7b9377b1aec", kill_on_drop: false }`
[INFO] [stdout] 3a3e86cc3c66d00d8bbef0afcce347f07469d9f8c51c6ed000fea7b9377b1aec