[INFO] cloning repository https://github.com/assapir/golem
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/assapir/golem" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fassapir%2Fgolem", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fassapir%2Fgolem'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 1b288ad801047af29a381af923f78453829b5f7f
[INFO] testing assapir/golem against beta-2026-04-21 for beta-1.96-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fassapir%2Fgolem" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/assapir/golem
[INFO] finished tweaking git repo https://github.com/assapir/golem
[INFO] tweaked toml for git repo https://github.com/assapir/golem written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/assapir/golem on toolchain beta-2026-04-21
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-04-21" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/assapir/golem 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" "+beta-2026-04-21" "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-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 20fa42d07643e745cf675dbf7caad16b1d0d8cdc0e394c96ae54879d786938b0
[INFO] running `Command { std: "docker" "start" "-a" "20fa42d07643e745cf675dbf7caad16b1d0d8cdc0e394c96ae54879d786938b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "20fa42d07643e745cf675dbf7caad16b1d0d8cdc0e394c96ae54879d786938b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "20fa42d07643e745cf675dbf7caad16b1d0d8cdc0e394c96ae54879d786938b0", kill_on_drop: false }`
[INFO] [stdout] 20fa42d07643e745cf675dbf7caad16b1d0d8cdc0e394c96ae54879d786938b0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 136ff0c38cc35380facea0c31d81e8aca98a717a75372c3534795a795fcb7ad6
[INFO] running `Command { std: "docker" "start" "-a" "136ff0c38cc35380facea0c31d81e8aca98a717a75372c3534795a795fcb7ad6", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling ipnet v2.12.0
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling is-docker v0.2.0
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling is-wsl v0.4.0
[INFO] [stderr]    Compiling fd-lock v4.0.4
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling unicode-width v0.2.2
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling home v0.5.12
[INFO] [stderr]    Compiling pathdiff v0.2.3
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling hashlink v0.11.0
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling cc v1.2.57
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling open v5.3.3
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling rand v0.10.0
[INFO] [stderr]    Compiling cmake v0.1.57
[INFO] [stderr]    Compiling aws-lc-sys v0.38.0
[INFO] [stderr]    Compiling libsqlite3-sys v0.36.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling rustyline v17.0.2
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.2
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling rusqlite v0.38.0
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling aws-lc-rs v1.16.1
[INFO] [stderr]    Compiling rustls v0.23.37
[INFO] [stderr]    Compiling rustls-webpki v0.103.9
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling rustls-platform-verifier v0.6.2
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling reqwest v0.13.2
[INFO] [stderr]    Compiling golem v0.28.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 19s
[INFO] running `Command { std: "docker" "inspect" "136ff0c38cc35380facea0c31d81e8aca98a717a75372c3534795a795fcb7ad6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "136ff0c38cc35380facea0c31d81e8aca98a717a75372c3534795a795fcb7ad6", kill_on_drop: false }`
[INFO] [stdout] 136ff0c38cc35380facea0c31d81e8aca98a717a75372c3534795a795fcb7ad6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8d643c33522ca68a79a5e9bb0d8fe61466648ba0fb75b2ae1dd098f2be26e752
[INFO] running `Command { std: "docker" "start" "-a" "8d643c33522ca68a79a5e9bb0d8fe61466648ba0fb75b2ae1dd098f2be26e752", kill_on_drop: false }`
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling golem v0.28.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 11.35s
[INFO] running `Command { std: "docker" "inspect" "8d643c33522ca68a79a5e9bb0d8fe61466648ba0fb75b2ae1dd098f2be26e752", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d643c33522ca68a79a5e9bb0d8fe61466648ba0fb75b2ae1dd098f2be26e752", kill_on_drop: false }`
[INFO] [stdout] 8d643c33522ca68a79a5e9bb0d8fe61466648ba0fb75b2ae1dd098f2be26e752
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9edfef08149028f4b2c2d3b306efe80d84f2c255474763d609f96eeca9f61f88
[INFO] running `Command { std: "docker" "start" "-a" "9edfef08149028f4b2c2d3b306efe80d84f2c255474763d609f96eeca9f61f88", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.40s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/golem-8bfb1ddf9af76dd7)
[INFO] [stdout] 
[INFO] [stdout] running 194 tests
[INFO] [stdout] test auth::google_oauth::tests::expiry_with_buffer_normal ... ok
[INFO] [stdout] test auth::google_oauth::tests::pkce_verifier_and_challenge_differ ... ok
[INFO] [stdout] test auth::google_oauth::tests::pkce_verifier_is_43_chars ... ok
[INFO] [stdout] test auth::google_oauth::tests::pkce_wrong_verifier_fails ... ok
[INFO] [stdout] test auth::google_oauth::tests::pkce_challenge_is_43_chars ... ok
[INFO] [stdout] test auth::google_oauth::tests::urldecode_passthrough ... ok
[INFO] [stdout] test auth::oauth::tests::authorize_url_has_required_params ... ok
[INFO] [stdout] test auth::google_oauth::tests::urldecode_plus_as_space ... ok
[INFO] [stdout] test auth::oauth::tests::authorize_url_verifier_is_valid_pkce ... ok
[INFO] [stdout] test auth::oauth::tests::credentials_not_expired_when_future ... ok
[INFO] [stdout] test auth::oauth::tests::pkce_challenge_is_43_chars ... ok
[INFO] [stdout] test auth::oauth::tests::credentials_expired_when_zero ... ok
[INFO] [stdout] test auth::google_oauth::tests::urldecode_basic ... ok
[INFO] [stdout] test auth::google_oauth::tests::state_is_random_each_time ... ok
[INFO] [stdout] test auth::oauth::tests::pkce_is_random_each_time ... ok
[INFO] [stdout] test auth::google_oauth::tests::urlencoded_encodes_slashes ... ok
[INFO] [stdout] test auth::oauth::tests::credentials_expired_when_past ... ok
[INFO] [stdout] test auth::oauth::tests::pkce_verifier_and_challenge_differ ... ok
[INFO] [stdout] test auth::google_oauth::tests::expiry_with_buffer_small_value_no_underflow ... ok
[INFO] [stdout] test auth::oauth::tests::pkce_wrong_verifier_fails ... ok
[INFO] [stdout] test auth::oauth::tests::urlencoded_preserves_unreserved ... ok
[INFO] [stdout] test auth::oauth::tests::urlencoded_encodes_spaces ... ok
[INFO] [stdout] test banner::tests::print_banner_does_not_panic ... ok
[INFO] [stdout] test banner::tests::print_banner_no_providers ... ok
[INFO] [stdout] test auth::oauth::tests::urlencoded_encodes_special_chars ... ok
[INFO] [stdout] test banner::tests::print_banner_multiple_providers ... ok
[INFO] [stdout] test banner::tests::print_session_summary_zero_tokens ... ok
[INFO] [stdout] test auth::google_oauth::tests::pkce_challenge_matches_verifier ... ok
[INFO] [stdout] test auth::google_oauth::tests::pkce_is_random_each_time ... ok
[INFO] [stdout] test banner::tests::print_session_summary_with_tokens ... ok
[INFO] [stdout] test commands::help::tests::has_aliases ... ok
[INFO] [stdout] test auth::google_oauth::tests::urlencoded_preserves_unreserved ... ok
[INFO] [stdout] test auth::oauth::tests::urlencoded_preserves_alphanumeric ... ok
[INFO] [stdout] test auth::google_oauth::tests::prepare_authorize_binds_to_port ... ok
[INFO] [stdout] test auth::google_oauth::tests::prepare_authorize_returns_valid_url ... ok
[INFO] [stdout] test auth::google_oauth::tests::urlencoded_encodes_special_chars ... ok
[INFO] [stdout] test auth::google_oauth::tests::state_is_non_empty ... ok
[INFO] [stdout] test commands::debug::tests::metadata ... ok
[INFO] [stdout] test commands::model::tests::metadata ... ok
[INFO] [stdout] test commands::model::tests::provider_display_name_known ... ok
[INFO] [stdout] test commands::model::tests::find_other_authenticated_empty_db ... ok
[INFO] [stdout] test commands::model::tests::provider_display_name_unknown_returns_id ... ok
[INFO] [stdout] test commands::model::tests::returns_handled_without_engine ... ok
[INFO] [stdout] test commands::logout::tests::returns_auth_changed_when_no_credentials ... ok
[INFO] [stdout] test auth::oauth::tests::pkce_challenge_matches_verifier ... ok
[INFO] [stdout] test commands::new::tests::metadata ... ok
[INFO] [stdout] test commands::quit::tests::has_aliases ... ok
[INFO] [stdout] test commands::new::tests::returns_handled_without_engine ... ok
[INFO] [stdout] test commands::tests::all_builtins_registered ... ok
[INFO] [stdout] test commands::tests::format_label_no_aliases ... ok
[INFO] [stdout] test commands::tests::format_label_with_aliases ... ok
[INFO] [stdout] test commands::tests::no_duplicate_triggers ... ok
[INFO] [stdout] test commands::tests::help_text_includes_aliases ... ok
[INFO] [stdout] test commands::tests::help_text_includes_all_commands ... ok
[INFO] [stdout] test commands::tests::parse_menu_choice_non_numeric ... ok
[INFO] [stdout] test commands::tests::parse_menu_choice_max_one ... ok
[INFO] [stdout] test commands::tests::non_command_passes_through ... ok
[INFO] [stdout] test commands::tests::parse_menu_choice_negative ... ok
[INFO] [stdout] test commands::login::tests::metadata ... ok
[INFO] [stdout] test auth::oauth::tests::pkce_verifier_is_43_chars ... ok
[INFO] [stdout] test commands::tests::parse_menu_choice_out_of_range ... ok
[INFO] [stdout] test auth::google_oauth::tests::urlencoded_preserves_alphanumeric ... ok
[INFO] [stdout] test commands::tests::parse_menu_choice_valid ... ok
[INFO] [stdout] test commands::logout::tests::find_authenticated_provider_returns_none_when_empty ... ok
[INFO] [stdout] test commands::quit::tests::returns_quit ... ok
[INFO] [stdout] test commands::tests::state_changed_variant_carries_value ... ok
[INFO] [stdout] test commands::tests::state_changed_provider_variant_carries_value ... ok
[INFO] [stdout] test commands::tests::unknown_slash_command_is_handled ... ok
[INFO] [stdout] test commands::logout::tests::removes_stored_credential ... ok
[INFO] [stdout] test commands::tokens::tests::returns_handled_zero ... ok
[INFO] [stdout] test commands::tokens::tests::returns_handled_with_usage ... ok
[INFO] [stdout] test commands::tools::tests::returns_handled_empty ... ok
[INFO] [stdout] test commands::tools::tests::returns_handled_with_tools ... ok
[INFO] [stdout] test commands::whoami::tests::metadata ... ok
[INFO] [stdout] test commands::whoami::tests::returns_handled ... ok
[INFO] [stdout] test config::tests::get_returns_none_for_missing_key ... ok
[INFO] [stdout] test config::tests::multiple_keys_independent ... ok
[INFO] [stdout] test config::tests::set_and_get ... ok
[INFO] [stdout] test consts::tests::consts_are_non_empty ... ok
[INFO] [stdout] test consts::tests::consts_from_cargo_toml ... ok
[INFO] [stdout] test config::tests::remove_nonexistent_is_ok ... ok
[INFO] [stdout] test consts::tests::default_history_path_is_in_golem_dir ... ok
[INFO] [stdout] test consts::tests::format_number_millions ... ok
[INFO] [stdout] test consts::tests::format_number_single_digit ... ok
[INFO] [stdout] test config::tests::set_overwrites_existing ... ok
[INFO] [stdout] test config::tests::remove_deletes_key ... ok
[INFO] [stdout] test consts::tests::format_number_thousands ... ok
[INFO] [stdout] test consts::tests::format_number_zero ... ok
[INFO] [stdout] test debug::tests::clone_shares_state ... ok
[INFO] [stdout] test debug::tests::default_is_off ... ok
[INFO] [stdout] test debug::tests::enable_and_disable ... ok
[INFO] [stdout] test debug::tests::new_respects_initial_state ... ok
[INFO] [stdout] test events::tests::emit_reaches_subscriber ... ok
[INFO] [stdout] test events::tests::emit_with_subscriber_returns_count ... ok
[INFO] [stdout] test events::tests::emit_without_subscribers_returns_zero ... ok
[INFO] [stdout] test events::tests::multiple_subscribers_receive_event ... ok
[INFO] [stdout] test prompts::react::tests::includes_agents_md_when_present ... ok
[INFO] [stdout] test prompts::react::tests::includes_session_context_with_history ... ok
[INFO] [stdout] test prompts::react::tests::emphasizes_json_only_output ... ok
[INFO] [stdout] test prompts::react::tests::includes_args_matching_rule ... ok
[INFO] [stdout] test prompts::react::tests::includes_tool_list ... ok
[INFO] [stdout] test prompts::react::tests::has_both_response_formats ... ok
[INFO] [stdout] test prompts::react::tests::includes_all_rules ... ok
[INFO] [stdout] test consts::tests::format_number_small ... ok
[INFO] [stdout] test prompts::react::tests::omits_agents_md_section_when_missing ... ok
[INFO] [stdout] test debug::tests::toggle_flips_state ... ok
[INFO] [stdout] test prompts::react::tests::json_examples_are_pretty_printed ... ok
[INFO] [stdout] test prompts::react::tests::default_prompt_has_no_session_context ... ok
[INFO] [stdout] test prompts::react::tests::no_tool_section_when_empty ... ok
[INFO] [stdout] test provider::tests::all_login_providers_have_display_names ... ok
[INFO] [stdout] test provider::tests::all_login_providers_have_env_vars ... ok
[INFO] [stdout] test commands::tests::plugin_command_works ... ok
[INFO] [stdout] test commands::logout::tests::find_authenticated_provider_skips_excluded ... ok
[INFO] [stdout] test prompts::react::tests::includes_direct_answer_guidance ... ok
[INFO] [stdout] test commands::logout::tests::find_authenticated_provider_finds_other ... ok
[INFO] [stdout] test provider::tests::all_login_providers_have_unique_ids ... ok
[INFO] [stdout] test prompts::react::tests::mentions_react ... ok
[INFO] [stdout] test prompts::react::tests::no_markdown_fences ... ok
[INFO] [stdout] test provider::tests::all_login_providers_excludes_human ... ok
[INFO] [stdout] test debug::tests::toggle_returns_new_state ... ok
[INFO] [stdout] test prompts::react::tests::no_session_context_without_history ... ok
[INFO] [stdout] test provider::tests::all_login_providers_includes_anthropic_and_google ... ok
[INFO] [stdout] test provider::tests::all_login_providers_is_non_empty ... ok
[INFO] [stdout] test prompts::react::tests::instruction_candidates_include_other_agent_files ... ok
[INFO] [stdout] test provider::tests::all_login_providers_matches_provider_enum ... ok
[INFO] [stdout] test provider::tests::provider_config_by_id_round_trips ... ok
[INFO] [stdout] test spinner::tests::frames_are_non_empty ... ok
[INFO] [stdout] test spinner::tests::frames_are_single_braille_chars ... ok
[INFO] [stdout] test thinker::anthropic::tests::build_messages_ignores_answer_entries ... ok
[INFO] [stdout] test provider::tests::provider_config_by_id_returns_none_for_unknown ... ok
[INFO] [stdout] test thinker::anthropic::tests::build_messages_includes_session_history ... ok
[INFO] [stdout] test thinker::anthropic::tests::build_messages_session_history_before_current_task ... ok
[INFO] [stdout] test provider::tests::provider_auth_status_unknown_provider ... ok
[INFO] [stdout] test thinker::anthropic::tests::api_key_not_detected_as_oauth ... ok
[INFO] [stdout] test spinner::tests::spinner_immediate_stop ... ok
[INFO] [stdout] test thinker::anthropic::tests::parse_models_handles_null_created_at ... ok
[INFO] [stdout] test thinker::anthropic::tests::build_messages_with_error_result ... ok
[INFO] [stdout] test thinker::anthropic::tests::build_messages_with_iteration_history ... ok
[INFO] [stdout] test thinker::anthropic::tests::oauth_token_detected ... ok
[INFO] [stdout] test provider::tests::all_provider_statuses_includes_display_names ... ok
[INFO] [stdout] test thinker::anthropic::tests::parse_models_empty_response ... ok
[INFO] [stdout] test provider::tests::provider_auth_status_not_authenticated ... ok
[INFO] [stdout] test thinker::anthropic::tests::build_messages_task_only ... ok
[INFO] [stdout] test provider::tests::all_provider_statuses_returns_all_providers ... ok
[INFO] [stdout] test thinker::anthropic::tests::parse_models_sorted_by_id ... ok
[INFO] [stdout] test thinker::gemini::tests::build_contents_ignores_answer_entries ... ok
[INFO] [stdout] test thinker::gemini::tests::build_contents_includes_session_history ... ok
[INFO] [stdout] test thinker::gemini::tests::build_contents_session_history_before_current_task ... ok
[INFO] [stdout] test thinker::anthropic::tests::parse_models_filters_non_model_types ... ok
[INFO] [stdout] test provider::tests::is_authenticated_false_without_credentials ... ok
[INFO] [stdout] test thinker::anthropic::tests::parse_models_maps_fields_correctly ... ok
[INFO] [stdout] test thinker::gemini::tests::build_contents_with_iteration_history ... ok
[INFO] [stdout] test thinker::gemini::tests::build_contents_task_only ... ok
[INFO] [stdout] test thinker::gemini::tests::parse_models_empty_response ... ok
[INFO] [stdout] test thinker::tests::extract_json_no_closing_fence_still_extracts ... ok
[INFO] [stdout] test thinker::gemini::tests::parse_models_sorted_by_id ... ok
[INFO] [stdout] test thinker::tests::extract_json_plain ... ok
[INFO] [stdout] test thinker::gemini::tests::build_contents_with_error_result ... ok
[INFO] [stdout] test thinker::gemini::tests::parse_models_filters_non_generate_models ... ok
[INFO] [stdout] test thinker::gemini::tests::build_contents_uses_model_role ... ok
[INFO] [stdout] test thinker::gemini::tests::parse_models_strips_prefix ... ok
[INFO] [stdout] test thinker::tests::extract_json_with_json_fence ... ok
[INFO] [stdout] test thinker::tests::extract_json_with_plain_fence ... ok
[INFO] [stdout] test thinker::gemini::tests::parse_models_no_created_at ... ok
[INFO] [stdout] test thinker::tests::parse_answer_takes_priority_over_action ... ok
[INFO] [stdout] test thinker::tests::extract_json_trims_whitespace ... ok
[INFO] [stdout] test thinker::tests::parse_action_response ... ok
[INFO] [stdout] test thinker::tests::extract_json_prose_before_and_after ... ok
[INFO] [stdout] test thinker::tests::extract_json_prose_before_json ... ok
[INFO] [stdout] test thinker::tests::extract_json_prose_with_nested_braces ... ok
[INFO] [stdout] test thinker::gemini::tests::parse_models_maps_display_name ... ok
[INFO] [stdout] test thinker::tests::parse_finish_response ... ok
[INFO] [stdout] test thinker::tests::parse_empty_calls_array_fails ... ok
[INFO] [stdout] test thinker::tests::parse_invalid_json_fails ... ok
[INFO] [stdout] test config::tests::persists_to_file ... ok
[INFO] [stdout] test thinker::tests::parse_parallel_calls ... ok
[INFO] [stdout] test thinker::tests::token_usage_add_accumulates ... ok
[INFO] [stdout] test thinker::tests::token_usage_add_zero_is_noop ... ok
[INFO] [stdout] test thinker::tests::token_usage_default_is_zero ... ok
[INFO] [stdout] test thinker::tests::parse_missing_thought_defaults_to_empty ... ok
[INFO] [stdout] test thinker::tests::parse_prose_before_json_succeeds ... ok
[INFO] [stdout] test thinker::tests::parse_no_action_no_answer_fails ... ok
[INFO] [stdout] test thinker::tests::parse_fenced_json ... ok
[INFO] [stdout] test thinker::tests::parse_non_string_arg_values_serialized ... ok
[INFO] [stdout] test thinker::tests::token_usage_total ... ok
[INFO] [stdout] test tools::exit::tests::name_is_exit ... ok
[INFO] [stdout] test tools::exit::tests::default_impl_works ... ok
[INFO] [stdout] test tools::exit::tests::description_mentions_quit ... ok
[INFO] [stdout] test tools::exit::tests::not_triggered_initially ... ok
[INFO] [stdout] test tools::exit::tests::reset_clears_flag ... ok
[INFO] [stdout] test tools::exit::tests::triggered_after_execute ... ok
[INFO] [stdout] test provider::tests::provider_auth_status_with_credentials ... ok
[INFO] [stdout] test provider::tests::is_authenticated_true_with_credentials ... ok
[INFO] [stdout] test spinner::tests::spinner_starts_and_stops_without_panic ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/golem-100d32557a81b53c)
[INFO] [stdout] test result: ok. 194 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.26s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/auth_test.rs (/opt/rustwide/target/debug/deps/auth_test-56abee94293519cf)
[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] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test authorize_url_pkce_is_valid ... ok
[INFO] [stdout] test authorize_url_is_unique_per_call ... ok
[INFO] [stdout] test get_api_key_credential_takes_priority_over_env ... ok
[INFO] [stdout] test login_rejects_empty_provider ... ok
[INFO] [stdout] test login_rejects_unsupported_provider ... ok
[INFO] [stdout] test logout_error_includes_context ... ok
[INFO] [stdout] test get_api_key_from_oauth_non_expired ... ok
[INFO] [stdout] test get_api_key_falls_back_to_env ... ok
[INFO] [stdout] test remove_deletes_credential ... ok
[INFO] [stdout] test remove_nonexistent_is_ok ... ok
[INFO] [stdout] test get_api_key_returns_none_when_nothing ... ok
[INFO] [stdout] test get_api_key_from_api_key_credential ... ok
[INFO] [stdout] test multiple_providers_independent ... ok
[INFO] [stdout] test logout_succeeds_when_no_credentials_exist ... ok
[INFO] [stdout] test set_and_get_oauth ... ok
[INFO] [stdout] test remove_one_preserves_others ... ok
[INFO] [stdout] test get_returns_none_when_empty ... ok
[INFO] [stdout] test set_overwrites_existing ... ok
[INFO] [stdout] test set_and_get_api_key ... ok
[INFO] [stdout] test get_api_key_ignores_empty_env ... ok
[INFO] [stdout] test file_based_storage_persists ... ok
[INFO] [stdout] test logout_removes_credentials ... ok
[INFO] [stdout] test logout_preserves_other_providers ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/login_test.rs (/opt/rustwide/target/debug/deps/login_test-c1674bfdf5e19978)
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test build_provider_by_id_with_model_override ... ok
[INFO] [stdout] test build_provider_anthropic ... ok
[INFO] [stdout] test build_provider_by_id_human_returns_error ... ok
[INFO] [stdout] test build_provider_by_id_unknown_returns_error ... ok
[INFO] [stdout] test build_provider_by_id_returns_anthropic ... ok
[INFO] [stdout] test build_provider_human_ignores_model ... ok
[INFO] [stdout] test login_command_appears_in_help ... ok
[INFO] [stdout] test login_command_is_registered ... ok
[INFO] [stdout] test login_providers_excludes_human ... ok
[INFO] [stdout] test login_providers_ids_are_unique ... ok
[INFO] [stdout] test build_provider_detects_env_var ... ok
[INFO] [stdout] test login_providers_includes_all_configurable_variants ... ok
[INFO] [stdout] test login_command_handles_eof_gracefully ... ok
[INFO] [stdout] test build_provider_uses_cli_model_override ... ok
[INFO] [stdout] test build_provider_by_id_returns_google ... ok
[INFO] [stdout] test build_provider_google ... ok
[INFO] [stdout] test build_provider_by_id_detects_auth_status ... ok
[INFO] [stdout] test build_provider_by_id_uses_default_model_not_config_db ... ok
[INFO] [stdout] test build_provider_cli_model_overrides_config_db ... ok
[INFO] [stdout] test build_provider_reads_model_from_config_db ... ok
[INFO] [stdout] test build_provider_detects_oauth_credentials ... ok
[INFO] [stdout] test logout_one_provider_preserves_others ... ok
[INFO] [stdout] test build_provider_detects_api_key_credentials ... ok
[INFO] [stdout] test logout_clears_credentials_for_each_login_provider ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/memory_test.rs (/opt/rustwide/target/debug/deps/memory_test-2878fdded715f17d)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test display_iteration_with_success_and_error ... ok
[INFO] [stdout] test display_iteration_truncates_long_output ... ok
[INFO] [stdout] test session_store_and_retrieve ... ok
[INFO] [stdout] test session_history_preserves_order ... ok
[INFO] [stdout] test session_history_respects_limit ... ok
[INFO] [stdout] test store_and_retrieve_history ... ok
[INFO] [stdout] test display_answer ... ok
[INFO] [stdout] test history_preserves_order ... ok
[INFO] [stdout] test session_clear_removes_all ... ok
[INFO] [stdout] test clear_removes_all_entries ... ok
[INFO] [stdout] test session_clear_does_not_affect_task_memory ... ok
[INFO] [stdout] test recall_finds_matching_entries ... ok
[INFO] [stdout] test task_clear_does_not_affect_session_memory ... ok
[INFO] [stdout] test session_persists_to_file ... ok
[INFO] [stdout] test display_task ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/react_test.rs (/opt/rustwide/target/debug/deps/react_test-6732db81a10e9885)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test session_entry_stored_after_task ... ok
[INFO] [stdout] test engine_models_returns_empty_for_mock ... ok
[INFO] [stdout] test engine_model_returns_mock_default ... ok
[INFO] [stdout] test finish_immediately ... ok
[INFO] [stdout] test multi_task_session_builds_history ... ok
[INFO] [stdout] test memory_cleared_between_runs ... ok
[INFO] [stdout] test clear_session_resets_history ... ok
[INFO] [stdout] test session_usage_zero_when_no_tokens ... ok
[INFO] [stdout] test config_model_persists_to_file ... ok
[INFO] [stdout] test single_tool_call_then_finish ... ok
[INFO] [stdout] test unknown_tool_produces_error_observation ... ok
[INFO] [stdout] test engine_set_model_updates_thinker ... ok
[INFO] [stdout] test session_usage_accumulates_across_runs ... ok
[INFO] [stdout] test swap_thinker_at_runtime ... ok
[INFO] [stdout] test config_model_round_trip ... ok
[INFO] [stdout] test parallel_tool_calls ... ok
[INFO] [stdout] test max_iterations_enforced ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tools_test.rs (/opt/rustwide/target/debug/deps/tools_test-1097f4963ec7b4e7)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test exit_tool_executes_via_registry ... ok
[INFO] [stdout] test registry_returns_error_for_unknown_tool ... ok
[INFO] [stdout] test registry_unregister_removes_tool ... ok
[INFO] [stdout] test shell_readonly_blocks_write_commands ... ok
[INFO] [stdout] test shell_tool_blocks_dangerous_commands ... ok
[INFO] [stdout] test shell_tool_requires_command_arg ... ok
[INFO] [stdout] test shell_tool_executes_command ... ok
[INFO] [stdout] test exit_tool_coexists_with_shell ... ok
[INFO] [stdout] test shell_tool_returns_error_on_bad_command ... ok
[INFO] [stdout] test shell_filters_environment ... ok
[INFO] [stdout] test shell_readwrite_allows_write_commands ... ok
[INFO] [stdout] test shell_truncates_large_output ... ok
[INFO] [stdout] test registry_executes_known_tool ... ok
[INFO] [stdout] test shell_readonly_allows_read_commands ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests golem
[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" "9edfef08149028f4b2c2d3b306efe80d84f2c255474763d609f96eeca9f61f88", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9edfef08149028f4b2c2d3b306efe80d84f2c255474763d609f96eeca9f61f88", kill_on_drop: false }`
[INFO] [stdout] 9edfef08149028f4b2c2d3b306efe80d84f2c255474763d609f96eeca9f61f88