[INFO] cloning repository https://github.com/swellaby/rusty-hook
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/swellaby/rusty-hook" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fswellaby%2Frusty-hook", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fswellaby%2Frusty-hook'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] f937f1ba82147583f90dc9de3aaa9a6e3a1d144d
[INFO] testing swellaby/rusty-hook against beta-2021-09-08 for beta-1.56-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fswellaby%2Frusty-hook" "/workspace/builds/worker-5/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/swellaby/rusty-hook on toolchain beta-2021-09-08
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/swellaby/rusty-hook
[INFO] finished tweaking git repo https://github.com/swellaby/rusty-hook
[INFO] tweaked toml for git repo https://github.com/swellaby/rusty-hook written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] crate git repo https://github.com/swellaby/rusty-hook already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "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-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9350d98bc52ea30fae1163b62e0d48ae4fb85920e1c1c9c81448ef735331b02f
[INFO] running `Command { std: "docker" "start" "-a" "9350d98bc52ea30fae1163b62e0d48ae4fb85920e1c1c9c81448ef735331b02f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9350d98bc52ea30fae1163b62e0d48ae4fb85920e1c1c9c81448ef735331b02f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9350d98bc52ea30fae1163b62e0d48ae4fb85920e1c1c9c81448ef735331b02f", kill_on_drop: false }`
[INFO] [stdout] 9350d98bc52ea30fae1163b62e0d48ae4fb85920e1c1c9c81448ef735331b02f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 45157dac3f7d4c007ed08c80cacaa2fdb5f6a7668992d0c3abaebae4ead759c8
[INFO] running `Command { std: "docker" "start" "-a" "45157dac3f7d4c007ed08c80cacaa2fdb5f6a7668992d0c3abaebae4ead759c8", 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] [stderr]    Compiling proc-macro2 v1.0.28
[INFO] [stderr]    Compiling version_check v0.9.2
[INFO] [stderr]    Compiling hashbrown v0.9.0
[INFO] [stderr]    Compiling serde v1.0.116
[INFO] [stderr]    Compiling syn v1.0.74
[INFO] [stderr]    Compiling libc v0.2.77
[INFO] [stderr]    Compiling fsio v0.2.0
[INFO] [stderr]    Compiling unicode-segmentation v1.6.0
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling nias v0.7.0
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling termcolor v1.1.0
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling os_str_bytes v3.1.0
[INFO] [stderr]    Compiling indexmap v1.6.0
[INFO] [stderr]    Compiling textwrap v0.14.2
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling envmnt v0.9.0
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling ci_info v0.14.2
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling rusty-hook v0.12.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling clap_derive v3.0.0-beta.4
[INFO] [stderr]    Compiling clap v3.0.0-beta.4
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 31.78s
[INFO] running `Command { std: "docker" "inspect" "45157dac3f7d4c007ed08c80cacaa2fdb5f6a7668992d0c3abaebae4ead759c8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "45157dac3f7d4c007ed08c80cacaa2fdb5f6a7668992d0c3abaebae4ead759c8", kill_on_drop: false }`
[INFO] [stdout] 45157dac3f7d4c007ed08c80cacaa2fdb5f6a7668992d0c3abaebae4ead759c8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b2c71096c10443d75396b8d4c3345501b58062a4b2ec83f1b668230b6258a7e0
[INFO] running `Command { std: "docker" "start" "-a" "b2c71096c10443d75396b8d4c3345501b58062a4b2ec83f1b668230b6258a7e0", kill_on_drop: false }`
[INFO] [stderr]    Compiling rusty-hook v0.12.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.26s
[INFO] running `Command { std: "docker" "inspect" "b2c71096c10443d75396b8d4c3345501b58062a4b2ec83f1b668230b6258a7e0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b2c71096c10443d75396b8d4c3345501b58062a4b2ec83f1b668230b6258a7e0", kill_on_drop: false }`
[INFO] [stdout] b2c71096c10443d75396b8d4c3345501b58062a4b2ec83f1b668230b6258a7e0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f389b220ea07b387057fc4c91daec3444081f134b27143f51ae586d36c742896
[INFO] running `Command { std: "docker" "start" "-a" "f389b220ea07b387057fc4c91daec3444081f134b27143f51ae586d36c742896", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/rusty_hook-f85d97e1be84db50)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/rusty_hook-51b8c876fa47571d)
[INFO] [stdout] 
[INFO] [stdout] running 57 tests
[INFO] [stdout] test rusty_hook::config::config_tests::create_config_file_tests::creates_specified_config_when_valid ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::create_config_file_tests::returns_error_when_write_fails ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_hook_script_tests::returns_result_when_value_valid ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_config_file_contents_tests::fails_on_config_file_not_found ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::find_config_file_tests::returns_correct_path_when_file_found ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::find_config_file_tests::returns_correct_message_on_no_file_found ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_config_file_contents_tests::returns_contents_on_success ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_config_file_contents_tests::fails_on_config_file_search_error ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::create_config_file_tests::returns_error_on_io_error ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_config_file_contents_tests::fails_on_config_file_read_error ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::find_config_file_tests::returns_error_on_io_error ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_log_setting_tests::returns_true_when_log_not_boolean ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::create_config_file_tests::returns_empty_when_config_exists ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_table_key_value_from_config::handles_invalid_toml ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::create_default_config_file_tests::creates_config_with_default_name ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_table_key_value_from_config::handles_missing_table ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::create_config_file_tests::creates_default_when_specified_file_invalid ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_hook_script_tests::returns_err_when_hook_not_string ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_log_setting_tests::returns_true_when_content_not_found ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_hook_script_tests::returns_err_when_content_not_found ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_table_key_value_from_config::handles_missing_table_key ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_log_setting_tests::returns_result_when_value_valid ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_hook_script_tests::returns_result_when_value_array ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_table_key_value_from_config::parses_hook_value ... ok
[INFO] [stdout] test rusty_hook::git::git_tests::setup_hooks_tests::creates_all_hooks ... ok
[INFO] [stdout] test rusty_hook::git::git_tests::get_hooks_directory_tests::uses_git_hooks_path_command ... ok
[INFO] [stdout] test rusty_hook::config::config_tests::get_hook_script_tests::returns_error_when_wrong_value_array ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::create_hook_files_tests::does_not_create_skipped_hook ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::get_semver_script_file_contents_tests::provides_correct_semver_script_file_contents ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::create_hook_files_tests::errors_when_hook_write_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::init_directory_tests::returns_error_when_root_directory_detect_fails ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::create_hook_files_tests::errors_when_semver_script_write_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::init_directory_tests::should_return_ok_on_success ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::get_cli_script_file_contents_tests::provides_correct_cli_script_file_contents ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::get_hook_file_contents_tests::provides_correct_hook_file_contents ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::git_params::handles_no_params_correctly ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::constants_tests::should_use_correct_hook_names ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::init_tests::invokes_init_directory_with_cwd ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::returns_error_when_config_contents_unloadable ... ok
[INFO] [stdout] test rusty_hook::git::git_tests::setup_hooks_tests::errors_when_hooks_directory_unknown ... ok
[INFO] [stdout] test rusty_hook::git::git_tests::get_root_directory_path_tests::returns_error_on_command_error ... ok
[INFO] [stdout] test rusty_hook::git::git_tests::get_hooks_directory_tests::returns_error_on_command_error ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::create_hook_files_tests::errors_when_cli_script_write_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::returns_error_when_config_file_missing ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::returns_error_when_root_directory_detect_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::git_params::handles_params_correctly ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::returns_ok_when_script_succeeds ... ok
[INFO] [stdout] test rusty_hook::git::hooks::hooks_tests::create_hook_files_tests::creates_all_hooks ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::logs_details_when_enabled ... ok
[INFO] [stdout] test rusty_hook::git::git_tests::get_root_directory_path_tests::uses_git_rev_parse_top_level_command ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::init_directory_tests::should_return_error_when_config_creation_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::returns_err_when_script_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::init_directory_tests::should_return_error_when_hook_creation_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::returns_error_on_invalid_config ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::does_not_log_details_when_disabled ... ok
[INFO] [stdout] test rusty_hook::git::git_tests::setup_hooks_tests::errors_when_hook_write_fails ... ok
[INFO] [stdout] test rusty_hook::rusty_hook_tests::run_tests::returns_ok_when_hook_missing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 57 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rusty-hook
[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] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "f389b220ea07b387057fc4c91daec3444081f134b27143f51ae586d36c742896", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f389b220ea07b387057fc4c91daec3444081f134b27143f51ae586d36c742896", kill_on_drop: false }`
[INFO] [stdout] f389b220ea07b387057fc4c91daec3444081f134b27143f51ae586d36c742896