[INFO] fetching crate headwater-scaffold 0.5.0...
[INFO] testing headwater-scaffold-0.5.0 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate headwater-scaffold 0.5.0 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate headwater-scaffold 0.5.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate headwater-scaffold 0.5.0
[INFO] tweaked toml for crates.io crate headwater-scaffold 0.5.0 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate headwater-scaffold 0.5.0 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate headwater-scaffold 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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded headwater-ref v0.5.0
[INFO] [stderr]   Downloaded saphyr-parser v0.0.11
[INFO] [stderr]   Downloaded headwater-mark v0.5.0
[INFO] [stderr]   Downloaded headwater-paint v0.5.0
[INFO] [stderr]   Downloaded headwater-hash v0.5.0
[INFO] [stderr]   Downloaded headwater-yaml v0.5.0
[INFO] [stderr]   Downloaded headwater-lock v0.5.0
[INFO] [stderr]   Downloaded headwater-doc v0.5.0
[INFO] [stderr]   Downloaded headwater-vcs v0.5.0
[INFO] [stderr]   Downloaded headwater-meta v0.5.0
[INFO] [stderr]   Downloaded headwater-graph v0.5.0
[INFO] [stderr]   Downloaded headwater-census v0.5.0
[INFO] [stderr]   Downloaded headwater-resolve v0.5.0
[INFO] [stderr]   Downloaded headwater-check v0.5.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed
[INFO] running `Command { std: "docker" "start" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed", 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" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed", 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" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling arraydeque v0.5.1
[INFO] [stderr]    Compiling pulldown-cmark v0.13.4
[INFO] [stderr]    Compiling headwater-ref v0.5.0
[INFO] [stderr]    Compiling headwater-resolve v0.5.0
[INFO] [stderr]    Compiling headwater-hash v0.5.0
[INFO] [stderr]    Compiling headwater-paint v0.5.0
[INFO] [stderr]    Compiling headwater-mark v0.5.0
[INFO] [stderr]    Compiling headwater-vcs v0.5.0
[INFO] [stderr]    Compiling saphyr-parser v0.0.11
[INFO] [stderr]    Compiling headwater-yaml v0.5.0
[INFO] [stderr]    Compiling headwater-meta v0.5.0
[INFO] [stderr]    Compiling headwater-doc v0.5.0
[INFO] [stderr]    Compiling headwater-census v0.5.0
[INFO] [stderr]    Compiling headwater-graph v0.5.0
[INFO] [stderr]    Compiling headwater-check v0.5.0
[INFO] [stderr]    Compiling headwater-scaffold v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 48.77s
[INFO] running `Command { std: "docker" "inspect" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed", 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" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling headwater-lock v0.5.0
[INFO] [stderr]    Compiling headwater-scaffold v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 10.56s
[INFO] running `Command { std: "docker" "inspect" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed", 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" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/headwater_scaffold-1ac5d2beca31e728)
[INFO] [stdout] 
[INFO] [stdout] running 73 tests
[INFO] [stdout] test fix::tests::an_offset_inside_a_block_quote_is_refused ... ok
[INFO] [stdout] test fix::tests::a_half_with_an_attribute_replaces_the_value_an_entry_already_holds ... ok
[INFO] [stdout] test fix::tests::a_half_is_written_by_the_splice ... ok
[INFO] [stdout] test fix::tests::two_patches_over_one_range_are_refused_together ... ok
[INFO] [stdout] test fix::tests::a_substitution_inside_a_links_text_lands_and_keeps_the_link ... ok
[INFO] [stdout] test fix::tests::a_replacement_that_reads_as_markup_is_refused ... ok
[INFO] [stdout] test fix::tests::a_file_that_moved_under_the_patch_is_refused_with_nothing_written ... ok
[INFO] [stdout] test fix::tests::two_facet_patches_over_one_facet_write_it_once ... ok
[INFO] [stdout] test fix::tests::a_half_with_an_attribute_turns_a_bare_entry_into_the_mapping_form ... ok
[INFO] [stdout] test fix::tests::a_substitution_lands_and_the_rest_of_the_file_is_untouched ... ok
[INFO] [stdout] test fix::tests::a_refusal_over_one_file_does_not_hold_back_another ... ok
[INFO] [stdout] test fix::tests::a_patch_that_changes_nothing_writes_no_file ... ok
[INFO] [stdout] test migrate::tests::two_moves_over_one_document_both_land ... ok
[INFO] [stdout] test fix::tests::a_state_and_its_stamp_land_together ... ok
[INFO] [stdout] test migrate::tests::a_quoted_value_keeps_its_quotes ... ok
[INFO] [stdout] test overlay::tests::a_move_that_does_not_describe_the_operation_at_its_span_is_refused ... ok
[INFO] [stdout] test migrate::tests::a_value_inside_a_sequence_moves_where_it_sits ... ok
[INFO] [stdout] test migrate::tests::a_key_the_document_does_not_declare_is_refused ... ok
[INFO] [stdout] test migrate::tests::a_refusal_over_one_document_does_not_hold_back_another ... ok
[INFO] [stdout] test migrate::tests::a_replacement_that_reads_as_a_second_key_is_refused ... ok
[INFO] [stdout] test fix::tests::a_facet_that_moved_refuses_both_writes ... ok
[INFO] [stdout] test proposal::a_lock_with_no_namespace_gets_the_placeholder_and_is_told_to_replace_it ... ok
[INFO] [stdout] test fix::tests::one_half_asked_for_twice_is_written_once ... ok
[INFO] [stdout] test proposal::a_scheme_that_overlaps_everything_leaves_no_proposal ... ok
[INFO] [stdout] test fix::tests::an_offset_inside_a_code_span_is_refused ... ok
[INFO] [stdout] test proposal::a_taken_name_steps_to_the_next_suffix ... ok
[INFO] [stdout] test overlay::tests::a_quoted_address_keeps_its_quotes ... ok
[INFO] [stdout] test migrate::tests::one_scalar_moves_and_the_body_is_untouched ... ok
[INFO] [stdout] test overlay::tests::a_span_whose_bytes_are_not_the_address_is_refused ... ok
[INFO] [stdout] test overlay::tests::a_rewrite_that_collides_with_another_address_is_refused ... ok
[INFO] [stdout] test overlay::tests::an_overlay_that_is_not_there_is_refused_by_name ... ok
[INFO] [stdout] test overlay::tests::an_empty_move_list_composes_no_file ... ok
[INFO] [stdout] test overlay::tests::every_address_under_the_step_moves_and_no_value_does ... ok
[INFO] [stdout] test proposal::an_overlapping_pattern_steps_to_the_next_suffix ... ok
[INFO] [stdout] test proposal::the_namespace_is_one_a_resolved_scheme_carries ... ok
[INFO] [stdout] test reading::tests::a_member_that_cannot_be_read_is_an_error_naming_the_member ... ok
[INFO] [stdout] test reading::tests::a_line_the_store_cannot_read_is_named_by_its_line_number_and_never_counted ... ok
[INFO] [stdout] test reading::tests::a_reading_renders_as_one_line_in_a_fixed_member_order ... ok
[INFO] [stdout] test reading::tests::a_reading_written_before_the_term_existed_states_no_surface ... ok
[INFO] [stdout] test reading::tests::a_surface_this_engine_does_not_know_is_an_error_naming_the_member ... ok
[INFO] [stdout] test reading::tests::a_reading_without_an_identifier_carries_no_member_for_one ... ok
[INFO] [stdout] test reading::tests::an_absent_store_is_an_empty_store ... ok
[INFO] [stdout] test reading::tests::appending_twice_holds_both_readings_in_the_order_they_were_taken ... ok
[INFO] [stdout] test reading::tests::the_two_entry_points_are_two_populations ... ok
[INFO] [stdout] test reading::tests::two_taxonomies_are_two_digests_and_the_store_keeps_both ... ok
[INFO] [stdout] test reading::tests::what_the_writer_emits_is_what_the_reader_reads ... ok
[INFO] [stdout] test tree::tests::a_commit_that_fails_removes_the_document_this_run_created ... ok
[INFO] [stdout] test tree::tests::a_created_document_that_would_not_go_is_never_called_an_intact_tree ... ok
[INFO] [stdout] test tree::tests::a_created_document_lands_under_a_directory_that_was_not_there ... ok
[INFO] [stdout] test fix::tests::a_facet_line_that_carries_more_than_its_value_is_refused ... ok
[INFO] [stdout] test tree::tests::a_created_document_whose_path_is_taken_refuses_and_leaves_no_directory ... ok
[INFO] [stdout] test tree::tests::a_created_file_that_will_not_go_is_named_rather_than_claimed_removed ... ok
[INFO] [stdout] test tree::tests::a_file_replaced_under_its_handle_is_lost_rather_than_restored ... ok
[INFO] [stdout] test tree::tests::a_target_that_will_not_open_stops_the_run_before_any_file_moves ... ok
[INFO] [stdout] test tree::tests::the_tree_is_as_it_was_is_printed_only_when_it_is ... ok
[INFO] [stdout] test write::tests::a_present_target_is_replaced_when_only_an_attribute_value_moves ... ok
[INFO] [stdout] test write::tests::an_absent_target_is_appended_beside_other_targets_of_the_same_relation ... ok
[INFO] [stdout] test write::tests::an_absent_target_is_appended_on_a_document_with_other_relations ... ok
[INFO] [stdout] test write::tests::an_absent_target_is_appended_on_an_empty_relation ... ok
[INFO] [stdout] test tree::tests::a_write_that_fails_part_way_puts_the_file_it_failed_on_back ... ok
[INFO] [stdout] test tree::tests::an_empty_run_commits_nothing_and_says_so ... ok
[INFO] [stdout] test tree::tests::a_file_unlinked_under_its_handle_is_lost_rather_than_restored ... ok
[INFO] [stdout] test tree::tests::a_write_that_does_not_read_back_off_the_tree_undoes_the_run ... ok
[INFO] [stdout] test tree::tests::a_file_that_could_not_be_put_back_is_named_rather_than_called_intact ... ok
[INFO] [stdout] test tree::tests::a_read_only_target_is_named_and_nothing_is_written ... FAILED
[INFO] [stdout] test tree::tests::a_read_back_that_fails_removes_the_document_this_run_created ... ok
[INFO] [stdout] test tree::tests::every_file_lands_and_reads_back ... ok
[INFO] [stdout] test fix::tests::an_offset_inside_the_front_matter_is_refused ... ok
[INFO] [stdout] test fix::tests::two_substitutions_in_one_file_both_land_at_the_bytes_they_named ... ok
[INFO] [stdout] test migrate::tests::a_key_that_no_longer_holds_the_value_is_refused_with_nothing_composed ... ok
[INFO] [stdout] test write::tests::a_present_target_is_replaced_not_duplicated_when_it_grows ... ok
[INFO] [stdout] test write::tests::a_present_target_is_replaced_not_duplicated_when_it_shrinks ... ok
[INFO] [stdout] test tree::tests::a_single_file_run_that_fails_part_way_puts_that_file_back ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tree::tests::a_read_only_target_is_named_and_nothing_is_written stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tree::tests::a_read_only_target_is_named_and_nothing_is_written' (958) panicked at src/tree.rs:900:14:
[INFO] [stdout] the read-only target does not open: Reserved["a.md", "b.md"]
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b62bb8acbf1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5b62bb8c2d3a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5b62bb8b13fc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5b62bb887056 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5b62bb8a4149 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5b62bb7e9b00 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5b62bb8a4302 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5b62bb887102 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5b62bb87fb79 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5b62bb887ead - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5b62bb8c346c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5b62bb8c3242 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5b62bb78ec40 - headwater_scaffold[a6a7b39beb1d091f]::tree::tests::a_read_only_target_is_named_and_nothing_is_written
[INFO] [stdout]   13:     0x5b62bb7c8109 - <headwater_scaffold[a6a7b39beb1d091f]::tree::tests::a_read_only_target_is_named_and_nothing_is_written::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5b62bb7dcdeb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   15:     0x5b62bb7ea455 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5b62bb7e3d14 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5b62bb7ed5b2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5b62bb8abf69 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x7eba44411dfa - <unknown>
[INFO] [stdout]   20:     0x7eba444a53d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tree::tests::a_read_only_target_is_named_and_nothing_is_written
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 72 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed", kill_on_drop: false }`
[INFO] [stdout] 5d6db75f0e53d21ff4a364b0b30fbac9ae49fab394a01d389e661c045814fbed
