[INFO] fetching crate statsai-pricing 0.5.0...
[INFO] testing statsai-pricing-0.5.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate statsai-pricing 0.5.0 into /workspace/builds/worker-0-tc2/source
[INFO] started tweaking crates.io crate statsai-pricing 0.5.0
[INFO] finished tweaking crates.io crate statsai-pricing 0.5.0
[INFO] tweaked toml for crates.io crate statsai-pricing 0.5.0 written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate statsai-pricing 0.5.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate statsai-pricing 0.5.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "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/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c
[INFO] running `Command { std: "docker" "start" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling schemars v0.8.22
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling tinyvec v1.12.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling unicode-normalization v0.1.25
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling schemars_derive v0.8.22
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling statsai-core v0.5.0
[INFO] [stderr]    Compiling statsai-pricing v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 20.87s
[INFO] running `Command { std: "docker" "inspect" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling statsai-pricing v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.20s
[INFO] running `Command { std: "docker" "inspect" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/statsai-pricing/5b11c57fc42d558d/out/statsai_pricing-5b11c57fc42d558d)
[INFO] [stdout] 
[INFO] [stdout] running 49 tests
[INFO] [stdout] test tests::applies_verified_xai_cached_and_long_context_rates ... ok
[INFO] [stdout] test tests::cached_input_reduces_billable ... ok
[INFO] [stdout] test tests::estimates_cost_for_legacy_claude_opus_4 ... ok
[INFO] [stdout] test tests::estimates_cost_for_provider_prefixed_model ... ok
[INFO] [stdout] test tests::codex_auto_review_reuses_luna_rates_from_july_30 ... ok
[INFO] [stdout] test tests::codex_auto_review_reuses_mapped_model_long_context_multipliers ... ok
[INFO] [stdout] test tests::applies_gpt_5_6_long_context_rates ... ok
[INFO] [stdout] test tests::estimates_cost_for_provider_prefixed_openai_models ... ok
[INFO] [stdout] test tests::estimates_cost_for_claude_family_alias ... ok
[INFO] [stdout] test tests::codex_auto_review_reuses_gpt_5_4_rates_before_july_30 ... ok
[INFO] [stdout] test tests::estimates_grok_4_3_cost_with_discounted_cached_input ... ok
[INFO] [stdout] test tests::gpt_5_4_long_context_pricing_requires_one_explicit_request ... ok
[INFO] [stdout] test tests::estimates_gpt_5_6_variant_costs_with_their_distinct_rates ... ok
[INFO] [stdout] test tests::claude_one_hour_cache_writes_use_the_extended_ttl_rate ... ok
[INFO] [stdout] test tests::estimates_cost_for_proxy_wrapped_claude_model ... ok
[INFO] [stdout] test tests::grok_4_6_mixed_requests_sum_short_and_long_context_costs ... ok
[INFO] [stdout] test tests::gpt_5_6_luna_and_terra_pricing_uses_usage_date ... ok
[INFO] [stdout] test tests::estimates_grok_4_5_cost_with_cached_input ... ok
[INFO] [stdout] test tests::grok_4_6_xai_long_context_boundary_includes_cached_tokens ... ok
[INFO] [stdout] test tests::historical_claude_fast_mode_uses_the_six_times_opus_rate ... ok
[INFO] [stdout] test tests::normalizes_provider_prefixes ... ok
[INFO] [stdout] test tests::missing_model_returns_unknown_cost ... ok
[INFO] [stdout] test tests::normalizes_proxy_wrapped_model_names ... ok
[INFO] [stdout] test tests::normalizes_unknown_model_to_lowercase ... ok
[INFO] [stdout] test tests::normalizes_whitespace ... ok
[INFO] [stdout] test tests::normalizes_claude_thinking_variant ... ok
[INFO] [stdout] test tests::overlay_replaces_estimated_only_cost ... ok
[INFO] [stdout] test tests::overlay_preserves_provider_reported_provenance ... ok
[INFO] [stdout] test tests::preserves_codex_auto_review_observed_identity ... ok
[INFO] [stdout] test tests::normalizes_grok_build_aliases ... ok
[INFO] [stdout] test tests::output_and_reasoning_pricing_does_not_overflow ... ok
[INFO] [stdout] test tests::normalizes_codex_aliases ... ok
[INFO] [stdout] test tests::normalizes_cursor_composer_aliases ... ok
[INFO] [stdout] test tests::codex_auto_review_reports_aggregate_periods_that_cross_its_equivalent_change ... ok
[INFO] [stdout] test tests::estimates_cost_for_known_model ... ok
[INFO] [stdout] test tests::reasoning_tokens_are_billed_as_output ... ok
[INFO] [stdout] test tests::ruleset_version_is_numeric_and_catalog_is_descriptive ... ok
[INFO] [stdout] test tests::sonnet_5_pricing_uses_usage_date ... ok
[INFO] [stdout] test tests::sonnet_5_reports_aggregate_periods_that_cross_its_price_change ... ok
[INFO] [stdout] test tests::unclassified_claude_cache_writes_keep_the_legacy_five_minute_rate ... ok
[INFO] [stdout] test tests::unknown_model_returns_unknown_cost ... ok
[INFO] [stdout] test tests::preserves_sub_cent_cost_in_micro_usd ... ok
[INFO] [stdout] test tests::gpt_5_6_luna_and_terra_report_aggregate_periods_that_cross_the_july_30_cut ... ok
[INFO] [stdout] test tests::normalizes_gpt_5_6_family_and_proxy_wrapped_ids ... ok
[INFO] [stdout] test tests::claude_fast_mode_prices_all_token_categories_at_premium_rates ... ok
[INFO] [stdout] test tests::cache_creation_tokens_are_billed_separately ... ok
[INFO] [stdout] test tests::grok_4_6_reasoning_tokens_use_the_output_rate ... ok
[INFO] [stdout] test tests::grok_4_6_uses_official_short_context_rates_without_rewriting_identity ... ok
[INFO] [stdout] test tests::grok_4_6_wrapped_ids_keep_observed_identity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 49 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests statsai_pricing
[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" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c", kill_on_drop: false }`
[INFO] [stdout] 632fb4f6a6643cf86b1e76f14a366895101e021591ee77808faab625a06ce36c
