[INFO] cloning repository https://github.com/huddlz-hq/force
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/huddlz-hq/force" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhuddlz-hq%2Fforce", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhuddlz-hq%2Fforce'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 3b1da2fcf00fe45ebadfe6f20d23c297cf587001
[INFO] testing huddlz-hq/force against 1.98.0-beta.1 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhuddlz-hq%2Fforce" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/huddlz-hq/force
[INFO] finished tweaking git repo https://github.com/huddlz-hq/force
[INFO] tweaked toml for git repo https://github.com/huddlz-hq/force written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/huddlz-hq/force on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/huddlz-hq/force 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" "+1.98.0-beta.1" "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
[ERROR] error running command: no output for 300 seconds
[INFO] testing huddlz-hq/force against 1.98.0-beta.1 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhuddlz-hq%2Fforce" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/huddlz-hq/force
[INFO] finished tweaking git repo https://github.com/huddlz-hq/force
[INFO] tweaked toml for git repo https://github.com/huddlz-hq/force written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/huddlz-hq/force on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/huddlz-hq/force 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" "+1.98.0-beta.1" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded assert_cmd v2.1.1
[INFO] [stderr]   Downloaded zerocopy-derive v0.8.30
[INFO] [stderr]   Downloaded zerocopy v0.8.30
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e
[INFO] running `Command { std: "docker" "start" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling toml_writer v1.0.4
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling serde_spanned v1.0.3
[INFO] [stderr]    Compiling clap_builder v4.5.53
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling toml_datetime v0.7.3
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling toml_parser v1.0.4
[INFO] [stderr]    Compiling toml v0.9.8
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling clap v4.5.53
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling force v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.51s
[INFO] running `Command { std: "docker" "inspect" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling zerocopy v0.8.30
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling predicates-core v1.0.9
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling assert_cmd v2.1.1
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling predicates-tree v1.0.12
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling tempfile v3.23.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.9.0
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling bstr v1.12.1
[INFO] [stderr]    Compiling predicates v3.1.3
[INFO] [stderr]    Compiling force v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 19.37s
[INFO] running `Command { std: "docker" "inspect" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.13s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/force-d4bc6cc2b1122698)
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test config::tests::test_force_config_defaults ... ok
[INFO] [stdout] test config::tests::test_parse_empty_config ... ok
[INFO] [stdout] test config::tests::test_parse_minimal_toml ... ok
[INFO] [stdout] test config::tests::test_parse_missing_category_fails ... ok
[INFO] [stdout] test config::tests::test_parse_missing_run_fails ... ok
[INFO] [stdout] test config::tests::test_parse_full_toml ... ok
[INFO] [stdout] test config::tests::test_parse_missing_up_fails ... ok
[INFO] [stdout] test config::tests::test_parse_negative_priority ... ok
[INFO] [stdout] test config::tests::test_parse_partial_config ... ok
[INFO] [stdout] test config::tests::test_parse_full_config ... ok
[INFO] [stdout] test env::tests::test_force_env_to_env_vars ... ok
[INFO] [stdout] test env::tests::test_hash_is_in_range ... ok
[INFO] [stdout] test env::tests::test_slugify ... ok
[INFO] [stdout] test env::tests::test_slugify_empty ... ok
[INFO] [stdout] test env::tests::test_hash_is_deterministic ... ok
[INFO] [stdout] test env::tests::test_slugify_special_chars ... ok
[INFO] [stdout] test state::tests::test_list_empty_sessions ... ok
[INFO] [stdout] test state::tests::test_add_and_list_sessions ... ok
[INFO] [stdout] test state::tests::test_add_duplicate_session ... ok
[INFO] [stdout] test state::tests::test_simple_hash_different_for_different_paths ... ok
[INFO] [stdout] test state::tests::test_remove_session ... ok
[INFO] [stdout] test env::tests::test_force_env_db_name ... ok
[INFO] [stdout] test state::tests::test_simple_hash_deterministic ... ok
[INFO] [stdout] test env::tests::test_hash_empty_string ... ok
[INFO] [stdout] test state::tests::test_state_dir_is_absolute_path ... ok
[INFO] [stdout] test worktree::tests::test_resolve_path_absolute ... ok
[INFO] [stdout] test worktree::tests::test_resolve_path_relative ... ok
[INFO] [stdout] test worktree::tests::test_expand_path_template ... ok
[INFO] [stdout] test env::tests::prop_slugify_only_valid_chars ... ok
[INFO] [stdout] test env::tests::prop_hash_is_deterministic ... ok
[INFO] [stdout] test env::tests::prop_slugify_is_idempotent ... ok
[INFO] [stdout] test env::tests::prop_port_in_valid_range ... ok
[INFO] [stdout] test env::tests::prop_slugify_same_length ... ok
[INFO] [stdout] test env::tests::prop_hash_always_in_range ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/config_discovery.rs (/opt/rustwide/target/debug/deps/config_discovery-c4164f42c86ddf9a)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_error_when_no_force_dir ... ok
[INFO] [stdout] test test_default_config_when_no_config_toml ... ok
[INFO] [stdout] test test_config_toml_custom_path ... ok
[INFO] [stdout] test test_finds_force_dir_in_grandparent ... ok
[INFO] [stdout] test test_finds_force_dir_in_current ... ok
[INFO] [stdout] test test_finds_force_dir_in_parent ... ok
[INFO] [stdout] test test_config_toml_partial ... ok
[INFO] [stdout] test test_uses_closest_force_dir ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/down_command.rs (/opt/rustwide/target/debug/deps/down_command-d545134ab3f84edf)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_down_reverses_priority_order ... ok
[INFO] [stdout] test test_down_preserves_worktree_when_configured ... ok
[INFO] [stdout] test test_down_with_alias ... ok
[INFO] [stdout] test test_down_with_single_script ... ok
[INFO] [stdout] test test_down_removes_worktree ... ok
[INFO] [stdout] test test_down_skips_scripts_without_down_section ... ok
[INFO] [stdout] test test_down_sets_env_vars ... ok
[INFO] [stdout] test test_down_runs_scripts_in_reverse_order ... ok
[INFO] [stderr]      Running tests/init_command.rs (/opt/rustwide/target/debug/deps/init_command-49adfc357fcdb9ae)
[INFO] [stdout] test test_down_fails_on_script_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_init_creates_config_and_example_scripts ... ok
[INFO] [stdout] test test_init_shows_next_steps ... ok
[INFO] [stdout] test test_init_fails_if_force_dir_exists ... ok
[INFO] [stdout] test test_init_creates_force_directory ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ls_command.rs (/opt/rustwide/target/debug/deps/ls_command-8f02d22c43c18d4b)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_ls_fails_without_force_dir ... ok
[INFO] [stdout] test test_ls_shows_no_sessions_initially ... ok
[INFO] [stdout] test test_ls_removes_session_after_down ... ok
[INFO] [stdout] test test_ls_shows_session_after_up ... ok
[INFO] [stdout] test test_ls_shows_multiple_sessions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/script_execution.rs (/opt/rustwide/target/debug/deps/script_execution-32676fc95c80e362)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_scripts_run_in_filename_order ... ok
[INFO] [stdout] test test_full_sorting_order ... ok
[INFO] [stdout] test test_scripts_run_in_priority_order ... ok
[INFO] [stdout] test test_force_worktree_env_var_matches_pwd ... ok
[INFO] [stdout] test test_script_receives_env_vars ... ok
[INFO] [stdout] test test_scripts_run_in_category_order ... ok
[INFO] [stdout] test test_different_features_get_different_ports ... ok
[INFO] [stdout] test test_scripts_run_in_worktree_directory ... ok
[INFO] [stdout] test test_deterministic_port_for_same_feature ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/up_command.rs (/opt/rustwide/target/debug/deps/up_command-1678a14e64d2081d)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_up_fails_without_force_dir ... ok
[INFO] [stdout] test test_up_fails_on_invalid_toml ... ok
[INFO] [stdout] test test_up_with_single_script ... ok
[INFO] [stdout] test test_up_shows_script_description ... ok
[INFO] [stdout] test test_up_with_alias ... ok
[INFO] [stdout] test test_up_fails_on_missing_category ... ok
[INFO] [stdout] test test_up_sets_all_env_vars ... ok
[INFO] [stdout] test test_up_fails_on_script_error ... ok
[INFO] [stdout] test test_up_creates_worktree_with_custom_path ... ok
[INFO] [stdout] test test_up_reuses_existing_worktree ... ok
[INFO] [stdout] test test_up_creates_worktree ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.28s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e", kill_on_drop: false }`
[INFO] [stdout] 2cab3b88f95ca6cd13e9f7c85e993a600efcd6cf0a4fa52d0f973020bc1a5d2e
