[INFO] fetching crate scenomise 0.0.4...
[INFO] testing scenomise-0.0.4 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate scenomise 0.0.4 into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate scenomise 0.0.4
[INFO] finished tweaking crates.io crate scenomise 0.0.4
[INFO] tweaked toml for crates.io crate scenomise 0.0.4 written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate scenomise 0.0.4 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 scenomise 0.0.4 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-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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] 707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e
[INFO] running `Command { std: "docker" "start" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e", 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" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e" "/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" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e", 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" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling sceno v0.0.4
[INFO] [stderr]    Compiling scenomise v0.0.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.30s
[INFO] running `Command { std: "docker" "inspect" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e", 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" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e" "/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 scenomise v0.0.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.03s
[INFO] running `Command { std: "docker" "inspect" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e", 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" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e" "/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.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/scenomise/e0ee06f8dc78c258/out/scenomise-e0ee06f8dc78c258)
[INFO] [stdout] 
[INFO] [stdout] running 68 tests
[INFO] [stdout] test families::embedded::tests::a_ring_position_does_not_move_when_a_neighbour_leaves ... ok
[INFO] [stdout] test families::embedded::tests::collapse_puts_the_unembedded_at_the_origin ... ok
[INFO] [stdout] test families::lsystem::tests::every_grammar_walks_a_non_empty_path ... ok
[INFO] [stdout] test families::axial::tests::without_a_trailing_column_strays_fold_into_the_last_one ... ok
[INFO] [stdout] test families::lsystem::tests::reversing_swaps_the_ends_of_the_walk ... ok
[INFO] [stdout] test families::embedded::tests::a_disclosed_coordinate_scales_about_the_origin ... ok
[INFO] [stdout] test families::lsystem::tests::the_path_stays_inside_the_configured_size ... ok
[INFO] [stdout] test families::axial::tests::kanban_keeps_configured_columns_even_when_empty ... ok
[INFO] [stdout] test families::axial::tests::timeline_normalizes_disclosed_values_across_the_axis ... ok
[INFO] [stdout] test families::lsystem::tests::hilbert_visits_distinct_points ... ok
[INFO] [stdout] test families::penrose::tests::an_empty_score_places_nothing ... ok
[INFO] [stdout] test families::embedded::tests::rotation_turns_the_whole_cloud_about_the_origin ... ok
[INFO] [stdout] test families::axial::tests::unlisted_tags_order_alphabetically_not_by_appearance ... ok
[INFO] [stdout] test families::embedded::tests::the_outside_ring_clears_the_embedded_cluster ... ok
[INFO] [stdout] test families::lsystem::tests::an_unsupplied_named_grammar_walks_rather_than_placing_nothing ... ok
[INFO] [stdout] test families::radial::tests::ring_index_selects_the_radius ... ok
[INFO] [stdout] test families::penrose::tests::every_item_is_placed_exactly_once_per_vertex ... ok
[INFO] [stdout] test families::lsystem::tests::auto_depth_covers_the_items ... ok
[INFO] [stdout] test families::penrose::tests::subdivision_grows_the_tile_count_for_both_variants ... ok
[INFO] [stdout] test families::lsystem::tests::expansion_is_deterministic ... ok
[INFO] [stdout] test families::radial::tests::absent_weights_fall_back_to_an_even_split ... ok
[INFO] [stdout] test families::radial::tests::a_ring_spreads_its_members_around_the_circle ... ok
[INFO] [stdout] test families::radial::tests::a_negative_ring_is_unassigned_not_the_centre ... ok
[INFO] [stdout] test families::penrose::tests::early_ordinals_land_nearer_the_centre ... ok
[INFO] [stdout] test families::penrose::tests::auto_depth_picks_a_tiling_that_fits_the_items ... ok
[INFO] [stdout] test families::axial::tests::an_unlisted_tag_earns_its_own_column_and_an_untagged_item_the_trailing_one ... ok
[INFO] [stdout] test families::axial::tests::timeline_stacks_coincident_items_instead_of_overprinting ... ok
[INFO] [stdout] test families::radial::tests::weighted_slots_give_a_hub_more_room_than_a_leaf ... ok
[INFO] [stdout] test families::radial::tests::an_undisclosed_ring_takes_the_outer_ring ... ok
[INFO] [stdout] test families::radial::tests::the_first_uniform_slot_sits_exactly_on_the_rotation_offset ... ok
[INFO] [stdout] test families::stack::tests::layers_advance_on_x_and_members_stack_on_y ... ok
[INFO] [stdout] test families::stack::tests::an_undisclosed_layer_is_zero_not_a_dropped_item ... ok
[INFO] [stdout] test families::penrose::tests::the_two_variants_produce_different_tilings ... ok
[INFO] [stdout] test relax::tests::a_collidable_backdrop_excludes_item_placement_even_when_invisible ... ok
[INFO] [stdout] test relax::tests::a_noncollidable_backdrop_does_not_move_an_item ... ok
[INFO] [stdout] test relax::tests::an_anchored_hold_still_relaxes ... ok
[INFO] [stdout] test families::axial::tests::a_zero_span_does_not_produce_nan ... ok
[INFO] [stdout] test relax::tests::plain_relax_no_longer_drags_a_recorded_pin ... ok
[INFO] [stdout] test relax::tests::a_held_item_does_not_move_however_crowded ... ok
[INFO] [stdout] test relax::tests::crowded_items_push_apart ... ok
[INFO] [stdout] test relax::tests::related_items_are_drawn_toward_the_rest_length ... ok
[INFO] [stdout] test relax::tests::relax_is_relax_holding_with_nothing_held ... ok
[INFO] [stdout] test relax::tests::the_arrangement_pull_holds_its_shape ... ok
[INFO] [stdout] test relax::tests::coincident_items_separate_reproducibly ... ok
[INFO] [stdout] test relax::tests::a_held_item_still_pushes_its_neighbours ... ok
[INFO] [stdout] test families::stack::tests::layers_order_by_value_not_by_appearance ... ok
[INFO] [stdout] test relax::tests::zero_steps_leaves_the_scene_untouched ... ok
[INFO] [stdout] test solve::tests::a_cell_is_the_nearest_site_rule_made_visible ... ok
[INFO] [stdout] test solve::tests::a_custom_arrangement_places_nothing_here_and_says_which_pins_went_unmet ... ok
[INFO] [stdout] test solve::tests::a_hulls_score_round_trips ... ok
[INFO] [stdout] test solve::tests::a_hold_outranks_the_arrangement_in_every_family ... ok
[INFO] [stdout] test solve::tests::a_satisfied_pin_reports_nothing ... ok
[INFO] [stdout] test solve::tests::a_satisfied_pin_is_recorded_against_its_instance ... ok
[INFO] [stdout] test solve::tests::an_anchored_hold_is_not_recorded_as_honored ... ok
[INFO] [stdout] test solve::tests::an_unplaced_anchor_is_not_a_violation ... ok
[INFO] [stdout] test solve::tests::an_unheld_score_places_exactly_as_before ... ok
[INFO] [stdout] test solve::tests::an_invisible_item_is_not_a_site ... ok
[INFO] [stdout] test solve::tests::cells_tile_the_bounds ... ok
[INFO] [stdout] test solve::tests::each_cell_contains_its_own_site ... ok
[INFO] [stdout] test solve::tests::grid_keeps_authored_cells_and_geographic_keeps_coordinates ... ok
[INFO] [stdout] test solve::tests::an_unsatisfiable_pin_is_reported_on_the_scene ... ok
[INFO] [stdout] test solve::tests::spiral_grows_spacing_to_clear_measured_cards ... ok
[INFO] [stdout] test solve::tests::geographic_map_fixture_keeps_disclosed_coordinates_and_lod ... ok
[INFO] [stdout] test solve::tests::every_family_places_every_item ... ok
[INFO] [stdout] test solve::tests::every_instance_of_a_held_source_is_recorded ... ok
[INFO] [stdout] test solve::tests::one_site_owns_the_whole_bounds ... ok
[INFO] [stdout] test solve::tests::pinned_instances_finds_every_instance_of_a_pinned_source ... ok
[INFO] [stdout] test solve::tests::score_order_drives_spiral_not_source_identity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 68 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests scenomise
[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" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e", kill_on_drop: false }`
[INFO] [stdout] 707548d5d97eb07c2ddbf5f4bdb326851341cb3f377f406830de810b9c39105e
