[INFO] cloning repository https://github.com/intbot/burnwall [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/intbot/burnwall" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fintbot%2Fburnwall", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fintbot%2Fburnwall'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 199716d0337d34dfdf6b9aac9bb8e97ca994ab8e [INFO] testing intbot/burnwall against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fintbot%2Fburnwall" "/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/intbot/burnwall [INFO] removed 0 missing tests [INFO] finished tweaking git repo https://github.com/intbot/burnwall [INFO] tweaked toml for git repo https://github.com/intbot/burnwall written to /workspace/builds/worker-0-tc2/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/intbot/burnwall on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/intbot/burnwall 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" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [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" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] c401fa02952faeb8b7fcab4d08fa9e63eeae4a1aea9dda820237bd1b79142783 [INFO] running `Command { std: "docker" "start" "-a" "c401fa02952faeb8b7fcab4d08fa9e63eeae4a1aea9dda820237bd1b79142783", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "c401fa02952faeb8b7fcab4d08fa9e63eeae4a1aea9dda820237bd1b79142783", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c401fa02952faeb8b7fcab4d08fa9e63eeae4a1aea9dda820237bd1b79142783", kill_on_drop: false }` [INFO] [stdout] c401fa02952faeb8b7fcab4d08fa9e63eeae4a1aea9dda820237bd1b79142783 [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=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" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] bd7ef584f91b23e7bc335087e985d74e7f2d119a88d06bfa3b686cbcb3ef14ba [INFO] running `Command { std: "docker" "start" "-a" "bd7ef584f91b23e7bc335087e985d74e7f2d119a88d06bfa3b686cbcb3ef14ba", kill_on_drop: false }` [INFO] [stderr] Compiling cc v1.2.62 [INFO] [stderr] Compiling getrandom v0.2.17 [INFO] [stderr] Compiling typenum v1.20.0 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling futures-io v0.3.32 [INFO] [stderr] Compiling rustls v0.23.40 [INFO] [stderr] Compiling semver v1.0.28 [INFO] [stderr] Compiling futures-channel v0.3.32 [INFO] [stderr] Compiling futures-util v0.3.32 [INFO] [stderr] Compiling pkg-config v0.3.33 [INFO] [stderr] Compiling serde_json v1.0.149 [INFO] [stderr] Compiling h2 v0.4.14 [INFO] [stderr] Compiling url v2.5.8 [INFO] [stderr] Compiling rustc_version v0.4.1 [INFO] [stderr] Compiling curve25519-dalek v4.1.3 [INFO] [stderr] Compiling webpki-roots v1.0.7 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling serde_spanned v0.6.9 [INFO] [stderr] Compiling toml_datetime v0.6.11 [INFO] [stderr] Compiling curve25519-dalek-derive v0.1.1 [INFO] [stderr] Compiling signature v2.2.0 [INFO] [stderr] Compiling option-ext v0.2.0 [INFO] [stderr] Compiling thiserror v2.0.18 [INFO] [stderr] Compiling toml_edit v0.22.27 [INFO] [stderr] Compiling dirs-sys v0.5.0 [INFO] [stderr] Compiling chrono v0.4.44 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling crypto-common v0.1.7 [INFO] [stderr] Compiling libsqlite3-sys v0.30.1 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling ed25519 v2.2.3 [INFO] [stderr] Compiling sha2 v0.10.9 [INFO] [stderr] Compiling getrandom v0.4.2 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling tracing-serde v0.2.0 [INFO] [stderr] Compiling thiserror-impl v2.0.18 [INFO] [stderr] Compiling hyper v1.9.0 [INFO] [stderr] Compiling tower v0.5.3 [INFO] [stderr] Compiling unsafe-libyaml-norway v0.2.15 [INFO] [stderr] Compiling tower-http v0.6.10 [INFO] [stderr] Compiling tracing-subscriber v0.3.23 [INFO] [stderr] Compiling serde_norway v0.9.42 [INFO] [stderr] Compiling toml v0.8.23 [INFO] [stderr] Compiling ed25519-dalek v2.2.0 [INFO] [stderr] Compiling uuid v1.23.1 [INFO] [stderr] Compiling hyper-util v0.1.20 [INFO] [stderr] Compiling rustls-webpki v0.103.13 [INFO] [stderr] Compiling clap_complete v4.6.5 [INFO] [stderr] Compiling dashmap v6.1.0 [INFO] [stderr] Compiling dirs v6.0.0 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling hyper-rustls v0.27.9 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling rusqlite v0.32.1 [INFO] [stderr] Compiling burnwall v0.9.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 40s [INFO] running `Command { std: "docker" "inspect" "bd7ef584f91b23e7bc335087e985d74e7f2d119a88d06bfa3b686cbcb3ef14ba", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bd7ef584f91b23e7bc335087e985d74e7f2d119a88d06bfa3b686cbcb3ef14ba", kill_on_drop: false }` [INFO] [stdout] bd7ef584f91b23e7bc335087e985d74e7f2d119a88d06bfa3b686cbcb3ef14ba [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=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" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8e0dba6d25a6d1c2de8ca8a110fd7352043ba1bb1740c65bd3bf44f845c4756e [INFO] running `Command { std: "docker" "start" "-a" "8e0dba6d25a6d1c2de8ca8a110fd7352043ba1bb1740c65bd3bf44f845c4756e", kill_on_drop: false }` [INFO] [stderr] Compiling tokio v1.52.3 [INFO] [stderr] Compiling futures-util v0.3.32 [INFO] [stderr] Compiling bitflags v2.11.1 [INFO] [stderr] Compiling predicates-core v1.0.10 [INFO] [stderr] Compiling float-cmp v0.10.0 [INFO] [stderr] Compiling num_cpus v1.17.0 [INFO] [stderr] Compiling deadpool-runtime v0.1.4 [INFO] [stderr] Compiling assert_cmd v2.2.2 [INFO] [stderr] Compiling predicates-tree v1.0.13 [INFO] [stderr] Compiling predicates v3.1.4 [INFO] [stderr] Compiling assert-json-diff v2.0.2 [INFO] [stderr] Compiling rusqlite v0.32.1 [INFO] [stderr] Compiling rustix v1.1.4 [INFO] [stderr] Compiling bstr v1.12.1 [INFO] [stderr] Compiling wait-timeout v0.2.1 [INFO] [stderr] Compiling fastrand v2.4.1 [INFO] [stderr] Compiling tempfile v3.27.0 [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 tokio-rustls v0.26.4 [INFO] [stderr] Compiling deadpool v0.12.3 [INFO] [stderr] Compiling tokio-stream v0.1.18 [INFO] [stderr] Compiling tokio-test v0.4.5 [INFO] [stderr] Compiling tower-http v0.6.10 [INFO] [stderr] Compiling h2 v0.4.14 [INFO] [stderr] Compiling hyper v1.9.0 [INFO] [stderr] Compiling hyper-util v0.1.20 [INFO] [stderr] Compiling hyper-rustls v0.27.9 [INFO] [stderr] Compiling wiremock v0.6.5 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling burnwall v0.9.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 48s [INFO] running `Command { std: "docker" "inspect" "8e0dba6d25a6d1c2de8ca8a110fd7352043ba1bb1740c65bd3bf44f845c4756e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8e0dba6d25a6d1c2de8ca8a110fd7352043ba1bb1740c65bd3bf44f845c4756e", kill_on_drop: false }` [INFO] [stdout] 8e0dba6d25a6d1c2de8ca8a110fd7352043ba1bb1740c65bd3bf44f845c4756e [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=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" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] beb8bfd3ce5324f846084d4b8bfb776d2635391048869b4fd915a431ccb076a0 [INFO] running `Command { std: "docker" "start" "-a" "beb8bfd3ce5324f846084d4b8bfb776d2635391048869b4fd915a431ccb076a0", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.64s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/burnwall-6d57faae3f50ccc8) [INFO] [stdout] [INFO] [stdout] running 36 tests [INFO] [stdout] test audit::tests::sarif_has_rules_and_results ... ok [INFO] [stdout] test audit::tests::aibom_is_cyclonedx_shaped ... ok [INFO] [stdout] test mcp::policy_tests::glob_matches_literals_and_wildcards ... ok [INFO] [stdout] test mcp::policy_tests::policy_matches_any_pattern ... ok [INFO] [stdout] test observe::attribution::tests::empty_window_is_zero_not_negative_zero ... ok [INFO] [stdout] test observe::attribution::tests::filters_by_repo_and_window ... ok [INFO] [stdout] test observe::attribution::tests::no_repo_root_counts_all_in_window ... ok [INFO] [stdout] test observe::attribution::tests::path_under_handles_separators_and_nesting ... ok [INFO] [stdout] test observe::metrics::tests::aggregate_groups_and_computes ... ok [INFO] [stdout] test observe::metrics::tests::error_classification ... ok [INFO] [stdout] test observe::metrics::tests::percentile_nearest_rank ... ok [INFO] [stdout] test observe::metrics::tests::throughput_divides_by_window ... ok [INFO] [stdout] test observe::otel::tests::google_maps_to_gcp_gemini ... ok [INFO] [stdout] test observe::otel::tests::random_hex_has_expected_length ... ok [INFO] [stdout] test observe::otel::tests::span_has_gen_ai_attributes ... ok [INFO] [stdout] test observe::otel::tests::writer_appends_lines ... ok [INFO] [stdout] test observe::otel::tests::error_status_maps_to_code_2 ... ok [INFO] [stdout] test proxy::resilience::tests::disabled_resilience_yields_only_primary ... ok [INFO] [stdout] test proxy::resilience::tests::enabled_resilience_appends_failover_without_duplicating_primary ... ok [INFO] [stdout] test proxy::resilience::tests::fresh_endpoint_is_available ... ok [INFO] [stdout] test proxy::resilience::tests::opens_after_threshold_failures ... ok [INFO] [stdout] test proxy::resilience::tests::success_closes_circuit ... ok [INFO] [stdout] test proxy::resilience::tests::threshold_clamped_to_one ... ok [INFO] [stdout] test security::signing::tests::empty_publishers_trusts_nothing ... ok [INFO] [stdout] test security::signing::tests::malformed_signature_fails ... ok [INFO] [stdout] test security::signing::tests::seed_roundtrip_signs_identically ... ok [INFO] [stdout] test observe::metrics::tests::empty_input_is_empty_output ... ok [INFO] [stdout] test audit::tests::deleting_a_receipt_breaks_the_chain ... ok [INFO] [stdout] test audit::tests::modifying_a_sealed_source_row_is_detected ... ok [INFO] [stdout] test proxy::resilience::tests::cooldown_elapse_allows_probe ... ok [INFO] [stdout] test security::signing::tests::sign_then_verify_roundtrips ... ok [INFO] [stdout] test security::signing::tests::untrusted_key_fails ... ok [INFO] [stdout] test security::signing::tests::tampered_body_fails ... ok [INFO] [stdout] test audit::tests::a_different_key_fails_signature_verification ... ok [INFO] [stdout] test audit::tests::unsealed_rows_added_after_seal_do_not_break_verify ... ok [INFO] [stdout] test audit::tests::seal_then_verify_is_intact_and_idempotent ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.24s [INFO] [stdout] [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/burnwall-5f492ad308a51c59) [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] [stderr] Running tests/integration/audit_cli_test.rs (/opt/rustwide/target/debug/deps/audit_cli_test-d42622ee42a59070) [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test audit_aibom_outputs_cyclonedx ... ok [INFO] [stdout] test audit_sarif_outputs_sarif_log ... ok [INFO] [stdout] test audit_seal_then_verify_on_empty_db ... ok [INFO] [stderr] Running tests/integration/budget_test.rs (/opt/rustwide/target/debug/deps/budget_test-9bd3f639fca3f610) [INFO] [stdout] test report_text_and_json ... ok [INFO] [stdout] test audit_export_json_and_csv ... 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] [stdout] [INFO] [stdout] running 25 tests [INFO] [stdout] test at_daily_limit_blocks ... ok [INFO] [stdout] test above_warning_below_limit_still_warns ... ok [INFO] [stdout] test at_warning_threshold_returns_warn ... ok [INFO] [stdout] test check_transitions_through_ok_warn_exceeded ... ok [INFO] [stdout] test cost_spiral_disabled_when_cap_zero ... ok [INFO] [stdout] test loop_detector_disabled_returns_ok ... ok [INFO] [stdout] test loop_detector_blocks_on_nth_identical_request ... ok [INFO] [stdout] test loop_detector_hashes_only_prefix_bytes ... ok [INFO] [stdout] test cost_spiral_detector_trips_above_cap ... ok [INFO] [stdout] test loop_detector_independent_hashes_dont_cross_count ... ok [INFO] [stdout] test loop_detector_passes_unique_requests ... ok [INFO] [stdout] test record_accumulates ... ok [INFO] [stdout] test over_daily_limit_blocks ... ok [INFO] [stdout] test record_clamps_invalid_inputs ... ok [INFO] [stdout] test reset_zeroes_counter ... ok [INFO] [stdout] test tracker_starts_at_zero ... ok [INFO] [stdout] test under_warning_threshold_returns_ok ... ok [INFO] [stdout] test zero_daily_means_unlimited ... ok [INFO] [stdout] test sub_cent_costs_accumulate_precisely ... ok [INFO] [stdout] test record_is_safe_under_concurrent_writers ... ok [INFO] [stdout] test loop_detector_safe_under_concurrent_writers ... ok [INFO] [stdout] test hydrate_on_empty_date_results_in_zero ... ok [INFO] [stdout] test hydrate_replaces_existing_counter_value ... ok [INFO] [stdout] test hydrate_loads_todays_total_from_storage ... ok [INFO] [stdout] test current_window_cost_excludes_expired_entries ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.10s [INFO] [stdout] [INFO] [stderr] Running tests/unit/cache_injection_test.rs (/opt/rustwide/target/debug/deps/cache_injection_test-4db0017d75e0050f) [INFO] [stdout] [INFO] [stdout] running 18 tests [INFO] [stdout] test empty_messages_array_does_not_mark_anything_in_messages ... ok [INFO] [stdout] test array_system_prompt_gets_marker_on_last_block ... ok [INFO] [stdout] test already_marked_array_system_with_unmarked_first_message_is_left_alone ... ok [INFO] [stdout] test estimate_savings_zero_for_unknown_model ... ok [INFO] [stdout] test first_message_content_non_string_non_array_is_skipped_gracefully ... ok [INFO] [stdout] test estimate_savings_zero_for_invalid_json ... ok [INFO] [stdout] test first_message_content_string_is_widened_and_marked ... ok [INFO] [stdout] test estimate_savings_resolves_date_suffixed_model_id ... ok [INFO] [stdout] test estimate_savings_matches_pricing_formula_for_string_inputs ... ok [INFO] [stdout] test invalid_json_body_passes_through_unchanged ... ok [INFO] [stdout] test marker_on_system_alone_is_sufficient_when_messages_absent ... ok [INFO] [stdout] test no_system_and_no_messages_results_in_no_modification ... ok [INFO] [stdout] test estimate_savings_zero_when_no_system_or_messages ... ok [INFO] [stdout] test string_system_prompt_is_widened_to_a_text_block_with_cache_control ... ok [INFO] [stdout] test estimate_savings_zero_when_request_already_has_cache_control ... ok [INFO] [stdout] test estimate_savings_counts_text_blocks_inside_arrays ... ok [INFO] [stdout] test existing_cache_control_anywhere_disables_injection ... ok [INFO] [stdout] test is_messages_path_recognizes_exact_and_query_suffixed ... ok [INFO] [stderr] Running tests/integration/cli_test.rs (/opt/rustwide/target/debug/deps/cli_test-c0c17884620dcc46) [INFO] [stdout] [INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 29 tests [INFO] [stdout] test completions_powershell_emits_argument_completer ... ok [INFO] [stdout] test config_doctor_flags_relaxing_toggles_and_deprecated_key ... ok [INFO] [stdout] test completions_rejects_unknown_shell ... ok [INFO] [stdout] test completions_bash_emits_a_compinit_script ... ok [INFO] [stdout] test completions_zsh_emits_compdef_block ... ok [INFO] [stdout] test config_show_prints_default_when_no_file ... ok [INFO] [stdout] test config_doctor_reports_clean_defaults ... ok [INFO] [stdout] test config_set_writes_to_file_and_persists ... ok [INFO] [stdout] test config_show_json_emits_valid_json ... ok [INFO] [stdout] test explore_table_shows_proxied_breakdown ... ok [INFO] [stdout] test digest_json_is_valid ... ok [INFO] [stdout] test explore_json_has_dimensions ... ok [INFO] [stdout] test digest_table_shows_bill_of_materials ... ok [INFO] [stdout] test history_json_emits_array_of_rows ... ok [INFO] [stdout] test history_json_includes_burndown ... ok [INFO] [stdout] test metrics_empty_db_does_not_panic ... ok [INFO] [stdout] test history_table_includes_seeded_day ... ok [INFO] [stdout] test metrics_json_is_valid ... ok [INFO] [stdout] test metrics_table_shows_percentiles ... ok [INFO] [stdout] test security_command_json_emits_array ... ok [INFO] [stdout] test config_set_rejects_invalid_value ... ok [INFO] [stdout] test security_command_lists_seeded_event ... ok [INFO] [stdout] test security_command_filters_by_event_type ... ok [INFO] [stdout] test config_doctor_errors_on_out_of_range_value ... ok [INFO] [stdout] test config_set_rejects_unknown_key ... ok [INFO] [stdout] test security_command_with_empty_db_says_none ... ok [INFO] [stdout] test status_table_shows_seeded_data ... ok [INFO] [stdout] test status_json_emits_valid_structure ... ok [INFO] [stdout] test status_with_empty_db_does_not_panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.73s [INFO] [stdout] [INFO] [stderr] Running tests/unit/config_test.rs (/opt/rustwide/target/debug/deps/config_test-7c35baac75c4c385) [INFO] [stdout] [INFO] [stdout] running 17 tests [INFO] [stdout] test load_returns_default_when_file_missing ... ok [INFO] [stdout] test security_config_converts_to_runtime_ruleset ... ok [INFO] [stdout] test security_enabled_flows_into_ruleset ... ok [INFO] [stdout] test set_dotted_key_handles_boolean_fields ... ok [INFO] [stdout] test scrape_helpers_honor_per_tool_and_legacy_kill_switch ... ok [INFO] [stdout] test default_config_has_sensible_values ... ok [INFO] [stdout] test budget_config_converts_to_runtime_type ... ok [INFO] [stdout] test set_dotted_key_handles_numeric_fields ... ok [INFO] [stdout] test set_dotted_key_handles_string_fields ... ok [INFO] [stdout] test set_dotted_key_parses_csv_lists ... ok [INFO] [stdout] test set_dotted_key_rejects_unknown_keys ... ok [INFO] [stdout] test tools_and_waste_defaults_and_set ... ok [INFO] [stdout] test set_dotted_key_rejects_invalid_values ... ok [INFO] [stdout] test save_creates_missing_directory ... ok [INFO] [stdout] test default_config_does_not_serialize_deprecated_log_scrape ... ok [INFO] [stdout] test save_then_load_roundtrips ... ok [INFO] [stdout] test explicitly_disabled_log_scrape_is_preserved ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/integration/daemon_test.rs (/opt/rustwide/target/debug/deps/daemon_test-8234f890ff91771f) [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] test process_is_alive_for_the_current_process ... ok [INFO] [stdout] test process_is_alive_false_for_a_bogus_pid ... ok [INFO] [stdout] test pid_file_write_read_remove_roundtrip ... ok [INFO] [stdout] test read_pid_file_discards_corrupt_contents ... ok [INFO] [stdout] test running_pid_clears_a_stale_file ... ok [INFO] [stdout] test read_pid_file_rejects_zero ... ok [INFO] [stdout] test running_pid_reports_a_live_process ... ok [INFO] [stdout] test stop_removes_a_stale_pid_file ... ok [INFO] [stdout] test stop_when_not_running_says_so ... ok [INFO] [stdout] test start_daemon_refuses_when_already_running ... ok [INFO] [stdout] test start_daemon_then_stop_lifecycle ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- start_daemon_then_stop_lifecycle stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'start_daemon_then_stop_lifecycle' (608) panicked at tests/integration/daemon_test.rs:194:10: [INFO] [stdout] Unexpected stdout, failed var.contains(Stopped Burnwall) [INFO] [stdout] ├── var: Sent stop signal to Burnwall (PID 656); it has not exited yet. [INFO] [stdout] └── var as str: Sent stop signal to Burnwall (PID 656); it has not exited yet. [INFO] [stdout] [INFO] [stdout] command=`BURNWALL_DATA_DIR="/tmp/.tmpyNRrpS" "/opt/rustwide/target/debug/burnwall" "stop"` [INFO] [stdout] code=0 [INFO] [stdout] stdout="Sent stop signal to Burnwall (PID 656); it has not exited yet.\n" [INFO] [stdout] stderr="" [INFO] [stdout] [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d4189f992a8 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d4189f992a8 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d4189f992a8 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5d4189f992a8 - <::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5d4189fb03ea - ::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5d4189fb03ea - core[5a1c3e9896636f3a]::fmt::write [INFO] [stdout] 6: 0x5d4189f9f492 - std[d054f6f42beb1baa]::io::default_write_fmt::> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x5d4189f9f492 - as std[d054f6f42beb1baa]::io::Write>::write_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x5d4189f75466 - ::print [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5d4189f75466 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5d4189f906d9 - std[d054f6f42beb1baa]::panicking::default_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5d4189ebfa4c - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 12: 0x5d4189ebfa4c - test[fad20673b750c10e]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x5d4189f90892 - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 14: 0x5d4189f90892 - std[d054f6f42beb1baa]::panicking::panic_with_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5d4189f75522 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5d4189f6c5c9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5d4189f765ad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5d4189fb0c2c - core[5a1c3e9896636f3a]::panicking::panic_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5d4189f2dad8 - core[5a1c3e9896636f3a]::panicking::panic_display:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:259:5 [INFO] [stdout] 20: 0x5d4189f2da37 - ::panic:: [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assert_cmd-2.2.2/src/assert.rs:1061:9 [INFO] [stdout] 21: 0x5d4189ea5201 - ::stdout::> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assert_cmd-2.2.2/src/assert.rs:387:25 [INFO] [stdout] 22: 0x5d4189ea89b8 - daemon_test[2166b17ede5de1ee]::start_daemon_then_stop_lifecycle [INFO] [stdout] at /opt/rustwide/workdir/tests/integration/daemon_test.rs:194:10 [INFO] [stdout] 23: 0x5d4189ea6697 - daemon_test[2166b17ede5de1ee]::start_daemon_then_stop_lifecycle::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/integration/daemon_test.rs:162:38 [INFO] [stdout] 24: 0x5d4189eaad26 - >::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x5d4189eb2b2b - core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 26: 0x5d4189eb2b2b - test[fad20673b750c10e]::__rust_begin_short_backtrace::, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18 [INFO] [stdout] 27: 0x5d4189ec03a5 - test[fad20673b750c10e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74 [INFO] [stdout] 28: 0x5d4189ec03a5 - as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 29: 0x5d4189ec03a5 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 30: 0x5d4189ec03a5 - std[d054f6f42beb1baa]::panicking::catch_unwind::, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 31: 0x5d4189ec03a5 - std[d054f6f42beb1baa]::panic::catch_unwind::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 32: 0x5d4189ec03a5 - test[fad20673b750c10e]::run_test_in_process [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27 [INFO] [stdout] 33: 0x5d4189ec03a5 - test[fad20673b750c10e]::run_test::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43 [INFO] [stdout] 34: 0x5d4189ebaf04 - test[fad20673b750c10e]::run_test::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41 [INFO] [stdout] 35: 0x5d4189ebaf04 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 36: 0x5d4189ec3422 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 37: 0x5d4189ec3422 - ::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 38: 0x5d4189ec3422 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 39: 0x5d4189ec3422 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 40: 0x5d4189ec3422 - std[d054f6f42beb1baa]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 41: 0x5d4189ec3422 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 42: 0x5d4189ec3422 - ::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 43: 0x5d4189f9864f - + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9 [INFO] [stdout] 44: 0x5d4189f9864f - ::new::thread_start [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 45: 0x7b954c7e3aa4 - [INFO] [stdout] 46: 0x7b954c870a64 - clone [INFO] [stdout] 47: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] start_daemon_then_stop_lifecycle [INFO] [stdout] [INFO] [stdout] test result: FAILED. 10 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.69s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test daemon_test` [INFO] running `Command { std: "docker" "inspect" "beb8bfd3ce5324f846084d4b8bfb776d2635391048869b4fd915a431ccb076a0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "beb8bfd3ce5324f846084d4b8bfb776d2635391048869b4fd915a431ccb076a0", kill_on_drop: false }` [INFO] [stdout] beb8bfd3ce5324f846084d4b8bfb776d2635391048869b4fd915a431ccb076a0