[INFO] fetching crate pez 0.3.0...
[INFO] testing pez-0.3.0 against master#caccb4d0368bd918ef6668af8e13834d07040417 for pr-146098-1
[INFO] extracting crate pez 0.3.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate pez 0.3.0
[INFO] finished tweaking crates.io crate pez 0.3.0
[INFO] tweaked toml for crates.io crate pez 0.3.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate pez 0.3.0 on toolchain caccb4d0368bd918ef6668af8e13834d07040417
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate pez 0.3.0 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" "+caccb4d0368bd918ef6668af8e13834d07040417" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded testing_table v0.3.0
[INFO] [stderr]   Downloaded papergrid v0.17.0
[INFO] [stderr]   Downloaded clap_complete v4.5.58
[INFO] [stderr]   Downloaded wasi v0.14.6+wasi-0.2.4
[INFO] [stderr]   Downloaded tabled_derive v0.11.0
[INFO] [stderr]   Downloaded tabled v0.20.0
[INFO] [stderr]   Downloaded console v0.16.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 43f4c2624ac20620d076b14bdbd2e21952b9c460418c98f20339f898215ed5fd
[INFO] running `Command { std: "docker" "start" "-a" "43f4c2624ac20620d076b14bdbd2e21952b9c460418c98f20339f898215ed5fd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "43f4c2624ac20620d076b14bdbd2e21952b9c460418c98f20339f898215ed5fd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "43f4c2624ac20620d076b14bdbd2e21952b9c460418c98f20339f898215ed5fd", kill_on_drop: false }`
[INFO] [stdout] 43f4c2624ac20620d076b14bdbd2e21952b9c460418c98f20339f898215ed5fd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2f74cc7e5e8d547f73e64c9622069316ef7b5bdadb7441dcb419e0b0ded46e90
[INFO] running `Command { std: "docker" "start" "-a" "2f74cc7e5e8d547f73e64c9622069316ef7b5bdadb7441dcb419e0b0ded46e90", kill_on_drop: false }`
[INFO] [stderr]    Compiling find-msvc-tools v0.1.1
[INFO] [stderr]    Compiling memchr v2.7.5
[INFO] [stderr]    Compiling serde_core v1.0.226
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling zerotrie v0.2.2
[INFO] [stderr]    Compiling tinystr v0.8.1
[INFO] [stderr]    Compiling potential_utf v0.1.3
[INFO] [stderr]    Compiling unicode-width v0.2.1
[INFO] [stderr]    Compiling icu_locale_core v2.0.0
[INFO] [stderr]    Compiling icu_collections v2.0.0
[INFO] [stderr]    Compiling serde v1.0.226
[INFO] [stderr]    Compiling cc v1.2.37
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling serde_derive v1.0.226
[INFO] [stderr]    Compiling proc-macro-error-attr2 v2.0.0
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling clap_builder v4.5.48
[INFO] [stderr]    Compiling icu_provider v2.0.0
[INFO] [stderr]    Compiling icu_properties v2.0.1
[INFO] [stderr]    Compiling icu_normalizer v2.0.0
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling proc-macro-error2 v2.0.1
[INFO] [stderr]    Compiling openssl-sys v0.9.109
[INFO] [stderr]    Compiling libz-sys v1.1.22
[INFO] [stderr]    Compiling libssh2-sys v0.3.1
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling libgit2-sys v0.18.2+1.9.1
[INFO] [stderr]    Compiling regex-automata v0.4.10
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling clap_derive v4.5.47
[INFO] [stderr]    Compiling winnow v0.7.13
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling bytecount v0.6.9
[INFO] [stderr]    Compiling papergrid v0.17.0
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling url v2.5.7
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling toml_datetime v0.7.2
[INFO] [stderr]    Compiling clap v4.5.48
[INFO] [stderr]    Compiling serde_spanned v1.0.2
[INFO] [stderr]    Compiling tabled_derive v0.11.0
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling toml_parser v1.0.3
[INFO] [stderr]    Compiling testing_table v0.3.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling nu-ansi-term v0.50.1
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling toml_writer v1.0.3
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling toml v0.9.7
[INFO] [stderr]    Compiling tabled v0.20.0
[INFO] [stderr]    Compiling tokio v1.47.1
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.20
[INFO] [stderr]    Compiling tempfile v3.23.0
[INFO] [stderr]    Compiling regex v1.11.2
[INFO] [stderr]    Compiling clap_complete v4.5.58
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling console v0.16.1
[INFO] [stderr]    Compiling semver v1.0.27
[INFO] [stderr]    Compiling git2 v0.20.2
[INFO] [stderr]    Compiling pez v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 57s
[INFO] running `Command { std: "docker" "inspect" "2f74cc7e5e8d547f73e64c9622069316ef7b5bdadb7441dcb419e0b0ded46e90", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2f74cc7e5e8d547f73e64c9622069316ef7b5bdadb7441dcb419e0b0ded46e90", kill_on_drop: false }`
[INFO] [stdout] 2f74cc7e5e8d547f73e64c9622069316ef7b5bdadb7441dcb419e0b0ded46e90
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e5ee222f987e9b6c933d1f23f430c6d47d989362fdf77cf78fe214feb710de06
[INFO] running `Command { std: "docker" "start" "-a" "e5ee222f987e9b6c933d1f23f430c6d47d989362fdf77cf78fe214feb710de06", kill_on_drop: false }`
[INFO] [stderr]    Compiling pez v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.64s
[INFO] running `Command { std: "docker" "inspect" "e5ee222f987e9b6c933d1f23f430c6d47d989362fdf77cf78fe214feb710de06", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e5ee222f987e9b6c933d1f23f430c6d47d989362fdf77cf78fe214feb710de06", kill_on_drop: false }`
[INFO] [stdout] e5ee222f987e9b6c933d1f23f430c6d47d989362fdf77cf78fe214feb710de06
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4b28cb81305157e04ef3966d4e14239475325e95dc3e4dc1ff0f2b3e77e31dc5
[INFO] running `Command { std: "docker" "start" "-a" "4b28cb81305157e04ef3966d4e14239475325e95dc3e4dc1ff0f2b3e77e31dc5", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.23s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/pez-55c3e5ffc4e5f775)
[INFO] [stdout] 
[INFO] [stdout] running 61 tests
[INFO] [stdout] test cli::tests::jobs_override_rejects_zero ... ok
[INFO] [stdout] test cli::tests::parse_jobs_override ... ok
[INFO] [stdout] test cmd::install::tests::test_add_existing_plugin_to_config ... ok
[INFO] [stdout] test cmd::init::tests::test_create_config_already_exists ... ok
[INFO] [stdout] test cmd::install::tests::test_repository_handling_without_force ... ok
[INFO] [stdout] test cli::tests::resolve_owner_repo_and_variants ... ok
[INFO] [stdout] test cmd::init::tests::test_create_config ... ok
[INFO] [stdout] test cmd::install::tests::test_add_plugin_in_empty_config ... ok
[INFO] [stdout] test cmd::install::tests::test_handle_existing_repository_with_force ... ok
[INFO] [stdout] test cmd::list::tests::test_display_plugins ... ok
[INFO] [stdout] test cmd::install::tests::test_add_new_plugin_to_existing_config ... ok
[INFO] [stdout] test cmd::prune::tests::test_find_unused_plugins ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune_empty_config_missing_data_dir_with_force ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune_empty_config_missing_data_dir_without_force ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune_empty_config_with_yes ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune_empty_config_without_yes_and_confirm_removal_true ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune_dry_run ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune_empty_config_without_yes_and_confirm_removal_false ... ok
[INFO] [stdout] test cmd::uninstall::tests::read_plugins_from_reader_filters_and_sorts_entries ... ok
[INFO] [stdout] test cmd::prune::tests::test_prune_empty_remove_plugins ... ok
[INFO] [stdout] test cmd::uninstall::tests::normalize_plugins_removes_duplicates_preserving_first_occurrence ... ok
[INFO] [stdout] test cmd::install::tests::install_all_force_reclones_remote_repo ... ok
[INFO] [stdout] test cmd::list::tests::list_outdated_falls_back_when_selector_missing ... ok
[INFO] [stdout] test config::internal_tests::ensure_plugin_for_repo_inserts_default_spec ... ok
[INFO] [stdout] test config::internal_tests::ensure_plugin_from_resolved_inserts_once ... ok
[INFO] [stdout] test config::internal_tests::from_resolved_builds_path_spec ... ok
[INFO] [stdout] test config::internal_tests::from_resolved_builds_repo_spec ... ok
[INFO] [stdout] test config::internal_tests::from_resolved_builds_url_spec ... ok
[INFO] [stdout] test config::internal_tests::one_of_rule_enforced ... ok
[INFO] [stdout] test config::internal_tests::path_requires_absolute_or_tilde ... ok
[INFO] [stdout] test config::internal_tests::repo_to_resolved_latest ... ok
[INFO] [stdout] test config::internal_tests::url_without_scheme_normalizes ... ok
[INFO] [stdout] test config::tests::one_of_rule_enforced ... ok
[INFO] [stdout] test config::tests::path_requires_absolute_or_tilde ... ok
[INFO] [stdout] test config::tests::repo_to_resolved_latest ... ok
[INFO] [stdout] test config::tests::url_without_scheme_normalizes ... ok
[INFO] [stdout] test git::tests::get_latest_remote_commit_from_local_remote_repo ... ok
[INFO] [stdout] test git::tests::pick_tag_for_version_dotted_non_semver_prefix ... ok
[INFO] [stdout] test git::tests::pick_tag_for_version_semver_prefix ... ok
[INFO] [stdout] test models::tests::install_target_resolves_host_metadata ... ok
[INFO] [stdout] test models::tests::plugin_repo_parsing_variants ... ok
[INFO] [stdout] test models::tests::plugin_spec_from_resolved_preserves_host_metadata ... ok
[INFO] [stdout] test resolver::tests::maps_to_selection ... ok
[INFO] [stdout] test resolver::tests::parses_ref_kinds ... ok
[INFO] [stdout] test cmd::list::tests::list_outdated_respects_branch_selector ... ok
[INFO] [stdout] test cmd::list::tests::list_outdated_respects_version_selector ... ok
[INFO] [stdout] test utils::tests::load_jobs_prefers_cli_override ... ok
[INFO] [stdout] test utils::tests::load_pez_config_dir_ignores_target_dir_when_unset ... ok
[INFO] [stdout] test utils::tests::load_pez_config_dir_prefers_config_dir_over_target_dir ... ok
[INFO] [stdout] test utils::tests::test_copy_plugin_files ... ok
[INFO] [stdout] test utils::tests::test_copy_plugin_files_dedupe_skip_on_duplicate ... ok
[INFO] [stdout] test utils::tests::test_copy_plugin_files_deep_directories ... ok
[INFO] [stdout] test utils::tests::test_copy_plugin_files_skips_non_file_entries ... ok
[INFO] [stdout] test cmd::list::tests::list_outdated_skips_tag_pinned_plugin ... ok
[INFO] [stdout] test cmd::uninstall::tests::test_uninstall_honors_target_dir_override ... ok
[INFO] [stdout] test cmd::uninstall::tests::test_uninstall_logs_repo_missing_without_force ... ok
[INFO] [stdout] test cmd::uninstall::tests::test_uninstall_removes_repo_and_files_and_updates_lock_and_config ... ok
[INFO] [stdout] test utils::tests::load_fish_config_dir_honors_target_dir ... ok
[INFO] [stdout] test utils::tests::load_jobs_falls_back_to_env_when_override_absent ... ok
[INFO] [stdout] test cmd::upgrade::tests::test_upgrade_logs_already_up_to_date ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 61 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.80s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "4b28cb81305157e04ef3966d4e14239475325e95dc3e4dc1ff0f2b3e77e31dc5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4b28cb81305157e04ef3966d4e14239475325e95dc3e4dc1ff0f2b3e77e31dc5", kill_on_drop: false }`
[INFO] [stdout] 4b28cb81305157e04ef3966d4e14239475325e95dc3e4dc1ff0f2b3e77e31dc5