[INFO] fetching crate virtualizer 0.4.0...
[INFO] testing virtualizer-0.4.0 against master#7704328ba5ae8d6ce0ac303c9d5a1a1605906766 for pr-146989
[INFO] extracting crate virtualizer 0.4.0 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate virtualizer 0.4.0
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate virtualizer 0.4.0
[INFO] tweaked toml for crates.io crate virtualizer 0.4.0 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate virtualizer 0.4.0 on toolchain 7704328ba5ae8d6ce0ac303c9d5a1a1605906766
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate virtualizer 0.4.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" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded quote v1.0.43
[INFO] [stderr]   Downloaded once_cell v1.21.3
[INFO] [stderr]   Downloaded tracing-core v0.1.36
[INFO] [stderr]   Downloaded pin-project-lite v0.2.16
[INFO] [stderr]   Downloaded unicode-ident v1.0.22
[INFO] [stderr]   Downloaded serde_derive v1.0.228
[INFO] [stderr]   Downloaded serde_core v1.0.228
[INFO] [stderr]   Downloaded proc-macro2 v1.0.105
[INFO] [stderr]   Downloaded serde v1.0.228
[INFO] [stderr]   Downloaded syn v2.0.114
[INFO] [stderr]   Downloaded tracing v0.1.44
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] dfd6ff4a93b9b159bb097a851074c8eea3bee487f4eba96e7dc39f67c34e0dfd
[INFO] running `Command { std: "docker" "start" "-a" "dfd6ff4a93b9b159bb097a851074c8eea3bee487f4eba96e7dc39f67c34e0dfd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dfd6ff4a93b9b159bb097a851074c8eea3bee487f4eba96e7dc39f67c34e0dfd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dfd6ff4a93b9b159bb097a851074c8eea3bee487f4eba96e7dc39f67c34e0dfd", kill_on_drop: false }`
[INFO] [stdout] dfd6ff4a93b9b159bb097a851074c8eea3bee487f4eba96e7dc39f67c34e0dfd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 68f6a5252295c7fee8441f4f3c60af184d87b377c91eeeb730a25fd5e1eeff23
[INFO] running `Command { std: "docker" "start" "-a" "68f6a5252295c7fee8441f4f3c60af184d87b377c91eeeb730a25fd5e1eeff23", kill_on_drop: false }`
[INFO] [stderr]    Compiling virtualizer v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.23s
[INFO] running `Command { std: "docker" "inspect" "68f6a5252295c7fee8441f4f3c60af184d87b377c91eeeb730a25fd5e1eeff23", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "68f6a5252295c7fee8441f4f3c60af184d87b377c91eeeb730a25fd5e1eeff23", kill_on_drop: false }`
[INFO] [stdout] 68f6a5252295c7fee8441f4f3c60af184d87b377c91eeeb730a25fd5e1eeff23
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d8eae439abe80243e4071b18b6be848296c2114208553ee9714e0cca3763d906
[INFO] running `Command { std: "docker" "start" "-a" "d8eae439abe80243e4071b18b6be848296c2114208553ee9714e0cca3763d906", kill_on_drop: false }`
[INFO] [stderr]    Compiling virtualizer v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.94s
[INFO] running `Command { std: "docker" "inspect" "d8eae439abe80243e4071b18b6be848296c2114208553ee9714e0cca3763d906", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d8eae439abe80243e4071b18b6be848296c2114208553ee9714e0cca3763d906", kill_on_drop: false }`
[INFO] [stdout] d8eae439abe80243e4071b18b6be848296c2114208553ee9714e0cca3763d906
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d4ed46b29676b9c221150ef29de55284b69a2de87de5e05e0aeb37fa1e6fd6b1
[INFO] running `Command { std: "docker" "start" "-a" "d4ed46b29676b9c221150ef29de55284b69a2de87de5e05e0aeb37fa1e6fd6b1", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/virtualizer-a4fe9685f6d407a0)
[INFO] [stdout] 
[INFO] [stdout] running 52 tests
[INFO] [stdout] test tests::align_auto_returns_current_offset_when_fully_visible ... ok
[INFO] [stdout] test tests::align_auto_scrolls_to_end_when_item_is_after_viewport ... ok
[INFO] [stdout] test tests::apply_scroll_frame_clamped_clamps_offset ... ok
[INFO] [stdout] test tests::batch_update_coalesces_on_change ... ok
[INFO] [stdout] test tests::apply_scroll_frame_coalesces_on_change ... ok
[INFO] [stdout] test tests::batch_update_is_nestable ... ok
[INFO] [stdout] test tests::collect_virtual_indexes_matches_for_each ... ok
[INFO] [stdout] test tests::collect_virtual_items_keyed_matches_for_each ... ok
[INFO] [stdout] test tests::collect_virtual_items_matches_for_each ... ok
[INFO] [stdout] test tests::disabled_virtualizer_is_empty_and_side_effect_free ... ok
[INFO] [stdout] test tests::example_dynamic_measurement_smoke ... ok
[INFO] [stdout] test tests::fixed_size_range_and_total ... ok
[INFO] [stdout] test tests::example_pinned_headers_smoke ... ok
[INFO] [stdout] test tests::frame_state_can_roundtrip ... ok
[INFO] [stdout] test tests::index_at_offset_with_gap_maps_into_previous_item ... ok
[INFO] [stdout] test tests::initial_rect_sets_viewport_and_scroll_rect ... ok
[INFO] [stdout] test tests::example_adapter_sim_smoke ... ok
[INFO] [stdout] test tests::measure_many_marks_items_measured_and_updates_total ... ok
[INFO] [stdout] test tests::measurement_cache_can_roundtrip ... ok
[INFO] [stdout] test tests::no_op_setters_do_not_notify ... ok
[INFO] [stdout] test tests::measure_updates_total_and_scroll_to_index_offset ... ok
[INFO] [stdout] test tests::initial_offset_provider_is_used ... ok
[INFO] [stdout] test tests::overscan_and_scroll ... ok
[INFO] [stdout] test tests::is_scrolling_resets_after_delay_without_scrollend_event ... ok
[INFO] [stdout] test tests::range_extractor_dedupes_consecutive_duplicates ... ok
[INFO] [stdout] test tests::range_extractor_receives_visible_range_and_overscan ... ok
[INFO] [stdout] test tests::measurements_follow_keys_after_reorder ... ok
[INFO] [stdout] test tests::example_tween_scroll_retarget_smoke ... ok
[INFO] [stdout] test tests::resize_item_can_adjust_scroll_to_prevent_jumps ... ok
[INFO] [stdout] test tests::padding_and_gap_affect_total_and_positions ... ok
[INFO] [stdout] test tests::property_keyed_reorder_sync_item_keys_preserves_measurements_by_key ... ok
[INFO] [stdout] test tests::reset_measurements_clears_measurements ... ok
[INFO] [stdout] test tests::resize_item_many_applies_scroll_offset_adjustment_when_items_are_before_viewport ... ok
[INFO] [stdout] test tests::scroll_margin_affects_visibility_and_item_starts ... ok
[INFO] [stdout] test tests::scroll_offset_in_list_subtracts_scroll_margin ... ok
[INFO] [stdout] test tests::set_count_roundtrips_measured_sizes_across_shrink_and_grow ... ok
[INFO] [stdout] test tests::scroll_to_index_offset_respects_padding_margin_gap_and_scroll_padding ... ok
[INFO] [stdout] test tests::set_count_to_zero_then_grow_is_well_defined ... ok
[INFO] [stdout] test tests::scroll_to_index_sets_offset_without_scrolling ... ok
[INFO] [stdout] test tests::set_gap_rebuilds_prefix_sums_and_index_mapping ... ok
[INFO] [stdout] test tests::set_count_updates_gap_bookkeeping ... ok
[INFO] [stdout] test tests::range_extractor_can_pin_indices ... ok
[INFO] [stdout] test tests::set_options_rebuilds_when_closures_change ... ok
[INFO] [stdout] test tests::set_count_preserves_existing_sizes_and_appends_estimates ... ok
[INFO] [stdout] test tests::set_scroll_rect_updates_viewport_size ... ok
[INFO] [stdout] test tests::sync_item_keys_can_move_measurements_without_replacing_get_item_key ... ok
[INFO] [stdout] test tests::virtual_item_for_offset_maps_to_correct_index ... ok
[INFO] [stdout] test tests::visible_range_clamps_overscrolled_offsets ... ok
[INFO] [stdout] test tests::set_scroll_offset_clamped_respects_max_scroll_offset ... ok
[INFO] [stdout] test tests::set_options_count_only_change_preserves_cached_measurements ... ok
[INFO] [stdout] test tests::property_random_layout_invariants ... ok
[INFO] [stdout] test tests::example_basic_smoke_large_count ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests virtualizer
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/emitter.rs - emitter::IndexEmitter (line 12) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.15s; merged doctests compilation took 0.14s
[INFO] running `Command { std: "docker" "inspect" "d4ed46b29676b9c221150ef29de55284b69a2de87de5e05e0aeb37fa1e6fd6b1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d4ed46b29676b9c221150ef29de55284b69a2de87de5e05e0aeb37fa1e6fd6b1", kill_on_drop: false }`
[INFO] [stdout] d4ed46b29676b9c221150ef29de55284b69a2de87de5e05e0aeb37fa1e6fd6b1