[INFO] fetching crate turbovault-core 1.5.0...
[INFO] testing turbovault-core-1.5.0 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate turbovault-core 1.5.0 into /workspace/builds/worker-2-tc1/source
[INFO] started tweaking crates.io crate turbovault-core 1.5.0
[INFO] finished tweaking crates.io crate turbovault-core 1.5.0
[INFO] tweaked toml for crates.io crate turbovault-core 1.5.0 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate turbovault-core 1.5.0 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate turbovault-core 1.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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f759f00d48b0b3d107845170d91754192c4c2d0f31e31dab65f3ae32e137663f
[INFO] running `Command { std: "docker" "start" "-a" "f759f00d48b0b3d107845170d91754192c4c2d0f31e31dab65f3ae32e137663f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f759f00d48b0b3d107845170d91754192c4c2d0f31e31dab65f3ae32e137663f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f759f00d48b0b3d107845170d91754192c4c2d0f31e31dab65f3ae32e137663f", kill_on_drop: false }`
[INFO] [stdout] f759f00d48b0b3d107845170d91754192c4c2d0f31e31dab65f3ae32e137663f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 50877275b56196f6efb59ccf84cfdf68bcc6470203bb5d1f33ae861c417bc9ef
[INFO] running `Command { std: "docker" "start" "-a" "50877275b56196f6efb59ccf84cfdf68bcc6470203bb5d1f33ae861c417bc9ef", kill_on_drop: false }`
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling winnow v1.0.2
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling shellexpand v3.1.2
[INFO] [stderr]    Compiling uuid v1.23.1
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling tokio v1.52.1
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling turbovault-core v1.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.53s
[INFO] running `Command { std: "docker" "inspect" "50877275b56196f6efb59ccf84cfdf68bcc6470203bb5d1f33ae861c417bc9ef", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "50877275b56196f6efb59ccf84cfdf68bcc6470203bb5d1f33ae861c417bc9ef", kill_on_drop: false }`
[INFO] [stdout] 50877275b56196f6efb59ccf84cfdf68bcc6470203bb5d1f33ae861c417bc9ef
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 78beff0501f1902ef2f9230fb85888586e9a68fe917d5409576989808e4c9082
[INFO] running `Command { std: "docker" "start" "-a" "78beff0501f1902ef2f9230fb85888586e9a68fe917d5409576989808e4c9082", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling tokio v1.52.1
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling turbovault-core v1.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 15.02s
[INFO] running `Command { std: "docker" "inspect" "78beff0501f1902ef2f9230fb85888586e9a68fe917d5409576989808e4c9082", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "78beff0501f1902ef2f9230fb85888586e9a68fe917d5409576989808e4c9082", kill_on_drop: false }`
[INFO] [stdout] 78beff0501f1902ef2f9230fb85888586e9a68fe917d5409576989808e4c9082
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 056662bfcfb397fcee68e2ff2035e63e50f9b7315d93369013372f1ad0016d7f
[INFO] running `Command { std: "docker" "start" "-a" "056662bfcfb397fcee68e2ff2035e63e50f9b7315d93369013372f1ad0016d7f", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/turbovault_core-aa1c59aaf1114130)
[INFO] [stdout] 
[INFO] [stdout] running 100 tests
[INFO] [stdout] test cache::tests::test_hash_path_different_paths ... ok
[INFO] [stdout] test cache::tests::test_hash_path_deterministic ... ok
[INFO] [stdout] test config::tests::test_vault_config_builder ... ok
[INFO] [stdout] test config::tests::test_server_config_validation ... ok
[INFO] [stdout] test error::tests::test_error_creation ... ok
[INFO] [stdout] test metrics::tests::test_counter_increment ... ok
[INFO] [stdout] test metrics::tests::test_counter_saturation ... ok
[INFO] [stdout] test metrics::tests::test_histogram_stats ... ok
[INFO] [stdout] test metrics::tests::test_metrics_context ... ok
[INFO] [stdout] test models::tests::test_line_index_empty_content ... ok
[INFO] [stdout] test models::tests::test_line_index_line_start ... ok
[INFO] [stdout] test models::tests::test_line_index_trailing_newline ... ok
[INFO] [stdout] test models::tests::test_source_position ... ok
[INFO] [stdout] test metrics::tests::test_metrics_context_disabled ... ok
[INFO] [stdout] test models::tests::test_task_item_deserializes_without_metadata_fields ... ok
[INFO] [stdout] test models::tests::test_frontmatter_tags ... ok
[INFO] [stdout] test models::tests::test_line_index_multiline ... ok
[INFO] [stdout] test cache::tests::test_load_nonexistent_returns_empty ... ok
[INFO] [stdout] test models::tests::test_source_position_from_offset_indexed ... ok
[INFO] [stdout] test models::tests::test_task_item_deserializes_with_metadata_fields ... ok
[INFO] [stdout] test cache::tests::test_clear_removes_data ... ok
[INFO] [stdout] test models::tests::test_line_index_single_line ... ok
[INFO] [stdout] test multi_vault::tests::test_add_vault ... ok
[INFO] [stdout] test multi_vault::tests::test_add_duplicate_vault_fails ... ok
[INFO] [stdout] test multi_vault::tests::test_multi_vault_manager_creation ... ok
[INFO] [stdout] test multi_vault::tests::test_clone ... ok
[INFO] [stdout] test multi_vault::tests::test_get_active_vault ... ok
[INFO] [stdout] test multi_vault::tests::test_add_vault_at_max_limit ... ok
[INFO] [stdout] test multi_vault::tests::test_get_effective_vault_settings ... ok
[INFO] [stdout] test multi_vault::tests::test_remove_active_vault_reassigns ... ok
[INFO] [stdout] test multi_vault::tests::test_remove_vault ... ok
[INFO] [stdout] test models::tests::test_source_position_first_line ... ok
[INFO] [stdout] test models::tests::test_task_item_from_parsed_metadata ... ok
[INFO] [stdout] test models::tests::test_task_priority_serializes_as_stable_api_value ... ok
[INFO] [stdout] test multi_vault::tests::test_set_active_vault ... ok
[INFO] [stdout] test cache::tests::test_save_and_load_roundtrip ... ok
[INFO] [stdout] test multi_vault::tests::test_remove_default_vault_reassigns ... ok
[INFO] [stdout] test profiles::tests::test_readonly_profile ... ok
[INFO] [stdout] test multi_vault::tests::test_vault_count ... ok
[INFO] [stdout] test profiles::tests::test_profile_names ... ok
[INFO] [stdout] test profiles::tests::test_recommend_large_vault ... ok
[INFO] [stdout] test profiles::tests::test_high_performance_profile ... ok
[INFO] [stdout] test metrics::tests::test_histogram_timer ... ok
[INFO] [stdout] test profiles::tests::test_development_profile ... ok
[INFO] [stdout] test profiles::tests::test_production_profile ... ok
[INFO] [stdout] test profiles::tests::test_minimal_profile ... ok
[INFO] [stdout] test cache::tests::test_init_creates_cache_directory ... ok
[INFO] [stdout] test profiles::tests::test_profile_descriptions ... ok
[INFO] [stdout] test models::tests::test_source_position_from_offset ... ok
[INFO] [stdout] test multi_vault::tests::test_set_invalid_active_vault ... ok
[INFO] [stdout] test profiles::tests::test_recommend_medium_vault ... ok
[INFO] [stdout] test resilience::tests::test_circuit_breaker_closed ... ok
[INFO] [stdout] test task_parser::tests::keeps_bare_recurrence_marker_in_description ... ok
[INFO] [stdout] test task_parser::tests::parses_dataview_metadata ... ok
[INFO] [stdout] test task_parser::tests::parses_dataview_on_completion_and_dependencies ... ok
[INFO] [stdout] test profiles::tests::test_recommend_production_vault ... ok
[INFO] [stdout] test task_parser::tests::parses_dataview_value_with_wikilink ... ok
[INFO] [stdout] test profiles::tests::test_recommend_small_vault ... ok
[INFO] [stdout] test multi_vault::tests::test_list_vaults ... ok
[INFO] [stdout] test task_parser::tests::parses_comma_separated_dataview_fields ... ok
[INFO] [stdout] test task_parser::tests::parses_dataview_completion_repeat_and_priority ... ok
[INFO] [stdout] test task_parser::tests::keeps_middle_metadata_in_description ... ok
[INFO] [stdout] test task_parser::tests::parses_basic_emoji_metadata ... ok
[INFO] [stdout] test task_parser::tests::ignores_false_positive_in_description ... ok
[INFO] [stdout] test task_parser::tests::supports_parenthesized_dataview_fields ... ok
[INFO] [stdout] test utils::tests::test_to_json_string ... ok
[INFO] [stdout] test utils::tests::test_csv_builder ... ok
[INFO] [stdout] test task_parser::tests::parses_priority ... ok
[INFO] [stdout] test utils::tests::test_path_validator_valid ... ok
[INFO] [stdout] test multi_vault::tests::test_can_create_empty_vaults ... ok
[INFO] [stdout] test task_parser::tests::parses_emoji_on_completion_and_dependencies ... ok
[INFO] [stdout] test cache::tests::test_corrupted_cache_graceful ... ok
[INFO] [stdout] test task_parser::tests::parses_mixed_emoji_and_dataview ... ok
[INFO] [stdout] test task_parser::tests::parses_tags_and_block_ref_after_metadata ... ok
[INFO] [stdout] test task_parser::tests::duplicate_fields_rightmost_wins ... ok
[INFO] [stdout] test utils::tests::test_path_validator_traversal ... ok
[INFO] [stdout] test validation::tests::test_composite_validator ... ok
[INFO] [stdout] test utils::tests::test_transaction_builder ... ok
[INFO] [stdout] test validation::tests::test_content_validator_max_length ... ok
[INFO] [stdout] test validation::tests::test_content_validator_min_length ... ok
[INFO] [stdout] test validation::tests::test_frontmatter_validator_missing_required_field ... ok
[INFO] [stdout] test validation::tests::test_link_validator_empty_target ... ok
[INFO] [stdout] test validation::tests::test_frontmatter_validator_with_required_field ... ok
[INFO] [stdout] test validation::tests::test_link_validator_url_in_wikilink ... ok
[INFO] [stdout] test validation::tests::test_frontmatter_validator_no_requirements ... ok
[INFO] [stdout] test validation::tests::test_validation_issue_with_suggestion ... ok
[INFO] [stdout] test validation::tests::test_severity_is_failure ... ok
[INFO] [stdout] test validation::tests::test_validation_report_add_issue ... ok
[INFO] [stdout] test validation::tests::test_validation_report_issues_by_severity ... ok
[INFO] [stdout] test validation::tests::test_validation_issue_creation ... ok
[INFO] [stdout] test validation::tests::test_link_validator_fragment_only ... ok
[INFO] [stdout] test validation::tests::test_validation_issue_with_line ... ok
[INFO] [stdout] test validation::tests::test_content_validator_require_heading ... ok
[INFO] [stdout] test validation::tests::test_validation_report_creation ... ok
[INFO] [stdout] test validation::tests::test_validation_report_merge ... ok
[INFO] [stdout] test resilience::tests::test_circuit_breaker_opens ... ok
[INFO] [stdout] test validation::tests::test_validator_name ... ok
[INFO] [stdout] test resilience::tests::test_retry_max_attempts ... ok
[INFO] [stdout] test resilience::tests::test_circuit_breaker_half_open ... ok
[INFO] [stdout] test resilience::tests::test_retry_success ... ok
[INFO] [stderr]    Doc-tests turbovault_core
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 100 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.33s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test src/models.rs - models::ListItem::to_plain_text (line 632) ... ok
[INFO] [stdout] test src/models.rs - models::InlineElement::to_plain_text (line 586) ... ok
[INFO] [stdout] test src/lib.rs - (line 61) ... ok
[INFO] [stdout] test src/lib.rs - (line 29) ... ok
[INFO] [stdout] test src/lib.rs - (line 46) ... ok
[INFO] [stdout] test src/models.rs - models::LineIndex (line 91) ... ok
[INFO] [stdout] test src/models.rs - models::ContentBlock::to_plain_text (line 478) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.71s; merged doctests compilation took 0.69s
[INFO] running `Command { std: "docker" "inspect" "056662bfcfb397fcee68e2ff2035e63e50f9b7315d93369013372f1ad0016d7f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "056662bfcfb397fcee68e2ff2035e63e50f9b7315d93369013372f1ad0016d7f", kill_on_drop: false }`
[INFO] [stdout] 056662bfcfb397fcee68e2ff2035e63e50f9b7315d93369013372f1ad0016d7f
