[INFO] fetching crate shore-ledger 0.1.17...
[INFO] testing shore-ledger-0.1.17 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate shore-ledger 0.1.17 into /workspace/builds/worker-0-tc2/source
[INFO] started tweaking crates.io crate shore-ledger 0.1.17
[INFO] finished tweaking crates.io crate shore-ledger 0.1.17
[INFO] tweaked toml for crates.io crate shore-ledger 0.1.17 written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate shore-ledger 0.1.17 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 shore-ledger 0.1.17 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] 5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036
[INFO] running `Command { std: "docker" "start" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036", 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" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036" "/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" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036", 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" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling hashbrown v0.17.0
[INFO] [stderr]    Compiling writeable v0.6.3
[INFO] [stderr]    Compiling litemap v0.8.2
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling icu_normalizer_data v2.2.0
[INFO] [stderr]    Compiling icu_properties_data v2.2.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling rustls v0.23.37
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling foldhash v0.1.5
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling zstd-safe v7.2.4
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling winnow v0.5.40
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling ipnet v2.12.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling hashlink v0.10.0
[INFO] [stderr]    Compiling webpki-roots v1.0.7
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling cc v1.2.59
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling iri-string v0.7.12
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling fastrand v2.4.1
[INFO] [stderr]    Compiling dotenvy v0.15.7
[INFO] [stderr]    Compiling uuid v1.23.0
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling zstd-sys v2.0.16+zstd.1.5.7
[INFO] [stderr]    Compiling libsqlite3-sys v0.35.0
[INFO] [stderr]    Compiling dashmap v6.1.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling zerofrom-derive v0.1.7
[INFO] [stderr]    Compiling yoke-derive v0.8.2
[INFO] [stderr]    Compiling zerovec-derive v0.11.3
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling zerofrom v0.1.7
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling yoke v0.8.2
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling tokio v1.51.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling rustls-webpki v0.103.10
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling zstd v0.13.3
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling toml_datetime v0.6.3
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling shore-protocol v0.12.0
[INFO] [stderr]    Compiling toml_edit v0.20.2
[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 toml v0.8.2
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling rusqlite v0.37.0
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling shore-config v0.18.2
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling shore-call-store v0.1.1
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling shore-llm v0.1.13
[INFO] [stderr]    Compiling shore-ledger v0.1.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 14s
[INFO] running `Command { std: "docker" "inspect" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036", 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" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036" "/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 shore-ledger v0.1.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.99s
[INFO] running `Command { std: "docker" "inspect" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036", 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" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036" "/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.27s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/shore-ledger/0919c6d2201b77cb/out/shore_ledger-0919c6d2201b77cb)
[INFO] [stdout] 
[INFO] [stdout] running 94 tests
[INFO] [stdout] test budget::tests::month_budget_respects_reset_day_of_month ... ok
[INFO] [stdout] test budget::tests::budget_can_filter_by_usage_kind ... ok
[INFO] [stdout] test budget::tests::day_budget_respects_reset_hour ... ok
[INFO] [stdout] test budget::tests::month_anchor_clamps_across_year_boundary ... ok
[INFO] [stdout] test budget::tests::compaction_can_bypass_block_budget ... ok
[INFO] [stdout] test budget::tests::month_anchor_clamps_to_short_months ... ok
[INFO] [stdout] test budget::tests::block_budget_blocks_matching_call ... ok
[INFO] [stdout] test budget::tests::newly_crossed_budget_warnings_are_deduped ... ok
[INFO] [stdout] test cache_tracker::tests::cold_keepalive_detected_despite_interleaved_model_thrash ... ok
[INFO] [stdout] test cache_tracker::tests::ceiling_raise_retunes_live_trackers ... ok
[INFO] [stdout] test budget::tests::week_budget_respects_reset_day_and_hour ... ok
[INFO] [stdout] test budget::tests::utc_day_budget_sums_matching_rows ... ok
[INFO] [stdout] test budget::tests::subscription_provider_call_is_never_blocked ... ok
[INFO] [stdout] test cache_tracker::tests::cold_keepalive_flagged_when_ping_writes_instead_of_reads ... ok
[INFO] [stdout] test cache_tracker::tests::cold_to_warm_no_anomaly_on_subsequent_calls ... ok
[INFO] [stdout] test cache_tracker::tests::cold_to_warm_on_cache_read ... ok
[INFO] [stdout] test cache_tracker::tests::cold_to_warm_on_cache_write ... ok
[INFO] [stdout] test cache_tracker::tests::compaction_transitions_to_cold ... ok
[INFO] [stdout] test budget::tests::week_budget_resets_today_when_past_anchor_hour ... ok
[INFO] [stdout] test cache_tracker::tests::keepalive_miss_when_ttl_expires_and_next_call_is_not_keepalive ... ok
[INFO] [stdout] test cache_tracker::tests::keepalive_with_smaller_read_is_not_unexpected_write ... ok
[INFO] [stdout] test cache_tracker::tests::first_tool_loop_zero_read_after_warm_message_is_unexpected_write ... ok
[INFO] [stdout] test cache_tracker::tests::model_change_transitions_to_cold ... ok
[INFO] [stdout] test budget::tests::over_limit_warning_refires_each_call ... ok
[INFO] [stdout] test budget::tests::unanchored_day_budget_matches_legacy_behavior ... ok
[INFO] [stdout] test cache_tracker::tests::no_keepalive_miss_when_idle_exceeds_ceiling ... ok
[INFO] [stdout] test cache_tracker::tests::consecutive_tool_loop_cache_drop_is_unexpected_write ... ok
[INFO] [stdout] test cache_tracker::tests::keepalive_miss_still_fires_within_ceiling ... ok
[INFO] [stdout] test cache_tracker::tests::reconstruct_cold_when_no_cache_read ... ok
[INFO] [stdout] test cache_tracker::tests::reconstruct_cold_when_ttl_expired ... ok
[INFO] [stdout] test cache_tracker::tests::no_keepalive_miss_when_keepalive_refreshes_warm_prefix ... ok
[INFO] [stdout] test cache_tracker::tests::reconstruct_warm_within_ttl ... ok
[INFO] [stdout] test cache_tracker::tests::starts_cold ... ok
[INFO] [stdout] test cache_tracker::tests::subagent_with_smaller_read_is_not_unexpected_write ... ok
[INFO] [stdout] test cache_tracker::tests::thinking_toggle_transitions_to_cold ... ok
[INFO] [stdout] test cache_tracker::tests::tool_loop_does_not_replace_normal_message_baseline ... ok
[INFO] [stdout] test cache_tracker::tests::ttl_expiry_transitions_to_cold_with_keepalive_miss ... ok
[INFO] [stdout] test cache_tracker::tests::unexpected_write_transitions_warm_to_cold ... ok
[INFO] [stdout] test cache_tracker::tests::warm_anomaly_on_cache_read_decrease ... ok
[INFO] [stdout] test cache_tracker::tests::no_keepalive_miss_on_compaction_cold ... ok
[INFO] [stdout] test cache_tracker::tests::tiny_tail_write_on_shorter_read_is_not_unexpected_write ... ok
[INFO] [stdout] test cache_tracker::tests::warm_stays_warm_on_increasing_cache_read ... ok
[INFO] [stdout] test client::tests::call_type_as_str ... ok
[INFO] [stdout] test cache_tracker::tests::no_keepalive_miss_when_pings_bridged_past_activity_ceiling ... ok
[INFO] [stdout] test cache_tracker::tests::no_keepalive_miss_when_cold_from_start ... ok
[INFO] [stdout] test client::tests::non_anthropic_skips_cache_tracker ... ok
[INFO] [stdout] test client::tests::record_maps_cache_creation_to_cache_write ... ok
[INFO] [stdout] test client::tests::dreaming_call_does_not_touch_cache_tracker ... ok
[INFO] [stdout] test client::tests::record_stores_cache_ttl ... ok
[INFO] [stdout] test client::tests::non_anthropic_records_cache_state_without_anomaly ... ok
[INFO] [stdout] test client::tests::record_updates_cache_tracker ... ok
[INFO] [stdout] test client::tests::foreign_model_compaction_resets_anthropic_tracker ... ok
[INFO] [stdout] test client::tests::record_uses_provider_total_cost_override ... ok
[INFO] [stdout] test client::tests::record_inserts_row ... ok
[INFO] [stdout] test client::tests::subscription_provider_records_zero_cost ... ok
[INFO] [stdout] test ledger::tests::last_anthropic_call ... ok
[INFO] [stdout] test ledger::tests::insert_and_read_back ... ok
[INFO] [stdout] test ledger::tests::create_and_insert ... ok
[INFO] [stdout] test ledger::tests::last_anthropic_call_matches_routed_anthropic ... ok
[INFO] [stdout] test pricing::tests::calculate_cost_with_known_pricing ... ok
[INFO] [stdout] test pricing::tests::calculate_cost_routed_anthropic_uses_catalog_cache_write_price ... ok
[INFO] [stdout] test ledger::tests::migration_backfills_provider_reported_cost_source ... ok
[INFO] [stdout] test pricing::tests::is_anthropic_pricing_recognizes_routed_calls ... ok
[INFO] [stdout] test ledger::tests::migrated_pre_v2_db_is_readable ... ok
[INFO] [stdout] test pricing::tests::calculate_cost_with_1h_cache_ttl ... ok
[INFO] [stdout] test pricing::tests::model_id_passthrough_for_prefixed_models ... ok
[INFO] [stdout] test pricing::tests::db_fallback_populates_memory_cache ... ok
[INFO] [stdout] test pricing::tests::parse_price_handles_string_and_number ... ok
[INFO] [stdout] test pricing::tests::store_and_retrieve_pricing ... ok
[INFO] [stdout] test pricing::tests::returns_none_for_unknown_model ... ok
[INFO] [stdout] test pricing::tests::clear_cache_removes_all ... ok
[INFO] [stdout] test ledger::tests::null_costs_when_pricing_unavailable ... ok
[INFO] [stdout] test pricing::tests::model_id_mapping ... ok
[INFO] [stdout] test query::tests::active_anthropic_characters_includes_routed_provider ... ok
[INFO] [stdout] test query::tests::anomalies_query ... ok
[INFO] [stdout] test pricing::tests::calculate_cost_with_none_cache_ttl_defaults_to_1h ... ok
[INFO] [stdout] test query::tests::filter_by_provider ... ok
[INFO] [stdout] test query::tests::all_cost_rows_skips_provider_reported_totals ... ok
[INFO] [stdout] test query::tests::model_usage_summary_groups_and_orders_by_first_seen ... ok
[INFO] [stdout] test query::tests::export_tsv_format ... ok
[INFO] [stdout] test query::tests::filter_by_api_key ... ok
[INFO] [stdout] test query::tests::summary_groups_by_api_key ... ok
[INFO] [stdout] test query::tests::summary_groups_by_call_type ... ok
[INFO] [stdout] test stream::tests::finalize_error_without_usage_records_zeros ... ok
[INFO] [stdout] test stream::tests::finalize_error_records_partial_usage_from_stream_errored ... ok
[INFO] [stdout] test query::tests::summary_groups_by_provider_model ... ok
[INFO] [stdout] test query::tests::warm_streak_counts_consecutive ... ok
[INFO] [stdout] test query::tests::summary_groups_by_usage_kind ... ok
[INFO] [stdout] test stream::tests::finalize_updates_cache_tracker ... ok
[INFO] [stdout] test stream::tests::finalize_records_to_ledger ... ok
[INFO] [stdout] test stream::tests::drop_without_finalize_records_cancelled_row ... ok
[INFO] [stdout] test pricing::tests::poisoned_memory_cache_mutex_is_recovered ... ok
[INFO] [stdout] test ledger::tests::poisoned_connection_mutex_is_recovered ... ok
[INFO] [stdout] test sync::tests::recovers_from_poisoned_mutex ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 94 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests shore_ledger
[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" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036", kill_on_drop: false }`
[INFO] [stdout] 5c72741fddf37e2dee22d407ad0b2aade4a9103119b9ec99fd99bd7ca59e3036
