[INFO] cloning repository https://github.com/philo-groves/fiddlesticks [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/philo-groves/fiddlesticks" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphilo-groves%2Ffiddlesticks", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphilo-groves%2Ffiddlesticks'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 01ea5ae847d02c09fd52c2c2462d3f4e4616e436 [INFO] testing philo-groves/fiddlesticks against master#562dee4820c458d823175268e41601d4c060588a for pr-154210 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fphilo-groves%2Ffiddlesticks" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/philo-groves/fiddlesticks [INFO] finished tweaking git repo https://github.com/philo-groves/fiddlesticks [INFO] tweaked toml for git repo https://github.com/philo-groves/fiddlesticks written to /workspace/builds/worker-4-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/philo-groves/fiddlesticks on toolchain 562dee4820c458d823175268e41601d4c060588a [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/philo-groves/fiddlesticks 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded postgres-types v0.2.12 [INFO] [stderr] Downloaded whoami v2.1.1 [INFO] [stderr] Downloaded postgres-protocol v0.6.10 [INFO] [stderr] Downloaded wasite v1.0.2 [INFO] [stderr] Downloaded objc2-system-configuration v0.3.2 [INFO] [stderr] Downloaded tokio-postgres v0.7.16 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 14b301b20d068927c5f4f7f513931bcb833ea7c4956523668f88e3e73de6c696 [INFO] running `Command { std: "docker" "start" "-a" "14b301b20d068927c5f4f7f513931bcb833ea7c4956523668f88e3e73de6c696", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "14b301b20d068927c5f4f7f513931bcb833ea7c4956523668f88e3e73de6c696", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "14b301b20d068927c5f4f7f513931bcb833ea7c4956523668f88e3e73de6c696", kill_on_drop: false }` [INFO] [stdout] 14b301b20d068927c5f4f7f513931bcb833ea7c4956523668f88e3e73de6c696 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] ec65a4b5ab8e9fa70aabbadd76cf0f3f294fae90e26eb4e2791030cae7cba70b [INFO] running `Command { std: "docker" "start" "-a" "ec65a4b5ab8e9fa70aabbadd76cf0f3f294fae90e26eb4e2791030cae7cba70b", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.106 [INFO] [stderr] Compiling unicode-ident v1.0.24 [INFO] [stderr] Compiling libc v0.2.182 [INFO] [stderr] Compiling pin-project-lite v0.2.17 [INFO] [stderr] Compiling itoa v1.0.17 [INFO] [stderr] Compiling quote v1.0.44 [INFO] [stderr] Compiling futures-sink v0.3.32 [INFO] [stderr] Compiling zerocopy v0.8.40 [INFO] [stderr] Compiling zeroize v1.8.2 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling openssl-sys v0.9.111 [INFO] [stderr] Compiling writeable v0.6.2 [INFO] [stderr] Compiling litemap v0.8.1 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling serde_core v1.0.228 [INFO] [stderr] Compiling tracing-core v0.1.36 [INFO] [stderr] Compiling log v0.4.29 [INFO] [stderr] Compiling bitflags v2.11.0 [INFO] [stderr] Compiling http v1.4.0 [INFO] [stderr] Compiling rustls v0.23.37 [INFO] [stderr] Compiling rustls-pki-types v1.14.0 [INFO] [stderr] Compiling icu_properties_data v2.1.2 [INFO] [stderr] Compiling icu_normalizer_data v2.1.1 [INFO] [stderr] Compiling futures-channel v0.3.32 [INFO] [stderr] Compiling zmij v1.0.21 [INFO] [stderr] Compiling native-tls v0.2.18 [INFO] [stderr] Compiling serde_json v1.0.149 [INFO] [stderr] Compiling openssl-probe v0.2.1 [INFO] [stderr] Compiling ipnet v2.12.0 [INFO] [stderr] Compiling sync_wrapper v1.0.2 [INFO] [stderr] Compiling sha1 v0.10.6 [INFO] [stderr] Compiling data-encoding v2.10.0 [INFO] [stderr] Compiling openssl v0.10.75 [INFO] [stderr] Compiling iri-string v0.7.10 [INFO] [stderr] Compiling ryu v1.0.23 [INFO] [stderr] Compiling webpki-roots v1.0.6 [INFO] [stderr] Compiling unicode-normalization v0.1.25 [INFO] [stderr] Compiling syn v2.0.117 [INFO] [stderr] Compiling webpki-roots v0.26.11 [INFO] [stderr] Compiling unicode-properties v0.1.4 [INFO] [stderr] Compiling sha2 v0.10.9 [INFO] [stderr] Compiling http-body v1.0.1 [INFO] [stderr] Compiling md-5 v0.10.6 [INFO] [stderr] Compiling hmac v0.12.1 [INFO] [stderr] Compiling libsqlite3-sys v0.31.0 [INFO] [stderr] Compiling fcommon v3.0.0 (/opt/rustwide/workdir/fcommon) [INFO] [stderr] Compiling fallible-iterator v0.2.0 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling phf_shared v0.13.1 [INFO] [stderr] Compiling hashbrown v0.15.5 [INFO] [stderr] Compiling stringprep v0.1.5 [INFO] [stderr] Compiling phf v0.13.1 [INFO] [stderr] Compiling socket2 v0.6.2 [INFO] [stderr] Compiling mio v1.1.1 [INFO] [stderr] Compiling getrandom v0.2.17 [INFO] [stderr] Compiling getrandom v0.3.4 [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling whoami v2.1.1 [INFO] [stderr] Compiling rand_core v0.9.5 [INFO] [stderr] Compiling tokio v1.48.0 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling hashlink v0.10.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling ahash v0.8.12 [INFO] [stderr] Compiling rustls-webpki v0.103.9 [INFO] [stderr] Compiling metrics v0.24.3 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling rand v0.9.2 [INFO] [stderr] Compiling postgres-protocol v0.6.10 [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 futures-macro v0.3.32 [INFO] [stderr] Compiling tracing-attributes v0.1.31 [INFO] [stderr] Compiling openssl-macros v0.1.1 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling thiserror-impl v2.0.18 [INFO] [stderr] Compiling async-stream-impl v0.3.6 [INFO] [stderr] Compiling async-trait v0.1.89 [INFO] [stderr] Compiling tokio-util v0.7.18 [INFO] [stderr] Compiling futures-util v0.3.32 [INFO] [stderr] Compiling postgres-types v0.2.12 [INFO] [stderr] Compiling async-stream v0.3.6 [INFO] [stderr] Compiling thiserror v2.0.18 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling yoke v0.8.1 [INFO] [stderr] Compiling zerovec v0.11.5 [INFO] [stderr] Compiling zerotrie v0.2.3 [INFO] [stderr] Compiling h2 v0.4.13 [INFO] [stderr] Compiling tinystr v0.8.2 [INFO] [stderr] Compiling potential_utf v0.1.4 [INFO] [stderr] Compiling icu_collections v2.1.1 [INFO] [stderr] Compiling icu_locale_core v2.1.1 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling tower v0.5.3 [INFO] [stderr] Compiling tokio-postgres v0.7.16 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling tungstenite v0.28.0 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling icu_provider v2.1.1 [INFO] [stderr] Compiling tower-http v0.6.8 [INFO] [stderr] Compiling icu_properties v2.1.2 [INFO] [stderr] Compiling icu_normalizer v2.1.1 [INFO] [stderr] Compiling tokio-tungstenite v0.28.0 [INFO] [stderr] Compiling hyper v1.8.1 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling idna v1.1.0 [INFO] [stderr] Compiling url v2.5.8 [INFO] [stderr] Compiling hyper-util v0.1.20 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling hyper-rustls v0.27.7 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling rusqlite v0.33.0 [INFO] [stderr] Compiling fprovider v3.0.0 (/opt/rustwide/workdir/fprovider) [INFO] [stderr] Compiling ftooling v3.0.0 (/opt/rustwide/workdir/ftooling) [INFO] [stderr] Compiling fchat v3.0.0 (/opt/rustwide/workdir/fchat) [INFO] [stderr] Compiling fmemory v3.0.0 (/opt/rustwide/workdir/fmemory) [INFO] [stderr] Compiling fharness v3.0.0 (/opt/rustwide/workdir/fharness) [INFO] [stderr] Compiling fobserve v3.0.0 (/opt/rustwide/workdir/fobserve) [INFO] [stderr] Compiling fiddlesticks v3.0.0 (/opt/rustwide/workdir/fiddlesticks) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 49.03s [INFO] running `Command { std: "docker" "inspect" "ec65a4b5ab8e9fa70aabbadd76cf0f3f294fae90e26eb4e2791030cae7cba70b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ec65a4b5ab8e9fa70aabbadd76cf0f3f294fae90e26eb4e2791030cae7cba70b", kill_on_drop: false }` [INFO] [stdout] ec65a4b5ab8e9fa70aabbadd76cf0f3f294fae90e26eb4e2791030cae7cba70b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] badd8fdc4f1d10881d905cda3bf6075991f0b6cb190da5bc567093f603cd7197 [INFO] running `Command { std: "docker" "start" "-a" "badd8fdc4f1d10881d905cda3bf6075991f0b6cb190da5bc567093f603cd7197", kill_on_drop: false }` [INFO] [stderr] Compiling tokio-macros v2.6.1 [INFO] [stderr] Compiling fcommon v3.0.0 (/opt/rustwide/workdir/fcommon) [INFO] [stderr] Compiling tokio v1.48.0 [INFO] [stderr] Compiling tokio-util v0.7.18 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tower v0.5.3 [INFO] [stderr] Compiling tokio-tungstenite v0.28.0 [INFO] [stderr] Compiling tower-http v0.6.8 [INFO] [stderr] Compiling h2 v0.4.13 [INFO] [stderr] Compiling tokio-postgres v0.7.16 [INFO] [stderr] Compiling hyper v1.8.1 [INFO] [stderr] Compiling hyper-util v0.1.20 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling hyper-rustls v0.27.7 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling fprovider v3.0.0 (/opt/rustwide/workdir/fprovider) [INFO] [stderr] Compiling ftooling v3.0.0 (/opt/rustwide/workdir/ftooling) [INFO] [stderr] Compiling fchat v3.0.0 (/opt/rustwide/workdir/fchat) [INFO] [stderr] Compiling fmemory v3.0.0 (/opt/rustwide/workdir/fmemory) [INFO] [stderr] Compiling fharness v3.0.0 (/opt/rustwide/workdir/fharness) [INFO] [stderr] Compiling fobserve v3.0.0 (/opt/rustwide/workdir/fobserve) [INFO] [stderr] Compiling fiddlesticks v3.0.0 (/opt/rustwide/workdir/fiddlesticks) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 39.16s [INFO] running `Command { std: "docker" "inspect" "badd8fdc4f1d10881d905cda3bf6075991f0b6cb190da5bc567093f603cd7197", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "badd8fdc4f1d10881d905cda3bf6075991f0b6cb190da5bc567093f603cd7197", kill_on_drop: false }` [INFO] [stdout] badd8fdc4f1d10881d905cda3bf6075991f0b6cb190da5bc567093f603cd7197 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] a4b823fe10d2a8a61bbd8ebde0bb01ec085c0a9675e2fd6e20faf7f29976e6ed [INFO] running `Command { std: "docker" "start" "-a" "a4b823fe10d2a8a61bbd8ebde0bb01ec085c0a9675e2fd6e20faf7f29976e6ed", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.41s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fchat-537b8d60d7916213) [INFO] [stdout] [INFO] [stdout] running 16 tests [INFO] [stdout] test error::tests::provider_error_conversion_preserves_retryability_and_source ... ok [INFO] [stdout] test error::tests::tooling_invalid_arguments_is_user_error ... ok [INFO] [stdout] test service::tests::builder_applies_default_turn_options_to_requests ... ok [INFO] [stdout] test service::tests::provider_hooks_are_called_for_complete_and_stream_operations ... ok [INFO] [stdout] test service::tests::run_turn_includes_history_and_system_prompt_in_provider_request ... ok [INFO] [stdout] test service::tests::stream_turn_executes_tools_and_emits_tool_events ... ok [INFO] [stdout] test service::tests::run_turn_executes_tools_when_runtime_configured ... ok [INFO] [stdout] test service::tests::stream_turn_maps_tool_runtime_failures_to_tooling_errors ... ok [INFO] [stdout] test service::tests::stream_turn_reports_streaming_phase_errors ... ok [INFO] [stdout] test service::tests::run_turn_marks_limit_reached_when_tool_cap_prevents_execution ... ok [INFO] [stderr] Running tests/tool_loop_integration.rs (/opt/rustwide/target/debug/deps/tool_loop_integration-cfa8bfe2cf035bea) [INFO] [stdout] test service::tests::builder_configures_tool_runtime_and_round_trip_policy ... ok [INFO] [stdout] test service::tests::run_turn_rejects_empty_user_input ... ok [INFO] [stdout] test service::tests::run_turn_returns_assistant_message_and_persists_transcript ... ok [INFO] [stdout] test service::tests::stream_turn_maps_provider_events_and_persists_transcript ... ok [INFO] [stdout] test service::tests::run_turn_retries_provider_completion_using_policy ... ok [INFO] [stdout] test service::tests::stream_turn_retries_stream_acquisition_using_policy ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test chat_stream_tool_loop_surfaces_tooling_error_context ... ok [INFO] [stdout] test chat_tool_loop_executes_registered_tool_and_completes_turn ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fcommon-bb1d4a15d684e3ce) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fharness-8c17aacf1ff93e95) [INFO] [stdout] test tests::generic_registry_basic_lifecycle ... ok [INFO] [stdout] test tests::generation_options_builder_helpers_set_values ... ok [INFO] [stdout] test tests::id_newtypes_round_trip_strings ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 25 tests [INFO] [stdout] test harness::tests::all_required_features_passed_requires_non_empty_and_all_true ... ok [INFO] [stdout] test tests::builder_wires_provider_tooling_memory_and_chat ... ok [INFO] [stdout] test tests::builder_requires_provider_to_build_runtime ... ok [INFO] [stdout] test tests::coding_iteration_gets_bearings_executes_and_marks_feature_passed ... ok [INFO] [stdout] test tests::coding_iteration_does_not_mark_feature_when_not_validated ... ok [INFO] [stdout] test tests::initializer_generates_starter_feature_list_when_missing ... ok [INFO] [stdout] test tests::harness_does_not_declare_done_when_selector_returns_none_early ... ok [INFO] [stdout] test tests::initializer_is_idempotent_when_session_already_initialized ... ok [INFO] [stdout] test tests::initializer_rejects_duplicate_or_passing_features ... ok [INFO] [stdout] test tests::initializer_rejects_empty_objective ... ok [INFO] [stdout] test tests::coding_iteration_retries_validation_when_policy_allows ... ok [INFO] [stdout] test tests::harness_hooks_report_phase_start_and_success ... ok [INFO] [stdout] test tests::coding_iteration_stops_when_turn_budget_is_exhausted ... ok [INFO] [stdout] test tests::runtime_run_initializer_applies_initializer_fields ... ok [INFO] [stdout] test tests::runtime_run_forwards_prompt_override_and_streaming ... ok [INFO] [stdout] test tests::runtime_run_selects_initializer_then_task_iteration_phase ... ok [INFO] [stdout] test tests::run_policy_modes_enforce_feature_limits ... ok [INFO] [stdout] test tests::initializer_creates_bootstrap_state_on_first_run ... ok [INFO] [stdout] test tests::select_phase_tracks_session_initialization_state ... ok [INFO] [stdout] test tests::coding_iteration_stream_path_works_and_records_handoff ... ok [INFO] [stdout] test tests::coding_iteration_uses_feature_selection_strategy ... ok [INFO] [stdout] test tests::harness_hooks_report_phase_failure ... ok [INFO] [stdout] test tests::completion_gate_requires_all_features_to_pass_true ... ok [INFO] [stdout] test harness::tests::validate_feature_list_rejects_empty_input ... ok [INFO] [stdout] test tests::coding_iteration_retries_chat_errors_within_retry_budget ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s [INFO] [stdout] [INFO] [stderr] Running tests/harness_integration.rs (/opt/rustwide/target/debug/deps/harness_integration-98e2c0fdc361739f) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test bounded_batch_mode_processes_up_to_feature_limit ... ok [INFO] [stdout] test task_iteration_does_not_mark_feature_pass_without_validation ... ok [INFO] [stdout] test multi_run_completion_requires_all_features_passed ... ok [INFO] [stdout] test fresh_context_window_recovers_state_from_fmemory_and_continues ... ok [INFO] [stdout] test task_iteration_picks_one_failing_feature_and_updates_progress ... ok [INFO] [stdout] test unlimited_batch_mode_processes_all_pending_features ... ok [INFO] [stdout] test initializer_creates_required_artifacts ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fiddlesticks-23f819fbce378529) [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test tests::fs_session_macro_supports_provider_shorthand_and_prompt ... ok [INFO] [stdout] test util::tests::parse_provider_id_supports_aliases ... ok [INFO] [stdout] test tests::fs_msg_macro_creates_expected_message ... ok [INFO] [stdout] test util::tests::message_and_turn_helpers_apply_expected_defaults ... ok [INFO] [stdout] test tests::fs_messages_macro_builds_message_vector ... ok [INFO] [stdout] test runtime::tests::build_runtime_with_tooling_builds_successfully ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fmemory-a70c69d07ccb8291) [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test tests::backend_stores_bootstrap_state_and_transcript ... ok [INFO] [stdout] test tests::conversation_store_adapter_reads_and_writes_transcript ... ok [INFO] [stdout] test tests::initialize_session_if_missing_is_idempotent ... ok [INFO] [stdout] test tests::postgres_backend_stores_bootstrap_state_and_transcript_when_configured ... ok [INFO] [stdout] test tests::is_initialized_tracks_manifest_presence ... ok [INFO] [stdout] test tests::update_feature_pass_fails_for_unknown_feature ... ok [INFO] [stdout] test tests::sqlite_backend_stores_bootstrap_state_and_transcript ... ok [INFO] [stdout] test tests::filesystem_backend_stores_bootstrap_state_and_transcript ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fobserve-81eea53eef25975d) [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test tests::safe_tool_hooks_delegate_when_inner_succeeds ... ok [INFO] [stdout] test tests::safe_provider_hooks_delegate_when_inner_succeeds ... ok [INFO] [stdout] test tests::safe_harness_hooks_delegate_when_inner_succeeds ... ok [INFO] [stdout] test tests::tracing_hooks_smoke_test_all_callbacks ... ok [INFO] [stdout] test tests::metrics_hooks_smoke_test_all_callbacks ... ok [INFO] [stdout] test tests::safe_tool_hooks_swallow_panics ... ok [INFO] [stdout] test tests::safe_harness_hooks_swallow_panics ... ok [INFO] [stdout] test tests::safe_provider_hooks_swallow_panics ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.23s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/fprovider-d27a3eadf9715e04) [INFO] [stdout] [INFO] [stdout] running 20 tests [INFO] [stdout] test resilience::tests::retry_policy_backoff_grows_and_caps ... ok [INFO] [stdout] test resilience::tests::execute_with_retry_stops_on_non_retryable_error ... ok [INFO] [stdout] test resilience::tests::retry_policy_uses_retryable_flag_and_attempt_limit ... ok [INFO] [stdout] test adapters::openai::tests::build_api_request_switches_token_parameter_name ... ok [INFO] [stdout] test tests::provider_id_display_is_stable ... ok [INFO] [stdout] test tests::credential_manager_observer_receives_sanitized_events ... ok [INFO] [stdout] test tests::model_provider_stream_returns_expected_events ... ok [INFO] [stdout] test tests::provider_registry_registers_and_returns_providers ... ok [INFO] [stdout] test tests::model_request_builder_validates_before_building ... ok [INFO] [stdout] test tests::model_request_validate_enforces_contract ... ok [INFO] [stdout] test tests::openai_helpers_validate_and_store_api_key ... ok [INFO] [stdout] test tests::provider_error_helper_builders_assign_expected_retryability ... ok [INFO] [stdout] test tests::secret_string_debug_is_redacted ... ok [INFO] [stdout] test tests::secure_credential_manager_handles_browser_sessions ... ok [INFO] [stdout] test tests::vec_event_stream_yields_events_in_order ... ok [INFO] [stdout] test adapters::openai::tests::build_openai_request_appends_tool_results_as_tool_messages ... ok [INFO] [stderr] Running tests/anthropic_provider_behavior.rs (/opt/rustwide/target/debug/deps/anthropic_provider_behavior-bae5fe179760a50a) [INFO] [stdout] test tests::secure_credential_manager_handles_provider_agnostic_credentials ... ok [INFO] [stderr] Running tests/ollama_provider_behavior.rs (/opt/rustwide/target/debug/deps/ollama_provider_behavior-fd8cc25e3e4a5d1c) [INFO] [stdout] test adapters::openai::tests::parse_finish_reason_maps_expected_values ... ok [INFO] [stderr] Running tests/openai_provider_behavior.rs (/opt/rustwide/target/debug/deps/openai_provider_behavior-046f8985677dbb87) [INFO] [stdout] test resilience::tests::execute_with_retry_retries_and_reports_hooks ... ok [INFO] [stderr] Running tests/openai_provider_integration.rs (/opt/rustwide/target/debug/deps/openai_provider_integration-b2fe2f60330d97c1) [INFO] [stdout] test tests::credential_manager_tracks_metadata_and_ttl ... ok [INFO] [stderr] Running tests/opencode_zen_provider_behavior.rs (/opt/rustwide/target/debug/deps/opencode_zen_provider_behavior-9e93e5e03b02ad47) [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ftooling-bdbab4716c9260d9) [INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test missing_anthropic_credentials_returns_authentication_error ... ok [INFO] [stdout] test stream_maps_response_complete_to_anthropic_provider_id ... ok [INFO] [stdout] test complete_uses_anthropic_credentials_and_maps_provider_id ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test stream_maps_response_complete_to_ollama_provider_id ... ok [INFO] [stdout] test complete_maps_to_ollama_provider_id_and_uses_placeholder_auth ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test missing_openai_credentials_returns_auth_error ... ok [INFO] [stdout] test complete_maps_openai_response_to_provider_response ... ok [INFO] [stdout] test stream_rejects_browser_session_without_api_key ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test openai_provider_uses_openai_credentials_and_maps_completion ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test stream_maps_response_complete_to_zen_provider_id ... ok [INFO] [stdout] test missing_zen_credentials_returns_authentication_error ... ok [INFO] [stdout] test complete_uses_zen_credentials_and_maps_provider_id ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] test args::tests::parse_invalid_json_returns_invalid_arguments ... ok [INFO] [stdout] test args::tests::parse_object_and_extract_required_string ... ok [INFO] [stdout] test error::tests::context_fields_are_included_in_display ... ok [INFO] [stdout] test runtime::tests::registry_tracks_registered_tools ... ok [INFO] [stdout] test runtime::tests::registry_register_fn_and_register_sync_fn_are_easy_to_use ... ok [INFO] [stdout] test error::tests::helper_methods_report_retryable_and_user_error ... ok [INFO] [stdout] test runtime::tests::runtime_executes_registered_tool ... ok [INFO] [stdout] test runtime::tests::runtime_returns_not_found_for_unknown_tool ... ok [INFO] [stdout] test runtime::tests::runtime_hooks_receive_success_and_failure_events ... ok [INFO] [stdout] test runtime::tests::runtime_propagates_tool_execution_error ... ok [INFO] [stdout] test runtime::tests::runtime_timeout_returns_timeout_error ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Doc-tests fchat [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test fchat/src/store.rs - store (line 3) ... ok [INFO] [stdout] test fchat/src/types.rs - types (line 3) ... ok [INFO] [stdout] test fchat/src/error.rs - error (line 3) ... ok [INFO] [stdout] test fchat/src/service.rs - service (line 3) ... ok [INFO] [stdout] test fchat/src/lib.rs - (line 3) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Doc-tests fcommon [INFO] [stdout] all doctests ran in 1.62s; merged doctests compilation took 1.55s [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test fcommon/src/lib.rs - (line 3) ... ok [INFO] [stdout] test fcommon/src/lib.rs - context (line 39) ... ok [INFO] [stdout] test fcommon/src/lib.rs - registry (line 167) ... ok [INFO] [stdout] test fcommon/src/lib.rs - future (line 20) ... ok [INFO] [stdout] test fcommon/src/lib.rs - model (line 122) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s [INFO] [stdout] [INFO] [stdout] all doctests ran in 0.84s; merged doctests compilation took 0.64s [INFO] [stderr] Doc-tests fharness [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test fharness/src/lib.rs - (line 3) ... ok [INFO] [stdout] test fharness/src/harness.rs - harness::HarnessBuilder (line 25) ... ok [INFO] [stdout] test fharness/src/error.rs - error (line 3) ... ok [INFO] [stdout] test fharness/src/hooks.rs - hooks (line 3) ... ok [INFO] [stdout] test fharness/src/traits.rs - traits (line 3) ... ok [INFO] [stdout] test fharness/src/types.rs - types (line 3) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stdout] all doctests ran in 1.46s; merged doctests compilation took 1.38s [INFO] [stderr] Doc-tests fiddlesticks [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test fiddlesticks/src/macros.rs - macros::fs_msg (line 3) ... ok [INFO] [stdout] test fiddlesticks/src/util.rs - util (line 3) ... ok [INFO] [stdout] test fiddlesticks/src/providers.rs - providers::build_provider_with_config (line 56) ... ok [INFO] [stdout] test fiddlesticks/src/macros.rs - macros::fs_messages (line 31) ... ok [INFO] [stdout] test fiddlesticks/src/macros.rs - macros::fs_session (line 55) ... ok [INFO] [stdout] test fiddlesticks/src/providers.rs - providers (line 3) ... ok [INFO] [stdout] test fiddlesticks/src/runtime.rs - runtime (line 3) ... ok [INFO] [stdout] test fiddlesticks/src/lib.rs - (line 7) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s [INFO] [stdout] [INFO] [stdout] all doctests ran in 2.13s; merged doctests compilation took 1.77s [INFO] [stderr] Doc-tests fmemory [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test fmemory/src/error.rs - error (line 3) ... ok [INFO] [stdout] test fmemory/src/adapter.rs - adapter (line 3) ... ok [INFO] [stdout] test fmemory/src/types.rs - types (line 3) ... ok [INFO] [stdout] test fmemory/src/lib.rs - (line 3) ... ok [INFO] [stdout] test fmemory/src/backend.rs - backend (line 3) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s [INFO] [stdout] [INFO] [stdout] all doctests ran in 1.77s; merged doctests compilation took 1.65s [INFO] [stderr] Doc-tests fobserve [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test fobserve/src/safe_hooks.rs - safe_hooks (line 3) ... ok [INFO] [stdout] test fobserve/src/metrics_hooks.rs - metrics_hooks (line 3) ... ok [INFO] [stdout] test fobserve/src/lib.rs - (line 3) ... ok [INFO] [stdout] test fobserve/src/tracing_hooks.rs - tracing_hooks (line 3) ... 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] [stdout] all doctests ran in 1.54s; merged doctests compilation took 1.38s [INFO] [stderr] Doc-tests fprovider [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test fprovider/src/stream.rs - stream (line 3) ... ok [INFO] [stdout] test fprovider/src/model.rs - model (line 3) ... ok [INFO] [stdout] test fprovider/src/error.rs - error (line 3) ... ok [INFO] [stdout] test fprovider/src/credentials.rs - credentials (line 3) ... ok [INFO] [stdout] test fprovider/src/registry.rs - registry (line 3) ... ok [INFO] [stdout] test fprovider/src/lib.rs - (line 3) ... ok [INFO] [stdout] test fprovider/src/resilience.rs - resilience (line 3) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stdout] all doctests ran in 1.16s; merged doctests compilation took 1.10s [INFO] [stderr] Doc-tests ftooling [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test ftooling/src/runtime.rs - runtime (line 3) ... ok [INFO] [stdout] test ftooling/src/hooks.rs - hooks (line 3) ... ok [INFO] [stdout] test ftooling/src/args.rs - args (line 3) ... ok [INFO] [stdout] test ftooling/src/registry.rs - registry (line 3) ... ok [INFO] [stdout] test ftooling/src/types.rs - types (line 3) ... ok [INFO] [stdout] test ftooling/src/tool.rs - tool (line 3) ... ok [INFO] [stdout] test ftooling/src/lib.rs - (line 3) ... ok [INFO] [stdout] test ftooling/src/error.rs - error (line 3) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] all doctests ran in 1.19s; merged doctests compilation took 1.16s [INFO] running `Command { std: "docker" "inspect" "a4b823fe10d2a8a61bbd8ebde0bb01ec085c0a9675e2fd6e20faf7f29976e6ed", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a4b823fe10d2a8a61bbd8ebde0bb01ec085c0a9675e2fd6e20faf7f29976e6ed", kill_on_drop: false }` [INFO] [stdout] a4b823fe10d2a8a61bbd8ebde0bb01ec085c0a9675e2fd6e20faf7f29976e6ed