[INFO] cloning repository https://github.com/BrianSigafoos/fast-format-x
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/BrianSigafoos/fast-format-x" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBrianSigafoos%2Ffast-format-x", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBrianSigafoos%2Ffast-format-x'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 0721608b4b4498a91d7cbc754d057065d951bd71
[INFO] testing BrianSigafoos/fast-format-x against master#2fd6efc32704647e64d3d646d21c4c68eae100e4 for pr-149852-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBrianSigafoos%2Ffast-format-x" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/BrianSigafoos/fast-format-x
[INFO] finished tweaking git repo https://github.com/BrianSigafoos/fast-format-x
[INFO] tweaked toml for git repo https://github.com/BrianSigafoos/fast-format-x written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/BrianSigafoos/fast-format-x on toolchain 2fd6efc32704647e64d3d646d21c4c68eae100e4
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/BrianSigafoos/fast-format-x 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" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded globset v0.4.18
[INFO] [stderr]   Downloaded clap v4.5.53
[INFO] [stderr]   Downloaded env_home v0.1.0
[INFO] [stderr]   Downloaded which v7.0.3
[INFO] [stderr]   Downloaded ureq-proto v0.5.3
[INFO] [stderr]   Downloaded winsafe v0.0.19
[INFO] [stderr]   Downloaded bstr v1.12.1
[INFO] [stderr]   Downloaded clap_builder v4.5.53
[INFO] [stderr]   Downloaded ureq v3.1.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ac62e3aa132e1b94813ab10ac3fbe310f8b44a704fe575fa113bc951f1e478a4
[INFO] running `Command { std: "docker" "start" "-a" "ac62e3aa132e1b94813ab10ac3fbe310f8b44a704fe575fa113bc951f1e478a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ac62e3aa132e1b94813ab10ac3fbe310f8b44a704fe575fa113bc951f1e478a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ac62e3aa132e1b94813ab10ac3fbe310f8b44a704fe575fa113bc951f1e478a4", kill_on_drop: false }`
[INFO] [stdout] ac62e3aa132e1b94813ab10ac3fbe310f8b44a704fe575fa113bc951f1e478a4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 190a75fbebeef0567b3fb3feded951c7c52ab7043ed94866a558e2152edd1c39
[INFO] running `Command { std: "docker" "start" "-a" "190a75fbebeef0567b3fb3feded951c7c52ab7043ed94866a558e2152edd1c39", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling find-msvc-tools v0.1.5
[INFO] [stderr]    Compiling libc v0.2.178
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling simd-adler32 v0.3.8
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling rustls v0.23.35
[INFO] [stderr]    Compiling bytes v1.11.0
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling clap_lex v0.7.6
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling cc v1.2.49
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling webpki-roots v1.0.4
[INFO] [stderr]    Compiling utf-8 v0.7.6
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling env_home v0.1.0
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling bstr v1.12.1
[INFO] [stderr]    Compiling flate2 v1.1.5
[INFO] [stderr]    Compiling clap_builder v4.5.53
[INFO] [stderr]    Compiling indexmap v2.12.1
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling ureq-proto v0.5.3
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling which v7.0.3
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling globset v0.4.18
[INFO] [stderr]    Compiling rustls-webpki v0.103.8
[INFO] [stderr]    Compiling clap v4.5.53
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling ureq v3.1.4
[INFO] [stderr]    Compiling ffx v0.1.26 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 35.79s
[INFO] running `Command { std: "docker" "inspect" "190a75fbebeef0567b3fb3feded951c7c52ab7043ed94866a558e2152edd1c39", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "190a75fbebeef0567b3fb3feded951c7c52ab7043ed94866a558e2152edd1c39", kill_on_drop: false }`
[INFO] [stdout] 190a75fbebeef0567b3fb3feded951c7c52ab7043ed94866a558e2152edd1c39
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 83f13d25ba099cedfff10b826c4508e9ccc0dd64f73432ddac7aebb43a5d1437
[INFO] running `Command { std: "docker" "start" "-a" "83f13d25ba099cedfff10b826c4508e9ccc0dd64f73432ddac7aebb43a5d1437", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling which v7.0.3
[INFO] [stderr]    Compiling tempfile v3.23.0
[INFO] [stderr]    Compiling ffx v0.1.26 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 5.82s
[INFO] running `Command { std: "docker" "inspect" "83f13d25ba099cedfff10b826c4508e9ccc0dd64f73432ddac7aebb43a5d1437", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "83f13d25ba099cedfff10b826c4508e9ccc0dd64f73432ddac7aebb43a5d1437", kill_on_drop: false }`
[INFO] [stdout] 83f13d25ba099cedfff10b826c4508e9ccc0dd64f73432ddac7aebb43a5d1437
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4420b00a67ea3592a504412d26ccb6298702e1ab40c73636f4dbbcf0ba278308
[INFO] running `Command { std: "docker" "start" "-a" "4420b00a67ea3592a504412d26ccb6298702e1ab40c73636f4dbbcf0ba278308", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/ffx-c5399b2a6a2ab2a5)
[INFO] [stdout] 
[INFO] [stdout] running 50 tests
[INFO] [stdout] test config::tests::test_args_defaults_to_empty ... ok
[INFO] [stdout] test config::tests::test_empty_tool_name ... ok
[INFO] [stdout] test config::tests::test_empty_cmd ... ok
[INFO] [stdout] test config::tests::test_empty_tools ... ok
[INFO] [stdout] test config::tests::test_get_args_check_mode_without_check_args ... ok
[INFO] [stdout] test config::tests::test_invalid_version ... ok
[INFO] [stdout] test config::tests::test_exclude_defaults_to_empty ... ok
[INFO] [stdout] test config::tests::test_get_args_normal_mode ... ok
[INFO] [stdout] test config::tests::test_get_args_check_mode_with_check_args ... ok
[INFO] [stdout] test config::tests::test_multiple_tools ... ok
[INFO] [stdout] test config::tests::test_parse_config_with_check_args ... ok
[INFO] [stdout] test config::tests::test_empty_include ... ok
[INFO] [stdout] test config::tests::test_parse_valid_config ... ok
[INFO] [stdout] test exec::tests::test_command_exists_true ... ok
[INFO] [stdout] test git::tests::test_filter_by_prefix_empty ... ok
[INFO] [stdout] test git::tests::test_filter_by_prefix_with_subdir ... ok
[INFO] [stdout] test exec::tests::test_command_exists_false ... ok
[INFO] [stdout] test git::tests::test_prepend_prefix_with_subdir ... ok
[INFO] [stdout] test exec::tests::test_configure_parallelism_can_be_called_multiple_times ... ok
[INFO] [stdout] test git::tests::test_prepend_prefix_empty ... ok
[INFO] [stdout] test exec::tests::test_batch_result_empty_command_when_not_verbose ... ok
[INFO] [stdout] test matcher::tests::test_basic_matching ... ok
[INFO] [stdout] test exec::tests::test_batch_result_contains_command_when_verbose ... ok
[INFO] [stdout] test exec::tests::test_run_tool_with_echo ... ok
[INFO] [stdout] test exec::tests::test_check_mode_falls_back_to_args ... ok
[INFO] [stdout] test matcher::tests::test_exclude_patterns ... ok
[INFO] [stdout] test matcher::tests::test_first_match_wins ... ok
[INFO] [stdout] test exec::tests::test_batching_splits_on_byte_limit ... ok
[INFO] [stdout] test matcher::tests::test_no_matches ... ok
[INFO] [stdout] test tests::exit_code_failure_without_missing_executable_uses_one ... ok
[INFO] [stdout] test tests::exit_code_missing_executable_uses_code_three ... ok
[INFO] [stdout] test tests::exit_code_success_when_all_pass ... ok
[INFO] [stdout] test tests::ensure_required_commands_reports_missing_executables ... ok
[INFO] [stdout] test tests::is_newer_version_detects_major_upgrade ... ok
[INFO] [stdout] test tests::is_newer_version_handles_double_digit_versions ... ok
[INFO] [stdout] test tests::is_newer_version_returns_false_for_older_version ... ok
[INFO] [stdout] test tests::run_outcome_convenience_builders_set_flags ... ok
[INFO] [stdout] test tests::print_planned_work_returns_positions_for_tty ... ok
[INFO] [stdout] test tests::is_newer_version_returns_false_for_same_version ... ok
[INFO] [stdout] test exec::tests::test_batching_includes_oversized_file ... ok
[INFO] [stdout] test exec::tests::test_check_mode_uses_check_args ... ok
[INFO] [stdout] test exec::tests::test_run_tool_failure ... ok
[INFO] [stdout] test tests::cursor_movement_counts_account_for_position ... ok
[INFO] [stdout] test git::tests::test_repo_root_returns_path ... ok
[INFO] [stdout] test git::tests::test_all_files_returns_tracked_files ... ok
[INFO] [stdout] test git::tests::test_staged_files_returns_vec ... ok
[INFO] [stdout] test git::tests::test_changed_files_returns_vec ... ok
[INFO] [stdout] test git::tests::test_diff_files_returns_vec ... ok
[INFO] [stdout] test exec::tests::test_batching_by_bytes ... ok
[INFO] [stdout] test exec::tests::test_run_tool_nonexistent_command ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-34fd5a0a7606443a)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test test_base_flag_conflicts_with_all ... ok
[INFO] [stdout] test test_help_flag ... ok
[INFO] [stdout] test test_base_flag_conflicts_with_staged ... ok
[INFO] [stdout] test test_init_installs_pre_commit_hook ... ok
[INFO] [stdout] test test_invalid_config_version ... ok
[INFO] [stdout] test test_init_creates_config_template ... ok
[INFO] [stdout] test test_changed_files_from_subdirectory_uses_default_config ... ok
[INFO] [stdout] test test_init_from_subdirectory_creates_config_in_current_dir ... ok
[INFO] [stdout] test test_all_flag_from_subdirectory ... ok
[INFO] [stdout] test test_all_flag_from_subdirectory_excludes_parent_files ... ok
[INFO] [stdout] test test_missing_command_error ... ok
[INFO] [stdout] test test_check_mode_shows_failure_details_after_summary ... ok
[INFO] [stdout] test test_failure_outputs_stdout_in_non_verbose_mode ... ok
[INFO] [stdout] test test_check_mode_no_details_on_success ... ok
[INFO] [stdout] test test_version_flag ... ok
[INFO] [stdout] test test_update_subcommand_help ... ok
[INFO] [stdout] test test_all_flag_runs_formatter ... ok
[INFO] [stdout] test test_base_flag_shows_correct_message_when_no_changes ... ok
[INFO] [stdout] test test_missing_config_file ... ok
[INFO] [stdout] test test_base_flag_finds_branch_changes ... ok
[INFO] [stdout] test test_formatter_failure_returns_exit_code_1 ... ok
[INFO] [stdout] test test_all_flag_no_files_matched ... ok
[INFO] [stdout] test test_staged_flag_shows_message_when_empty ... ok
[INFO] [stdout] test test_subdirectory_scoping_with_similar_directory_names ... ok
[INFO] [stdout] test test_no_changed_files_message ... ok
[INFO] [stdout] test test_verbose_flag_shows_command ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "4420b00a67ea3592a504412d26ccb6298702e1ab40c73636f4dbbcf0ba278308", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4420b00a67ea3592a504412d26ccb6298702e1ab40c73636f4dbbcf0ba278308", kill_on_drop: false }`
[INFO] [stdout] 4420b00a67ea3592a504412d26ccb6298702e1ab40c73636f4dbbcf0ba278308