[INFO] fetching crate vthread-stack 0.1.0...
[INFO] testing vthread-stack-0.1.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate vthread-stack 0.1.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate vthread-stack 0.1.0
[INFO] finished tweaking crates.io crate vthread-stack 0.1.0
[INFO] tweaked toml for crates.io crate vthread-stack 0.1.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate vthread-stack 0.1.0 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 vthread-stack 0.1.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.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-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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] 0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc
[INFO] running `Command { std: "docker" "start" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc", 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" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc" "/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" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc", 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" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling vthread-stack v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated method `std::sync::atomic::Atomic::<u64>::fetch_update`: renamed to `try_update` for consistency
[INFO] [stdout]   --> src/context.rs:74:14
[INFO] [stdout]    |
[INFO] [stdout] 74 |             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout]    |              ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] help: replace the use of the deprecated method
[INFO] [stdout]    |
[INFO] [stdout] 74 -             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout] 74 +             .try_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout]    |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.66s
[INFO] running `Command { std: "docker" "inspect" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc", 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" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc" "/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 vthread-stack v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated method `std::sync::atomic::Atomic::<u64>::fetch_update`: renamed to `try_update` for consistency
[INFO] [stdout]   --> src/context.rs:74:14
[INFO] [stdout]    |
[INFO] [stdout] 74 |             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout]    |              ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] help: replace the use of the deprecated method
[INFO] [stdout]    |
[INFO] [stdout] 74 -             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout] 74 +             .try_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout]    |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated method `std::sync::atomic::Atomic::<u64>::fetch_update`: renamed to `try_update` for consistency
[INFO] [stdout]   --> src/context.rs:74:14
[INFO] [stdout]    |
[INFO] [stdout] 74 |             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout]    |              ^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout] help: replace the use of the deprecated method
[INFO] [stdout]    |
[INFO] [stdout] 74 -             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout] 74 +             .try_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stdout]    |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.78s
[INFO] running `Command { std: "docker" "inspect" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc", 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" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: use of deprecated method `std::sync::atomic::Atomic::<u64>::fetch_update`: renamed to `try_update` for consistency
[INFO] [stderr]   --> src/context.rs:74:14
[INFO] [stderr]    |
[INFO] [stderr] 74 |             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stderr]    |              ^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(deprecated)]` on by default
[INFO] [stderr] help: replace the use of the deprecated method
[INFO] [stderr]    |
[INFO] [stderr] 74 -             .fetch_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stderr] 74 +             .try_update(Ordering::Relaxed, Ordering::Relaxed, |block| {
[INFO] [stderr]    |
[INFO] [stderr] 
[INFO] [stderr] warning: `vthread-stack` (lib) generated 1 warning (run `cargo fix --lib -p vthread-stack` to apply 1 suggestion)
[INFO] [stderr] warning: `vthread-stack` (lib test) generated 1 warning (1 duplicate)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/vthread-stack/7fa4be10f337b6b3/out/vthread_stack-7fa4be10f337b6b3)
[INFO] [stdout] 
[INFO] [stdout] running 82 tests
[INFO] [stdout] test arch::arch_test::the_first_frame_sits_directly_below_the_frame_top ... ok
[INFO] [stdout] test arch::x86_64_sysv::x86_64_sysv_test::the_default_control_words_are_the_abi_defaults ... ok
[INFO] [stdout] test context::context_test::every_block_receives_a_distinct_nonzero_cookie ... ok
[INFO] [stdout] test arch::x86_64_sysv::x86_64_sysv_test::floating_point_control_state_stays_with_its_context ... ok
[INFO] [stdout] test context::context_test::shared_outcomes_round_trip_through_the_block ... ok
[INFO] [stdout] test context::context_test::only_the_matching_forced_unwind_token_is_suppressed ... ok
[INFO] [stdout] test context::context_test::the_control_block_and_entry_sit_above_an_aligned_first_frame ... ok
[INFO] [stdout] test engine::engine_test::dropping_a_suspended_execution_runs_every_live_destructor ... ok
[INFO] [stdout] test context::context_test::the_entry_is_taken_once_and_dropped_when_unused ... ok
[INFO] [stdout] test engine::engine_test::deep_recursion_keeps_the_stack_pointer_aligned ... ok
[INFO] [stdout] test engine::engine_panic_reclaim_test::forced_reclamation_rejects_destructor_suspension_and_reuses_the_stack ... ok
[INFO] [stdout] test entry::entry_test::an_uncalled_entry_drops_its_captures_exactly_once_in_place ... ok
[INFO] [stdout] test engine::engine_test::a_caught_forced_unwind_is_reinjected_at_the_next_suspension ... ok
[INFO] [stdout] test engine::engine_test::a_foreign_forced_unwind_token_is_an_ordinary_panic ... ok
[INFO] [stdout] test context::context_test::cookies_are_unique_across_carriers_and_sequential_within_one ... ok
[INFO] [stdout] test engine::engine_test::suspends_resumes_and_completes_in_order ... ok
[INFO] [stdout] test entry::entry_test::a_called_entry_runs_once_and_drops_its_captures_once ... ok
[INFO] [stdout] test entry::entry_test::zero_sized_entries_run_from_any_storage ... ok
[INFO] [stdout] test fiber::fiber_drop_test::an_unstarted_entry_destructor_keeps_the_actual_outer_fiber_mounted ... ok
[INFO] [stdout] test fiber::fiber_drop_test::dropping_an_unstarted_entry_does_not_mount_its_never_saved_context ... ok
[INFO] [stdout] test engine::engine_test::a_pooled_fiber_runs_without_heap_allocation ... ok
[INFO] [stdout] test engine::engine_test::a_never_started_execution_drops_its_entry_once_on_the_carrier ... ok
[INFO] [stdout] test fiber::fiber_test::a_nested_function_can_suspend_and_resume ... ok
[INFO] [stdout] test fiber::fiber_test::suspended_fiber_can_move_before_resuming ... ok
[INFO] [stdout] test fiber::fiber_test::typed_context_tracks_each_resume_and_restores_the_caller ... ok
[INFO] [stdout] test fiber::fiber_test::resume_decision_returns_to_the_suspension_point ... ok
[INFO] [stdout] test fiber::fiber_test::parking_requests_preserve_token_and_deadline ... ok
[INFO] [stdout] test fiber::fiber_test::nested_fiber_context_restores_the_outer_value ... ok
[INFO] [stdout] test fiber::fiber_test::suspension_outside_a_fiber_is_rejected ... ok
[INFO] [stdout] test fiber::fiber_drop_test::unstarted_entry_destructors_suspend_only_an_actual_running_fiber ... ok
[INFO] [stdout] test lease::lease_test::lease_forwards_typed_context_without_extending_its_mount ... ok
[INFO] [stdout] test mount::mount_borrow_test::a_context_reference_cannot_survive_its_resume_by_suspending ... ok
[INFO] [stdout] test lib_test::public_state_types_are_comparable ... ok
[INFO] [stdout] test mount::mount_borrow_test::nested_fibers_can_suspend_without_releasing_an_outer_context_borrow ... ok
[INFO] [stdout] test mount::mount_borrow_test::nested_context_callbacks_restore_the_outer_borrow_restriction ... ok
[INFO] [stdout] test panic_payload::panic_payload_test::control_join_capture_retains_opaque_values_without_running_drop ... ok
[INFO] [stdout] test panic_payload::panic_payload_test::externally_constructed_captured_payloads_are_rebounded_on_every_boundary ... ok
[INFO] [stdout] test mount::mount_test::context_keys_select_only_their_own_value ... ok
[INFO] [stdout] test mount::mount_test::current_mount_is_two_machine_words ... ok
[INFO] [stdout] test panic_payload::panic_payload_test::utf8_text_is_bounded_and_truncation_is_explicit ... ok
[INFO] [stdout] test pool::pool_test::the_cache_never_exceeds_its_limit ... ok
[INFO] [stdout] test pool::pool_test::completed_stacks_are_reused ... ok
[INFO] [stdout] test scoped::scoped_test::a_running_lease_can_be_inspected_without_borrowing_its_executing_fiber ... ok
[INFO] [stdout] test scoped::scoped_test::escaped_and_forgotten_leases_cannot_outlive_borrowed_values ... ok
[INFO] [stdout] test scoped::scoped_test::forced_parent_reclamation_preserves_the_backend_unwind_token ... ok
[INFO] [stdout] test context::context_test::an_oversized_entry_is_rejected_before_anything_is_written ... ok
[INFO] [stdout] test engine::engine_test::a_panic_unwinds_the_fiber_stack_before_reaching_the_carrier ... ok
[INFO] [stdout] test scoped::scoped_test::reclaiming_a_nested_stack_restores_the_parent_mount ... ok
[INFO] [stdout] test context::context_cookie_test::the_last_cookie_is_returned_once_before_permanent_exhaustion ... ok
[INFO] [stdout] test scoped::scoped_test::scope_value_remains_live_while_borrowed_destructors_run ... ok
[INFO] [stdout] test scoped::scoped_test::incomplete_extraction_preserves_the_lease_for_later_completion ... ok
[INFO] [stdout] test stack::stack_test::capacity_rounds_up_to_whole_pages_above_one_guard_page ... ok
[INFO] [stdout] test engine::engine_test::extracting_a_suspended_stack_fails_and_still_reclaims_it ... ok
[INFO] [stdout] test stack::stack_test::the_whole_usable_range_is_writable ... ok
[INFO] [stdout] test stack::stack_test::empty_and_overflowing_capacities_are_rejected ... ok
[INFO] [stdout] test stack::stack_test::stacks_may_move_between_threads ... ok
[INFO] [stdout] test stack_unix::stack_unix_test::the_page_size_is_a_power_of_two_of_at_least_four_kib ... ok
[INFO] [stdout] test fiber::fiber_test::panic_unwinds_values_on_the_fiber_stack ... ok
[INFO] [stdout] test stack_unix::stack_unix_test::enabled_pages_are_writable_and_release_succeeds ... ok
[INFO] [stdout] test suspension::suspension_test::park_tokens_expose_their_wait_and_generation ... ok
[INFO] [stdout] test suspension::suspension_test::the_default_resume_decision_continues ... ok
[INFO] [stdout] test terminal_test::completion_after_yield_and_park_returns_the_shared_outcome ... ok
[INFO] [stdout] test mount::mount_borrow_test::callback_unwind_restores_the_running_fibers_suspension_context ... ok
[INFO] [stdout] test suspension::suspension_test::the_suspend_error_names_panic_handling ... ok
[INFO] [stdout] test terminal_test::forced_unwind_returns_after_dropping_nested_parked_frames ... ok
[INFO] [stdout] test lease::lease_test::reentrant_resume_is_rejected_without_revoking_the_running_stack ... ok
[INFO] [stdout] test suspension::suspension_test::the_suspend_error_names_the_missing_mount ... ok
[INFO] [stdout] test terminal_test::immediate_completion_returns_to_the_caller_and_reuses_the_same_stack ... ok
[INFO] [stdout] test fiber::fiber_test::incomplete_stack_extraction_reclaims_with_its_block_mounted ... ok
[INFO] [stdout] test scoped::scoped_test::parent_unwind_drops_borrowed_children ... ok
[INFO] [stdout] test mount::mount_test::panicking_fiber_cannot_suspend_before_reaching_its_catch_boundary ... ok
[INFO] [stdout] test panic_payload::panic_payload_test::opaque_secondary_payload_is_not_dropped ... ok
[INFO] [stdout] test scoped::scoped_test::failed_cleanup_mount_preserves_ownership_for_retry ... ok
[INFO] [stdout] test context::context_cookie_test::exhausted_cookie_blocks_never_advance_or_reissue_an_old_identity ... ok
[INFO] [stdout] test fiber::fiber_test::completed_resume_panics_before_installing_a_stale_mount ... ok
[INFO] [stdout] test trace_test::every_scenario_produces_its_specified_observation ... ok
[INFO] [stdout] test trace_test::a_reclaimed_stack_serves_the_next_trace_identically ... ok
[INFO] [stdout] test terminal_test::panic_reports_its_payload_and_allows_terminal_stack_reuse ... ok
[INFO] [stdout] test engine::engine_test::callee_saved_state_survives_a_million_switches ... ok
[INFO] [stdout] test stack_unix::stack_unix_test::empty_reservations_are_rejected ... ok
[INFO] [stdout] test stack::stack_test::touching_the_guard_page_stops_the_process ... ok
[INFO] [stdout] test panic_payload::panic_payload_test::opaque_quarantine_has_a_process_limit ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 82 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.27s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests vthread_stack
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/fiber.rs - fiber::Fiber (line 10) - compile fail ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc", kill_on_drop: false }`
[INFO] [stdout] 0447db2d3458c5047726bfe6d5edb875aaf0ecc5bc4d43b946aa58bfe9dbfecc
